builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-021 starttime: 1465561225.45 results: success (0) buildid: 20160610044828 builduid: 62dbb54c4a5a42c3988caf91568269fa revision: 151500c01e44846223acb5bfcb4dcd2123e620c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:25.449678) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:25.450364) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:25.450654) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:25.492393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:25.492664) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1465558857.594069-128602410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 05:20:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.9M=0s 2016-06-10 05:20:25 (66.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156974 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:25.664307) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:25.664686) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1465558857.594069-128602410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014918 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:25.715041) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:25.715368) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 151500c01e44846223acb5bfcb4dcd2123e620c5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 151500c01e44846223acb5bfcb4dcd2123e620c5 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1465558857.594069-128602410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 05:20:26,077 truncating revision to first 12 chars 2016-06-10 05:20:26,077 Setting DEBUG logging. 2016-06-10 05:20:26,077 attempt 1/10 2016-06-10 05:20:26,077 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/151500c01e44?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 05:20:26,376 unpacking tar archive at: fx-team-151500c01e44/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644675 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:26.477864) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:26.478232) ========= script_repo_revision: 151500c01e44846223acb5bfcb4dcd2123e620c5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:26.479048) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:26.479661) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 05:20:26.502671) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-06-10 05:20:26.502949) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1465558857.594069-128602410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:20:26 INFO - MultiFileLogger online at 20160610 05:20:26 in /builds/slave/test 05:20:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:20:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:20:26 INFO - {'append_to_log': False, 05:20:26 INFO - 'base_work_dir': '/builds/slave/test', 05:20:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:20:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:20:26 INFO - 'branch': 'Fx-Team-Non-PGO', 05:20:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:20:26 INFO - 'config_files': ('talos/linux_config.py',), 05:20:26 INFO - 'default_actions': ('clobber', 05:20:26 INFO - 'read-buildbot-config', 05:20:26 INFO - 'download-and-extract', 05:20:26 INFO - 'populate-webroot', 05:20:26 INFO - 'create-virtualenv', 05:20:26 INFO - 'install', 05:20:26 INFO - 'run-tests'), 05:20:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:20:26 INFO - 'download_minidump_stackwalk': True, 05:20:26 INFO - 'download_symbols': 'ondemand', 05:20:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:20:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:20:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:20:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:20:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:20:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:20:26 INFO - 'installer_path': 'installer.exe', 05:20:26 INFO - 'log_level': 'info', 05:20:26 INFO - 'log_name': 'talos', 05:20:26 INFO - 'log_to_console': True, 05:20:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:20:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:20:26 INFO - 'opt_config_files': (), 05:20:26 INFO - 'pip_index': False, 05:20:26 INFO - 'sps_profile': False, 05:20:26 INFO - 'sps_profile_interval': 0, 05:20:26 INFO - 'suite': 'dromaeojs', 05:20:26 INFO - 'system_bits': '32', 05:20:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:20:26 INFO - 'title': 'talos-linux64-ix-021', 05:20:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:20:26 INFO - 'use_talos_json': True, 05:20:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:20:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:20:26 INFO - 'work_dir': 'build'} 05:20:26 INFO - ##### 05:20:26 INFO - ##### Running clobber step. 05:20:26 INFO - ##### 05:20:26 INFO - Running pre-action listener: _resource_record_pre_action 05:20:26 INFO - Running main action method: clobber 05:20:26 INFO - rmtree: /builds/slave/test/build 05:20:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:20:27 INFO - Running post-action listener: _resource_record_post_action 05:20:27 INFO - ##### 05:20:27 INFO - ##### Finished clobber step (success) 05:20:27 INFO - ##### 05:20:27 INFO - ##### 05:20:27 INFO - ##### Running read-buildbot-config step. 05:20:27 INFO - ##### 05:20:27 INFO - Running pre-action listener: _resource_record_pre_action 05:20:27 INFO - Running main action method: read_buildbot_config 05:20:27 INFO - Using buildbot properties: 05:20:27 INFO - { 05:20:27 INFO - "project": "", 05:20:27 INFO - "product": "firefox", 05:20:27 INFO - "script_repo_revision": "production", 05:20:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:20:27 INFO - "repository": "", 05:20:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:20:27 INFO - "buildid": "20160610044828", 05:20:27 INFO - "pgo_build": "False", 05:20:27 INFO - "basedir": "/builds/slave/test", 05:20:27 INFO - "buildnumber": 1843, 05:20:27 INFO - "slavename": "talos-linux64-ix-021", 05:20:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:20:27 INFO - "platform": "ubuntu64_hw", 05:20:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:20:27 INFO - "branch": "fx-team", 05:20:27 INFO - "repo_path": "integration/fx-team", 05:20:27 INFO - "revision": "151500c01e44846223acb5bfcb4dcd2123e620c5", 05:20:27 INFO - "stage_platform": "linux64", 05:20:27 INFO - "builduid": "62dbb54c4a5a42c3988caf91568269fa", 05:20:27 INFO - "slavebuilddir": "test" 05:20:27 INFO - } 05:20:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:20:27 INFO - Running post-action listener: _resource_record_post_action 05:20:27 INFO - ##### 05:20:27 INFO - ##### Finished read-buildbot-config step (success) 05:20:27 INFO - ##### 05:20:27 INFO - ##### 05:20:27 INFO - ##### Running download-and-extract step. 05:20:27 INFO - ##### 05:20:27 INFO - Running pre-action listener: _resource_record_pre_action 05:20:27 INFO - Running main action method: download_and_extract 05:20:27 INFO - mkdir: /builds/slave/test/build/tests 05:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:27 INFO - https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:20:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:20:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:20:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:20:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:20:28 INFO - Downloaded 1361 bytes. 05:20:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:20:28 INFO - Using the following test package requirements: 05:20:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:20:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:20:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:20:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:28 INFO - u'jsshell-linux-x86_64.zip'], 05:20:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:20:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:20:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:20:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:20:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:20:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:20:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:28 INFO - https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:20:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:20:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:20:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:20:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:20:29 INFO - Downloaded 22879686 bytes. 05:20:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:20:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:20:30 INFO - Return code: 0 05:20:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:30 INFO - https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:20:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:20:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:20:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:20:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:20:50 INFO - Downloaded 22879686 bytes. 05:20:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:20:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:20:51 INFO - Return code: 0 05:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:51 INFO - https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:20:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:20:53 INFO - Downloaded 10833377 bytes. 05:20:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:20:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:20:53 INFO - Return code: 0 05:20:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:53 INFO - https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:20:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:20:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:20:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:20:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:20:54 INFO - Downloaded 55378716 bytes. 05:20:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:20:54 INFO - mkdir: /builds/slave/test/properties 05:20:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:20:54 INFO - Writing to file /builds/slave/test/properties/build_url 05:20:54 INFO - Contents: 05:20:54 INFO - build_url:https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:20:55 INFO - Running post-action listener: _resource_record_post_action 05:20:55 INFO - Running post-action listener: set_extra_try_arguments 05:20:55 INFO - ##### 05:20:55 INFO - ##### Finished download-and-extract step (success) 05:20:55 INFO - ##### 05:20:55 INFO - ##### 05:20:55 INFO - ##### Running populate-webroot step. 05:20:55 INFO - ##### 05:20:55 INFO - Running pre-action listener: _resource_record_pre_action 05:20:55 INFO - Running main action method: populate_webroot 05:20:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:20:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:20:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:20:55 INFO - '--tppagecycles', 05:20:55 INFO - '7'], 05:20:55 INFO - 'tests': ['tsvgm']}}, 05:20:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:20:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:20:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:20:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:20:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:20:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:20:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:55 INFO - 'talos_options': ['--disable-e10s'], 05:20:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:55 INFO - 'talos_options': ['--disable-e10s'], 05:20:55 INFO - 'tests': ['damp', 'tps']}, 05:20:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:55 INFO - 'tests': ['damp', 'tps']}, 05:20:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:20:55 INFO - 'tests': ['dromaeo_dom']}, 05:20:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:20:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:20:55 INFO - 'tests': ['a11yr', 05:20:55 INFO - 'ts_paint', 05:20:55 INFO - 'tpaint', 05:20:55 INFO - 'sessionrestore', 05:20:55 INFO - 'sessionrestore_no_auto_restore', 05:20:55 INFO - 'tabpaint']}, 05:20:55 INFO - 'other-e10s': {'tests': ['a11yr', 05:20:55 INFO - 'ts_paint', 05:20:55 INFO - 'tpaint', 05:20:55 INFO - 'sessionrestore', 05:20:55 INFO - 'sessionrestore_no_auto_restore', 05:20:55 INFO - 'tabpaint']}, 05:20:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:20:55 INFO - 'ts_paint', 05:20:55 INFO - 'tpaint', 05:20:55 INFO - 'sessionrestore', 05:20:55 INFO - 'sessionrestore_no_auto_restore', 05:20:55 INFO - 'tabpaint']}, 05:20:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:20:55 INFO - 'ts_paint', 05:20:55 INFO - 'tpaint', 05:20:55 INFO - 'sessionrestore', 05:20:55 INFO - 'sessionrestore_no_auto_restore', 05:20:55 INFO - 'tabpaint']}, 05:20:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:20:55 INFO - 'tests': ['a11yr', 05:20:55 INFO - 'ts_paint', 05:20:55 INFO - 'tpaint', 05:20:55 INFO - 'sessionrestore', 05:20:55 INFO - 'sessionrestore_no_auto_restore', 05:20:55 INFO - 'tabpaint']}, 05:20:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:20:55 INFO - 'tests': ['a11yr', 05:20:55 INFO - 'ts_paint', 05:20:55 INFO - 'tpaint', 05:20:55 INFO - 'sessionrestore', 05:20:55 INFO - 'sessionrestore_no_auto_restore', 05:20:55 INFO - 'tabpaint']}, 05:20:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:20:55 INFO - 'tests': ['tsvgx', 05:20:55 INFO - 'tsvgr_opacity', 05:20:55 INFO - 'tart', 05:20:55 INFO - 'tscrollx', 05:20:55 INFO - 'cart']}, 05:20:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:20:55 INFO - 'tsvgr_opacity', 05:20:55 INFO - 'tart', 05:20:55 INFO - 'tscrollx', 05:20:55 INFO - 'cart']}, 05:20:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:55 INFO - 'talos_options': ['--disable-e10s'], 05:20:55 INFO - 'tests': ['tp5o']}, 05:20:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:55 INFO - 'tests': ['tp5o']}, 05:20:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:55 INFO - 'talos_options': ['--disable-e10s', 05:20:55 INFO - '--xperf_path', 05:20:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:55 INFO - 'tests': ['tp5n']}, 05:20:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:55 INFO - 'talos_options': ['--xperf_path', 05:20:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:55 INFO - 'tests': ['tp5n']}}, 05:20:55 INFO - 'talos.zip': {'path': '', 05:20:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:20:55 INFO - Running post-action listener: _resource_record_post_action 05:20:55 INFO - ##### 05:20:55 INFO - ##### Finished populate-webroot step (success) 05:20:55 INFO - ##### 05:20:55 INFO - ##### 05:20:55 INFO - ##### Running create-virtualenv step. 05:20:55 INFO - ##### 05:20:55 INFO - Running pre-action listener: _resource_record_pre_action 05:20:55 INFO - Running main action method: create_virtualenv 05:20:55 INFO - Creating virtualenv /builds/slave/test/build/venv 05:20:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:20:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:20:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:20:55 INFO - Using real prefix '/usr' 05:20:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:20:56 INFO - Installing distribute.............................................................................................................................................................................................done. 05:20:58 INFO - Installing pip.................done. 05:20:58 INFO - Return code: 0 05:20:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2036358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2297350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23261c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2327550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:20:58 INFO - Using env: {'DISPLAY': ':0', 05:20:58 INFO - 'HOME': '/home/cltbld', 05:20:58 INFO - 'LANG': 'en_US.UTF-8', 05:20:58 INFO - 'LANGUAGE': 'en_US:en', 05:20:58 INFO - 'LOGNAME': 'cltbld', 05:20:58 INFO - 'MAIL': '/var/mail/cltbld', 05:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:58 INFO - 'MOZ_NO_REMOTE': '1', 05:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:58 INFO - 'NO_EM_RESTART': '1', 05:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:58 INFO - 'PWD': '/builds/slave/test', 05:20:58 INFO - 'SHELL': '/bin/bash', 05:20:58 INFO - 'SHLVL': '1', 05:20:58 INFO - 'TERM': 'linux', 05:20:58 INFO - 'TMOUT': '86400', 05:20:58 INFO - 'USER': 'cltbld', 05:20:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 05:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:58 INFO - '_': '/tools/buildbot/bin/python'} 05:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:20:58 INFO - Cleaning up... 05:20:58 INFO - Return code: 0 05:20:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2036358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2297350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23261c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2327550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:20:58 INFO - Using env: {'DISPLAY': ':0', 05:20:58 INFO - 'HOME': '/home/cltbld', 05:20:58 INFO - 'LANG': 'en_US.UTF-8', 05:20:58 INFO - 'LANGUAGE': 'en_US:en', 05:20:58 INFO - 'LOGNAME': 'cltbld', 05:20:58 INFO - 'MAIL': '/var/mail/cltbld', 05:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:58 INFO - 'MOZ_NO_REMOTE': '1', 05:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:58 INFO - 'NO_EM_RESTART': '1', 05:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:58 INFO - 'PWD': '/builds/slave/test', 05:20:58 INFO - 'SHELL': '/bin/bash', 05:20:58 INFO - 'SHLVL': '1', 05:20:58 INFO - 'TERM': 'linux', 05:20:58 INFO - 'TMOUT': '86400', 05:20:58 INFO - 'USER': 'cltbld', 05:20:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 05:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:58 INFO - '_': '/tools/buildbot/bin/python'} 05:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:58 INFO - Downloading/unpacking psutil>=3.1.1 05:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:21:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:00 INFO - Installing collected packages: psutil 05:21:00 INFO - Running setup.py install for psutil 05:21:00 INFO - building 'psutil._psutil_linux' extension 05:21:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:21:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:21:00 INFO - building 'psutil._psutil_posix' extension 05:21:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:21:01 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:21:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:01 INFO - Successfully installed psutil 05:21:01 INFO - Cleaning up... 05:21:01 INFO - Return code: 0 05:21:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2036358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2297350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23261c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2327550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:21:01 INFO - Using env: {'DISPLAY': ':0', 05:21:01 INFO - 'HOME': '/home/cltbld', 05:21:01 INFO - 'LANG': 'en_US.UTF-8', 05:21:01 INFO - 'LANGUAGE': 'en_US:en', 05:21:01 INFO - 'LOGNAME': 'cltbld', 05:21:01 INFO - 'MAIL': '/var/mail/cltbld', 05:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:01 INFO - 'MOZ_NO_REMOTE': '1', 05:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:01 INFO - 'NO_EM_RESTART': '1', 05:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:01 INFO - 'PWD': '/builds/slave/test', 05:21:01 INFO - 'SHELL': '/bin/bash', 05:21:01 INFO - 'SHLVL': '1', 05:21:01 INFO - 'TERM': 'linux', 05:21:01 INFO - 'TMOUT': '86400', 05:21:01 INFO - 'USER': 'cltbld', 05:21:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 05:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:01 INFO - '_': '/tools/buildbot/bin/python'} 05:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:21:03 INFO - Installing collected packages: mozsystemmonitor 05:21:03 INFO - Running setup.py install for mozsystemmonitor 05:21:03 INFO - Successfully installed mozsystemmonitor 05:21:03 INFO - Cleaning up... 05:21:03 INFO - Return code: 0 05:21:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2036358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2297350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23261c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2327550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:21:03 INFO - Using env: {'DISPLAY': ':0', 05:21:03 INFO - 'HOME': '/home/cltbld', 05:21:03 INFO - 'LANG': 'en_US.UTF-8', 05:21:03 INFO - 'LANGUAGE': 'en_US:en', 05:21:03 INFO - 'LOGNAME': 'cltbld', 05:21:03 INFO - 'MAIL': '/var/mail/cltbld', 05:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:03 INFO - 'MOZ_NO_REMOTE': '1', 05:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:03 INFO - 'NO_EM_RESTART': '1', 05:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:03 INFO - 'PWD': '/builds/slave/test', 05:21:03 INFO - 'SHELL': '/bin/bash', 05:21:03 INFO - 'SHLVL': '1', 05:21:03 INFO - 'TERM': 'linux', 05:21:03 INFO - 'TMOUT': '86400', 05:21:03 INFO - 'USER': 'cltbld', 05:21:03 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 05:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:03 INFO - '_': '/tools/buildbot/bin/python'} 05:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:03 INFO - Downloading/unpacking jsonschema==2.5.1 05:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:21:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:05 INFO - Downloading functools32-3.2.3-2.tar.gz 05:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:21:05 INFO - warning: no files found matching '*.txt' 05:21:05 INFO - no previously-included directories found matching 'build' 05:21:05 INFO - no previously-included directories found matching 'dist' 05:21:05 INFO - no previously-included directories found matching '.git*' 05:21:05 INFO - Installing collected packages: jsonschema, functools32 05:21:06 INFO - Running setup.py install for functools32 05:21:06 INFO - warning: no files found matching '*.txt' 05:21:06 INFO - no previously-included directories found matching 'build' 05:21:06 INFO - no previously-included directories found matching 'dist' 05:21:06 INFO - no previously-included directories found matching '.git*' 05:21:06 INFO - Successfully installed jsonschema functools32 05:21:06 INFO - Cleaning up... 05:21:06 INFO - Return code: 0 05:21:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2036358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2297350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23261c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2327550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:21:06 INFO - Using env: {'DISPLAY': ':0', 05:21:06 INFO - 'HOME': '/home/cltbld', 05:21:06 INFO - 'LANG': 'en_US.UTF-8', 05:21:06 INFO - 'LANGUAGE': 'en_US:en', 05:21:06 INFO - 'LOGNAME': 'cltbld', 05:21:06 INFO - 'MAIL': '/var/mail/cltbld', 05:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:06 INFO - 'MOZ_NO_REMOTE': '1', 05:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:06 INFO - 'NO_EM_RESTART': '1', 05:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:06 INFO - 'PWD': '/builds/slave/test', 05:21:06 INFO - 'SHELL': '/bin/bash', 05:21:06 INFO - 'SHLVL': '1', 05:21:06 INFO - 'TERM': 'linux', 05:21:06 INFO - 'TMOUT': '86400', 05:21:06 INFO - 'USER': 'cltbld', 05:21:06 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 05:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:06 INFO - '_': '/tools/buildbot/bin/python'} 05:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:06 INFO - Downloading/unpacking blobuploader==1.2.4 05:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:08 INFO - Downloading blobuploader-1.2.4.tar.gz 05:21:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:21:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:21:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:08 INFO - Downloading docopt-0.6.1.tar.gz 05:21:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:21:09 INFO - Installing collected packages: blobuploader, requests, docopt 05:21:09 INFO - Running setup.py install for blobuploader 05:21:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:21:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:21:09 INFO - Running setup.py install for requests 05:21:09 INFO - Running setup.py install for docopt 05:21:09 INFO - Successfully installed blobuploader requests docopt 05:21:09 INFO - Cleaning up... 05:21:09 INFO - Return code: 0 05:21:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2036358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2297350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23261c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2327550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:09 INFO - Using env: {'DISPLAY': ':0', 05:21:09 INFO - 'HOME': '/home/cltbld', 05:21:09 INFO - 'LANG': 'en_US.UTF-8', 05:21:09 INFO - 'LANGUAGE': 'en_US:en', 05:21:09 INFO - 'LOGNAME': 'cltbld', 05:21:09 INFO - 'MAIL': '/var/mail/cltbld', 05:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:09 INFO - 'MOZ_NO_REMOTE': '1', 05:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:09 INFO - 'NO_EM_RESTART': '1', 05:21:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:09 INFO - 'PWD': '/builds/slave/test', 05:21:09 INFO - 'SHELL': '/bin/bash', 05:21:09 INFO - 'SHLVL': '1', 05:21:09 INFO - 'TERM': 'linux', 05:21:09 INFO - 'TMOUT': '86400', 05:21:09 INFO - 'USER': 'cltbld', 05:21:09 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 05:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:09 INFO - '_': '/tools/buildbot/bin/python'} 05:21:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:09 INFO - Running setup.py (path:/tmp/pip-7IKJcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:09 INFO - Running setup.py (path:/tmp/pip-YxEwh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:09 INFO - Running setup.py (path:/tmp/pip-WJMJ4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:10 INFO - Running setup.py (path:/tmp/pip-7nGBY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:10 INFO - Running setup.py (path:/tmp/pip-TWBroy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:10 INFO - Running setup.py (path:/tmp/pip-rP5WGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:10 INFO - Running setup.py (path:/tmp/pip-SCWkTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:10 INFO - Running setup.py (path:/tmp/pip-TKItmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:10 INFO - Running setup.py (path:/tmp/pip-KY5_Ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:10 INFO - Running setup.py (path:/tmp/pip-XAL1_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:10 INFO - Running setup.py (path:/tmp/pip-5cckKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:10 INFO - Running setup.py (path:/tmp/pip-9Tx6bU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:10 INFO - Running setup.py (path:/tmp/pip-AwuZcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:10 INFO - Running setup.py (path:/tmp/pip-W_78hJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:10 INFO - Running setup.py (path:/tmp/pip-9UPPH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:10 INFO - Running setup.py (path:/tmp/pip-1g3RGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:10 INFO - Running setup.py (path:/tmp/pip-zkOSL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:21:11 INFO - Running setup.py install for manifestparser 05:21:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:21:11 INFO - Running setup.py install for mozcrash 05:21:11 INFO - Running setup.py install for mozdebug 05:21:11 INFO - Running setup.py install for mozdevice 05:21:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:21:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:21:11 INFO - Running setup.py install for mozfile 05:21:11 INFO - Running setup.py install for mozhttpd 05:21:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:21:11 INFO - Running setup.py install for mozinfo 05:21:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:21:11 INFO - Running setup.py install for mozInstall 05:21:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:21:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:21:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:21:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:21:11 INFO - Running setup.py install for mozleak 05:21:11 INFO - Running setup.py install for mozlog 05:21:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:21:12 INFO - Running setup.py install for moznetwork 05:21:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:21:12 INFO - Running setup.py install for mozprocess 05:21:12 INFO - Running setup.py install for mozprofile 05:21:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:21:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:21:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:21:12 INFO - Running setup.py install for mozrunner 05:21:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:21:12 INFO - Running setup.py install for mozscreenshot 05:21:12 INFO - Running setup.py install for moztest 05:21:12 INFO - Running setup.py install for mozversion 05:21:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:21:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:21:12 INFO - Cleaning up... 05:21:12 INFO - Return code: 0 05:21:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2036358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2297350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23261c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2327550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:12 INFO - Using env: {'DISPLAY': ':0', 05:21:12 INFO - 'HOME': '/home/cltbld', 05:21:12 INFO - 'LANG': 'en_US.UTF-8', 05:21:12 INFO - 'LANGUAGE': 'en_US:en', 05:21:12 INFO - 'LOGNAME': 'cltbld', 05:21:12 INFO - 'MAIL': '/var/mail/cltbld', 05:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:12 INFO - 'MOZ_NO_REMOTE': '1', 05:21:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:12 INFO - 'NO_EM_RESTART': '1', 05:21:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:12 INFO - 'PWD': '/builds/slave/test', 05:21:12 INFO - 'SHELL': '/bin/bash', 05:21:12 INFO - 'SHLVL': '1', 05:21:12 INFO - 'TERM': 'linux', 05:21:12 INFO - 'TMOUT': '86400', 05:21:12 INFO - 'USER': 'cltbld', 05:21:12 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 05:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:12 INFO - '_': '/tools/buildbot/bin/python'} 05:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:13 INFO - Running setup.py (path:/tmp/pip-RgEVz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:13 INFO - Running setup.py (path:/tmp/pip-X6TyJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:13 INFO - Running setup.py (path:/tmp/pip-5FJD9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:13 INFO - Running setup.py (path:/tmp/pip-2o8btE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:13 INFO - Running setup.py (path:/tmp/pip-vS_4nI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:13 INFO - Running setup.py (path:/tmp/pip-0ia9aB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:13 INFO - Running setup.py (path:/tmp/pip-EQrxvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:13 INFO - Running setup.py (path:/tmp/pip-Xb6nTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:13 INFO - Running setup.py (path:/tmp/pip-6usTGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:13 INFO - Running setup.py (path:/tmp/pip-6PrSsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:13 INFO - Running setup.py (path:/tmp/pip-NLM6cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:13 INFO - Running setup.py (path:/tmp/pip-xso1ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:13 INFO - Running setup.py (path:/tmp/pip-v6aCHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:21:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:14 INFO - Running setup.py (path:/tmp/pip-rccb3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:14 INFO - Running setup.py (path:/tmp/pip-17arSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:14 INFO - Running setup.py (path:/tmp/pip-W8Hvbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:21:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:14 INFO - Running setup.py (path:/tmp/pip-02GMAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:16 INFO - Downloading blessings-1.6.tar.gz 05:21:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:21:16 INFO - Installing collected packages: blessings 05:21:16 INFO - Running setup.py install for blessings 05:21:16 INFO - Successfully installed blessings 05:21:16 INFO - Cleaning up... 05:21:16 INFO - Return code: 0 05:21:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:21:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:16 INFO - Reading from file tmpfile_stdout 05:21:16 INFO - Current package versions: 05:21:16 INFO - argparse == 1.2.1 05:21:16 INFO - blessings == 1.6 05:21:16 INFO - blobuploader == 1.2.4 05:21:16 INFO - docopt == 0.6.1 05:21:16 INFO - functools32 == 3.2.3-2 05:21:16 INFO - jsonschema == 2.5.1 05:21:16 INFO - manifestparser == 1.1 05:21:16 INFO - mozInstall == 1.12 05:21:16 INFO - mozcrash == 0.17 05:21:16 INFO - mozdebug == 0.1 05:21:16 INFO - mozdevice == 0.48 05:21:16 INFO - mozfile == 1.2 05:21:16 INFO - mozhttpd == 0.7 05:21:16 INFO - mozinfo == 0.9 05:21:16 INFO - mozleak == 0.1 05:21:16 INFO - mozlog == 3.2 05:21:16 INFO - moznetwork == 0.27 05:21:16 INFO - mozprocess == 0.22 05:21:16 INFO - mozprofile == 0.28 05:21:16 INFO - mozrunner == 6.11 05:21:16 INFO - mozscreenshot == 0.1 05:21:16 INFO - mozsystemmonitor == 0.3 05:21:16 INFO - moztest == 0.7 05:21:16 INFO - mozversion == 1.4 05:21:16 INFO - psutil == 3.1.1 05:21:16 INFO - requests == 1.2.3 05:21:16 INFO - wsgiref == 0.1.2 05:21:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2036358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2297350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23261c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2327550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:16 INFO - Using env: {'DISPLAY': ':0', 05:21:16 INFO - 'HOME': '/home/cltbld', 05:21:16 INFO - 'LANG': 'en_US.UTF-8', 05:21:16 INFO - 'LANGUAGE': 'en_US:en', 05:21:16 INFO - 'LOGNAME': 'cltbld', 05:21:16 INFO - 'MAIL': '/var/mail/cltbld', 05:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:16 INFO - 'MOZ_NO_REMOTE': '1', 05:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:16 INFO - 'NO_EM_RESTART': '1', 05:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:16 INFO - 'PWD': '/builds/slave/test', 05:21:16 INFO - 'SHELL': '/bin/bash', 05:21:16 INFO - 'SHLVL': '1', 05:21:16 INFO - 'TERM': 'linux', 05:21:16 INFO - 'TMOUT': '86400', 05:21:16 INFO - 'USER': 'cltbld', 05:21:16 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 05:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:16 INFO - '_': '/tools/buildbot/bin/python'} 05:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:21:16 INFO - Cleaning up... 05:21:16 INFO - Return code: 0 05:21:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2036358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2297350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23261c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2327550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:21:16 INFO - Using env: {'DISPLAY': ':0', 05:21:16 INFO - 'HOME': '/home/cltbld', 05:21:16 INFO - 'LANG': 'en_US.UTF-8', 05:21:16 INFO - 'LANGUAGE': 'en_US:en', 05:21:16 INFO - 'LOGNAME': 'cltbld', 05:21:16 INFO - 'MAIL': '/var/mail/cltbld', 05:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:16 INFO - 'MOZ_NO_REMOTE': '1', 05:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:16 INFO - 'NO_EM_RESTART': '1', 05:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:16 INFO - 'PWD': '/builds/slave/test', 05:21:16 INFO - 'SHELL': '/bin/bash', 05:21:16 INFO - 'SHLVL': '1', 05:21:16 INFO - 'TERM': 'linux', 05:21:16 INFO - 'TMOUT': '86400', 05:21:16 INFO - 'USER': 'cltbld', 05:21:16 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 05:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:16 INFO - '_': '/tools/buildbot/bin/python'} 05:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:21:17 INFO - Cleaning up... 05:21:17 INFO - Return code: 0 05:21:17 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2036358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21cc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2297350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23261c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2327550>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:21:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:21:17 INFO - Using env: {'DISPLAY': ':0', 05:21:17 INFO - 'HOME': '/home/cltbld', 05:21:17 INFO - 'LANG': 'en_US.UTF-8', 05:21:17 INFO - 'LANGUAGE': 'en_US:en', 05:21:17 INFO - 'LOGNAME': 'cltbld', 05:21:17 INFO - 'MAIL': '/var/mail/cltbld', 05:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:17 INFO - 'MOZ_NO_REMOTE': '1', 05:21:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:17 INFO - 'NO_EM_RESTART': '1', 05:21:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:17 INFO - 'PWD': '/builds/slave/test', 05:21:17 INFO - 'SHELL': '/bin/bash', 05:21:17 INFO - 'SHLVL': '1', 05:21:17 INFO - 'TERM': 'linux', 05:21:17 INFO - 'TMOUT': '86400', 05:21:17 INFO - 'USER': 'cltbld', 05:21:17 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 05:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:17 INFO - '_': '/tools/buildbot/bin/python'} 05:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:17 INFO - Downloading/unpacking flake8 05:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:21:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:21:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:21:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:21:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:21:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:21:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:21:19 INFO - no previously-included directories found matching 'docs/_build' 05:21:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:21:19 INFO - Running setup.py install for pep8 05:21:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:21:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:21:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:21:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:21:20 INFO - no previously-included directories found matching 'docs/_build' 05:21:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:21:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:21:20 INFO - Cleaning up... 05:21:20 INFO - Return code: 0 05:21:20 INFO - Running post-action listener: _resource_record_post_action 05:21:20 INFO - Running post-action listener: _start_resource_monitoring 05:21:20 INFO - Starting resource monitoring. 05:21:20 INFO - ##### 05:21:20 INFO - ##### Finished create-virtualenv step (success) 05:21:20 INFO - ##### 05:21:20 INFO - ##### 05:21:20 INFO - ##### Running install step. 05:21:20 INFO - ##### 05:21:20 INFO - Running pre-action listener: _resource_record_pre_action 05:21:20 INFO - Running main action method: install 05:21:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:20 INFO - Reading from file tmpfile_stdout 05:21:20 INFO - Detecting whether we're running mozinstall >=1.0... 05:21:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:21:20 INFO - Reading from file tmpfile_stdout 05:21:20 INFO - Output received: 05:21:20 INFO - Usage: mozinstall [options] installer 05:21:20 INFO - Options: 05:21:20 INFO - -h, --help show this help message and exit 05:21:20 INFO - -d DEST, --destination=DEST 05:21:20 INFO - Directory to install application into. [default: 05:21:20 INFO - "/builds/slave/test"] 05:21:20 INFO - --app=APP Application being installed. [default: firefox] 05:21:20 INFO - mkdir: /builds/slave/test/build/application 05:21:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:21:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:21:36 INFO - Reading from file tmpfile_stdout 05:21:36 INFO - Output received: 05:21:36 INFO - /builds/slave/test/build/application/firefox/firefox 05:21:36 INFO - Running post-action listener: _resource_record_post_action 05:21:36 INFO - ##### 05:21:36 INFO - ##### Finished install step (success) 05:21:36 INFO - ##### 05:21:36 INFO - ##### 05:21:36 INFO - ##### Running run-tests step. 05:21:36 INFO - ##### 05:21:36 INFO - Running pre-action listener: _resource_record_pre_action 05:21:36 INFO - Running main action method: run_tests 05:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:21:36 INFO - Python 2.7.3 05:21:36 INFO - Return code: 0 05:21:36 INFO - grabbing minidump binary from tooltool 05:21:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:36 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23261c0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23270c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2327550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:21:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:21:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:21:36 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:21:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:21:36 INFO - Return code: 0 05:21:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:21:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:21:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:21:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:21:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:21:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:21:37 INFO - Return code: 0 05:21:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:21:37 INFO - Using env: {'DISPLAY': ':0', 05:21:37 INFO - 'HOME': '/home/cltbld', 05:21:37 INFO - 'LANG': 'en_US.UTF-8', 05:21:37 INFO - 'LANGUAGE': 'en_US:en', 05:21:37 INFO - 'LOGNAME': 'cltbld', 05:21:37 INFO - 'MAIL': '/var/mail/cltbld', 05:21:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:21:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:37 INFO - 'MOZ_NO_REMOTE': '1', 05:21:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:37 INFO - 'NO_EM_RESTART': '1', 05:21:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:37 INFO - 'PWD': '/builds/slave/test', 05:21:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:21:37 INFO - 'SHELL': '/bin/bash', 05:21:37 INFO - 'SHLVL': '1', 05:21:37 INFO - 'TERM': 'linux', 05:21:37 INFO - 'TMOUT': '86400', 05:21:37 INFO - 'USER': 'cltbld', 05:21:37 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465558857.594069-128602410', 05:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:37 INFO - '_': '/tools/buildbot/bin/python'} 05:21:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:21:38 INFO - mozversion application_buildid: 20160610044828 05:21:38 INFO - mozversion application_changeset: 151500c01e44846223acb5bfcb4dcd2123e620c5 05:21:38 INFO - mozversion application_display_name: Nightly 05:21:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:21:38 INFO - mozversion application_name: Firefox 05:21:38 INFO - mozversion application_remotingname: firefox 05:21:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:21:38 INFO - mozversion application_vendor: Mozilla 05:21:38 INFO - mozversion application_version: 50.0a1 05:21:38 INFO - mozversion platform_buildid: 20160610044828 05:21:38 INFO - mozversion platform_changeset: 151500c01e44846223acb5bfcb4dcd2123e620c5 05:21:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:21:38 INFO - mozversion platform_version: 50.0a1 05:21:38 INFO - using testdate: 1465561298 05:21:38 INFO - actual date: 1465561298 05:21:38 INFO - starting webserver on 'localhost:53753' 05:21:38 INFO - SUITE-START | Running 2 tests 05:21:38 INFO - TEST-START | dromaeo_css 05:21:38 INFO - operating with platform_type : linux_ 05:21:38 INFO - Initialising browser for dromaeo_css test... 05:21:38 INFO - TEST-INFO | started process 11775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxFnMA9/profile http://localhost:53753/getInfo.html) 05:21:43 INFO - PROCESS | 11775 | __metrics Screen width/height:1600/1200 05:21:43 INFO - PROCESS | 11775 | colorDepth:24 05:21:43 INFO - PROCESS | 11775 | Browser inner width/height: 1024/697 05:21:43 INFO - PROCESS | 11775 | __metrics 05:21:44 ERROR - PROCESS | 11775 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:21:44 INFO - PROCESS | 11775 | console.error: PushService: 05:21:44 INFO - PROCESS | 11775 | stateChangeProcessEnqueue: Error transitioning state 05:21:44 INFO - PROCESS | 11775 | UnknownError 05:21:45 INFO - TEST-INFO | 11775: exit 0 05:21:45 INFO - Browser initialized. 05:21:45 INFO - Running cycle 1/1 for dromaeo_css test... 05:21:45 INFO - TEST-INFO | started process 11857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxFnMA9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:57 INFO - PROCESS | 11857 | RSS: Main: 174960640 05:21:57 INFO - PROCESS | 11857 | 05:22:49 INFO - PROCESS | 11857 | 1465561369590 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:25:01 INFO - PROCESS | 11857 | Cycle 1(1): loaded http://localhost:53753/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53753/tests/dromaeo/cssquery-ext.html) 05:25:02 INFO - PROCESS | 11857 | RSS: Main: 288747520 05:25:02 INFO - PROCESS | 11857 | 05:28:05 INFO - PROCESS | 11857 | Cycle 1(1): loaded http://localhost:53753/tests/dromaeo/cssquery-ext.html (next: http://localhost:53753/tests/dromaeo/cssquery-jquery.html) 05:28:05 INFO - PROCESS | 11857 | RSS: Main: 271233024 05:28:05 INFO - PROCESS | 11857 | 05:31:08 INFO - PROCESS | 11857 | Cycle 1(1): loaded http://localhost:53753/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53753/tests/dromaeo/cssquery-mootools.html) 05:31:08 INFO - PROCESS | 11857 | RSS: Main: 269742080 05:31:08 INFO - PROCESS | 11857 | 05:34:11 INFO - PROCESS | 11857 | Cycle 1(1): loaded http://localhost:53753/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53753/tests/dromaeo/cssquery-prototype.html) 05:34:11 INFO - PROCESS | 11857 | RSS: Main: 259637248 05:34:11 INFO - PROCESS | 11857 | 05:37:14 INFO - PROCESS | 11857 | Cycle 1(1): loaded http://localhost:53753/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53753/tests/dromaeo/cssquery-yui.html) 05:37:15 INFO - PROCESS | 11857 | RSS: Main: 249315328 05:37:15 INFO - PROCESS | 11857 | 05:40:18 INFO - PROCESS | 11857 | Cycle 1(1): loaded http://localhost:53753/tests/dromaeo/cssquery-yui.html (next: http://localhost:53753/tests/dromaeo/cssquery-dojo.html) 05:40:18 INFO - PROCESS | 11857 | RSS: Main: 293457920 05:40:18 INFO - PROCESS | 11857 | 05:40:18 INFO - PROCESS | 11857 | __start_tp_report 05:40:18 INFO - PROCESS | 11857 | _x_x_mozilla_page_load 05:40:18 INFO - PROCESS | 11857 | _x_x_mozilla_page_load_details 05:40:18 INFO - PROCESS | 11857 | |i|pagename|runs| 05:40:18 INFO - PROCESS | 11857 | |0;dojo.html;2618.2145356393085;2631.0659715800903;2660.574308110702;2676.986615066923;2685.5568831142864;4620.630349572035;4704.482506924235;4720.480747117818;4790.9760451197735;4857.0771553404875;4668.113058518879;4672.112298663252;4676.298555216711;4680.4149481314835;4695.953040469594;4200;4351.760653164067;4450.198964186461;4476.462824461069;4543.22765129927;4449.0434556570335;4472.619827314666;4499.392582001437;4511.413516242884;4528.9094218115615;4294.463192100971;4335.19798837213;4338.674599405057;4353.891152721176;4434.2905135178535;4373.25654638709;4378.759168245745;4379;4418.315161150027;4432.667549933768;4408.074304396081;4418.491873434564;4419.535948725402;4474.485434175079;4482.708623939466;4612.976935115336;4696.436427628672;4728.66899317048;4747.098051370229;4819.180739274332;5078.7460626968505;5115.5396014358885;5134.0758663440565;5136.948630513684;5138.537531622172;5094.923576146323;5127.717975511346;5144.279800827887;5159.355080614923;5159.871003224912;4548.204064288736;4720.12677654635;4733.5503127202865;4755.144074066701;4817.662763606584;5220.660657057279;5225.425203227718;5226.503482169188;5251.396089449686;5281.9471805281455;5021.4225364083595;5062.493750624908;5065.366829146356;5068.239764035424;5074.13739664258;4953.25701144824;4976.402831660224;5019.899602008012;5039.244113382949;5142.537171654494;5011.223260394645;5020.397552293675;5024.271480635361;5057.949420505748;5070.61970352225;4981.950180498221;4987.1771157759285;4987.5760560352055;5015.84952451427;5043.167877300204;4153.107081977329;4184.686148538872;4272.423222864935;4298.312270036779;4345.217860785026;3787.4697542344093;3792.7724336539895;3799.563050249257;3829.3681542545723;3863.150106976461;4363.345498175299;4369.08249267651;4372.80322385487;4417.094495628388;4418.6023257906945;4916.213405855117;4935.531124543163;5055.949440505621;5118.488151184852;5165.483451654804;4348.043430445297;4376.824927002885;4380.846670366522;4400.603945644907;4414.668899832525;4594.310853372021;4608.124456353282;4612;4616.422947131608;4656.3946686930485;4637.350770892011;4761.357216775829;4765.142274390643;4800.73595952226;4803.735794531264;5113.8721531962;5123;5138.563222126161;5139.049275883974;5172.379314482287;4812.446568644651;4815.15734746411;4816;4821.083994041121;4856.295837103671;4873.4639189689815;4990.750462476934;4998.225275082368;5041.697498150123;5109.463506331782;5118.462561431145;5131.666441681279;5136.30659860929;5138.332016837787;5142.692016421552;5010.8246211383885;5014.247862820606;5016.799328026984;5019.32239147725;5041.7227052511;4796;4926.285688575065;4937.358143441474;4964.35463389757;4984.501549844987;4880;4908.312836202863;4919.778609962489;4944.826931057396;4970.27930950003;4808.567228949411;5018.874528136826;5067.797288108434;5073.416557095981;5078.18749000173;4845.63657725665;4884.853454396374;4893.828715994923;4894.1679914415345;4952.455229924633 05:40:18 INFO - PROCESS | 11857 | |1;ext.html;562.6370990710991;573.166043406843;580.5123696095279;584.0742423259134;585.0697391148076;26982.86508567457;29246.707532924665;39854.80072599636;40734.79632601833;40951;41734;41964.37053444201;42087.57912420875;42185;42225.78887105568;7756.146823849358;7943.72196973106;7943.960280198591;7945.562994035326;7951.483153595027;7589.772306830776;9968.601255949754;10164.136048435892;10175.542100605453;10514.316569423001;10233.948830255838;10323.070923616873;10326.58693652253;10335;10339.22455815813;7650.885236721398;10010.59957601695;10110.898891011106;10161.085502304792;10186.694399168036;9855.507224638739;10184.338018028804;10193.235507336905;10195.08244258013;10205.183585313158;38731;38872.41691374632;39096;39119.80440097781;39166.60833391658;3029.303260250155;3136.52952057191;3379.020084175586;3486.6687664671817;3489.180042689966;29064.854675726696;29477.705222947712;29779.851100744574;30177.09468715942;30521.08436746901;3495.615482296945;3550.289942011608;3562.839672214757;3590.3357878792244;3653.8903832885057;250838;252128;252606;253114;253431;31854.840725796224;50794.984100317786;51120.488795111574;51220;51220.231696524585;31141.8442907784;32985;32989;33049.17377065593;33070.50394244088;12830.807537886752;12937.223766574036;12986.870131298756;13012.154209976321;13027.153235039692;10195.439250841275;10422.374657520573;10436.37381757097;11017.11863050954;11018.39398833072;7759;7768.0678318601;7832.530048197126;7880.605969701492;7904.604769761489;3075.324467713059;3111.191090316489;3115.01876908773;3115.081051089934;3123.6563977962405;852.9701460448855;967.670991862756;988.7577543501889;995.5520015992832;1006.3710181136789;27806.582901256497;28575.42849143047;28583.85708071488;28887.133385998455;28995.565066524017;938.1369140390857;940.2524992630875;951.7906060666643;971.6793458158791;1001.4041645221228;14681.77977330341;14911.776323355158;14924.850751492564;15251;15353.15557644318;376051;380545;380842;380900;381299;49749;50931.23603145956;51030.74484627553;51069.74465127725;51103.48896511061;1054.46222426563;1171.9941400292944;1193.3794426897964;1204;1206.6500714792612;27882.721172788824;28597.714022859505;28687.282817929718;29026.709732903244;29219.85390073036;41114.383284250165;41252.58747412488;41742.79128604338;41748.165036699706;41801.58198417977;232954;233040;233628;234339;234346;22260.88869555642;22806.771932280466;23845.761542384353;24451.877740611184;24511.754882450947;41633.79183104065;41756.373654395815;41959.790201048796;42562;42862;35525.64474355327;35628;35672.108197294234;36187.09532261715;36406;35862.103447414025;36019.45970810492;36079.27841443104;36266.27467450689;36271.455928161624;35132;35162.47256291106;35922.8203858979;35940;35954;31780.841095794374;32829.671703282664;32983.50524742179;33060.33879322352;33093.66906330906;24337.51324973455;24983.375415614755;25375;25807.612885806353;25975.610365844906 05:40:18 INFO - PROCESS | 11857 | |2;jquery.html;356.34788337342667;358.4587273217441;359.611619450993;374.8350725680702;376.4785771706186;16583.41958031469;16633;17445.56386090345;17446.82553174468;17462.738058929128;16058.75911861323;16630.66738665226;16721.247543860525;16913.15434228287;16915.57711057224;4958.553730164275;5129.333186685725;5180.585553155757;5191.377034755835;5192.506711862386;3088.7837851350414;3230.273188532573;3235.6279027911737;3265.7060864522186;5056.443791182967;3353.9496907546404;5912.733926973297;5928.1404196391495;6006.48944839687;6019.7893073742425;5835.854103647401;5919.733611987471;5972.044472884318;5991.071383935475;6014.188084608588;2823.153054083787;5171.172612382038;5179.171332586768;5186.636935414523;5203.297554830087;15006.576587348964;19113.426597202106;19538;20325.18699252028;20621.587568248702;1902.4958386027713;1975.8122978317037;2004.849636277285;2018.4348382452936;2095.905684244213;12313;12805.679858003532;13302.201867887958;13553.59339219825;13603.727925441535;1554.6113471632093;1710.5523658681498;1802.594416256332;1807.7740282464692;1820.2445984916244;65096.34903650998;67652.66173669149;67929.32070679279;68189.3181068188;69003.65498172477;8294;8355.832883342298;8956.955215223883;9069.637214511478;9185.402948808307;11914.821277680841;11917.761644767055;11988.700282492833;12017.699557510958;12232.510699572096;7265.273472652692;7278.7034561960545;7371.6682749276415;7416.443766717518;7468.900306893409;7246.6641552827905;7438.330550250504;7482.625868706543;7558.319751222416;7606;5922.466977971917;5960.642361458326;5960.970195149083;5989.64062156272;6047.455728984412;1546.4510098914948;1553.3010145434373;1656.5829736760725;1674.372110458578;1735.8128757765307;811.7077851973285;862.4738909265343;921.2675922641382;933.9112784285481;945.5366870233673;16222.756658650129;16827.495175144766;16968.830311696725;17030.48908532746;17231.827681723273;867.0938868882033;867.8394497018072;871.111466304366;873.4409977614332;887.3965703321803;7970.681172753141;9713.70858874235;9750.90249097514;9817.081325256482;9945.701628951143;383185;384478;392611;393718;394318;66466.33533664698;70823.64588177027;72331;73135.2686473139;77920.61039694765;953.0993211415146;955.8183945050419;956.6125719083782;995.0348162282575;998.8901220865699;15680.788236411021;15734;16083.276252568896;16166.191690415668;16371.672566548841;37379;37848.62151378451;37924.24151517009;38260.234795304495;38740;52261.216081758044;53668.73165634147;53879;54160.45839541712;54331.18503222534;7637.198094200029;7675.53946763196;7716.7684969451;7748.418868584991;7913.129555748978;10856.674299771019;11302.83045754298;11992.220505667105;12009.579664711693;12038.157328986887;10037.347572408062;10062.144717699077;10123.64567240143;10173.067117247996;10240.385576865412;9929.3545919515;10166.898331016891;10285.125764310118;10508.159347252355;10615.363078215332;10079.395236285847;10112.949435252776;10219.948900255451;10360.481975901326;10626.946865265625;7715.614219288901;7735.303822655988;7816.257455541714;7852.725154619561;7937.722179723682;9695.466749328854;10171.84742228882;10221.74445638865;10223.642172523925;10367.896321036995 05:40:18 INFO - PROCESS | 11857 | |3;mootools.html;1204.0427859851418;1373.835139783226;1417.6385021819435;1483.1768368555454;1721.561001944504;6360.586561873481;7486.700531978721;7735.651895664688;7762.223777622235;7893.092294386147;7635.083789945214;7794.883076753853;7799.727009554666;7838.529688218711;7852.685892564305;1803.1705415508882;2086.8330533557355;2184.7050648162535;2199.29622520793;2241.9327420177337;2201.922932697356;2232.3303009097285;2233.3076746208644;2235.1394713035515;2240.283109404983;2176.804087632113;2199.164317559333;2203.6694495825595;2215.789499997498;2217.4899773052207;1813.8820976636475;1887.4337698690338;1894.7442095317094;2078.0648708081426;2139.0801955159277;2135.6582946728604;2179.4769255378596;2186.464316242515;2190.583789080086;2191.769864164272;7758.301752842215;7827.921720782833;7852.17552157021;7882.5270483771155;7887.487313324673;4547.226971414867;4689.859304220845;4690.366800481926;4694.5540173683785;4694.647901407408;2697.3526353675175;2824.5198316286283;2831.263871393432;2841.559558268472;2879.1074766822353;862.6635612111281;876.8158686675806;905.1943770044666;917.6650522559285;920.802027564077;10456.058954694037;10496.160307175483;10501.579936802518;10535.631252906189;10553.683389498327;4125.752454852718;4214.599613036757;4256.808443620044;4292.334688123346;4313.0726893718;9060.728178154666;9067.818643627223;9077.68228112013;9102.453852768855;9109.544522773967;4650.093231819763;4651.627869770478;4652.116097941381;4652.3951886255245;4655.162070827216;3604.6395360463744;4176.686748493875;4315.266404711207;4328.805203765775;4381.233284175257;3620.4931309616672;3625.3655610268097;3671.4125739881492;3728.0493474163914;3761.1725420407465;1156.8438260834848;1166.4284500594647;1167.7606090751376;1170.8185231289165;1173.3546549397797;726.4841962206892;817.7424111404888;820.8112134209165;830.5805568188026;850.2050582705191;5021.4225364083595;5150.948490515122;5181.6890986540175;5197.324347834758;5222.9216561750845;401.1795877430661;411.84555791578157;415.2131710408819;415.2587631078571;424.55421807103033;3420.486926960926;3433.776804507749;3475.565554305712;3477;3528.576570811519;9129.589168487433;9498.667546635834;9565.282603804742;9594.616215351307;9595.47224902637;9456.952715236379;9458.33791634579;9529.047095290416;9571.090746379083;9604.135627793532;7184.209736928934;7282.5630462171375;7289.781306560812;7309.671064802096;7321.304476074764;4972.8508144755715;5031.471695471922;5043.5460808527405;5114.232865070269;5138.486151384981;8838.204561589488;8863.157999989991;8883.955580222058;8950.552472376225;9010.909890901006;8867.512286824287;8878.86681699788;8943.508107054175;8991.41555798871;9044.231240344645;5752.9137062943255;5757.942420575908;6242.625442473466;6331.556791024584;6331.9366806331345;7377.483576149618;7383.852322953619;7385.778426647209;7385.9630701846145;7393.186749457663;6439.774607888701;6593.604383736799;6656.633885136364;6716.126903502513;6790.558613690095;6237.594556353823;6444.194475690539;6535.673216339259;6612.272650008592;6753.898691519729;5877.265341832271;5937.940620593911;5946.583739138218;5983.222181116427;6029.547783916136;4341.739495630272;4350.73895566267;4366.607005369532;4456.732596044248;4510.481294651157;4369.694121411598;4400.823967041282;4489.281714925596;4502.617277531446;4503.279475283939 05:40:18 INFO - PROCESS | 11857 | |4;prototype.html;288.7199416565931;295.3369685057047;299.835090700115;302.96364436267635;304.33958310466284;4865.172920603497;4917.868890155262;4926.137925862969;4927.408710954691;4935.629827762914;4837.5646191842725;4852.781624826883;4878.536539028786;4879.487653796354;4898.559129678329;3611.7110631149444;3729.608391118934;3738.476613274144;3836.290286297044;3872.961270387302;3817.2747178036084;3825.9808700956455;3856.9586211722817;3857.517810273716;3859.729818912663;3609.2420591675777;3750.924981500368;3770.151715863922;3800.5629352624387;3803.9809800951093;3654.30568192044;3763.7741735495956;3778.149916268845;3800.9429858551866;3803.5435747710453;3327.068420842168;3337.349216902705;3337.4660054391425;3344.6320904700706;3364.3775901458307;4762.595179409755;4772.856814295576;4774.761261936889;4776;4785.401824771903;4205.3481710334945;4289.849855255051;4299.398084268205;4315.223259813232;4340.74118505633;5079.517445842639;5115.20714289282;5126.410462796789;5126.820561280338;5134.7689353978785;3661.864821905218;3662.633736626316;3667.4132138857653;3681.7238707097076;3689.612590677994;5180.4042535108565;5321.654092484015;5351.973240133813;5399.1091469907415;5401.135818269058;3710.2023065041144;3723.5159429274563;3735.2716220337315;3738.813059347022;3747.606501317377;3801.790901500444;3811.6188381162215;3812.5615554211067;3817.599152089046;3817.751846129993;4290.485141783006;4320.805563749576;4322.135572885372;4325.243082460557;4342;4930.235813448921;5016.423111342169;5071.061853557104;5107.412647545506;5130;1283.0313113599173;1311.9934400327936;1324.38416136497;1324.8741369569875;1330.2284674888542;813.247745835112;851.5784686580182;878.4421892098563;916.8028873792167;921.433318509112;4519.84180553679;4526.117407105583;4544.909101818012;4565.589096981221;4565.908681826345;5241.9213711794355;5261.658277139305;5277.23480095384;5333.653312534673;5357.678539287655;4337.501187363494;4447.911041779146;4476.507584165739;4486.7083639563325;4620.722756634613;2818.5490321548864;2830.4905117079124;2836.5603331483653;2844.264998351004;2846.7722582193373;4984;4988.800447982113;4989.3264409305;5017.197248440232;5037.496250374933;5158.226266060121;5424.783008679608;5441.646292990943;5461.481159289861;5480.479354461399;4987.750612469362;5005.199168133081;5024.497550244946;5026.79892804291;5037.79848806051;5287.603429742861;5295.417504074626;5299;5303.522682958398;5308.283381743569;4984.775685094107;5253.395859476209;5298.8077682521125;5301.204819277139;5309.177077552986;5055.924161137512;5061.266116413173;5062.848114556569;5067.569256613082;5077.644564880423;3690.6678398944223;3702.4816525685887;3727.7763334200035;3729.869454569077;3739.3546839390583;5168.3797944246935;5355.250264962986;5360.195970604441;5374.623776335619;5376.623636345418;5134.5378915897745;5159.380874295109;5163.870903227299;5165.225216217597;5170.3278573785165;5176.844694659167;5178.6374953752875;5200.375954885438;5203.609729270395;5211.322528071327;4843.95156048435;4870.928395753071;5021.317858517292;5069.264956581349;5113.64204505681;5003.324551185543;5006.6495345325475;5032.974835125801;5067.746612669425;5086.618503612318;4923.507649235048;5063.164577844762;5083.517065878736;5110.029094472038;5120.3343565337755 05:40:18 INFO - PROCESS | 11857 | |5;yui.html;556.2740623486349;558.2352177516802;576.6626523483761;588.920495733076;619.7242227208891;10828.837567436485;11309.943450282737;11491.942540287308;11500.597479088223;11530.423478826056;11335.489902954367;11601.3039217647;11604.187706860503;11608.709782255448;11609.245399049056;615.4614712126889;749.2507492507492;762.0588573112188;778.7040924448702;779.2091027606983;769.3383690026573;779.9415043871704;781.1017330070435;781.1095351299523;781.9491733037335;817.23588444804;822.8189798244376;823.5223570329194;824.2293455618985;824.2952275804191;634.571664126715;790.5730905311125;815.1848151848152;816.5957850863831;817.2236375443323;596.2100217212211;596.8567543789503;597.2743117112685;597.5488506177851;598.1775059293471;10733.892661073445;10744.247902646817;10746.731331716692;10790.082842958358;10834.72913177169;12112;12294.75410491785;12769.233845969271;13261.734765304736;13296.401661925236;10012;10124.89875101247;10382.279741164759;10392.844107338396;10531.947340263327;3982.681385489154;4018.738781979191;4122.670186385082;4128.298189307825;4138.317177665682;57002.42997570013;57739.42260577383;57855;59176.40823591752;59887.1016934742;9050.773730656654;9117.77205569866;9398.48308343034;9414.858777118348;9434.19809316202;18918.243270269035;18955.24179032851;18957.620847583246;19008.144633491527;19015.144318505423;6208;6361;6417.486601071903;6418.101465794793;6431.614103153825;3380.560527131506;3416.8462419191196;3500.334936362083;3503.211777350076;3511.5259439975275;2684.637573927495;2768.709285525031;2770.9168724938286;2774.0845520978028;2776.5418705913703;458.0929759077046;458.12726755530105;460.2268189441703;468.39810843066493;470.7763812189251;425.9020425302136;466.07251569376695;479.1761741304341;510.3722421421598;521.6661336744487;5794.275715535558;5800.303963524404;5822.883542329129;5869.911951320733;5961.7615295387695;470.5153691697557;477.6680207255993;477.99522004779504;478.7920929770551;507.9212722028092;3185.2833112549492;3283.277678910636;3288.1615188126875;3374.4263475209273;3405.6083550392023;85128.57435712781;85753;88132;90750;92511.53744231371;49578.75210623996;51926;76454.23545764583;77852.2214777845;81750.59124704338;67855.98216026764;67919.66040169768;68269.31730682729;68965;69021.3097869025;6227.875442491216;6263.217097862767;6290.433860952537;6307.211598550181;6416.807495775134;41801.581984180986;42103.421209197564;42709;43766.78116609396;44811;52753.20870187027;57148.14277785753;57783;58204;59721.402785971586;10428.895711043097;10451;10507.579696812041;10641.787164256826;10871.096149716048;11858.644240672793;11945.761084778429;12004.699882503008;12224.511019559119;12554.121211515472;10642.361458312525;10879.075278601407;11107.666769996913;11242.494087766234;11329.206955513035;11167.162462815484;11216.327020378803;11560.884391155982;11651.41742912868;11719.589814356457;10170.949145254523;10205.38767673942;10211.642592509226;10272.897271027194;10396.688099357032;9052.90947090547;9060.728178154666;9202.815943680955;9334.953325233331;9396.154346108882;8989.101089890959;9117.863232051657;9215.170634642915;9295.814083718153;9421.434713917188 05:40:18 INFO - PROCESS | 11857 | __end_tp_report 05:40:18 INFO - PROCESS | 11857 | __start_cc_report 05:40:18 INFO - PROCESS | 11857 | _x_x_mozilla_cycle_collect,1039 05:40:18 INFO - PROCESS | 11857 | __end_cc_report 05:40:18 INFO - PROCESS | 11857 | __startTimestamp1465562418474__endTimestamp 05:40:18 INFO - PROCESS | 11857 | 05:40:18 INFO - PROCESS | 11857 | ------- Summary: start ------- 05:40:18 INFO - PROCESS | 11857 | Number of tests: 6 05:40:18 INFO - PROCESS | 11857 | 05:40:18 INFO - PROCESS | 11857 | [#0] dojo.html Cycles:165 Average:4707.02 Median:4817.66 stddev:491.32 (10.2%) stddev-sans-first:464.70 05:40:18 INFO - PROCESS | 11857 | Values: 2618.2 2631.1 2660.6 2677.0 2685.6 4620.6 4704.5 4720.5 4791.0 4857.1 4668.1 4672.1 4676.3 4680.4 4696.0 4200.0 4351.8 4450.2 4476.5 4543.2 4449.0 4472.6 4499.4 4511.4 4528.9 4294.5 4335.2 4338.7 4353.9 4434.3 4373.3 4378.8 4379.0 4418.3 4432.7 4408.1 4418.5 4419.5 4474.5 4482.7 4613.0 4696.4 4728.7 4747.1 4819.2 5078.7 5115.5 5134.1 5136.9 5138.5 5094.9 5127.7 5144.3 5159.4 5159.9 4548.2 4720.1 4733.6 4755.1 4817.7 5220.7 5225.4 5226.5 5251.4 5281.9 5021.4 5062.5 5065.4 5068.2 5074.1 4953.3 4976.4 5019.9 5039.2 5142.5 5011.2 5020.4 5024.3 5057.9 5070.6 4982.0 4987.2 4987.6 5015.8 5043.2 4153.1 4184.7 4272.4 4298.3 4345.2 3787.5 3792.8 3799.6 3829.4 3863.2 4363.3 4369.1 4372.8 4417.1 4418.6 4916.2 4935.5 5055.9 5118.5 5165.5 4348.0 4376.8 4380.8 4400.6 4414.7 4594.3 4608.1 4612.0 4616.4 4656.4 4637.4 4761.4 4765.1 4800.7 4803.7 5113.9 5123.0 5138.6 5139.0 5172.4 4812.4 4815.2 4816.0 4821.1 4856.3 4873.5 4990.8 4998.2 5041.7 5109.5 5118.5 5131.7 5136.3 5138.3 5142.7 5010.8 5014.2 5016.8 5019.3 5041.7 4796.0 4926.3 4937.4 4964.4 4984.5 4880.0 4908.3 4919.8 4944.8 4970.3 4808.6 5018.9 5067.8 5073.4 5078.2 4845.6 4884.9 4893.8 4894.2 4952.5 05:40:18 INFO - PROCESS | 11857 | 05:40:18 INFO - PROCESS | 11857 | [#1] ext.html Cycles:180 Average:43915.86 Median:33065.42 stddev:77852.75 (235.5%) stddev-sans-first:78003.10 05:40:18 INFO - PROCESS | 11857 | Values: 562.6 573.2 580.5 584.1 585.1 26982.9 29246.7 39854.8 40734.8 40951.0 41734.0 41964.4 42087.6 42185.0 42225.8 7756.1 7943.7 7944.0 7945.6 7951.5 7589.8 9968.6 10164.1 10175.5 10514.3 10233.9 10323.1 10326.6 10335.0 10339.2 7650.9 10010.6 10110.9 10161.1 10186.7 9855.5 10184.3 10193.2 10195.1 10205.2 38731.0 38872.4 39096.0 39119.8 39166.6 3029.3 3136.5 3379.0 3486.7 3489.2 29064.9 29477.7 29779.9 30177.1 30521.1 3495.6 3550.3 3562.8 3590.3 3653.9 250838.0 252128.0 252606.0 253114.0 253431.0 31854.8 50795.0 51120.5 51220.0 51220.2 31141.8 32985.0 32989.0 33049.2 33070.5 12830.8 12937.2 12986.9 13012.2 13027.2 10195.4 10422.4 10436.4 11017.1 11018.4 7759.0 7768.1 7832.5 7880.6 7904.6 3075.3 3111.2 3115.0 3115.1 3123.7 853.0 967.7 988.8 995.6 1006.4 27806.6 28575.4 28583.9 28887.1 28995.6 938.1 940.3 951.8 971.7 1001.4 14681.8 14911.8 14924.9 15251.0 15353.2 376051.0 380545.0 380842.0 380900.0 381299.0 49749.0 50931.2 51030.7 51069.7 51103.5 1054.5 1172.0 1193.4 1204.0 1206.7 27882.7 28597.7 28687.3 29026.7 29219.9 41114.4 41252.6 41742.8 41748.2 41801.6 232954.0 233040.0 233628.0 234339.0 234346.0 22260.9 22806.8 23845.8 24451.9 24511.8 41633.8 41756.4 41959.8 42562.0 42862.0 35525.6 35628.0 35672.1 36187.1 36406.0 35862.1 36019.5 36079.3 36266.3 36271.5 35132.0 35162.5 35922.8 35940.0 35954.0 31780.8 32829.7 32983.5 33060.3 33093.7 24337.5 24983.4 25375.0 25807.6 25975.6 05:40:18 INFO - PROCESS | 11857 | 05:40:18 INFO - PROCESS | 11857 | [#2] jquery.html Cycles:180 Average:24224.28 Median:215675.50 stddev:64245.30 (29.8%) stddev-sans-first:64400.53 05:40:18 INFO - PROCESS | 11857 | Values: 356.3 358.5 359.6 374.8 376.5 16583.4 16633.0 17445.6 17446.8 17462.7 16058.8 16630.7 16721.2 16913.2 16915.6 4958.6 5129.3 5180.6 5191.4 5192.5 3088.8 3230.3 3235.6 3265.7 5056.4 3353.9 5912.7 5928.1 6006.5 6019.8 5835.9 5919.7 5972.0 5991.1 6014.2 2823.2 5171.2 5179.2 5186.6 5203.3 15006.6 19113.4 19538.0 20325.2 20621.6 1902.5 1975.8 2004.8 2018.4 2095.9 12313.0 12805.7 13302.2 13553.6 13603.7 1554.6 1710.6 1802.6 1807.8 1820.2 65096.3 67652.7 67929.3 68189.3 69003.7 8294.0 8355.8 8957.0 9069.6 9185.4 11914.8 11917.8 11988.7 12017.7 12232.5 7265.3 7278.7 7371.7 7416.4 7468.9 7246.7 7438.3 7482.6 7558.3 7606.0 5922.5 5960.6 5961.0 5989.6 6047.5 1546.5 1553.3 1656.6 1674.4 1735.8 811.7 862.5 921.3 933.9 945.5 16222.8 16827.5 16968.8 17030.5 17231.8 867.1 867.8 871.1 873.4 887.4 7970.7 9713.7 9750.9 9817.1 9945.7 383185.0 384478.0 392611.0 393718.0 394318.0 66466.3 70823.6 72331.0 73135.3 77920.6 953.1 955.8 956.6 995.0 998.9 15680.8 15734.0 16083.3 16166.2 16371.7 37379.0 37848.6 37924.2 38260.2 38740.0 52261.2 53668.7 53879.0 54160.5 54331.2 7637.2 7675.5 7716.8 7748.4 7913.1 10856.7 11302.8 11992.2 12009.6 12038.2 10037.3 10062.1 10123.6 10173.1 10240.4 9929.4 10166.9 10285.1 10508.2 10615.4 10079.4 10112.9 10219.9 10360.5 10626.9 7715.6 7735.3 7816.3 7852.7 7937.7 9695.5 10171.8 10221.7 10223.6 10367.9 05:40:18 INFO - PROCESS | 11857 | 05:40:18 INFO - PROCESS | 11857 | [#3] mootools.html Cycles:180 Average:5042.56 Median:4997.14 stddev:2864.27 (57.3%) stddev-sans-first:2857.78 05:40:18 INFO - PROCESS | 11857 | Values: 1204.0 1373.8 1417.6 1483.2 1721.6 6360.6 7486.7 7735.7 7762.2 7893.1 7635.1 7794.9 7799.7 7838.5 7852.7 1803.2 2086.8 2184.7 2199.3 2241.9 2201.9 2232.3 2233.3 2235.1 2240.3 2176.8 2199.2 2203.7 2215.8 2217.5 1813.9 1887.4 1894.7 2078.1 2139.1 2135.7 2179.5 2186.5 2190.6 2191.8 7758.3 7827.9 7852.2 7882.5 7887.5 4547.2 4689.9 4690.4 4694.6 4694.6 2697.4 2824.5 2831.3 2841.6 2879.1 862.7 876.8 905.2 917.7 920.8 10456.1 10496.2 10501.6 10535.6 10553.7 4125.8 4214.6 4256.8 4292.3 4313.1 9060.7 9067.8 9077.7 9102.5 9109.5 4650.1 4651.6 4652.1 4652.4 4655.2 3604.6 4176.7 4315.3 4328.8 4381.2 3620.5 3625.4 3671.4 3728.0 3761.2 1156.8 1166.4 1167.8 1170.8 1173.4 726.5 817.7 820.8 830.6 850.2 5021.4 5150.9 5181.7 5197.3 5222.9 401.2 411.8 415.2 415.3 424.6 3420.5 3433.8 3475.6 3477.0 3528.6 9129.6 9498.7 9565.3 9594.6 9595.5 9457.0 9458.3 9529.0 9571.1 9604.1 7184.2 7282.6 7289.8 7309.7 7321.3 4972.9 5031.5 5043.5 5114.2 5138.5 8838.2 8863.2 8884.0 8950.6 9010.9 8867.5 8878.9 8943.5 8991.4 9044.2 5752.9 5757.9 6242.6 6331.6 6331.9 7377.5 7383.9 7385.8 7386.0 7393.2 6439.8 6593.6 6656.6 6716.1 6790.6 6237.6 6444.2 6535.7 6612.3 6753.9 5877.3 5937.9 5946.6 5983.2 6029.5 4341.7 4350.7 4366.6 4456.7 4510.5 4369.7 4400.8 4489.3 4502.6 4503.3 05:40:18 INFO - PROCESS | 11857 | 05:40:18 INFO - PROCESS | 11857 | [#4] prototype.html Cycles:180 Average:4262.74 Median:4879.01 stddev:1242.71 (25.5%) stddev-sans-first:1209.87 05:40:18 INFO - PROCESS | 11857 | Values: 288.7 295.3 299.8 303.0 304.3 4865.2 4917.9 4926.1 4927.4 4935.6 4837.6 4852.8 4878.5 4879.5 4898.6 3611.7 3729.6 3738.5 3836.3 3873.0 3817.3 3826.0 3857.0 3857.5 3859.7 3609.2 3750.9 3770.2 3800.6 3804.0 3654.3 3763.8 3778.1 3800.9 3803.5 3327.1 3337.3 3337.5 3344.6 3364.4 4762.6 4772.9 4774.8 4776.0 4785.4 4205.3 4289.8 4299.4 4315.2 4340.7 5079.5 5115.2 5126.4 5126.8 5134.8 3661.9 3662.6 3667.4 3681.7 3689.6 5180.4 5321.7 5352.0 5399.1 5401.1 3710.2 3723.5 3735.3 3738.8 3747.6 3801.8 3811.6 3812.6 3817.6 3817.8 4290.5 4320.8 4322.1 4325.2 4342.0 4930.2 5016.4 5071.1 5107.4 5130.0 1283.0 1312.0 1324.4 1324.9 1330.2 813.2 851.6 878.4 916.8 921.4 4519.8 4526.1 4544.9 4565.6 4565.9 5241.9 5261.7 5277.2 5333.7 5357.7 4337.5 4447.9 4476.5 4486.7 4620.7 2818.5 2830.5 2836.6 2844.3 2846.8 4984.0 4988.8 4989.3 5017.2 5037.5 5158.2 5424.8 5441.6 5461.5 5480.5 4987.8 5005.2 5024.5 5026.8 5037.8 5287.6 5295.4 5299.0 5303.5 5308.3 4984.8 5253.4 5298.8 5301.2 5309.2 5055.9 5061.3 5062.8 5067.6 5077.6 3690.7 3702.5 3727.8 3729.9 3739.4 5168.4 5355.3 5360.2 5374.6 5376.6 5134.5 5159.4 5163.9 5165.2 5170.3 5176.8 5178.6 5200.4 5203.6 5211.3 4844.0 4870.9 5021.3 5069.3 5113.6 5003.3 5006.6 5033.0 5067.7 5086.6 4923.5 5063.2 5083.5 5110.0 5120.3 05:40:18 INFO - PROCESS | 11857 | 05:40:18 INFO - PROCESS | 11857 | [#5] yui.html Cycles:180 Average:16097.70 Median:478.98 stddev:22733.97 (4746.3%) stddev-sans-first:22767.79 05:40:18 INFO - PROCESS | 11857 | Values: 556.3 558.2 576.7 588.9 619.7 10828.8 11309.9 11491.9 11500.6 11530.4 11335.5 11601.3 11604.2 11608.7 11609.2 615.5 749.3 762.1 778.7 779.2 769.3 779.9 781.1 781.1 781.9 817.2 822.8 823.5 824.2 824.3 634.6 790.6 815.2 816.6 817.2 596.2 596.9 597.3 597.5 598.2 10733.9 10744.2 10746.7 10790.1 10834.7 12112.0 12294.8 12769.2 13261.7 13296.4 10012.0 10124.9 10382.3 10392.8 10531.9 3982.7 4018.7 4122.7 4128.3 4138.3 57002.4 57739.4 57855.0 59176.4 59887.1 9050.8 9117.8 9398.5 9414.9 9434.2 18918.2 18955.2 18957.6 19008.1 19015.1 6208.0 6361.0 6417.5 6418.1 6431.6 3380.6 3416.8 3500.3 3503.2 3511.5 2684.6 2768.7 2770.9 2774.1 2776.5 458.1 458.1 460.2 468.4 470.8 425.9 466.1 479.2 510.4 521.7 5794.3 5800.3 5822.9 5869.9 5961.8 470.5 477.7 478.0 478.8 507.9 3185.3 3283.3 3288.2 3374.4 3405.6 85128.6 85753.0 88132.0 90750.0 92511.5 49578.8 51926.0 76454.2 77852.2 81750.6 67856.0 67919.7 68269.3 68965.0 69021.3 6227.9 6263.2 6290.4 6307.2 6416.8 41801.6 42103.4 42709.0 43766.8 44811.0 52753.2 57148.1 57783.0 58204.0 59721.4 10428.9 10451.0 10507.6 10641.8 10871.1 11858.6 11945.8 12004.7 12224.5 12554.1 10642.4 10879.1 11107.7 11242.5 11329.2 11167.2 11216.3 11560.9 11651.4 11719.6 10170.9 10205.4 10211.6 10272.9 10396.7 9052.9 9060.7 9202.8 9335.0 9396.2 8989.1 9117.9 9215.2 9295.8 9421.4 05:40:18 INFO - PROCESS | 11857 | -------- Summary: end -------- 05:40:18 INFO - PROCESS | 11857 | 05:40:19 INFO - TEST-INFO | 11857: exit 0 05:40:19 INFO - TEST-OK | dromaeo_css | took 1121227ms 05:40:19 INFO - TEST-START | kraken 05:40:19 INFO - operating with platform_type : linux_ 05:40:19 INFO - Initialising browser for kraken test... 05:40:19 INFO - TEST-INFO | started process 12037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzPH3u7/profile http://localhost:53753/getInfo.html) 05:40:24 INFO - PROCESS | 12037 | __metrics Screen width/height:1600/1200 05:40:24 INFO - PROCESS | 12037 | colorDepth:24 05:40:24 INFO - PROCESS | 12037 | Browser inner width/height: 1024/697 05:40:24 INFO - PROCESS | 12037 | __metrics 05:40:25 ERROR - PROCESS | 12037 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:40:25 INFO - PROCESS | 12037 | console.error: PushService: 05:40:25 INFO - PROCESS | 12037 | stateChangeProcessEnqueue: Error transitioning state 05:40:25 INFO - PROCESS | 12037 | UnknownError 05:40:26 INFO - TEST-INFO | 12037: exit 0 05:40:26 INFO - Browser initialized. 05:40:26 INFO - Running cycle 1/1 for kraken test... 05:40:26 INFO - TEST-INFO | started process 12116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzPH3u7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:38 INFO - PROCESS | 12116 | RSS: Main: 175206400 05:40:38 INFO - PROCESS | 12116 | 05:40:41 INFO - PROCESS | 12116 | Cycle 1(1): loaded http://localhost:53753/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53753/tests/kraken/driver.html?testName=audio-beat-detection) 05:40:42 INFO - PROCESS | 12116 | RSS: Main: 231964672 05:40:42 INFO - PROCESS | 12116 | 05:40:45 INFO - PROCESS | 12116 | Cycle 1(1): loaded http://localhost:53753/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53753/tests/kraken/driver.html?testName=audio-dft) 05:40:45 INFO - PROCESS | 12116 | RSS: Main: 220495872 05:40:45 INFO - PROCESS | 12116 | 05:40:48 INFO - PROCESS | 12116 | Cycle 1(1): loaded http://localhost:53753/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53753/tests/kraken/driver.html?testName=audio-fft) 05:40:49 INFO - PROCESS | 12116 | RSS: Main: 287444992 05:40:49 INFO - PROCESS | 12116 | 05:40:51 INFO - PROCESS | 12116 | Cycle 1(1): loaded http://localhost:53753/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53753/tests/kraken/driver.html?testName=audio-oscillator) 05:40:52 INFO - PROCESS | 12116 | RSS: Main: 198045696 05:40:52 INFO - PROCESS | 12116 | 05:40:54 INFO - PROCESS | 12116 | Cycle 1(1): loaded http://localhost:53753/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53753/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:40:55 INFO - PROCESS | 12116 | RSS: Main: 202067968 05:40:55 INFO - PROCESS | 12116 | 05:40:58 INFO - PROCESS | 12116 | Cycle 1(1): loaded http://localhost:53753/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53753/tests/kraken/driver.html?testName=imaging-darkroom) 05:40:58 INFO - PROCESS | 12116 | RSS: Main: 237928448 05:40:58 INFO - PROCESS | 12116 | 05:41:02 INFO - PROCESS | 12116 | Cycle 1(1): loaded http://localhost:53753/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53753/tests/kraken/driver.html?testName=imaging-desaturate) 05:41:03 INFO - PROCESS | 12116 | RSS: Main: 233750528 05:41:03 INFO - PROCESS | 12116 | 05:41:06 INFO - PROCESS | 12116 | Cycle 1(1): loaded http://localhost:53753/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53753/tests/kraken/driver.html?testName=json-parse-financial) 05:41:06 INFO - PROCESS | 12116 | RSS: Main: 236457984 05:41:06 INFO - PROCESS | 12116 | 05:41:08 INFO - PROCESS | 12116 | Cycle 1(1): loaded http://localhost:53753/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53753/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:41:08 INFO - PROCESS | 12116 | RSS: Main: 223141888 05:41:08 INFO - PROCESS | 12116 | 05:41:10 INFO - PROCESS | 12116 | Cycle 1(1): loaded http://localhost:53753/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53753/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:41:11 INFO - PROCESS | 12116 | RSS: Main: 229117952 05:41:11 INFO - PROCESS | 12116 | 05:41:13 INFO - PROCESS | 12116 | Cycle 1(1): loaded http://localhost:53753/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53753/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:41:14 INFO - PROCESS | 12116 | RSS: Main: 237101056 05:41:14 INFO - PROCESS | 12116 | 05:41:17 INFO - PROCESS | 12116 | Cycle 1(1): loaded http://localhost:53753/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53753/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:41:17 INFO - PROCESS | 12116 | RSS: Main: 238153728 05:41:17 INFO - PROCESS | 12116 | 05:41:20 INFO - PROCESS | 12116 | Cycle 1(1): loaded http://localhost:53753/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53753/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:41:21 INFO - PROCESS | 12116 | RSS: Main: 237559808 05:41:21 INFO - PROCESS | 12116 | 05:41:23 INFO - PROCESS | 12116 | Cycle 1(1): loaded http://localhost:53753/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53753/tests/kraken/driver.html?testName=ai-astar) 05:41:23 INFO - PROCESS | 12116 | RSS: Main: 279863296 05:41:23 INFO - PROCESS | 12116 | 05:41:23 INFO - PROCESS | 12116 | __start_tp_report 05:41:23 INFO - PROCESS | 12116 | _x_x_mozilla_page_load 05:41:23 INFO - PROCESS | 12116 | _x_x_mozilla_page_load_details 05:41:23 INFO - PROCESS | 12116 | |i|pagename|runs| 05:41:23 INFO - PROCESS | 12116 | |0;ai-astar;113;110;113;114;111;113;112;115;113;115 05:41:23 INFO - PROCESS | 12116 | |1;audio-beat-detection;165;136;132;201;139;140;152;130;198;130 05:41:23 INFO - PROCESS | 12116 | |2;audio-dft;161;162;161;162;160;161;160;160;160;161 05:41:23 INFO - PROCESS | 12116 | |3;audio-fft;76;77;76;116;76;76;75;75;102;74 05:41:23 INFO - PROCESS | 12116 | |4;audio-oscillator;87;87;119;86;86;86;122;85;86;128 05:41:23 INFO - PROCESS | 12116 | |5;imaging-gaussian-blur;117;116;117;117;117;116;117;117;117;117 05:41:23 INFO - PROCESS | 12116 | |6;imaging-darkroom;146;146;147;147;147;147;146;147;147;148 05:41:23 INFO - PROCESS | 12116 | |7;imaging-desaturate;95;95;95;94;95;95;95;94;94;95 05:41:23 INFO - PROCESS | 12116 | |8;json-parse-financial;63;62;64;62;63;63;63;62;63;62 05:41:23 INFO - PROCESS | 12116 | |9;json-stringify-tinderbox;64;64;65;74;65;65;66;65;65;66 05:41:23 INFO - PROCESS | 12116 | |10;stanford-crypto-aes;85;85;84;89;92;84;85;86;114;85 05:41:23 INFO - PROCESS | 12116 | |11;stanford-crypto-ccm;145;132;134;148;138;130;137;134;154;149 05:41:23 INFO - PROCESS | 12116 | |12;stanford-crypto-pbkdf2;169;168;168;171;167;168;168;169;167;170 05:41:23 INFO - PROCESS | 12116 | |13;stanford-crypto-sha256-iterative;69;66;67;68;66;66;66;66;66;65 05:41:23 INFO - PROCESS | 12116 | __end_tp_report 05:41:23 INFO - PROCESS | 12116 | __start_cc_report 05:41:23 INFO - PROCESS | 12116 | _x_x_mozilla_cycle_collect,1880 05:41:23 INFO - PROCESS | 12116 | __end_cc_report 05:41:23 INFO - PROCESS | 12116 | __startTimestamp1465562483319__endTimestamp 05:41:23 INFO - PROCESS | 12116 | 05:41:23 INFO - PROCESS | 12116 | ------- Summary: start ------- 05:41:23 INFO - PROCESS | 12116 | Number of tests: 14 05:41:23 INFO - PROCESS | 12116 | 05:41:23 INFO - PROCESS | 12116 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:1.60 (1.4%) stddev-sans-first:1.69 05:41:23 INFO - PROCESS | 12116 | Values: 113.0 110.0 113.0 114.0 111.0 113.0 112.0 115.0 113.0 115.0 05:41:23 INFO - PROCESS | 12116 | 05:41:23 INFO - PROCESS | 12116 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:146.00 stddev:27.13 (18.6%) stddev-sans-first:28.38 05:41:23 INFO - PROCESS | 12116 | Values: 165.0 136.0 132.0 201.0 139.0 140.0 152.0 130.0 198.0 130.0 05:41:23 INFO - PROCESS | 12116 | 05:41:23 INFO - PROCESS | 12116 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 05:41:23 INFO - PROCESS | 12116 | Values: 161.0 162.0 161.0 162.0 160.0 161.0 160.0 160.0 160.0 161.0 05:41:23 INFO - PROCESS | 12116 | 05:41:23 INFO - PROCESS | 12116 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.00 stddev:14.48 (19.0%) stddev-sans-first:15.17 05:41:23 INFO - PROCESS | 12116 | Values: 76.0 77.0 76.0 116.0 76.0 76.0 75.0 75.0 102.0 74.0 05:41:23 INFO - PROCESS | 12116 | 05:41:23 INFO - PROCESS | 12116 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:86.00 stddev:17.94 (20.9%) stddev-sans-first:18.65 05:41:23 INFO - PROCESS | 12116 | Values: 87.0 87.0 119.0 86.0 86.0 86.0 122.0 85.0 86.0 128.0 05:41:23 INFO - PROCESS | 12116 | 05:41:23 INFO - PROCESS | 12116 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:41:23 INFO - PROCESS | 12116 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 05:41:23 INFO - PROCESS | 12116 | 05:41:23 INFO - PROCESS | 12116 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 05:41:23 INFO - PROCESS | 12116 | Values: 146.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 148.0 05:41:23 INFO - PROCESS | 12116 | 05:41:23 INFO - PROCESS | 12116 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:41:23 INFO - PROCESS | 12116 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 05:41:23 INFO - PROCESS | 12116 | 05:41:23 INFO - PROCESS | 12116 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 05:41:23 INFO - PROCESS | 12116 | Values: 63.0 62.0 64.0 62.0 63.0 63.0 63.0 62.0 63.0 62.0 05:41:23 INFO - PROCESS | 12116 | 05:41:23 INFO - PROCESS | 12116 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:65.00 stddev:2.92 (4.5%) stddev-sans-first:3.02 05:41:23 INFO - PROCESS | 12116 | Values: 64.0 64.0 65.0 74.0 65.0 65.0 66.0 65.0 65.0 66.0 05:41:23 INFO - PROCESS | 12116 | 05:41:23 INFO - PROCESS | 12116 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:85.00 stddev:9.17 (10.8%) stddev-sans-first:9.62 05:41:23 INFO - PROCESS | 12116 | Values: 85.0 85.0 84.0 89.0 92.0 84.0 85.0 86.0 114.0 85.0 05:41:23 INFO - PROCESS | 12116 | 05:41:23 INFO - PROCESS | 12116 | [#11] stanford-crypto-ccm Cycles:10 Average:140.10 Median:141.50 stddev:8.27 (5.8%) stddev-sans-first:8.57 05:41:23 INFO - PROCESS | 12116 | Values: 145.0 132.0 134.0 148.0 138.0 130.0 137.0 134.0 154.0 149.0 05:41:23 INFO - PROCESS | 12116 | 05:41:23 INFO - PROCESS | 12116 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.50 Median:168.50 stddev:1.27 (0.8%) stddev-sans-first:1.33 05:41:23 INFO - PROCESS | 12116 | Values: 169.0 168.0 168.0 171.0 167.0 168.0 168.0 169.0 167.0 170.0 05:41:23 INFO - PROCESS | 12116 | 05:41:23 INFO - PROCESS | 12116 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:1.18 (1.8%) stddev-sans-first:0.83 05:41:23 INFO - PROCESS | 12116 | Values: 69.0 66.0 67.0 68.0 66.0 66.0 66.0 66.0 66.0 65.0 05:41:23 INFO - PROCESS | 12116 | -------- Summary: end -------- 05:41:23 INFO - PROCESS | 12116 | 05:41:24 INFO - TEST-INFO | 12116: exit 0 05:41:24 INFO - TEST-OK | kraken | took 65298ms 05:41:24 INFO - SUITE-END | took 1186s 05:41:24 INFO - Completed test suite (00:19:46) 05:41:24 INFO - javascript benchmark 05:41:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2618.2145356393085, 2631.0659715800903, 2660.574308110702, 2676.986615066923, 2685.5568831142864, 4620.630349572035, 4704.482506924235, 4720.480747117818, 4790.9760451197735, 4857.0771553404875, 4668.113058518879, 4672.112298663252, 4676.298555216711, 4680.4149481314835, 4695.953040469594, 4200.0, 4351.760653164067, 4450.198964186461, 4476.462824461069, 4543.22765129927, 4449.0434556570335, 4472.619827314666, 4499.392582001437, 4511.413516242884, 4528.9094218115615, 4294.463192100971, 4335.19798837213, 4338.674599405057, 4353.891152721176, 4434.2905135178535, 4373.25654638709, 4378.759168245745, 4379.0, 4418.315161150027, 4432.667549933768, 4408.074304396081, 4418.491873434564, 4419.535948725402, 4474.485434175079, 4482.708623939466, 4612.976935115336, 4696.436427628672, 4728.66899317048, 4747.098051370229, 4819.180739274332, 5078.7460626968505, 5115.5396014358885, 5134.0758663440565, 5136.948630513684, 5138.537531622172, 5094.923576146323, 5127.717975511346, 5144.279800827887, 5159.355080614923, 5159.871003224912, 4548.204064288736, 4720.12677654635, 4733.5503127202865, 4755.144074066701, 4817.662763606584, 5220.660657057279, 5225.425203227718, 5226.503482169188, 5251.396089449686, 5281.9471805281455, 5021.4225364083595, 5062.493750624908, 5065.366829146356, 5068.239764035424, 5074.13739664258, 4953.25701144824, 4976.402831660224, 5019.899602008012, 5039.244113382949, 5142.537171654494, 5011.223260394645, 5020.397552293675, 5024.271480635361, 5057.949420505748, 5070.61970352225, 4981.950180498221, 4987.1771157759285, 4987.5760560352055, 5015.84952451427, 5043.167877300204, 4153.107081977329, 4184.686148538872, 4272.423222864935, 4298.312270036779, 4345.217860785026, 3787.4697542344093, 3792.7724336539895, 3799.563050249257, 3829.3681542545723, 3863.150106976461, 4363.345498175299, 4369.08249267651, 4372.80322385487, 4417.094495628388, 4418.6023257906945, 4916.213405855117, 4935.531124543163, 5055.949440505621, 5118.488151184852, 5165.483451654804, 4348.043430445297, 4376.824927002885, 4380.846670366522, 4400.603945644907, 4414.668899832525, 4594.310853372021, 4608.124456353282, 4612.0, 4616.422947131608, 4656.3946686930485, 4637.350770892011, 4761.357216775829, 4765.142274390643, 4800.73595952226, 4803.735794531264, 5113.8721531962, 5123.0, 5138.563222126161, 5139.049275883974, 5172.379314482287, 4812.446568644651, 4815.15734746411, 4816.0, 4821.083994041121, 4856.295837103671, 4873.4639189689815, 4990.750462476934, 4998.225275082368, 5041.697498150123, 5109.463506331782, 5118.462561431145, 5131.666441681279, 5136.30659860929, 5138.332016837787, 5142.692016421552, 5010.8246211383885, 5014.247862820606, 5016.799328026984, 5019.32239147725, 5041.7227052511, 4796.0, 4926.285688575065, 4937.358143441474, 4964.35463389757, 4984.501549844987, 4880.0, 4908.312836202863, 4919.778609962489, 4944.826931057396, 4970.27930950003, 4808.567228949411, 5018.874528136826, 5067.797288108434, 5073.416557095981, 5078.18749000173, 4845.63657725665, 4884.853454396374, 4893.828715994923, 4894.1679914415345, 4952.455229924633], "value": 4675.7939027530365, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.6370990710991, 573.166043406843, 580.5123696095279, 584.0742423259134, 585.0697391148076, 26982.86508567457, 29246.707532924665, 39854.80072599636, 40734.79632601833, 40951.0, 41734.0, 41964.37053444201, 42087.57912420875, 42185.0, 42225.78887105568, 7756.146823849358, 7943.72196973106, 7943.960280198591, 7945.562994035326, 7951.483153595027, 7589.772306830776, 9968.601255949754, 10164.136048435892, 10175.542100605453, 10514.316569423001, 10233.948830255838, 10323.070923616873, 10326.58693652253, 10335.0, 10339.22455815813, 7650.885236721398, 10010.59957601695, 10110.898891011106, 10161.085502304792, 10186.694399168036, 9855.507224638739, 10184.338018028804, 10193.235507336905, 10195.08244258013, 10205.183585313158, 38731.0, 38872.41691374632, 39096.0, 39119.80440097781, 39166.60833391658, 3029.303260250155, 3136.52952057191, 3379.020084175586, 3486.6687664671817, 3489.180042689966, 29064.854675726696, 29477.705222947712, 29779.851100744574, 30177.09468715942, 30521.08436746901, 3495.615482296945, 3550.289942011608, 3562.839672214757, 3590.3357878792244, 3653.8903832885057, 250838.0, 252128.0, 252606.0, 253114.0, 253431.0, 31854.840725796224, 50794.984100317786, 51120.488795111574, 51220.0, 51220.231696524585, 31141.8442907784, 32985.0, 32989.0, 33049.17377065593, 33070.50394244088, 12830.807537886752, 12937.223766574036, 12986.870131298756, 13012.154209976321, 13027.153235039692, 10195.439250841275, 10422.374657520573, 10436.37381757097, 11017.11863050954, 11018.39398833072, 7759.0, 7768.0678318601, 7832.530048197126, 7880.605969701492, 7904.604769761489, 3075.324467713059, 3111.191090316489, 3115.01876908773, 3115.081051089934, 3123.6563977962405, 852.9701460448855, 967.670991862756, 988.7577543501889, 995.5520015992832, 1006.3710181136789, 27806.582901256497, 28575.42849143047, 28583.85708071488, 28887.133385998455, 28995.565066524017, 938.1369140390857, 940.2524992630875, 951.7906060666643, 971.6793458158791, 1001.4041645221228, 14681.77977330341, 14911.776323355158, 14924.850751492564, 15251.0, 15353.15557644318, 376051.0, 380545.0, 380842.0, 380900.0, 381299.0, 49749.0, 50931.23603145956, 51030.74484627553, 51069.74465127725, 51103.48896511061, 1054.46222426563, 1171.9941400292944, 1193.3794426897964, 1204.0, 1206.6500714792612, 27882.721172788824, 28597.714022859505, 28687.282817929718, 29026.709732903244, 29219.85390073036, 41114.383284250165, 41252.58747412488, 41742.79128604338, 41748.165036699706, 41801.58198417977, 232954.0, 233040.0, 233628.0, 234339.0, 234346.0, 22260.88869555642, 22806.771932280466, 23845.761542384353, 24451.877740611184, 24511.754882450947, 41633.79183104065, 41756.373654395815, 41959.790201048796, 42562.0, 42862.0, 35525.64474355327, 35628.0, 35672.108197294234, 36187.09532261715, 36406.0, 35862.103447414025, 36019.45970810492, 36079.27841443104, 36266.27467450689, 36271.455928161624, 35132.0, 35162.47256291106, 35922.8203858979, 35940.0, 35954.0, 31780.841095794374, 32829.671703282664, 32983.50524742179, 33060.33879322352, 33093.66906330906, 24337.51324973455, 24983.375415614755, 25375.0, 25807.612885806353, 25975.610365844906], "value": 16735.775449597426, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.34788337342667, 358.4587273217441, 359.611619450993, 374.8350725680702, 376.4785771706186, 16583.41958031469, 16633.0, 17445.56386090345, 17446.82553174468, 17462.738058929128, 16058.75911861323, 16630.66738665226, 16721.247543860525, 16913.15434228287, 16915.57711057224, 4958.553730164275, 5129.333186685725, 5180.585553155757, 5191.377034755835, 5192.506711862386, 3088.7837851350414, 3230.273188532573, 3235.6279027911737, 3265.7060864522186, 5056.443791182967, 3353.9496907546404, 5912.733926973297, 5928.1404196391495, 6006.48944839687, 6019.7893073742425, 5835.854103647401, 5919.733611987471, 5972.044472884318, 5991.071383935475, 6014.188084608588, 2823.153054083787, 5171.172612382038, 5179.171332586768, 5186.636935414523, 5203.297554830087, 15006.576587348964, 19113.426597202106, 19538.0, 20325.18699252028, 20621.587568248702, 1902.4958386027713, 1975.8122978317037, 2004.849636277285, 2018.4348382452936, 2095.905684244213, 12313.0, 12805.679858003532, 13302.201867887958, 13553.59339219825, 13603.727925441535, 1554.6113471632093, 1710.5523658681498, 1802.594416256332, 1807.7740282464692, 1820.2445984916244, 65096.34903650998, 67652.66173669149, 67929.32070679279, 68189.3181068188, 69003.65498172477, 8294.0, 8355.832883342298, 8956.955215223883, 9069.637214511478, 9185.402948808307, 11914.821277680841, 11917.761644767055, 11988.700282492833, 12017.699557510958, 12232.510699572096, 7265.273472652692, 7278.7034561960545, 7371.6682749276415, 7416.443766717518, 7468.900306893409, 7246.6641552827905, 7438.330550250504, 7482.625868706543, 7558.319751222416, 7606.0, 5922.466977971917, 5960.642361458326, 5960.970195149083, 5989.64062156272, 6047.455728984412, 1546.4510098914948, 1553.3010145434373, 1656.5829736760725, 1674.372110458578, 1735.8128757765307, 811.7077851973285, 862.4738909265343, 921.2675922641382, 933.9112784285481, 945.5366870233673, 16222.756658650129, 16827.495175144766, 16968.830311696725, 17030.48908532746, 17231.827681723273, 867.0938868882033, 867.8394497018072, 871.111466304366, 873.4409977614332, 887.3965703321803, 7970.681172753141, 9713.70858874235, 9750.90249097514, 9817.081325256482, 9945.701628951143, 383185.0, 384478.0, 392611.0, 393718.0, 394318.0, 66466.33533664698, 70823.64588177027, 72331.0, 73135.2686473139, 77920.61039694765, 953.0993211415146, 955.8183945050419, 956.6125719083782, 995.0348162282575, 998.8901220865699, 15680.788236411021, 15734.0, 16083.276252568896, 16166.191690415668, 16371.672566548841, 37379.0, 37848.62151378451, 37924.24151517009, 38260.234795304495, 38740.0, 52261.216081758044, 53668.73165634147, 53879.0, 54160.45839541712, 54331.18503222534, 7637.198094200029, 7675.53946763196, 7716.7684969451, 7748.418868584991, 7913.129555748978, 10856.674299771019, 11302.83045754298, 11992.220505667105, 12009.579664711693, 12038.157328986887, 10037.347572408062, 10062.144717699077, 10123.64567240143, 10173.067117247996, 10240.385576865412, 9929.3545919515, 10166.898331016891, 10285.125764310118, 10508.159347252355, 10615.363078215332, 10079.395236285847, 10112.949435252776, 10219.948900255451, 10360.481975901326, 10626.946865265625, 7715.614219288901, 7735.303822655988, 7816.257455541714, 7852.725154619561, 7937.722179723682, 9695.466749328854, 10171.84742228882, 10221.74445638865, 10223.642172523925, 10367.896321036995], "value": 8208.654254809882, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1204.0427859851418, 1373.835139783226, 1417.6385021819435, 1483.1768368555454, 1721.561001944504, 6360.586561873481, 7486.700531978721, 7735.651895664688, 7762.223777622235, 7893.092294386147, 7635.083789945214, 7794.883076753853, 7799.727009554666, 7838.529688218711, 7852.685892564305, 1803.1705415508882, 2086.8330533557355, 2184.7050648162535, 2199.29622520793, 2241.9327420177337, 2201.922932697356, 2232.3303009097285, 2233.3076746208644, 2235.1394713035515, 2240.283109404983, 2176.804087632113, 2199.164317559333, 2203.6694495825595, 2215.789499997498, 2217.4899773052207, 1813.8820976636475, 1887.4337698690338, 1894.7442095317094, 2078.0648708081426, 2139.0801955159277, 2135.6582946728604, 2179.4769255378596, 2186.464316242515, 2190.583789080086, 2191.769864164272, 7758.301752842215, 7827.921720782833, 7852.17552157021, 7882.5270483771155, 7887.487313324673, 4547.226971414867, 4689.859304220845, 4690.366800481926, 4694.5540173683785, 4694.647901407408, 2697.3526353675175, 2824.5198316286283, 2831.263871393432, 2841.559558268472, 2879.1074766822353, 862.6635612111281, 876.8158686675806, 905.1943770044666, 917.6650522559285, 920.802027564077, 10456.058954694037, 10496.160307175483, 10501.579936802518, 10535.631252906189, 10553.683389498327, 4125.752454852718, 4214.599613036757, 4256.808443620044, 4292.334688123346, 4313.0726893718, 9060.728178154666, 9067.818643627223, 9077.68228112013, 9102.453852768855, 9109.544522773967, 4650.093231819763, 4651.627869770478, 4652.116097941381, 4652.3951886255245, 4655.162070827216, 3604.6395360463744, 4176.686748493875, 4315.266404711207, 4328.805203765775, 4381.233284175257, 3620.4931309616672, 3625.3655610268097, 3671.4125739881492, 3728.0493474163914, 3761.1725420407465, 1156.8438260834848, 1166.4284500594647, 1167.7606090751376, 1170.8185231289165, 1173.3546549397797, 726.4841962206892, 817.7424111404888, 820.8112134209165, 830.5805568188026, 850.2050582705191, 5021.4225364083595, 5150.948490515122, 5181.6890986540175, 5197.324347834758, 5222.9216561750845, 401.1795877430661, 411.84555791578157, 415.2131710408819, 415.2587631078571, 424.55421807103033, 3420.486926960926, 3433.776804507749, 3475.565554305712, 3477.0, 3528.576570811519, 9129.589168487433, 9498.667546635834, 9565.282603804742, 9594.616215351307, 9595.47224902637, 9456.952715236379, 9458.33791634579, 9529.047095290416, 9571.090746379083, 9604.135627793532, 7184.209736928934, 7282.5630462171375, 7289.781306560812, 7309.671064802096, 7321.304476074764, 4972.8508144755715, 5031.471695471922, 5043.5460808527405, 5114.232865070269, 5138.486151384981, 8838.204561589488, 8863.157999989991, 8883.955580222058, 8950.552472376225, 9010.909890901006, 8867.512286824287, 8878.86681699788, 8943.508107054175, 8991.41555798871, 9044.231240344645, 5752.9137062943255, 5757.942420575908, 6242.625442473466, 6331.556791024584, 6331.9366806331345, 7377.483576149618, 7383.852322953619, 7385.778426647209, 7385.9630701846145, 7393.186749457663, 6439.774607888701, 6593.604383736799, 6656.633885136364, 6716.126903502513, 6790.558613690095, 6237.594556353823, 6444.194475690539, 6535.673216339259, 6612.272650008592, 6753.898691519729, 5877.265341832271, 5937.940620593911, 5946.583739138218, 5983.222181116427, 6029.547783916136, 4341.739495630272, 4350.73895566267, 4366.607005369532, 4456.732596044248, 4510.481294651157, 4369.694121411598, 4400.823967041282, 4489.281714925596, 4502.617277531446, 4503.279475283939], "value": 3985.237899112706, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.7199416565931, 295.3369685057047, 299.835090700115, 302.96364436267635, 304.33958310466284, 4865.172920603497, 4917.868890155262, 4926.137925862969, 4927.408710954691, 4935.629827762914, 4837.5646191842725, 4852.781624826883, 4878.536539028786, 4879.487653796354, 4898.559129678329, 3611.7110631149444, 3729.608391118934, 3738.476613274144, 3836.290286297044, 3872.961270387302, 3817.2747178036084, 3825.9808700956455, 3856.9586211722817, 3857.517810273716, 3859.729818912663, 3609.2420591675777, 3750.924981500368, 3770.151715863922, 3800.5629352624387, 3803.9809800951093, 3654.30568192044, 3763.7741735495956, 3778.149916268845, 3800.9429858551866, 3803.5435747710453, 3327.068420842168, 3337.349216902705, 3337.4660054391425, 3344.6320904700706, 3364.3775901458307, 4762.595179409755, 4772.856814295576, 4774.761261936889, 4776.0, 4785.401824771903, 4205.3481710334945, 4289.849855255051, 4299.398084268205, 4315.223259813232, 4340.74118505633, 5079.517445842639, 5115.20714289282, 5126.410462796789, 5126.820561280338, 5134.7689353978785, 3661.864821905218, 3662.633736626316, 3667.4132138857653, 3681.7238707097076, 3689.612590677994, 5180.4042535108565, 5321.654092484015, 5351.973240133813, 5399.1091469907415, 5401.135818269058, 3710.2023065041144, 3723.5159429274563, 3735.2716220337315, 3738.813059347022, 3747.606501317377, 3801.790901500444, 3811.6188381162215, 3812.5615554211067, 3817.599152089046, 3817.751846129993, 4290.485141783006, 4320.805563749576, 4322.135572885372, 4325.243082460557, 4342.0, 4930.235813448921, 5016.423111342169, 5071.061853557104, 5107.412647545506, 5130.0, 1283.0313113599173, 1311.9934400327936, 1324.38416136497, 1324.8741369569875, 1330.2284674888542, 813.247745835112, 851.5784686580182, 878.4421892098563, 916.8028873792167, 921.433318509112, 4519.84180553679, 4526.117407105583, 4544.909101818012, 4565.589096981221, 4565.908681826345, 5241.9213711794355, 5261.658277139305, 5277.23480095384, 5333.653312534673, 5357.678539287655, 4337.501187363494, 4447.911041779146, 4476.507584165739, 4486.7083639563325, 4620.722756634613, 2818.5490321548864, 2830.4905117079124, 2836.5603331483653, 2844.264998351004, 2846.7722582193373, 4984.0, 4988.800447982113, 4989.3264409305, 5017.197248440232, 5037.496250374933, 5158.226266060121, 5424.783008679608, 5441.646292990943, 5461.481159289861, 5480.479354461399, 4987.750612469362, 5005.199168133081, 5024.497550244946, 5026.79892804291, 5037.79848806051, 5287.603429742861, 5295.417504074626, 5299.0, 5303.522682958398, 5308.283381743569, 4984.775685094107, 5253.395859476209, 5298.8077682521125, 5301.204819277139, 5309.177077552986, 5055.924161137512, 5061.266116413173, 5062.848114556569, 5067.569256613082, 5077.644564880423, 3690.6678398944223, 3702.4816525685887, 3727.7763334200035, 3729.869454569077, 3739.3546839390583, 5168.3797944246935, 5355.250264962986, 5360.195970604441, 5374.623776335619, 5376.623636345418, 5134.5378915897745, 5159.380874295109, 5163.870903227299, 5165.225216217597, 5170.3278573785165, 5176.844694659167, 5178.6374953752875, 5200.375954885438, 5203.609729270395, 5211.322528071327, 4843.95156048435, 4870.928395753071, 5021.317858517292, 5069.264956581349, 5113.64204505681, 5003.324551185543, 5006.6495345325475, 5032.974835125801, 5067.746612669425, 5086.618503612318, 4923.507649235048, 5063.164577844762, 5083.517065878736, 5110.029094472038, 5120.3343565337755], "value": 3866.9806543113577, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.2740623486349, 558.2352177516802, 576.6626523483761, 588.920495733076, 619.7242227208891, 10828.837567436485, 11309.943450282737, 11491.942540287308, 11500.597479088223, 11530.423478826056, 11335.489902954367, 11601.3039217647, 11604.187706860503, 11608.709782255448, 11609.245399049056, 615.4614712126889, 749.2507492507492, 762.0588573112188, 778.7040924448702, 779.2091027606983, 769.3383690026573, 779.9415043871704, 781.1017330070435, 781.1095351299523, 781.9491733037335, 817.23588444804, 822.8189798244376, 823.5223570329194, 824.2293455618985, 824.2952275804191, 634.571664126715, 790.5730905311125, 815.1848151848152, 816.5957850863831, 817.2236375443323, 596.2100217212211, 596.8567543789503, 597.2743117112685, 597.5488506177851, 598.1775059293471, 10733.892661073445, 10744.247902646817, 10746.731331716692, 10790.082842958358, 10834.72913177169, 12112.0, 12294.75410491785, 12769.233845969271, 13261.734765304736, 13296.401661925236, 10012.0, 10124.89875101247, 10382.279741164759, 10392.844107338396, 10531.947340263327, 3982.681385489154, 4018.738781979191, 4122.670186385082, 4128.298189307825, 4138.317177665682, 57002.42997570013, 57739.42260577383, 57855.0, 59176.40823591752, 59887.1016934742, 9050.773730656654, 9117.77205569866, 9398.48308343034, 9414.858777118348, 9434.19809316202, 18918.243270269035, 18955.24179032851, 18957.620847583246, 19008.144633491527, 19015.144318505423, 6208.0, 6361.0, 6417.486601071903, 6418.101465794793, 6431.614103153825, 3380.560527131506, 3416.8462419191196, 3500.334936362083, 3503.211777350076, 3511.5259439975275, 2684.637573927495, 2768.709285525031, 2770.9168724938286, 2774.0845520978028, 2776.5418705913703, 458.0929759077046, 458.12726755530105, 460.2268189441703, 468.39810843066493, 470.7763812189251, 425.9020425302136, 466.07251569376695, 479.1761741304341, 510.3722421421598, 521.6661336744487, 5794.275715535558, 5800.303963524404, 5822.883542329129, 5869.911951320733, 5961.7615295387695, 470.5153691697557, 477.6680207255993, 477.99522004779504, 478.7920929770551, 507.9212722028092, 3185.2833112549492, 3283.277678910636, 3288.1615188126875, 3374.4263475209273, 3405.6083550392023, 85128.57435712781, 85753.0, 88132.0, 90750.0, 92511.53744231371, 49578.75210623996, 51926.0, 76454.23545764583, 77852.2214777845, 81750.59124704338, 67855.98216026764, 67919.66040169768, 68269.31730682729, 68965.0, 69021.3097869025, 6227.875442491216, 6263.217097862767, 6290.433860952537, 6307.211598550181, 6416.807495775134, 41801.581984180986, 42103.421209197564, 42709.0, 43766.78116609396, 44811.0, 52753.20870187027, 57148.14277785753, 57783.0, 58204.0, 59721.402785971586, 10428.895711043097, 10451.0, 10507.579696812041, 10641.787164256826, 10871.096149716048, 11858.644240672793, 11945.761084778429, 12004.699882503008, 12224.511019559119, 12554.121211515472, 10642.361458312525, 10879.075278601407, 11107.666769996913, 11242.494087766234, 11329.206955513035, 11167.162462815484, 11216.327020378803, 11560.884391155982, 11651.41742912868, 11719.589814356457, 10170.949145254523, 10205.38767673942, 10211.642592509226, 10272.897271027194, 10396.688099357032, 9052.90947090547, 9060.728178154666, 9202.815943680955, 9334.953325233331, 9396.154346108882, 8989.101089890959, 9117.863232051657, 9215.170634642915, 9295.814083718153, 9421.434713917188], "value": 6013.54905632055, "unit": "score"}], "name": "dromaeo_css", "value": 6248.796999789649, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 110.0, 113.0, 114.0, 111.0, 113.0, 112.0, 115.0, 113.0, 115.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 136.0, 132.0, 201.0, 139.0, 140.0, 152.0, 130.0, 198.0, 130.0], "value": 152.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 160.0, 161.0, 160.0, 160.0, 160.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 116.0, 76.0, 76.0, 75.0, 75.0, 102.0, 74.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 119.0, 86.0, 86.0, 86.0, 122.0, 85.0, 86.0, 128.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 148.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 62.0, 63.0, 63.0, 63.0, 62.0, 63.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 74.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 89.0, 92.0, 84.0, 85.0, 86.0, 114.0, 85.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 132.0, 134.0, 148.0, 138.0, 130.0, 137.0, 134.0, 154.0, 149.0], "value": 140.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 168.0, 171.0, 167.0, 168.0, 168.0, 169.0, 167.0, 170.0], "value": 168.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 67.0, 68.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1556.4000000000003, "alertThreshold": 2.0}]} 05:41:25 INFO - Return code: 0 05:41:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:41:25 ERROR - # TBPL SUCCESS # 05:41:25 INFO - Running post-action listener: _resource_record_post_action 05:41:25 INFO - ##### 05:41:25 INFO - ##### Finished run-tests step (success) 05:41:25 INFO - ##### 05:41:25 INFO - Running post-run listener: _resource_record_post_run 05:41:25 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535396352; Read time: 8; Write time: 1389004 05:41:25 INFO - TinderboxPrint: CPU usage
13.2% 05:41:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:41:25 INFO - TinderboxPrint: I/O write bytes / time
535,396,352 / 1,389,004 05:41:25 INFO - TinderboxPrint: CPU idle
8,337.5 (86.8%) 05:41:25 INFO - TinderboxPrint: CPU user
1,212.7 (12.6%) 05:41:25 INFO - TinderboxPrint: Swap in / out
0 / 0 05:41:25 INFO - install - Wall time: 17s; CPU: 19.0%; Read bytes: 0; Write bytes: 211943424; Read time: 0; Write time: 880592 05:41:25 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295940096; Read time: 8; Write time: 496160 05:41:25 INFO - Running post-run listener: _upload_blobber_files 05:41:25 INFO - Blob upload gear active. 05:41:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:41:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:41:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:41:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:41:26 INFO - (blobuploader) - INFO - Open directory for files ... 05:41:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:41:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:41:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:31 INFO - (blobuploader) - INFO - Done attempting. 05:41:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:41:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:41:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:32 INFO - (blobuploader) - INFO - Done attempting. 05:41:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:41:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:41:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:41:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:41:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:41:33 INFO - (blobuploader) - INFO - Done attempting. 05:41:33 INFO - (blobuploader) - INFO - Iteration through files over. 05:41:33 INFO - Return code: 0 05:41:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:41:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:41:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c14e6936786d12740826c8eecae8cb97082f5054d3c24e4d449e4e4f8ec878b996c54fc8cfdff1ed460df94072eb762d4fc56edfdfc89c5fd7044533b5b9d8c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3050cc56a0dbfa00a718fe9477a657cf983976285ae3556c7437e599e8f42fa924a1e6389236ad40cfd387fe5b2e750e1084241c1da3eb942ef9bcf036351b36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3605512f26e4551a3cd887f7c66d10e55c686dfe7bdc1cfb99d1f9ecf251da57686a928ceb64d659de3cba7f2e06d6bd78d3c2fc340ce1c3f52fc7861c9831ae"} 05:41:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:41:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:41:33 INFO - Contents: 05:41:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c14e6936786d12740826c8eecae8cb97082f5054d3c24e4d449e4e4f8ec878b996c54fc8cfdff1ed460df94072eb762d4fc56edfdfc89c5fd7044533b5b9d8c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3050cc56a0dbfa00a718fe9477a657cf983976285ae3556c7437e599e8f42fa924a1e6389236ad40cfd387fe5b2e750e1084241c1da3eb942ef9bcf036351b36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3605512f26e4551a3cd887f7c66d10e55c686dfe7bdc1cfb99d1f9ecf251da57686a928ceb64d659de3cba7f2e06d6bd78d3c2fc340ce1c3f52fc7861c9831ae"} 05:41:33 INFO - Running post-run listener: copy_logs_to_upload_dir 05:41:33 INFO - Copying logs to upload dir... 05:41:33 INFO - mkdir: /builds/slave/test/build/upload/logs 05:41:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.829290 ========= master_lag: 0.49 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-06-10 05:41:33.825336) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:33.829110) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1465558857.594069-128602410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c14e6936786d12740826c8eecae8cb97082f5054d3c24e4d449e4e4f8ec878b996c54fc8cfdff1ed460df94072eb762d4fc56edfdfc89c5fd7044533b5b9d8c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3050cc56a0dbfa00a718fe9477a657cf983976285ae3556c7437e599e8f42fa924a1e6389236ad40cfd387fe5b2e750e1084241c1da3eb942ef9bcf036351b36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3605512f26e4551a3cd887f7c66d10e55c686dfe7bdc1cfb99d1f9ecf251da57686a928ceb64d659de3cba7f2e06d6bd78d3c2fc340ce1c3f52fc7861c9831ae"} build_url:https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/ABDi84mQStK4QJVDI_6Ccg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c14e6936786d12740826c8eecae8cb97082f5054d3c24e4d449e4e4f8ec878b996c54fc8cfdff1ed460df94072eb762d4fc56edfdfc89c5fd7044533b5b9d8c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3050cc56a0dbfa00a718fe9477a657cf983976285ae3556c7437e599e8f42fa924a1e6389236ad40cfd387fe5b2e750e1084241c1da3eb942ef9bcf036351b36", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3605512f26e4551a3cd887f7c66d10e55c686dfe7bdc1cfb99d1f9ecf251da57686a928ceb64d659de3cba7f2e06d6bd78d3c2fc340ce1c3f52fc7861c9831ae"}' ========= master_lag: 0.50 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:34.342053) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:34.342804) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1465558857.594069-128602410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.27 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 05:41:34.616548) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 05:41:34.616975) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 05:41:34.618136) ========= ========= Total master_lag: 1.43 =========