builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-053 starttime: 1465322303.41 results: success (0) buildid: 20160607083033 builduid: 0a45dc501d7641f09c07992603701d75 revision: 2f0a8c420b18954e18b57993ea9c1a84190a0cb1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 10:58:23.415478) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 10:58:23.415878) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 10:58:23.416147) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 10:58:23.451277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 10:58:23.451535) ========= 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=920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 10:58:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2016-06-07 10:58:23 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096178 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 10:58:23.563867) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 10:58:23.564144) ========= 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=920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017462 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 10:58:23.614723) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 10:58:23.615048) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2f0a8c420b18954e18b57993ea9c1a84190a0cb1 --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 2f0a8c420b18954e18b57993ea9c1a84190a0cb1 --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=920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 10:58:23,858 truncating revision to first 12 chars 2016-06-07 10:58:23,858 Setting DEBUG logging. 2016-06-07 10:58:23,858 attempt 1/10 2016-06-07 10:58:23,859 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2f0a8c420b18?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 10:58:24,401 unpacking tar archive at: fx-team-2f0a8c420b18/testing/mozharness/ program finished with exit code 0 elapsedTime=0.982608 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 10:58:24.611746) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 10:58:24.612051) ========= script_repo_revision: 2f0a8c420b18954e18b57993ea9c1a84190a0cb1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 10:58:24.612447) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 10:58:24.612711) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 10:58:24.623034) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-07 10:58:24.623349) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:58:24 INFO - MultiFileLogger online at 20160607 10:58:24 in /builds/slave/test 10:58:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 10:58:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:58:24 INFO - {'append_to_log': False, 10:58:24 INFO - 'base_work_dir': '/builds/slave/test', 10:58:24 INFO - 'blob_upload_branch': 'Fx-Team', 10:58:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:58:24 INFO - 'branch': 'Fx-Team', 10:58:24 INFO - 'buildbot_json_path': 'buildprops.json', 10:58:24 INFO - 'config_files': ('talos/linux_config.py',), 10:58:24 INFO - 'default_actions': ('clobber', 10:58:24 INFO - 'read-buildbot-config', 10:58:24 INFO - 'download-and-extract', 10:58:24 INFO - 'populate-webroot', 10:58:24 INFO - 'create-virtualenv', 10:58:24 INFO - 'install', 10:58:24 INFO - 'run-tests'), 10:58:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:58:24 INFO - 'download_minidump_stackwalk': True, 10:58:24 INFO - 'download_symbols': 'ondemand', 10:58:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:58:24 INFO - 'tooltool.py': '/tools/tooltool.py', 10:58:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:58:24 INFO - '/tools/misc-python/virtualenv.py')}, 10:58:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:58:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:58:24 INFO - 'installer_path': 'installer.exe', 10:58:24 INFO - 'log_level': 'info', 10:58:24 INFO - 'log_name': 'talos', 10:58:24 INFO - 'log_to_console': True, 10:58:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:58:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:58:24 INFO - 'opt_config_files': (), 10:58:24 INFO - 'pip_index': False, 10:58:24 INFO - 'sps_profile': False, 10:58:24 INFO - 'sps_profile_interval': 0, 10:58:24 INFO - 'suite': 'dromaeojs', 10:58:24 INFO - 'system_bits': '32', 10:58:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:58:24 INFO - 'title': 'talos-linux64-ix-053', 10:58:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:58:24 INFO - 'use_talos_json': True, 10:58:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:58:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:58:24 INFO - 'work_dir': 'build'} 10:58:24 INFO - ##### 10:58:24 INFO - ##### Running clobber step. 10:58:24 INFO - ##### 10:58:24 INFO - Running pre-action listener: _resource_record_pre_action 10:58:24 INFO - Running main action method: clobber 10:58:24 INFO - rmtree: /builds/slave/test/build 10:58:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:58:25 INFO - Running post-action listener: _resource_record_post_action 10:58:25 INFO - ##### 10:58:25 INFO - ##### Finished clobber step (success) 10:58:25 INFO - ##### 10:58:25 INFO - ##### 10:58:25 INFO - ##### Running read-buildbot-config step. 10:58:25 INFO - ##### 10:58:25 INFO - Running pre-action listener: _resource_record_pre_action 10:58:25 INFO - Running main action method: read_buildbot_config 10:58:25 INFO - Using buildbot properties: 10:58:25 INFO - { 10:58:25 INFO - "project": "", 10:58:25 INFO - "product": "firefox", 10:58:25 INFO - "script_repo_revision": "production", 10:58:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:58:25 INFO - "repository": "", 10:58:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 10:58:25 INFO - "buildid": "20160607083033", 10:58:25 INFO - "pgo_build": "True", 10:58:25 INFO - "basedir": "/builds/slave/test", 10:58:25 INFO - "buildnumber": 775, 10:58:25 INFO - "slavename": "talos-linux64-ix-053", 10:58:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:58:25 INFO - "platform": "ubuntu64_hw", 10:58:25 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 10:58:25 INFO - "branch": "fx-team", 10:58:25 INFO - "repo_path": "integration/fx-team", 10:58:25 INFO - "revision": "2f0a8c420b18954e18b57993ea9c1a84190a0cb1", 10:58:25 INFO - "stage_platform": "linux64-pgo", 10:58:25 INFO - "builduid": "0a45dc501d7641f09c07992603701d75", 10:58:25 INFO - "slavebuilddir": "test" 10:58:25 INFO - } 10:58:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:58:25 INFO - Running post-action listener: _resource_record_post_action 10:58:25 INFO - ##### 10:58:25 INFO - ##### Finished read-buildbot-config step (success) 10:58:25 INFO - ##### 10:58:25 INFO - ##### 10:58:25 INFO - ##### Running download-and-extract step. 10:58:25 INFO - ##### 10:58:25 INFO - Running pre-action listener: _resource_record_pre_action 10:58:25 INFO - Running main action method: download_and_extract 10:58:25 INFO - mkdir: /builds/slave/test/build/tests 10:58:25 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')]} 10:58:25 INFO - https://queue.taskcluster.net/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:58:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:58:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:58:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN9B9UliRYeHHalwucsYXw/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 10:58:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN9B9UliRYeHHalwucsYXw/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 10:58:30 INFO - Downloaded 1361 bytes. 10:58:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:58:30 INFO - Using the following test package requirements: 10:58:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:58:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:58:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:58:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:30 INFO - u'jsshell-linux-x86_64.zip'], 10:58:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:58:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:58:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:58:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:58:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:58:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:58:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:58:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:58: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')]} 10:58:30 INFO - https://queue.taskcluster.net/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:58:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:58:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:58:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN9B9UliRYeHHalwucsYXw/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 10:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN9B9UliRYeHHalwucsYXw/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 10:58:32 INFO - Downloaded 24446032 bytes. 10:58:32 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'] 10:58:32 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 10:58:33 INFO - Return code: 0 10:58:33 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 10:58:33 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')]} 10:58:33 INFO - https://queue.taskcluster.net/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:58:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:58:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:58:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN9B9UliRYeHHalwucsYXw/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 10:58:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN9B9UliRYeHHalwucsYXw/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 10:58:41 INFO - Downloaded 24446032 bytes. 10:58:41 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'] 10:58:41 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 10:58:43 INFO - Return code: 0 10:58:43 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')]} 10:58:43 INFO - https://queue.taskcluster.net/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:58:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:58:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:58:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN9B9UliRYeHHalwucsYXw/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 10:58:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN9B9UliRYeHHalwucsYXw/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 10:58:44 INFO - Downloaded 10833369 bytes. 10:58:44 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'] 10:58:44 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 10:58:44 INFO - Return code: 0 10:58:44 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')]} 10:58:44 INFO - https://queue.taskcluster.net/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:58:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:58:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:58:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN9B9UliRYeHHalwucsYXw/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 10:58:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XN9B9UliRYeHHalwucsYXw/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 10:58:45 INFO - Downloaded 59192392 bytes. 10:58:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:58:45 INFO - mkdir: /builds/slave/test/properties 10:58:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:58:45 INFO - Writing to file /builds/slave/test/properties/build_url 10:58:45 INFO - Contents: 10:58:45 INFO - build_url:https://queue.taskcluster.net/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:58:46 INFO - Running post-action listener: _resource_record_post_action 10:58:46 INFO - Running post-action listener: set_extra_try_arguments 10:58:46 INFO - ##### 10:58:46 INFO - ##### Finished download-and-extract step (success) 10:58:46 INFO - ##### 10:58:46 INFO - ##### 10:58:46 INFO - ##### Running populate-webroot step. 10:58:46 INFO - ##### 10:58:46 INFO - Running pre-action listener: _resource_record_pre_action 10:58:46 INFO - Running main action method: populate_webroot 10:58:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:58:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:58:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:58:46 INFO - '--tppagecycles', 10:58:46 INFO - '7'], 10:58:46 INFO - 'tests': ['tsvgm']}}, 10:58:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:58:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:58:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:58:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:58:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:58:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:58:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:46 INFO - 'talos_options': ['--disable-e10s'], 10:58:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:58:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:58:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:46 INFO - 'talos_options': ['--disable-e10s'], 10:58:46 INFO - 'tests': ['damp', 'tps']}, 10:58:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:46 INFO - 'tests': ['damp', 'tps']}, 10:58:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:58:46 INFO - 'tests': ['dromaeo_dom']}, 10:58:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:58:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:58:46 INFO - 'tests': ['a11yr', 10:58:46 INFO - 'ts_paint', 10:58:46 INFO - 'tpaint', 10:58:46 INFO - 'sessionrestore', 10:58:46 INFO - 'sessionrestore_no_auto_restore', 10:58:46 INFO - 'tabpaint']}, 10:58:46 INFO - 'other-e10s': {'tests': ['a11yr', 10:58:46 INFO - 'ts_paint', 10:58:46 INFO - 'tpaint', 10:58:46 INFO - 'sessionrestore', 10:58:46 INFO - 'sessionrestore_no_auto_restore', 10:58:46 INFO - 'tabpaint']}, 10:58:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:58:46 INFO - 'ts_paint', 10:58:46 INFO - 'tpaint', 10:58:46 INFO - 'sessionrestore', 10:58:46 INFO - 'sessionrestore_no_auto_restore', 10:58:46 INFO - 'tabpaint']}, 10:58:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:58:46 INFO - 'ts_paint', 10:58:46 INFO - 'tpaint', 10:58:46 INFO - 'sessionrestore', 10:58:46 INFO - 'sessionrestore_no_auto_restore', 10:58:46 INFO - 'tabpaint']}, 10:58:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:58:46 INFO - 'tests': ['a11yr', 10:58:46 INFO - 'ts_paint', 10:58:46 INFO - 'tpaint', 10:58:46 INFO - 'sessionrestore', 10:58:46 INFO - 'sessionrestore_no_auto_restore', 10:58:46 INFO - 'tabpaint']}, 10:58:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:58:46 INFO - 'tests': ['a11yr', 10:58:46 INFO - 'ts_paint', 10:58:46 INFO - 'tpaint', 10:58:46 INFO - 'sessionrestore', 10:58:46 INFO - 'sessionrestore_no_auto_restore', 10:58:46 INFO - 'tabpaint']}, 10:58:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:58:46 INFO - 'tests': ['tsvgx', 10:58:46 INFO - 'tsvgr_opacity', 10:58:46 INFO - 'tart', 10:58:46 INFO - 'tscrollx', 10:58:46 INFO - 'cart']}, 10:58:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:58:46 INFO - 'tsvgr_opacity', 10:58:46 INFO - 'tart', 10:58:46 INFO - 'tscrollx', 10:58:46 INFO - 'cart']}, 10:58:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:46 INFO - 'talos_options': ['--disable-e10s'], 10:58:46 INFO - 'tests': ['tp5o']}, 10:58:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:46 INFO - 'tests': ['tp5o']}, 10:58:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:46 INFO - 'talos_options': ['--disable-e10s', 10:58:46 INFO - '--xperf_path', 10:58:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:58:46 INFO - 'tests': ['tp5n']}, 10:58:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:58:46 INFO - 'talos_options': ['--xperf_path', 10:58:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:58:46 INFO - 'tests': ['tp5n']}}, 10:58:46 INFO - 'talos.zip': {'path': '', 10:58:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:58:46 INFO - Running post-action listener: _resource_record_post_action 10:58:46 INFO - ##### 10:58:46 INFO - ##### Finished populate-webroot step (success) 10:58:46 INFO - ##### 10:58:46 INFO - ##### 10:58:46 INFO - ##### Running create-virtualenv step. 10:58:46 INFO - ##### 10:58:46 INFO - Running pre-action listener: _resource_record_pre_action 10:58:46 INFO - Running main action method: create_virtualenv 10:58:46 INFO - Creating virtualenv /builds/slave/test/build/venv 10:58:46 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 10:58:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:58:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:58:46 INFO - Using real prefix '/usr' 10:58:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:58:47 INFO - Installing distribute.............................................................................................................................................................................................done. 10:58:49 INFO - Installing pip.................done. 10:58:49 INFO - Return code: 0 10:58:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:58:49 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')]} 10:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:49 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')]} 10:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:49 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 0x7fb930e2bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2856110>, '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 0x27c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c26c0>, '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': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', '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 10:58:49 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 10:58:49 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 10:58:49 INFO - Using env: {'DISPLAY': ':0', 10:58:49 INFO - 'HOME': '/home/cltbld', 10:58:49 INFO - 'LANG': 'en_US.UTF-8', 10:58:49 INFO - 'LANGUAGE': 'en_US:en', 10:58:49 INFO - 'LOGNAME': 'cltbld', 10:58:49 INFO - 'MAIL': '/var/mail/cltbld', 10:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:49 INFO - 'MOZ_NO_REMOTE': '1', 10:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:49 INFO - 'NO_EM_RESTART': '1', 10:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:49 INFO - 'PWD': '/builds/slave/test', 10:58:49 INFO - 'SHELL': '/bin/bash', 10:58:49 INFO - 'SHLVL': '1', 10:58:49 INFO - 'TERM': 'linux', 10:58:49 INFO - 'TMOUT': '86400', 10:58:49 INFO - 'USER': 'cltbld', 10:58:49 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', 10:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:49 INFO - '_': '/tools/buildbot/bin/python'} 10:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:49 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 10:58:49 INFO - Cleaning up... 10:58:49 INFO - Return code: 0 10:58:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:58:49 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')]} 10:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:49 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')]} 10:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:49 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 0x7fb930e2bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2856110>, '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 0x27c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c26c0>, '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': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', '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 10:58:49 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 10:58:49 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 10:58:49 INFO - Using env: {'DISPLAY': ':0', 10:58:49 INFO - 'HOME': '/home/cltbld', 10:58:49 INFO - 'LANG': 'en_US.UTF-8', 10:58:49 INFO - 'LANGUAGE': 'en_US:en', 10:58:49 INFO - 'LOGNAME': 'cltbld', 10:58:49 INFO - 'MAIL': '/var/mail/cltbld', 10:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:49 INFO - 'MOZ_NO_REMOTE': '1', 10:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:49 INFO - 'NO_EM_RESTART': '1', 10:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:49 INFO - 'PWD': '/builds/slave/test', 10:58:49 INFO - 'SHELL': '/bin/bash', 10:58:49 INFO - 'SHLVL': '1', 10:58:49 INFO - 'TERM': 'linux', 10:58:49 INFO - 'TMOUT': '86400', 10:58:49 INFO - 'USER': 'cltbld', 10:58:49 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', 10:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:49 INFO - '_': '/tools/buildbot/bin/python'} 10:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:49 INFO - Downloading/unpacking psutil>=3.1.1 10:58:49 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 10:58:49 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 10:58:49 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 10:58:49 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 10:58:49 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 10:58:49 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 10:58:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:58:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:58:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:58:51 INFO - Installing collected packages: psutil 10:58:51 INFO - Running setup.py install for psutil 10:58:51 INFO - building 'psutil._psutil_linux' extension 10:58:51 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 10:58:51 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 10:58:51 INFO - building 'psutil._psutil_posix' extension 10:58:51 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 10:58:52 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 10:58:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:58:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:58:52 INFO - Successfully installed psutil 10:58:52 INFO - Cleaning up... 10:58:52 INFO - Return code: 0 10:58:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:58:52 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')]} 10:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:52 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')]} 10:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:52 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 0x7fb930e2bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2856110>, '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 0x27c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c26c0>, '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': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', '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 10:58:52 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 10:58:52 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 10:58:52 INFO - Using env: {'DISPLAY': ':0', 10:58:52 INFO - 'HOME': '/home/cltbld', 10:58:52 INFO - 'LANG': 'en_US.UTF-8', 10:58:52 INFO - 'LANGUAGE': 'en_US:en', 10:58:52 INFO - 'LOGNAME': 'cltbld', 10:58:52 INFO - 'MAIL': '/var/mail/cltbld', 10:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:52 INFO - 'MOZ_NO_REMOTE': '1', 10:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:52 INFO - 'NO_EM_RESTART': '1', 10:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:52 INFO - 'PWD': '/builds/slave/test', 10:58:52 INFO - 'SHELL': '/bin/bash', 10:58:52 INFO - 'SHLVL': '1', 10:58:52 INFO - 'TERM': 'linux', 10:58:52 INFO - 'TMOUT': '86400', 10:58:52 INFO - 'USER': 'cltbld', 10:58:52 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', 10:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:52 INFO - '_': '/tools/buildbot/bin/python'} 10:58:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:58:52 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 10:58:52 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 10:58:52 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 10:58:52 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 10:58:52 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 10:58:52 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 10:58:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:58:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:58:54 INFO - Installing collected packages: mozsystemmonitor 10:58:54 INFO - Running setup.py install for mozsystemmonitor 10:58:54 INFO - Successfully installed mozsystemmonitor 10:58:54 INFO - Cleaning up... 10:58:54 INFO - Return code: 0 10:58:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:58:54 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')]} 10:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:54 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')]} 10:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:54 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 0x7fb930e2bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2856110>, '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 0x27c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c26c0>, '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': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', '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 10:58:54 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 10:58:54 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 10:58:54 INFO - Using env: {'DISPLAY': ':0', 10:58:54 INFO - 'HOME': '/home/cltbld', 10:58:54 INFO - 'LANG': 'en_US.UTF-8', 10:58:54 INFO - 'LANGUAGE': 'en_US:en', 10:58:54 INFO - 'LOGNAME': 'cltbld', 10:58:54 INFO - 'MAIL': '/var/mail/cltbld', 10:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:54 INFO - 'MOZ_NO_REMOTE': '1', 10:58:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:54 INFO - 'NO_EM_RESTART': '1', 10:58:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:54 INFO - 'PWD': '/builds/slave/test', 10:58:54 INFO - 'SHELL': '/bin/bash', 10:58:54 INFO - 'SHLVL': '1', 10:58:54 INFO - 'TERM': 'linux', 10:58:54 INFO - 'TMOUT': '86400', 10:58:54 INFO - 'USER': 'cltbld', 10:58:54 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', 10:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:54 INFO - '_': '/tools/buildbot/bin/python'} 10:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:54 INFO - Downloading/unpacking jsonschema==2.5.1 10:58:54 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 10:58:54 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 10:58:54 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 10:58:54 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 10:58:54 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 10:58:54 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 10:58:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:58:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:58:56 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 10:58:56 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 10:58:56 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 10:58:56 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 10:58:56 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 10:58:56 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 10:58:56 INFO - Downloading functools32-3.2.3-2.tar.gz 10:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:58:56 INFO - warning: no files found matching '*.txt' 10:58:56 INFO - no previously-included directories found matching 'build' 10:58:56 INFO - no previously-included directories found matching 'dist' 10:58:56 INFO - no previously-included directories found matching '.git*' 10:58:56 INFO - Installing collected packages: jsonschema, functools32 10:58:56 INFO - Running setup.py install for functools32 10:58:57 INFO - warning: no files found matching '*.txt' 10:58:57 INFO - no previously-included directories found matching 'build' 10:58:57 INFO - no previously-included directories found matching 'dist' 10:58:57 INFO - no previously-included directories found matching '.git*' 10:58:57 INFO - Successfully installed jsonschema functools32 10:58:57 INFO - Cleaning up... 10:58:57 INFO - Return code: 0 10:58:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:58:57 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')]} 10:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:57 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')]} 10:58:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:57 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 0x7fb930e2bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2856110>, '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 0x27c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c26c0>, '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': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', '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 10:58:57 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 10:58:57 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 10:58:57 INFO - Using env: {'DISPLAY': ':0', 10:58:57 INFO - 'HOME': '/home/cltbld', 10:58:57 INFO - 'LANG': 'en_US.UTF-8', 10:58:57 INFO - 'LANGUAGE': 'en_US:en', 10:58:57 INFO - 'LOGNAME': 'cltbld', 10:58:57 INFO - 'MAIL': '/var/mail/cltbld', 10:58:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:57 INFO - 'MOZ_NO_REMOTE': '1', 10:58:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:57 INFO - 'NO_EM_RESTART': '1', 10:58:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:58:57 INFO - 'PWD': '/builds/slave/test', 10:58:57 INFO - 'SHELL': '/bin/bash', 10:58:57 INFO - 'SHLVL': '1', 10:58:57 INFO - 'TERM': 'linux', 10:58:57 INFO - 'TMOUT': '86400', 10:58:57 INFO - 'USER': 'cltbld', 10:58:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', 10:58:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:57 INFO - '_': '/tools/buildbot/bin/python'} 10:58:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:57 INFO - Downloading/unpacking blobuploader==1.2.4 10:58:57 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 10:58:57 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 10:58:57 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 10:58:57 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 10:58:57 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 10:58:57 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 10:58:59 INFO - Downloading blobuploader-1.2.4.tar.gz 10:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:58:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:58:59 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 10:58:59 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 10:58:59 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 10:58:59 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 10:58:59 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 10:58:59 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 10:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:58:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:58:59 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 10:58:59 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 10:58:59 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 10:58:59 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 10:58:59 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 10:58:59 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 10:58:59 INFO - Downloading docopt-0.6.1.tar.gz 10:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:59:00 INFO - Installing collected packages: blobuploader, requests, docopt 10:59:00 INFO - Running setup.py install for blobuploader 10:59:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:59:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:59:00 INFO - Running setup.py install for requests 10:59:00 INFO - Running setup.py install for docopt 10:59:00 INFO - Successfully installed blobuploader requests docopt 10:59:00 INFO - Cleaning up... 10:59:00 INFO - Return code: 0 10:59:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:00 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')]} 10:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:00 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')]} 10:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:00 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 0x7fb930e2bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2856110>, '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 0x27c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c26c0>, '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': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', '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 10:59:00 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 10:59:00 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 10:59:00 INFO - Using env: {'DISPLAY': ':0', 10:59:00 INFO - 'HOME': '/home/cltbld', 10:59:00 INFO - 'LANG': 'en_US.UTF-8', 10:59:00 INFO - 'LANGUAGE': 'en_US:en', 10:59:00 INFO - 'LOGNAME': 'cltbld', 10:59:00 INFO - 'MAIL': '/var/mail/cltbld', 10:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:00 INFO - 'MOZ_NO_REMOTE': '1', 10:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:00 INFO - 'NO_EM_RESTART': '1', 10:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:00 INFO - 'PWD': '/builds/slave/test', 10:59:00 INFO - 'SHELL': '/bin/bash', 10:59:00 INFO - 'SHLVL': '1', 10:59:00 INFO - 'TERM': 'linux', 10:59:00 INFO - 'TMOUT': '86400', 10:59:00 INFO - 'USER': 'cltbld', 10:59:00 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', 10:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:00 INFO - '_': '/tools/buildbot/bin/python'} 10:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:59:00 INFO - Running setup.py (path:/tmp/pip-7oU29V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:59:00 INFO - Running setup.py (path:/tmp/pip-6EP9ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:59:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:59:00 INFO - Running setup.py (path:/tmp/pip-gQj1Xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:59:01 INFO - Running setup.py (path:/tmp/pip-IBwFtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:59:01 INFO - Running setup.py (path:/tmp/pip-86093u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:59:01 INFO - Running setup.py (path:/tmp/pip-BDuZdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:59:01 INFO - Running setup.py (path:/tmp/pip-psdrNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:59:01 INFO - Running setup.py (path:/tmp/pip-u71qHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:59:01 INFO - Running setup.py (path:/tmp/pip-mSwmhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:59:01 INFO - Running setup.py (path:/tmp/pip-HWiHIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:59:01 INFO - Running setup.py (path:/tmp/pip-4ETKL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:59:01 INFO - Running setup.py (path:/tmp/pip-GTmq_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:59:01 INFO - Running setup.py (path:/tmp/pip-IGEIap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:59:01 INFO - Running setup.py (path:/tmp/pip-bI5cvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:01 INFO - Running setup.py (path:/tmp/pip-OV9fxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:59:01 INFO - Running setup.py (path:/tmp/pip-k0ybL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:59:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:59:01 INFO - Running setup.py (path:/tmp/pip-zOsveB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:59:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:59:02 INFO - Running setup.py install for manifestparser 10:59:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:59:02 INFO - Running setup.py install for mozcrash 10:59:02 INFO - Running setup.py install for mozdebug 10:59:02 INFO - Running setup.py install for mozdevice 10:59:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:59:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:59:02 INFO - Running setup.py install for mozfile 10:59:02 INFO - Running setup.py install for mozhttpd 10:59:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:59:02 INFO - Running setup.py install for mozinfo 10:59:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:59:02 INFO - Running setup.py install for mozInstall 10:59:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:59:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:59:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:59:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:59:02 INFO - Running setup.py install for mozleak 10:59:02 INFO - Running setup.py install for mozlog 10:59:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:59:03 INFO - Running setup.py install for moznetwork 10:59:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:59:03 INFO - Running setup.py install for mozprocess 10:59:03 INFO - Running setup.py install for mozprofile 10:59:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:59:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:59:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:59:03 INFO - Running setup.py install for mozrunner 10:59:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:59:03 INFO - Running setup.py install for mozscreenshot 10:59:03 INFO - Running setup.py install for moztest 10:59:03 INFO - Running setup.py install for mozversion 10:59:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:59:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:59:03 INFO - Cleaning up... 10:59:03 INFO - Return code: 0 10:59:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59: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')]} 10:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59: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')]} 10:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:03 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 0x7fb930e2bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2856110>, '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 0x27c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c26c0>, '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': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', '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 10:59:03 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 10:59:03 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 10:59:03 INFO - Using env: {'DISPLAY': ':0', 10:59:03 INFO - 'HOME': '/home/cltbld', 10:59:03 INFO - 'LANG': 'en_US.UTF-8', 10:59:03 INFO - 'LANGUAGE': 'en_US:en', 10:59:03 INFO - 'LOGNAME': 'cltbld', 10:59:03 INFO - 'MAIL': '/var/mail/cltbld', 10:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:03 INFO - 'MOZ_NO_REMOTE': '1', 10:59:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:03 INFO - 'NO_EM_RESTART': '1', 10:59:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:03 INFO - 'PWD': '/builds/slave/test', 10:59:03 INFO - 'SHELL': '/bin/bash', 10:59:03 INFO - 'SHLVL': '1', 10:59:03 INFO - 'TERM': 'linux', 10:59:03 INFO - 'TMOUT': '86400', 10:59:03 INFO - 'USER': 'cltbld', 10:59:03 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', 10:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:03 INFO - '_': '/tools/buildbot/bin/python'} 10:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:59:04 INFO - Running setup.py (path:/tmp/pip-I9jFkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:59:04 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)) 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:59:04 INFO - Running setup.py (path:/tmp/pip-SLUFjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:59:04 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)) 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:59:04 INFO - Running setup.py (path:/tmp/pip-ACzD2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:59:04 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)) 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:59:04 INFO - Running setup.py (path:/tmp/pip-5ZAC7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:59:04 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)) 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:59:04 INFO - Running setup.py (path:/tmp/pip-W3Nb7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:59:04 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)) 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:59:04 INFO - Running setup.py (path:/tmp/pip-CySAgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:59:04 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)) 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:59:04 INFO - Running setup.py (path:/tmp/pip-rxiV85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:59:04 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)) 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:59:04 INFO - Running setup.py (path:/tmp/pip-Ro0fIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:59:04 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)) 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:59:04 INFO - Running setup.py (path:/tmp/pip-tBSoW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:59:04 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)) 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:59:04 INFO - Running setup.py (path:/tmp/pip-UK2u5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:59:04 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)) 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:59:04 INFO - Running setup.py (path:/tmp/pip-D0avx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:59:04 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)) 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:59:04 INFO - Running setup.py (path:/tmp/pip-80A3Wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:59:04 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)) 10:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:59:04 INFO - Running setup.py (path:/tmp/pip-OSpgkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:59:05 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)) 10:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:59:05 INFO - Running setup.py (path:/tmp/pip-SY_Azs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:59:05 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)) 10:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:05 INFO - Running setup.py (path:/tmp/pip-ePjUbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:05 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)) 10:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:59:05 INFO - Running setup.py (path:/tmp/pip-gSuXu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:59:05 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)) 10:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:59:05 INFO - Running setup.py (path:/tmp/pip-IZRjL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:59:05 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)) 10:59:05 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)) 10:59:05 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)) 10:59:05 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)) 10:59:05 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)) 10:59:05 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)) 10:59:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:59: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 10:59: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 10:59: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 10:59: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 10:59: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 10:59: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 10:59:07 INFO - Downloading blessings-1.6.tar.gz 10:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:59:07 INFO - Installing collected packages: blessings 10:59:07 INFO - Running setup.py install for blessings 10:59:07 INFO - Successfully installed blessings 10:59:07 INFO - Cleaning up... 10:59:07 INFO - Return code: 0 10:59:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:59:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:59:07 INFO - Reading from file tmpfile_stdout 10:59:07 INFO - Current package versions: 10:59:07 INFO - argparse == 1.2.1 10:59:07 INFO - blessings == 1.6 10:59:07 INFO - blobuploader == 1.2.4 10:59:07 INFO - docopt == 0.6.1 10:59:07 INFO - functools32 == 3.2.3-2 10:59:07 INFO - jsonschema == 2.5.1 10:59:07 INFO - manifestparser == 1.1 10:59:07 INFO - mozInstall == 1.12 10:59:07 INFO - mozcrash == 0.17 10:59:07 INFO - mozdebug == 0.1 10:59:07 INFO - mozdevice == 0.48 10:59:07 INFO - mozfile == 1.2 10:59:07 INFO - mozhttpd == 0.7 10:59:07 INFO - mozinfo == 0.9 10:59:07 INFO - mozleak == 0.1 10:59:07 INFO - mozlog == 3.2 10:59:07 INFO - moznetwork == 0.27 10:59:07 INFO - mozprocess == 0.22 10:59:07 INFO - mozprofile == 0.28 10:59:07 INFO - mozrunner == 6.11 10:59:07 INFO - mozscreenshot == 0.1 10:59:07 INFO - mozsystemmonitor == 0.3 10:59:07 INFO - moztest == 0.7 10:59:07 INFO - mozversion == 1.4 10:59:07 INFO - psutil == 3.1.1 10:59:07 INFO - requests == 1.2.3 10:59:07 INFO - wsgiref == 0.1.2 10:59:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:07 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')]} 10:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:07 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')]} 10:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:07 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 0x7fb930e2bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2856110>, '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 0x27c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c26c0>, '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': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', '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 10:59:07 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 10:59:07 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 10:59:07 INFO - Using env: {'DISPLAY': ':0', 10:59:07 INFO - 'HOME': '/home/cltbld', 10:59:07 INFO - 'LANG': 'en_US.UTF-8', 10:59:07 INFO - 'LANGUAGE': 'en_US:en', 10:59:07 INFO - 'LOGNAME': 'cltbld', 10:59:07 INFO - 'MAIL': '/var/mail/cltbld', 10:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:07 INFO - 'MOZ_NO_REMOTE': '1', 10:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:07 INFO - 'NO_EM_RESTART': '1', 10:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:07 INFO - 'PWD': '/builds/slave/test', 10:59:07 INFO - 'SHELL': '/bin/bash', 10:59:07 INFO - 'SHLVL': '1', 10:59:07 INFO - 'TERM': 'linux', 10:59:07 INFO - 'TMOUT': '86400', 10:59:07 INFO - 'USER': 'cltbld', 10:59:07 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', 10:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:07 INFO - '_': '/tools/buildbot/bin/python'} 10:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:07 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)) 10:59:07 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)) 10:59:07 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)) 10:59:07 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)) 10:59:07 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)) 10:59:07 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)) 10:59:07 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)) 10:59:07 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)) 10:59:07 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)) 10:59:07 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)) 10:59:07 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)) 10:59:07 INFO - Cleaning up... 10:59:07 INFO - Return code: 0 10:59:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:59:07 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')]} 10:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:07 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')]} 10:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:07 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 0x7fb930e2bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2856110>, '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 0x27c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c26c0>, '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': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', '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 10:59:07 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 10:59:07 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 10:59:07 INFO - Using env: {'DISPLAY': ':0', 10:59:07 INFO - 'HOME': '/home/cltbld', 10:59:07 INFO - 'LANG': 'en_US.UTF-8', 10:59:07 INFO - 'LANGUAGE': 'en_US:en', 10:59:07 INFO - 'LOGNAME': 'cltbld', 10:59:07 INFO - 'MAIL': '/var/mail/cltbld', 10:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:07 INFO - 'MOZ_NO_REMOTE': '1', 10:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:07 INFO - 'NO_EM_RESTART': '1', 10:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:07 INFO - 'PWD': '/builds/slave/test', 10:59:07 INFO - 'SHELL': '/bin/bash', 10:59:07 INFO - 'SHLVL': '1', 10:59:07 INFO - 'TERM': 'linux', 10:59:07 INFO - 'TMOUT': '86400', 10:59:07 INFO - 'USER': 'cltbld', 10:59:07 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', 10:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:07 INFO - '_': '/tools/buildbot/bin/python'} 10:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:59:08 INFO - Cleaning up... 10:59:08 INFO - Return code: 0 10:59:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:59:08 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')]} 10:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:08 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')]} 10:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:08 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 0x7fb930e2bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27c4190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2856110>, '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 0x27c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c26c0>, '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': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', '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 10:59:08 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 10:59:08 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 10:59:08 INFO - Using env: {'DISPLAY': ':0', 10:59:08 INFO - 'HOME': '/home/cltbld', 10:59:08 INFO - 'LANG': 'en_US.UTF-8', 10:59:08 INFO - 'LANGUAGE': 'en_US:en', 10:59:08 INFO - 'LOGNAME': 'cltbld', 10:59:08 INFO - 'MAIL': '/var/mail/cltbld', 10:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:08 INFO - 'MOZ_NO_REMOTE': '1', 10:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:08 INFO - 'NO_EM_RESTART': '1', 10:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:08 INFO - 'PWD': '/builds/slave/test', 10:59:08 INFO - 'SHELL': '/bin/bash', 10:59:08 INFO - 'SHLVL': '1', 10:59:08 INFO - 'TERM': 'linux', 10:59:08 INFO - 'TMOUT': '86400', 10:59:08 INFO - 'USER': 'cltbld', 10:59:08 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', 10:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:08 INFO - '_': '/tools/buildbot/bin/python'} 10:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:08 INFO - Downloading/unpacking flake8 10:59: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 10:59: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 10:59: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 10:59: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 10:59: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 10:59: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 10:59:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:59:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:59:10 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 10:59:10 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 10:59:10 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 10:59:10 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 10:59:10 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 10:59:10 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 10:59:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:59:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:59:10 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 10:59:10 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 10:59:10 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 10:59:10 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 10:59:10 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 10:59:10 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 10:59:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:59:10 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 10:59:10 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 10:59:10 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 10:59:10 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 10:59:10 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 10:59:10 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 10:59:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:59:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:59:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:59:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:59:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:59:10 INFO - no previously-included directories found matching 'docs/_build' 10:59:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:59:11 INFO - Running setup.py install for pep8 10:59:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:59:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:59:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:59:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:59:11 INFO - no previously-included directories found matching 'docs/_build' 10:59:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:59:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:59:11 INFO - Cleaning up... 10:59:11 INFO - Return code: 0 10:59:11 INFO - Running post-action listener: _resource_record_post_action 10:59:11 INFO - Running post-action listener: _start_resource_monitoring 10:59:11 INFO - Starting resource monitoring. 10:59:11 INFO - ##### 10:59:11 INFO - ##### Finished create-virtualenv step (success) 10:59:11 INFO - ##### 10:59:11 INFO - ##### 10:59:11 INFO - ##### Running install step. 10:59:11 INFO - ##### 10:59:11 INFO - Running pre-action listener: _resource_record_pre_action 10:59:11 INFO - Running main action method: install 10:59:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:59:11 INFO - Reading from file tmpfile_stdout 10:59:11 INFO - Detecting whether we're running mozinstall >=1.0... 10:59:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:59:11 INFO - Reading from file tmpfile_stdout 10:59:11 INFO - Output received: 10:59:11 INFO - Usage: mozinstall [options] installer 10:59:11 INFO - Options: 10:59:11 INFO - -h, --help show this help message and exit 10:59:11 INFO - -d DEST, --destination=DEST 10:59:11 INFO - Directory to install application into. [default: 10:59:11 INFO - "/builds/slave/test"] 10:59:11 INFO - --app=APP Application being installed. [default: firefox] 10:59:11 INFO - mkdir: /builds/slave/test/build/application 10:59:11 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'] 10:59:11 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 10:59:28 INFO - Reading from file tmpfile_stdout 10:59:28 INFO - Output received: 10:59:28 INFO - /builds/slave/test/build/application/firefox/firefox 10:59:28 INFO - Running post-action listener: _resource_record_post_action 10:59:28 INFO - ##### 10:59:28 INFO - ##### Finished install step (success) 10:59:28 INFO - ##### 10:59:28 INFO - ##### 10:59:28 INFO - ##### Running run-tests step. 10:59:28 INFO - ##### 10:59:28 INFO - Running pre-action listener: _resource_record_pre_action 10:59:28 INFO - Running main action method: run_tests 10:59:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:59:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:59:28 INFO - Python 2.7.3 10:59:28 INFO - Return code: 0 10:59:28 INFO - grabbing minidump binary from tooltool 10:59: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')]} 10:59:28 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 0x2856110>, '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 0x27c2230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27c26c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:59:28 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 10:59:28 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 10:59:28 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 10:59:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:59:28 INFO - Return code: 0 10:59:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:59:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:59:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:59:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:59:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:59:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:59:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:59:29 INFO - Return code: 0 10:59:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 10:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 10:59:29 INFO - Using env: {'DISPLAY': ':0', 10:59:29 INFO - 'HOME': '/home/cltbld', 10:59:29 INFO - 'LANG': 'en_US.UTF-8', 10:59:29 INFO - 'LANGUAGE': 'en_US:en', 10:59:29 INFO - 'LOGNAME': 'cltbld', 10:59:29 INFO - 'MAIL': '/var/mail/cltbld', 10:59:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:59:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:29 INFO - 'MOZ_NO_REMOTE': '1', 10:59:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:29 INFO - 'NO_EM_RESTART': '1', 10:59:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:29 INFO - 'PWD': '/builds/slave/test', 10:59:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:59:29 INFO - 'SHELL': '/bin/bash', 10:59:29 INFO - 'SHLVL': '1', 10:59:29 INFO - 'TERM': 'linux', 10:59:29 INFO - 'TMOUT': '86400', 10:59:29 INFO - 'USER': 'cltbld', 10:59:29 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086', 10:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:29 INFO - '_': '/tools/buildbot/bin/python'} 10:59:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 10:59:29 INFO - mozversion application_buildid: 20160607083033 10:59:29 INFO - mozversion application_changeset: 2f0a8c420b18954e18b57993ea9c1a84190a0cb1 10:59:29 INFO - mozversion application_display_name: Nightly 10:59:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:59:29 INFO - mozversion application_name: Firefox 10:59:29 INFO - mozversion application_remotingname: firefox 10:59:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:59:29 INFO - mozversion application_vendor: Mozilla 10:59:29 INFO - mozversion application_version: 50.0a1 10:59:29 INFO - mozversion platform_buildid: 20160607083033 10:59:29 INFO - mozversion platform_changeset: 2f0a8c420b18954e18b57993ea9c1a84190a0cb1 10:59:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:59:29 INFO - mozversion platform_version: 50.0a1 10:59:29 INFO - using testdate: 1465322369 10:59:29 INFO - actual date: 1465322369 10:59:29 INFO - starting webserver on 'localhost:60569' 10:59:29 INFO - SUITE-START | Running 2 tests 10:59:29 INFO - TEST-START | dromaeo_css 10:59:29 INFO - operating with platform_type : linux_ 10:59:29 INFO - Initialising browser for dromaeo_css test... 10:59:29 INFO - TEST-INFO | started process 28666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPzz2l7/profile http://localhost:60569/getInfo.html) 10:59:33 INFO - PROCESS | 28666 | __metrics Screen width/height:1600/1200 10:59:33 INFO - PROCESS | 28666 | colorDepth:24 10:59:33 INFO - PROCESS | 28666 | Browser inner width/height: 1024/697 10:59:33 INFO - PROCESS | 28666 | __metrics 10:59:34 ERROR - PROCESS | 28666 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:59:35 INFO - PROCESS | 28666 | console.error: PushService: 10:59:35 INFO - PROCESS | 28666 | stateChangeProcessEnqueue: Error transitioning state 10:59:35 INFO - PROCESS | 28666 | UnknownError 10:59:35 INFO - TEST-INFO | 28666: exit 0 10:59:35 INFO - Browser initialized. 10:59:35 INFO - Running cycle 1/1 for dromaeo_css test... 10:59:35 INFO - TEST-INFO | started process 28747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPzz2l7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:59:47 INFO - PROCESS | 28747 | RSS: Main: 156016640 10:59:47 INFO - PROCESS | 28747 | 11:00:38 INFO - PROCESS | 28747 | 1465322438547 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] 11:02:47 INFO - PROCESS | 28747 | Cycle 1(1): loaded http://localhost:60569/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60569/tests/dromaeo/cssquery-ext.html) 11:02:48 INFO - PROCESS | 28747 | RSS: Main: 253923328 11:02:48 INFO - PROCESS | 28747 | 11:05:50 INFO - PROCESS | 28747 | Cycle 1(1): loaded http://localhost:60569/tests/dromaeo/cssquery-ext.html (next: http://localhost:60569/tests/dromaeo/cssquery-jquery.html) 11:05:51 INFO - PROCESS | 28747 | RSS: Main: 254705664 11:05:51 INFO - PROCESS | 28747 | 11:08:53 INFO - PROCESS | 28747 | Cycle 1(1): loaded http://localhost:60569/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60569/tests/dromaeo/cssquery-mootools.html) 11:08:54 INFO - PROCESS | 28747 | RSS: Main: 246976512 11:08:54 INFO - PROCESS | 28747 | 11:11:56 INFO - PROCESS | 28747 | Cycle 1(1): loaded http://localhost:60569/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60569/tests/dromaeo/cssquery-prototype.html) 11:11:56 INFO - PROCESS | 28747 | RSS: Main: 246251520 11:11:56 INFO - PROCESS | 28747 | 11:14:59 INFO - PROCESS | 28747 | Cycle 1(1): loaded http://localhost:60569/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60569/tests/dromaeo/cssquery-yui.html) 11:14:59 INFO - PROCESS | 28747 | RSS: Main: 207904768 11:14:59 INFO - PROCESS | 28747 | 11:18:02 INFO - PROCESS | 28747 | Cycle 1(1): loaded http://localhost:60569/tests/dromaeo/cssquery-yui.html (next: http://localhost:60569/tests/dromaeo/cssquery-dojo.html) 11:18:02 INFO - PROCESS | 28747 | RSS: Main: 299319296 11:18:02 INFO - PROCESS | 28747 | 11:18:02 INFO - PROCESS | 28747 | __start_tp_report 11:18:02 INFO - PROCESS | 28747 | _x_x_mozilla_page_load 11:18:02 INFO - PROCESS | 28747 | _x_x_mozilla_page_load_details 11:18:02 INFO - PROCESS | 28747 | |i|pagename|runs| 11:18:02 INFO - PROCESS | 28747 | |0;dojo.html;3171.2547551325433;3174.4286028514857;3176.729977951874;3216.951745723813;3234.9029529114136;5251.264822924793;5306.442823503525;5351.2775775270375;5413.539849112825;5465.0982587873;5305.65513241639;5371.57027437805;5377.542908852753;5425;5426.050441172789;4922.360093187881;4925;4928;5035.967626636549;5039.496050394968;5015.824446144386;5032.924506132411;5039.31969184161;5046.6719663221775;5077.822276220333;4800;4847.830325938575;4980.726060066713;4998.2752500887345;5042.546170844624;4913.803447862081;4914;4918.188498897677;4919.7540122993705;4922.433920099199;4817.879553011167;4879.829205977774;4896.436909755353;4897.632677549198;4899.902001959941;5291.603129765283;5392.541633961118;5395.271638328814;5402.189671549259;5424;5812.767489300423;5844.766209351664;5845.620034697731;5846.561507886883;5864.266966629171;5695.572832037614;5833.679147646878;5842.152887831241;5890.410958904075;5898.056310990221;5511.145772405243;5631.802886898939;5647.29408823897;5650.802221922254;5652.9152062719095;6069.302244476016;6085.513158947274;6085.965385884322;6108.08378743192;6140.938590614126;5563.944360556424;5682.687452190086;5712.971435142881;5851.853703657443;5900.852478687982;5833.358330583633;5873.177755114288;5912.054071348563;5928.911066334009;5929.318128415288;5820.82537523875;5847.532197424196;5851.531877449794;5856.033754430557;5858.355580886099;5599.524040456526;5678.290213723285;5725;5738.942610573924;5850.765969361178;4427.335899615019;4432.246518091933;4437.134758722083;4470.575295346936;4477.2164871147415;3951.1702542466405;3967.940480892731;3987.182627561343;3996.3406038003404;4019.83920643171;5265.973670131625;5284.550813180846;5395;5397.8380648580605;5415.891682166413;5893.5579831512805;5895.056790913519;5897.67562784051;5903.940960590425;5951.970240148771;5478.835634930959;5486.862828429321;5489.149181876815;5500.779968801203;5505.889882202334;4916.827911023169;4986.152354099811;5018.096742586296;5030.773615187325;5057.974710126426;6019.127226552126;6073.119397687399;6080.0879868019265;6080.300765411946;6087.147799308101;5874.735636896436;5882.205902203319;5898.734556944862;5917.497012753792;5918.348981611933;5876.853078672896;5902.586818922634;5943.108533719977;5944.227250457413;6024.427679370453;5715.257016587817;5729.713514324184;5742.626729262584;5748.568857335633;5763.308402991668;5610.158476228598;5838.678872661874;5851.034579294539;5856.267966504187;5868.5305175585;5637.8590535236945;5683.829485115453;5689.800856969986;5731.369549349652;5735.942640573708;5720.856978575569;5721.227634269487;5721.370649228665;5723.084306510938;5732.025555655465;5425.755840987086;5432.619716619799;5612.85967850807;5623.634463759842;5628.155776633538;5603.80386686464;5734.684592347461;5737.225474560881;5742.59801813869;5743.1385292206505;5530.446955304437;5558.583106267127;5558.666480011212;5563.499285064364;5620.325560932714 11:18:02 INFO - PROCESS | 28747 | |1;ext.html;615.4399496458223;622.9190205273313;635.1267007864187;646.4666650013739;651.8370407398147;41441.79279103604;43293.78353108234;43622;47883;48079.75960120194;46610.76694616522;47153.056938861206;47175.76412117943;47260.52739472604;47295.52704472954;8019.719309824157;8814.86777698335;9047.864282035742;9055.185033346997;10421.791564168712;10370.222233332492;10831.24181307305;10837.67486975392;10845.457727113651;10848.620298289561;10875.564977400894;10954.890451095507;10956.12351011921;10960.890391096107;10967.945160274227;8156.469829461095;10536.525856336406;10761.461926903623;10773.730656733565;10842.72893177669;10642.946785266024;10756.300840445347;10759.193060520493;10760.139188864872;10770.946145269301;41417.792911035554;41562;41835.790821046;41878.581214188074;41911.37132943008;3592.7844329340323;3617.1680513481783;3715.851365945359;4023.839046438139;4042.6361627453375;32388.352232955443;32499.187520311945;32834;32918.177045573815;33015;4435.933460998088;4472.776361181928;4485.820567177309;4537.795799189044;4610.838620648295;244904.99999999822;247349;247377;248183;248277;59526.70236648876;59609.701951489966;59942.70028649916;59959.2032637388;59966;35863.10342241465;36490.087747806516;36540.26919461596;38805;63264.683676582245;17532;17532.82467175312;17642.558936026446;17653.735193971843;17672.646547068987;12482;13370.130941488773;13768.518101866586;13782.862171378358;14088.647783805282;19880.50298742514;19903.203871845253;19926.800731992495;19984.90007549953;20027.399178024683;7257.8548429031125;7308.993339562417;7355.705771769176;7477.70089196426;7517.932568543694;1007.7631756537207;1012.7468132966758;1040.942748148844;1068.2041878800187;1092.792369449802;31781.682183178335;32254.83872580669;32414.513782293285;32732.509012364833;32953.67046329506;1119.8432219489277;1130.1749722702473;1161.4425075963584;1191.3149938785234;1257.3775980889518;16855.747163792552;16890;17017.149142543072;17182.312707491812;17358.13209339528;589221;592397;592549;593169;596047;58605;58988.70505647444;59140.11289830656;59140.11289830656;59286.70356648189;1269.3780047776522;1349.8312710911136;1353.5262658069794;1407.5214427094836;1416.6895621550232;30501.847490762404;32360.676393235768;32368.792057032435;32732.509012364357;33077;49788.75105624449;50364.49635503598;50382.2442663353;50487;50502;456245;459644;460897;461979;486502;27710;28543.14370568886;28653.713462865937;30009.3998120032;30010.24974375658;46359.536404635524;46849.53150468451;47016.529834701214;47929;48159.5184048169;39793.40309895412;40099.1980160401;40111.39832902567;43668.34497482604;44848.32727509155;39634;40481.797591011855;41121.38317925293;41802.58197417987;42594.36108458437;41864;41992.79003604963;42517;43402.782986084865;43544.129117416844;34397.312053759284;36361;36649.267014659024;36805.44791828071;37200.44199336958;27167.592486112328;27828.72171278261;27910.44179116447;28168.43663126685;28351.71648283491 11:18:02 INFO - PROCESS | 28747 | |2;jquery.html;375.5962340483979;387.7430646206211;394.773005521825;395.436502983249;411.2351027089613;17696;18875.811241887575;19228.327008554705;19285.614287714256;19457;17743.73384399235;17880.731789023175;18307;18326;18468.907655461702;5501.889962200774;5584.4136365681625;5720.79977200798;5767.36558978512;5805.042168042268;5783.161441590967;5789.739461724212;5812.505936995361;5821.243238379005;5823.505002074829;5491.395946445888;5770.19217309577;5775.797847075353;5814.4185581441725;5817.680027598481;5647.774089036413;5693.544516438696;5702.0021496238405;5709.0580054290995;5733.799317023905;5412.621116521845;5670.716464176775;5705.686187259699;5711.02912504871;5715.399883012307;12388.504459821595;12656.240625562403;12665.303408312539;20010;21154.15383384678;2163.935081947544;2193.802557769792;2327.5461285049423;2328.836981411302;2699.8650067496546;9750.90249097514;9767;9791.608335666564;10200.438975856325;10246.6413675521;1871.756671632679;1932.2657390191778;1942.1260432805152;1988.2643421933833;1998.7601487821555;74029;83316;83788;88705;90962.54518727364;10425.895741042645;10809.83785243222;10814.971807893802;10838.349699018085;10985.176111791647;14957.102573845605;15001;15049.54851354461;15087.773683394758;15090.094594324375;7964.402669799672;8230.42387032914;8287.254147126787;8399.790005249795;8413.116622754646;8025.197480251928;8056.315213206943;8074.82914977325;8201.548914809742;8268.8346233075;4499.34759459883;4620.630349572026;4621.491635920046;4641.814327426932;4697.7651117444675;1774.5918438759159;1859.5072305838964;1919.1555715485142;1948.1915005272936;1954.5993071420326;868.4181598329009;944.2776276148752;972.8735264415723;1045.9529321180564;1075.7794652096302;18122.63754724898;18378;18388.540286492676;18506.537336566693;18848.52878678044;979.5689896445683;993.3493561717087;994.8457989011715;1011.6256984915628;1050.847627094067;10327.173826093895;10605.734856628646;10665.9466702666;10677.305975111749;10687.732806679895;472142;474387;475503;476532;477610;94188.52905735564;96476.51761741287;96880.51559742156;97385.5130724356;97514;998.286225348879;1001.9599216031423;1018.251585084962;1023.0281232828694;1028.3983869436313;15949;16401.42595009169;16445;16689.332426702797;16836.410725624544;31693.683063169072;33611.49582756309;41383.37924931189;42351.1529769409;42502.14995700007;53129.734351328;56060;56111.71944140253;56575.71712141413;56874.7156264216;8265.380096492907;8361.623726932425;8532.402731808714;8682;8821.161989610977;9483.336166468282;10420.635277765241;12528.911912956917;13199.934000329937;13219.206847589176;8270.793230169053;11785.410729463663;11868.347240901834;12005;12127.151099423309;11716.121290903046;11919.880801192225;11935;12016;12345.444454999726;11652.184347095623;12296.50813967467;12315.706850780898;12323.75352492963;12388.318642474751;7479.401647868266;8507.489550626982;8705.869411958953;8999.370044097112;9007.684731034382;11558.653240402802;11662.300261984308;11678.824817627912;11712.063034957013;11765.352905589933 11:18:02 INFO - PROCESS | 28747 | |3;mootools.html;1319.0898280186677;1481.87404070654;1495.2673190136834;1638.3774165816988;1783.2510345654816;7960.601969901503;8325;8333.499990000604;8337.499750014997;8542.829143417128;7851.725189618364;8005.439619226657;8265.173482651748;8273.710420135296;8281.130481299468;2036.3280117561244;2271.681964524968;2285.0859656137595;2341.391238278043;2353.599888019041;2368.846025008369;2372.6559648850994;2375.2517956843626;2378.7502312257225;2378.845375050616;2309.7459279479244;2317.455397981473;2333.6149535326736;2336.5560543496767;2337.275444612167;1908.332083770683;2185.267935241696;2193.7367515898113;2262.061244583496;2267.025179172955;2312.479692069288;2315.6526521021815;2334.579775640384;2335.97664023361;2336.719593648773;8509.48943063412;8558.443701159405;8567.100454452317;8579.399442039059;8581.570921453966;5094.668846525001;5255.684658920477;5257.631965762398;5258.158694608883;5262.8684282892855;3204.583404157468;3343.164208947763;3364.8485818138242;3403.2002479417315;3404.114930118187;1113.4822307626991;1122.5341483284428;1157.2767020612118;1157.8321143434155;2047.6518991771434;11442.084633229322;11960.820587691192;11977.580784672495;11988.880111198863;11989.580364687281;4728.645351598644;4733.928991065137;4759.809607615656;4767.404074490689;4848.636352273523;10137.746556336151;10262;10271.332363396356;10295.330803497749;10305.639302624371;5335.146376579729;5379.193121031876;5400.540954018874;5400.91898621521;5401.783928642811;4268.573142685768;4672.229082201467;4829.830955916596;4839.564439200489;4919.0407870464915;3950.4074388841905;4002.3196056670436;4030.831058992859;4091.8772436826944;4109.075458021921;1256.723520825417;1271.5994461744706;1287.7553264879643;1295.2940647347218;1301.7136230029569;886.4592598514901;941.2846236859899;941.8963913969458;945.163530275711;960.582146766159;5566.025945459528;5631.94697465023;5690.374058853523;5822.475977161991;5913.172155898178;906.859436787299;921.7050543825911;956.2159029595665;1005.2259759984771;1017.8829434614966;3697.1681371691157;3865.0530619997717;3955.5846636102797;3967.285888540033;3996.7402118862183;10436.165106791439;10750.247482676294;10802.459877006118;10802.567897284178;10816.891831081746;10434.68695939123;10674.946625266824;10692.305000174963;10769.353838769699;10773.138148948065;7814.492058016211;7822.06135263772;7897.05235371759;7928.246816552533;7958.04503459577;5483.61614686984;5508.55931525485;5584.525315348241;5587.525060369914;5652;9804.068613481708;9876.259280553844;9974.950125249326;9990.350627209207;9995;9920.702378928643;9999.800004000024;10045.748856278651;10308.536115874653;10347.379157250589;6505.674716264262;6707.396334329934;6710.4631629470505;7226.096737907762;7361.006264154271;7825.5304681717;8070.677172913018;8323.167683231628;8345.95827020861;8615.784605384664;7482.438817088849;7621.580813055335;7638.541687498768;7694.615269236628;7697.076350837935;7209.3872020876715;7211.2428195038765;7263.309985551364;7366.852662946604;7395.260473952777;6862.451003919575;6868.9313106870295;6926.757563485254;6947.687354068978;6974;5038.093143234253;5127;5137.33214682089;5206.73966301691;5225.555827754683;4842.297866809364;4863.708177509361;4906.362172917497;4942.728149951788;4945.159322915041 11:18:02 INFO - PROCESS | 28747 | |4;prototype.html;322.11257984253393;332.80530889429684;335.4816808031591;337.5004992610934;339.27733926736056;5210.505002024802;5228.503292187245;5300.204969254613;5336.146216605344;5347.54545863602;5256.894862102765;5274.4198138204865;5280.445553216915;5297.417284098756;5340.359156901168;4144.23331683638;4174.874753757392;4183.6025577570235;4197.286461301586;4198.748075115487;3892.046448620078;4005.638083051762;4159.211539038212;4198.8320467181275;4207.768572728514;4137.110521237933;4158.08522125132;4169.520505141902;4169.7907606794;4172.582741725818;4094.7274262784144;4130.277201489727;4146.3365861462025;4157.792110394484;4167.354060120686;3449.5688038995127;3724.6647801697704;3733.2720119576693;3738.3831667774784;3754.455603937441;5061.659304858776;5089.847304580869;5100.515451032146;5101.668391554575;5140.563052140536;4679.479169269966;4685.203515402356;4688.601468875149;4694.694844835075;4748.382710247645;5385.138377859524;5474.39781624021;5512.751926163332;5545.417731138213;5546.694931778791;3962.93000889761;3974;3977.7016723745546;4003.079291762882;4010.177913527749;5744.626599271034;5761.84763047388;5785.884282314372;5796.50729687977;5844.152597873327;3997.780122093313;4105.014796448831;4109.438413402888;4122.9381559276635;4124.505059392892;4141.482314710661;4144.865394321927;4157.91684166321;4159.875203743893;4168.24971505132;4742.19382704941;4752.78803905002;4761.4524329701835;4782.354382158364;4808.687435316763;5519.116941289374;5610.85972850682;5626.212330273765;5653.095504719226;5694.288213973254;1418.7800890861934;1421.9146851188755;1432.9641758955902;1437.2741765408402;1438.8848892088608;879.8988116366572;890.8774943571148;904.9864052483304;919.9080091990747;931.3992474853682;4765.284497580868;4769.379980602499;4799.232122860326;4802.951970480321;4809.615230781529;5046.419661738873;5069.465267366317;5078.156232509807;5100.515451032146;5107.642465027412;4755.643326750507;4786.707588950963;4793.640476964241;4843.903121937541;4990.6506544541535;3030.1364111228195;3031.7119873611973;3033.226527235585;3040.863161157753;3044.75641948648;5907.793227237026;5912.674802885796;5914.728333408338;5923.696786706918;5926.762929482858;5579.330480342385;5793;5819.719661674425;5830.3586605473365;5845.210896528914;5822.301323841166;5835.708214589254;5862.472377486047;5887.76448942046;5900.704964751745;5418.455740114048;5673.234113394639;5738.684372359393;5759.366469688414;5763.221965034834;5686.4029276926985;5709.628874123168;5715.342735585461;5719.57103217252;5724.79963201286;5877.647341159544;5881.5588830837005;5897.823065308047;5906.793262235801;5914.970425147847;3668.596454390068;3874.767513949172;4023.3964905264443;4037.8990525237105;4071.959280407158;5684.8010319638615;5688.715564221689;5701.857453563694;5707.971460142839;5709.65742055478;5558.694271815089;5561.833145005657;5572.832815015394;5576.804811831566;5602.299712535933;5339.546138578265;5589.972050139723;5591.748371323219;5627.380988091225;5633.8309850704545;5514.228008078792;5517.675757818175;5519.571388589008;5545.639533430314;5549.7780088796;5342.9465705342445;5658.915116273177;5661.405552416937;5692.886142277049;5698.943010569841;5476.385585513542;5487.573230959899;5514.338279406497;5530.198121272473;5532.482720362306 11:18:02 INFO - PROCESS | 28747 | |5;yui.html;725.263857184957;757.2162811490109;761.3300295739748;814.6537721468376;858.3219256787137;15723.135227562494;16023.670650093207;16462.423815166472;16578.336866525326;16602.335906563723;14531.636709082251;14583.781243281359;14711.852881471183;14722.116672999628;14814.777778333333;684.9794506164798;804.3364224514769;805.3114587028094;827.983440331193;829.9792505187359;808.1796976069294;808.7654580171773;810.0441479054713;810.469142711522;814.8777683347515;842.6545116502235;843.5950743643025;844.4933040175907;846.1622993236713;848.4103548034119;704.8766465868453;837.0750320895414;850.961706723199;852.4203541591716;856.5973992223645;622.5175488996019;623.2832242920632;623.2925629410606;623.5728525959732;623.6569886562372;14883.404663813435;14958.62603434912;15007.324670389859;15025.924870375688;15038.172900490577;13608.38762255701;13754.65613359664;13754.862451375458;13982.761797115003;14080.92959535206;12493.375331233401;12675.366231688378;12740.299283539402;12833.607661974065;12949.676258093528;3757.511523501927;3815.4086116651965;3835.884923452301;3851.4030325299623;3949.861754838567;50255.74872125616;50312.24531632029;50417.74791126057;50456.74771626118;50647.493525064645;11093.833592495957;11269.94365028186;11383.88616113845;11462.48418821155;11627.941860290644;20452.38642840717;20475.795242047687;20482.283120091022;20519.17923283052;20561.38315850527;8308.70919517814;8430.831383372299;8439.113893041142;8487.278581320534;8606.483610983361;4722.669413141047;4785.760711964388;4858.05267972749;4874.317595536628;4999.125153098194;3479.460683594047;3614.945775813365;3627.038834708804;3628;3630.074331045619;577.206341280739;646.6508085633799;651.7067319706151;652.6997581112741;690.8514669346115;634.1660716158237;689.7310049080862;723.4357201382929;765.7664412354285;799.2167675677869;9850.80298394028;10974.428612794578;11187.832182517268;11233.775324493465;11423.657290281139;632.4529282170981;688.9242183359827;693.719043787267;771.8803585444265;806.2058872011064;4843.854684359475;5057.291979122926;5073.239014147907;5099.413567439718;5264.289320941624;73347;123487;127266;128114;131568;78180.60909695529;98596;101446.49276753717;103048.48475757573;106212.46893765636;71024;82814.58592706997;84046.57976710077;85967.14032859591;86246.56876715702;9639.807203856024;9935.304528682922;9950.402975821475;10009.849852252077;10130.848037279595;49085.5380555124;49618.255726163414;50305;50805.49194508156;52132.47867521428;66857.33142668706;75586.62206688931;76382.6180869092;76701.61649191719;77116;12963.870361296265;13010.869891300967;13333;13487.25820079905;13505.797413038616;14993.925030374778;15046.022008569407;15185.544433667008;15359.769603456181;15418.922905385401;13670.93164534171;14089.506867259597;14173.716525669635;14206.158768246598;14268.357923893658;13937.651558711113;14158.646033849236;14252.216128113054;14575.03237062983;14969.40122395092;13957.651058723613;13990.510332138327;14004.36980335867;14230.644233894236;14483.565493035227;11120.44397780124;11374.31754094757;11544.134189935621;11663.650090497298;11887.643370698894;11698.532058717556;11985.580504682293;12160.878391216329;12218.450169742206;12234.694132646755 11:18:02 INFO - PROCESS | 28747 | __end_tp_report 11:18:02 INFO - PROCESS | 28747 | __start_cc_report 11:18:02 INFO - PROCESS | 28747 | _x_x_mozilla_cycle_collect,949 11:18:02 INFO - PROCESS | 28747 | __end_cc_report 11:18:02 INFO - PROCESS | 28747 | __startTimestamp1465323482948__endTimestamp 11:18:02 INFO - PROCESS | 28747 | 11:18:02 INFO - PROCESS | 28747 | ------- Summary: start ------- 11:18:02 INFO - PROCESS | 28747 | Number of tests: 6 11:18:02 INFO - PROCESS | 28747 | 11:18:02 INFO - PROCESS | 28747 | [#0] dojo.html Cycles:165 Average:5410.06 Median:5620.33 stddev:617.50 (11.0%) stddev-sans-first:593.90 11:18:02 INFO - PROCESS | 28747 | Values: 3171.3 3174.4 3176.7 3217.0 3234.9 5251.3 5306.4 5351.3 5413.5 5465.1 5305.7 5371.6 5377.5 5425.0 5426.1 4922.4 4925.0 4928.0 5036.0 5039.5 5015.8 5032.9 5039.3 5046.7 5077.8 4800.0 4847.8 4980.7 4998.3 5042.5 4913.8 4914.0 4918.2 4919.8 4922.4 4817.9 4879.8 4896.4 4897.6 4899.9 5291.6 5392.5 5395.3 5402.2 5424.0 5812.8 5844.8 5845.6 5846.6 5864.3 5695.6 5833.7 5842.2 5890.4 5898.1 5511.1 5631.8 5647.3 5650.8 5652.9 6069.3 6085.5 6086.0 6108.1 6140.9 5563.9 5682.7 5713.0 5851.9 5900.9 5833.4 5873.2 5912.1 5928.9 5929.3 5820.8 5847.5 5851.5 5856.0 5858.4 5599.5 5678.3 5725.0 5738.9 5850.8 4427.3 4432.2 4437.1 4470.6 4477.2 3951.2 3967.9 3987.2 3996.3 4019.8 5266.0 5284.6 5395.0 5397.8 5415.9 5893.6 5895.1 5897.7 5903.9 5952.0 5478.8 5486.9 5489.1 5500.8 5505.9 4916.8 4986.2 5018.1 5030.8 5058.0 6019.1 6073.1 6080.1 6080.3 6087.1 5874.7 5882.2 5898.7 5917.5 5918.3 5876.9 5902.6 5943.1 5944.2 6024.4 5715.3 5729.7 5742.6 5748.6 5763.3 5610.2 5838.7 5851.0 5856.3 5868.5 5637.9 5683.8 5689.8 5731.4 5735.9 5720.9 5721.2 5721.4 5723.1 5732.0 5425.8 5432.6 5612.9 5623.6 5628.2 5603.8 5734.7 5737.2 5742.6 5743.1 5530.4 5558.6 5558.7 5563.5 5620.3 11:18:02 INFO - PROCESS | 28747 | 11:18:02 INFO - PROCESS | 28747 | [#1] ext.html Cycles:180 Average:59804.61 Median:36515.18 stddev:122004.94 (334.1%) stddev-sans-first:122266.26 11:18:02 INFO - PROCESS | 28747 | Values: 615.4 622.9 635.1 646.5 651.8 41441.8 43293.8 43622.0 47883.0 48079.8 46610.8 47153.1 47175.8 47260.5 47295.5 8019.7 8814.9 9047.9 9055.2 10421.8 10370.2 10831.2 10837.7 10845.5 10848.6 10875.6 10954.9 10956.1 10960.9 10967.9 8156.5 10536.5 10761.5 10773.7 10842.7 10642.9 10756.3 10759.2 10760.1 10770.9 41417.8 41562.0 41835.8 41878.6 41911.4 3592.8 3617.2 3715.9 4023.8 4042.6 32388.4 32499.2 32834.0 32918.2 33015.0 4435.9 4472.8 4485.8 4537.8 4610.8 244905.0 247349.0 247377.0 248183.0 248277.0 59526.7 59609.7 59942.7 59959.2 59966.0 35863.1 36490.1 36540.3 38805.0 63264.7 17532.0 17532.8 17642.6 17653.7 17672.6 12482.0 13370.1 13768.5 13782.9 14088.6 19880.5 19903.2 19926.8 19984.9 20027.4 7257.9 7309.0 7355.7 7477.7 7517.9 1007.8 1012.7 1040.9 1068.2 1092.8 31781.7 32254.8 32414.5 32732.5 32953.7 1119.8 1130.2 1161.4 1191.3 1257.4 16855.7 16890.0 17017.1 17182.3 17358.1 589221.0 592397.0 592549.0 593169.0 596047.0 58605.0 58988.7 59140.1 59140.1 59286.7 1269.4 1349.8 1353.5 1407.5 1416.7 30501.8 32360.7 32368.8 32732.5 33077.0 49788.8 50364.5 50382.2 50487.0 50502.0 456245.0 459644.0 460897.0 461979.0 486502.0 27710.0 28543.1 28653.7 30009.4 30010.2 46359.5 46849.5 47016.5 47929.0 48159.5 39793.4 40099.2 40111.4 43668.3 44848.3 39634.0 40481.8 41121.4 41802.6 42594.4 41864.0 41992.8 42517.0 43402.8 43544.1 34397.3 36361.0 36649.3 36805.4 37200.4 27167.6 27828.7 27910.4 28168.4 28351.7 11:18:02 INFO - PROCESS | 28747 | 11:18:02 INFO - PROCESS | 28747 | [#2] jquery.html Cycles:180 Average:28307.88 Median:381.67 stddev:78627.67 (20601.0%) stddev-sans-first:78820.27 11:18:02 INFO - PROCESS | 28747 | Values: 375.6 387.7 394.8 395.4 411.2 17696.0 18875.8 19228.3 19285.6 19457.0 17743.7 17880.7 18307.0 18326.0 18468.9 5501.9 5584.4 5720.8 5767.4 5805.0 5783.2 5789.7 5812.5 5821.2 5823.5 5491.4 5770.2 5775.8 5814.4 5817.7 5647.8 5693.5 5702.0 5709.1 5733.8 5412.6 5670.7 5705.7 5711.0 5715.4 12388.5 12656.2 12665.3 20010.0 21154.2 2163.9 2193.8 2327.5 2328.8 2699.9 9750.9 9767.0 9791.6 10200.4 10246.6 1871.8 1932.3 1942.1 1988.3 1998.8 74029.0 83316.0 83788.0 88705.0 90962.5 10425.9 10809.8 10815.0 10838.3 10985.2 14957.1 15001.0 15049.5 15087.8 15090.1 7964.4 8230.4 8287.3 8399.8 8413.1 8025.2 8056.3 8074.8 8201.5 8268.8 4499.3 4620.6 4621.5 4641.8 4697.8 1774.6 1859.5 1919.2 1948.2 1954.6 868.4 944.3 972.9 1046.0 1075.8 18122.6 18378.0 18388.5 18506.5 18848.5 979.6 993.3 994.8 1011.6 1050.8 10327.2 10605.7 10665.9 10677.3 10687.7 472142.0 474387.0 475503.0 476532.0 477610.0 94188.5 96476.5 96880.5 97385.5 97514.0 998.3 1002.0 1018.3 1023.0 1028.4 15949.0 16401.4 16445.0 16689.3 16836.4 31693.7 33611.5 41383.4 42351.2 42502.1 53129.7 56060.0 56111.7 56575.7 56874.7 8265.4 8361.6 8532.4 8682.0 8821.2 9483.3 10420.6 12528.9 13199.9 13219.2 8270.8 11785.4 11868.3 12005.0 12127.2 11716.1 11919.9 11935.0 12016.0 12345.4 11652.2 12296.5 12315.7 12323.8 12388.3 7479.4 8507.5 8705.9 8999.4 9007.7 11558.7 11662.3 11678.8 11712.1 11765.4 11:18:02 INFO - PROCESS | 28747 | 11:18:02 INFO - PROCESS | 28747 | [#3] mootools.html Cycles:180 Average:5655.71 Median:4885.04 stddev:3180.15 (65.1%) stddev-sans-first:3172.37 11:18:02 INFO - PROCESS | 28747 | Values: 1319.1 1481.9 1495.3 1638.4 1783.3 7960.6 8325.0 8333.5 8337.5 8542.8 7851.7 8005.4 8265.2 8273.7 8281.1 2036.3 2271.7 2285.1 2341.4 2353.6 2368.8 2372.7 2375.3 2378.8 2378.8 2309.7 2317.5 2333.6 2336.6 2337.3 1908.3 2185.3 2193.7 2262.1 2267.0 2312.5 2315.7 2334.6 2336.0 2336.7 8509.5 8558.4 8567.1 8579.4 8581.6 5094.7 5255.7 5257.6 5258.2 5262.9 3204.6 3343.2 3364.8 3403.2 3404.1 1113.5 1122.5 1157.3 1157.8 2047.7 11442.1 11960.8 11977.6 11988.9 11989.6 4728.6 4733.9 4759.8 4767.4 4848.6 10137.7 10262.0 10271.3 10295.3 10305.6 5335.1 5379.2 5400.5 5400.9 5401.8 4268.6 4672.2 4829.8 4839.6 4919.0 3950.4 4002.3 4030.8 4091.9 4109.1 1256.7 1271.6 1287.8 1295.3 1301.7 886.5 941.3 941.9 945.2 960.6 5566.0 5631.9 5690.4 5822.5 5913.2 906.9 921.7 956.2 1005.2 1017.9 3697.2 3865.1 3955.6 3967.3 3996.7 10436.2 10750.2 10802.5 10802.6 10816.9 10434.7 10674.9 10692.3 10769.4 10773.1 7814.5 7822.1 7897.1 7928.2 7958.0 5483.6 5508.6 5584.5 5587.5 5652.0 9804.1 9876.3 9975.0 9990.4 9995.0 9920.7 9999.8 10045.7 10308.5 10347.4 6505.7 6707.4 6710.5 7226.1 7361.0 7825.5 8070.7 8323.2 8346.0 8615.8 7482.4 7621.6 7638.5 7694.6 7697.1 7209.4 7211.2 7263.3 7366.9 7395.3 6862.5 6868.9 6926.8 6947.7 6974.0 5038.1 5127.0 5137.3 5206.7 5225.6 4842.3 4863.7 4906.4 4942.7 4945.2 11:18:02 INFO - PROCESS | 28747 | 11:18:02 INFO - PROCESS | 28747 | [#4] prototype.html Cycles:180 Average:4643.88 Median:5219.50 stddev:1365.20 (26.2%) stddev-sans-first:1329.93 11:18:02 INFO - PROCESS | 28747 | Values: 322.1 332.8 335.5 337.5 339.3 5210.5 5228.5 5300.2 5336.1 5347.5 5256.9 5274.4 5280.4 5297.4 5340.4 4144.2 4174.9 4183.6 4197.3 4198.7 3892.0 4005.6 4159.2 4198.8 4207.8 4137.1 4158.1 4169.5 4169.8 4172.6 4094.7 4130.3 4146.3 4157.8 4167.4 3449.6 3724.7 3733.3 3738.4 3754.5 5061.7 5089.8 5100.5 5101.7 5140.6 4679.5 4685.2 4688.6 4694.7 4748.4 5385.1 5474.4 5512.8 5545.4 5546.7 3962.9 3974.0 3977.7 4003.1 4010.2 5744.6 5761.8 5785.9 5796.5 5844.2 3997.8 4105.0 4109.4 4122.9 4124.5 4141.5 4144.9 4157.9 4159.9 4168.2 4742.2 4752.8 4761.5 4782.4 4808.7 5519.1 5610.9 5626.2 5653.1 5694.3 1418.8 1421.9 1433.0 1437.3 1438.9 879.9 890.9 905.0 919.9 931.4 4765.3 4769.4 4799.2 4803.0 4809.6 5046.4 5069.5 5078.2 5100.5 5107.6 4755.6 4786.7 4793.6 4843.9 4990.7 3030.1 3031.7 3033.2 3040.9 3044.8 5907.8 5912.7 5914.7 5923.7 5926.8 5579.3 5793.0 5819.7 5830.4 5845.2 5822.3 5835.7 5862.5 5887.8 5900.7 5418.5 5673.2 5738.7 5759.4 5763.2 5686.4 5709.6 5715.3 5719.6 5724.8 5877.6 5881.6 5897.8 5906.8 5915.0 3668.6 3874.8 4023.4 4037.9 4072.0 5684.8 5688.7 5701.9 5708.0 5709.7 5558.7 5561.8 5572.8 5576.8 5602.3 5339.5 5590.0 5591.7 5627.4 5633.8 5514.2 5517.7 5519.6 5545.6 5549.8 5342.9 5658.9 5661.4 5692.9 5698.9 5476.4 5487.6 5514.3 5530.2 5532.5 11:18:02 INFO - PROCESS | 28747 | 11:18:02 INFO - PROCESS | 28747 | [#5] yui.html Cycles:180 Average:20112.47 Median:3843.64 stddev:28867.57 (751.0%) stddev-sans-first:28911.84 11:18:02 INFO - PROCESS | 28747 | Values: 725.3 757.2 761.3 814.7 858.3 15723.1 16023.7 16462.4 16578.3 16602.3 14531.6 14583.8 14711.9 14722.1 14814.8 685.0 804.3 805.3 828.0 830.0 808.2 808.8 810.0 810.5 814.9 842.7 843.6 844.5 846.2 848.4 704.9 837.1 851.0 852.4 856.6 622.5 623.3 623.3 623.6 623.7 14883.4 14958.6 15007.3 15025.9 15038.2 13608.4 13754.7 13754.9 13982.8 14080.9 12493.4 12675.4 12740.3 12833.6 12949.7 3757.5 3815.4 3835.9 3851.4 3949.9 50255.7 50312.2 50417.7 50456.7 50647.5 11093.8 11269.9 11383.9 11462.5 11627.9 20452.4 20475.8 20482.3 20519.2 20561.4 8308.7 8430.8 8439.1 8487.3 8606.5 4722.7 4785.8 4858.1 4874.3 4999.1 3479.5 3614.9 3627.0 3628.0 3630.1 577.2 646.7 651.7 652.7 690.9 634.2 689.7 723.4 765.8 799.2 9850.8 10974.4 11187.8 11233.8 11423.7 632.5 688.9 693.7 771.9 806.2 4843.9 5057.3 5073.2 5099.4 5264.3 73347.0 123487.0 127266.0 128114.0 131568.0 78180.6 98596.0 101446.5 103048.5 106212.5 71024.0 82814.6 84046.6 85967.1 86246.6 9639.8 9935.3 9950.4 10009.8 10130.8 49085.5 49618.3 50305.0 50805.5 52132.5 66857.3 75586.6 76382.6 76701.6 77116.0 12963.9 13010.9 13333.0 13487.3 13505.8 14993.9 15046.0 15185.5 15359.8 15418.9 13670.9 14089.5 14173.7 14206.2 14268.4 13937.7 14158.6 14252.2 14575.0 14969.4 13957.7 13990.5 14004.4 14230.6 14483.6 11120.4 11374.3 11544.1 11663.7 11887.6 11698.5 11985.6 12160.9 12218.5 12234.7 11:18:02 INFO - PROCESS | 28747 | -------- Summary: end -------- 11:18:02 INFO - PROCESS | 28747 | 11:18:03 INFO - TEST-INFO | 28747: exit 0 11:18:03 INFO - TEST-OK | dromaeo_css | took 1114133ms 11:18:03 INFO - TEST-START | kraken 11:18:03 INFO - operating with platform_type : linux_ 11:18:03 INFO - Initialising browser for kraken test... 11:18:03 INFO - TEST-INFO | started process 28929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkp_APW/profile http://localhost:60569/getInfo.html) 11:18:07 INFO - PROCESS | 28929 | __metrics Screen width/height:1600/1200 11:18:07 INFO - PROCESS | 28929 | colorDepth:24 11:18:07 INFO - PROCESS | 28929 | Browser inner width/height: 1024/697 11:18:07 INFO - PROCESS | 28929 | __metrics 11:18:08 ERROR - PROCESS | 28929 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:18:08 INFO - PROCESS | 28929 | console.error: PushService: 11:18:08 INFO - PROCESS | 28929 | stateChangeProcessEnqueue: Error transitioning state 11:18:08 INFO - PROCESS | 28929 | UnknownError 11:18:09 INFO - TEST-INFO | 28929: exit 0 11:18:09 INFO - Browser initialized. 11:18:09 INFO - Running cycle 1/1 for kraken test... 11:18:09 INFO - TEST-INFO | started process 29007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkp_APW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:18:21 INFO - PROCESS | 29007 | RSS: Main: 156459008 11:18:21 INFO - PROCESS | 29007 | 11:18:24 INFO - PROCESS | 29007 | Cycle 1(1): loaded http://localhost:60569/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60569/tests/kraken/driver.html?testName=audio-beat-detection) 11:18:24 INFO - PROCESS | 29007 | RSS: Main: 214843392 11:18:24 INFO - PROCESS | 29007 | 11:18:27 INFO - PROCESS | 29007 | Cycle 1(1): loaded http://localhost:60569/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60569/tests/kraken/driver.html?testName=audio-dft) 11:18:28 INFO - PROCESS | 29007 | RSS: Main: 201154560 11:18:28 INFO - PROCESS | 29007 | 11:18:31 INFO - PROCESS | 29007 | Cycle 1(1): loaded http://localhost:60569/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60569/tests/kraken/driver.html?testName=audio-fft) 11:18:32 INFO - PROCESS | 29007 | RSS: Main: 269070336 11:18:32 INFO - PROCESS | 29007 | 11:18:34 INFO - PROCESS | 29007 | Cycle 1(1): loaded http://localhost:60569/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60569/tests/kraken/driver.html?testName=audio-oscillator) 11:18:34 INFO - PROCESS | 29007 | RSS: Main: 179695616 11:18:34 INFO - PROCESS | 29007 | 11:18:36 INFO - PROCESS | 29007 | Cycle 1(1): loaded http://localhost:60569/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60569/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:18:37 INFO - PROCESS | 29007 | RSS: Main: 183721984 11:18:37 INFO - PROCESS | 29007 | 11:18:40 INFO - PROCESS | 29007 | Cycle 1(1): loaded http://localhost:60569/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60569/tests/kraken/driver.html?testName=imaging-darkroom) 11:18:41 INFO - PROCESS | 29007 | RSS: Main: 217686016 11:18:41 INFO - PROCESS | 29007 | 11:18:44 INFO - PROCESS | 29007 | Cycle 1(1): loaded http://localhost:60569/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60569/tests/kraken/driver.html?testName=imaging-desaturate) 11:18:45 INFO - PROCESS | 29007 | RSS: Main: 220123136 11:18:45 INFO - PROCESS | 29007 | 11:18:47 INFO - PROCESS | 29007 | Cycle 1(1): loaded http://localhost:60569/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60569/tests/kraken/driver.html?testName=json-parse-financial) 11:18:48 INFO - PROCESS | 29007 | RSS: Main: 220164096 11:18:48 INFO - PROCESS | 29007 | 11:18:49 INFO - PROCESS | 29007 | Cycle 1(1): loaded http://localhost:60569/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60569/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:18:50 INFO - PROCESS | 29007 | RSS: Main: 207044608 11:18:50 INFO - PROCESS | 29007 | 11:18:52 INFO - PROCESS | 29007 | Cycle 1(1): loaded http://localhost:60569/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60569/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:18:52 INFO - PROCESS | 29007 | RSS: Main: 212455424 11:18:52 INFO - PROCESS | 29007 | 11:18:55 INFO - PROCESS | 29007 | Cycle 1(1): loaded http://localhost:60569/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60569/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:18:55 INFO - PROCESS | 29007 | RSS: Main: 218116096 11:18:55 INFO - PROCESS | 29007 | 11:18:58 INFO - PROCESS | 29007 | Cycle 1(1): loaded http://localhost:60569/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60569/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:18:58 INFO - PROCESS | 29007 | RSS: Main: 224202752 11:18:58 INFO - PROCESS | 29007 | 11:19:01 INFO - PROCESS | 29007 | Cycle 1(1): loaded http://localhost:60569/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60569/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:19:02 INFO - PROCESS | 29007 | RSS: Main: 225144832 11:19:02 INFO - PROCESS | 29007 | 11:19:03 INFO - PROCESS | 29007 | Cycle 1(1): loaded http://localhost:60569/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60569/tests/kraken/driver.html?testName=ai-astar) 11:19:04 INFO - PROCESS | 29007 | RSS: Main: 267272192 11:19:04 INFO - PROCESS | 29007 | 11:19:04 INFO - PROCESS | 29007 | __start_tp_report 11:19:04 INFO - PROCESS | 29007 | _x_x_mozilla_page_load 11:19:04 INFO - PROCESS | 29007 | _x_x_mozilla_page_load_details 11:19:04 INFO - PROCESS | 29007 | |i|pagename|runs| 11:19:04 INFO - PROCESS | 29007 | |0;ai-astar;110;105;110;109;109;109;108;110;110;109 11:19:04 INFO - PROCESS | 29007 | |1;audio-beat-detection;157;123;136;183;124;126;153;128;196;132 11:19:04 INFO - PROCESS | 29007 | |2;audio-dft;159;159;160;159;160;158;160;160;160;162 11:19:04 INFO - PROCESS | 29007 | |3;audio-fft;74;75;75;126;75;77;74;75;107;75 11:19:04 INFO - PROCESS | 29007 | |4;audio-oscillator;84;85;117;86;84;85;120;85;84;121 11:19:04 INFO - PROCESS | 29007 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;116;117 11:19:04 INFO - PROCESS | 29007 | |6;imaging-darkroom;146;146;144;145;146;145;146;145;145;147 11:19:04 INFO - PROCESS | 29007 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 11:19:04 INFO - PROCESS | 29007 | |8;json-parse-financial;53;53;52;52;53;53;53;53;52;62 11:19:04 INFO - PROCESS | 29007 | |9;json-stringify-tinderbox;62;62;61;62;62;61;62;61;61;61 11:19:04 INFO - PROCESS | 29007 | |10;stanford-crypto-aes;83;80;78;86;80;81;79;79;115;85 11:19:04 INFO - PROCESS | 29007 | |11;stanford-crypto-ccm;134;124;133;128;121;124;129;130;152;133 11:19:04 INFO - PROCESS | 29007 | |12;stanford-crypto-pbkdf2;169;167;162;163;163;160;165;168;162;163 11:19:04 INFO - PROCESS | 29007 | |13;stanford-crypto-sha256-iterative;64;63;63;63;63;64;63;63;64;64 11:19:04 INFO - PROCESS | 29007 | __end_tp_report 11:19:04 INFO - PROCESS | 29007 | __start_cc_report 11:19:04 INFO - PROCESS | 29007 | _x_x_mozilla_cycle_collect,1645 11:19:04 INFO - PROCESS | 29007 | __end_cc_report 11:19:04 INFO - PROCESS | 29007 | __startTimestamp1465323544194__endTimestamp 11:19:04 INFO - PROCESS | 29007 | 11:19:04 INFO - PROCESS | 29007 | ------- Summary: start ------- 11:19:04 INFO - PROCESS | 29007 | Number of tests: 14 11:19:04 INFO - PROCESS | 29007 | 11:19:04 INFO - PROCESS | 29007 | [#0] ai-astar Cycles:10 Average:108.90 Median:109.50 stddev:1.52 (1.4%) stddev-sans-first:1.56 11:19:04 INFO - PROCESS | 29007 | Values: 110.0 105.0 110.0 109.0 109.0 109.0 108.0 110.0 110.0 109.0 11:19:04 INFO - PROCESS | 29007 | 11:19:04 INFO - PROCESS | 29007 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:144.50 stddev:25.97 (18.0%) stddev-sans-first:27.23 11:19:04 INFO - PROCESS | 29007 | Values: 157.0 123.0 136.0 183.0 124.0 126.0 153.0 128.0 196.0 132.0 11:19:04 INFO - PROCESS | 29007 | 11:19:04 INFO - PROCESS | 29007 | [#2] audio-dft Cycles:10 Average:159.70 Median:160.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 11:19:04 INFO - PROCESS | 29007 | Values: 159.0 159.0 160.0 159.0 160.0 158.0 160.0 160.0 160.0 162.0 11:19:04 INFO - PROCESS | 29007 | 11:19:04 INFO - PROCESS | 29007 | [#3] audio-fft Cycles:10 Average:83.30 Median:75.00 stddev:18.08 (24.1%) stddev-sans-first:18.86 11:19:04 INFO - PROCESS | 29007 | Values: 74.0 75.0 75.0 126.0 75.0 77.0 74.0 75.0 107.0 75.0 11:19:04 INFO - PROCESS | 29007 | 11:19:04 INFO - PROCESS | 29007 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:84.50 stddev:16.76 (19.8%) stddev-sans-first:17.29 11:19:04 INFO - PROCESS | 29007 | Values: 84.0 85.0 117.0 86.0 84.0 85.0 120.0 85.0 84.0 121.0 11:19:04 INFO - PROCESS | 29007 | 11:19:04 INFO - PROCESS | 29007 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:19:04 INFO - PROCESS | 29007 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 11:19:04 INFO - PROCESS | 29007 | 11:19:04 INFO - PROCESS | 29007 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 11:19:04 INFO - PROCESS | 29007 | Values: 146.0 146.0 144.0 145.0 146.0 145.0 146.0 145.0 145.0 147.0 11:19:04 INFO - PROCESS | 29007 | 11:19:04 INFO - PROCESS | 29007 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:19:04 INFO - PROCESS | 29007 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 11:19:04 INFO - PROCESS | 29007 | 11:19:04 INFO - PROCESS | 29007 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.00 stddev:2.99 (5.6%) stddev-sans-first:3.16 11:19:04 INFO - PROCESS | 29007 | Values: 53.0 53.0 52.0 52.0 53.0 53.0 53.0 53.0 52.0 62.0 11:19:04 INFO - PROCESS | 29007 | 11:19:04 INFO - PROCESS | 29007 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 11:19:04 INFO - PROCESS | 29007 | Values: 62.0 62.0 61.0 62.0 62.0 61.0 62.0 61.0 61.0 61.0 11:19:04 INFO - PROCESS | 29007 | 11:19:04 INFO - PROCESS | 29007 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:80.50 stddev:11.01 (13.7%) stddev-sans-first:11.66 11:19:04 INFO - PROCESS | 29007 | Values: 83.0 80.0 78.0 86.0 80.0 81.0 79.0 79.0 115.0 85.0 11:19:04 INFO - PROCESS | 29007 | 11:19:04 INFO - PROCESS | 29007 | [#11] stanford-crypto-ccm Cycles:10 Average:130.80 Median:131.50 stddev:8.63 (6.6%) stddev-sans-first:9.07 11:19:04 INFO - PROCESS | 29007 | Values: 134.0 124.0 133.0 128.0 121.0 124.0 129.0 130.0 152.0 133.0 11:19:04 INFO - PROCESS | 29007 | 11:19:04 INFO - PROCESS | 29007 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:164.00 stddev:2.94 (1.8%) stddev-sans-first:2.55 11:19:04 INFO - PROCESS | 29007 | Values: 169.0 167.0 162.0 163.0 163.0 160.0 165.0 168.0 162.0 163.0 11:19:04 INFO - PROCESS | 29007 | 11:19:04 INFO - PROCESS | 29007 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:0.52 (0.8%) stddev-sans-first:0.50 11:19:04 INFO - PROCESS | 29007 | Values: 64.0 63.0 63.0 63.0 63.0 64.0 63.0 63.0 64.0 64.0 11:19:04 INFO - PROCESS | 29007 | -------- Summary: end -------- 11:19:04 INFO - PROCESS | 29007 | 11:19:05 INFO - TEST-INFO | 29007: exit 0 11:19:05 INFO - TEST-OK | kraken | took 61458ms 11:19:05 INFO - SUITE-END | took 1175s 11:19:05 INFO - Completed test suite (00:19:35) 11:19:05 INFO - javascript benchmark 11:19:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3171.2547551325433, 3174.4286028514857, 3176.729977951874, 3216.951745723813, 3234.9029529114136, 5251.264822924793, 5306.442823503525, 5351.2775775270375, 5413.539849112825, 5465.0982587873, 5305.65513241639, 5371.57027437805, 5377.542908852753, 5425.0, 5426.050441172789, 4922.360093187881, 4925.0, 4928.0, 5035.967626636549, 5039.496050394968, 5015.824446144386, 5032.924506132411, 5039.31969184161, 5046.6719663221775, 5077.822276220333, 4800.0, 4847.830325938575, 4980.726060066713, 4998.2752500887345, 5042.546170844624, 4913.803447862081, 4914.0, 4918.188498897677, 4919.7540122993705, 4922.433920099199, 4817.879553011167, 4879.829205977774, 4896.436909755353, 4897.632677549198, 4899.902001959941, 5291.603129765283, 5392.541633961118, 5395.271638328814, 5402.189671549259, 5424.0, 5812.767489300423, 5844.766209351664, 5845.620034697731, 5846.561507886883, 5864.266966629171, 5695.572832037614, 5833.679147646878, 5842.152887831241, 5890.410958904075, 5898.056310990221, 5511.145772405243, 5631.802886898939, 5647.29408823897, 5650.802221922254, 5652.9152062719095, 6069.302244476016, 6085.513158947274, 6085.965385884322, 6108.08378743192, 6140.938590614126, 5563.944360556424, 5682.687452190086, 5712.971435142881, 5851.853703657443, 5900.852478687982, 5833.358330583633, 5873.177755114288, 5912.054071348563, 5928.911066334009, 5929.318128415288, 5820.82537523875, 5847.532197424196, 5851.531877449794, 5856.033754430557, 5858.355580886099, 5599.524040456526, 5678.290213723285, 5725.0, 5738.942610573924, 5850.765969361178, 4427.335899615019, 4432.246518091933, 4437.134758722083, 4470.575295346936, 4477.2164871147415, 3951.1702542466405, 3967.940480892731, 3987.182627561343, 3996.3406038003404, 4019.83920643171, 5265.973670131625, 5284.550813180846, 5395.0, 5397.8380648580605, 5415.891682166413, 5893.5579831512805, 5895.056790913519, 5897.67562784051, 5903.940960590425, 5951.970240148771, 5478.835634930959, 5486.862828429321, 5489.149181876815, 5500.779968801203, 5505.889882202334, 4916.827911023169, 4986.152354099811, 5018.096742586296, 5030.773615187325, 5057.974710126426, 6019.127226552126, 6073.119397687399, 6080.0879868019265, 6080.300765411946, 6087.147799308101, 5874.735636896436, 5882.205902203319, 5898.734556944862, 5917.497012753792, 5918.348981611933, 5876.853078672896, 5902.586818922634, 5943.108533719977, 5944.227250457413, 6024.427679370453, 5715.257016587817, 5729.713514324184, 5742.626729262584, 5748.568857335633, 5763.308402991668, 5610.158476228598, 5838.678872661874, 5851.034579294539, 5856.267966504187, 5868.5305175585, 5637.8590535236945, 5683.829485115453, 5689.800856969986, 5731.369549349652, 5735.942640573708, 5720.856978575569, 5721.227634269487, 5721.370649228665, 5723.084306510938, 5732.025555655465, 5425.755840987086, 5432.619716619799, 5612.85967850807, 5623.634463759842, 5628.155776633538, 5603.80386686464, 5734.684592347461, 5737.225474560881, 5742.59801813869, 5743.1385292206505, 5530.446955304437, 5558.583106267127, 5558.666480011212, 5563.499285064364, 5620.325560932714], "value": 5368.671320575488, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.4399496458223, 622.9190205273313, 635.1267007864187, 646.4666650013739, 651.8370407398147, 41441.79279103604, 43293.78353108234, 43622.0, 47883.0, 48079.75960120194, 46610.76694616522, 47153.056938861206, 47175.76412117943, 47260.52739472604, 47295.52704472954, 8019.719309824157, 8814.86777698335, 9047.864282035742, 9055.185033346997, 10421.791564168712, 10370.222233332492, 10831.24181307305, 10837.67486975392, 10845.457727113651, 10848.620298289561, 10875.564977400894, 10954.890451095507, 10956.12351011921, 10960.890391096107, 10967.945160274227, 8156.469829461095, 10536.525856336406, 10761.461926903623, 10773.730656733565, 10842.72893177669, 10642.946785266024, 10756.300840445347, 10759.193060520493, 10760.139188864872, 10770.946145269301, 41417.792911035554, 41562.0, 41835.790821046, 41878.581214188074, 41911.37132943008, 3592.7844329340323, 3617.1680513481783, 3715.851365945359, 4023.839046438139, 4042.6361627453375, 32388.352232955443, 32499.187520311945, 32834.0, 32918.177045573815, 33015.0, 4435.933460998088, 4472.776361181928, 4485.820567177309, 4537.795799189044, 4610.838620648295, 244904.99999999822, 247349.0, 247377.0, 248183.0, 248277.0, 59526.70236648876, 59609.701951489966, 59942.70028649916, 59959.2032637388, 59966.0, 35863.10342241465, 36490.087747806516, 36540.26919461596, 38805.0, 63264.683676582245, 17532.0, 17532.82467175312, 17642.558936026446, 17653.735193971843, 17672.646547068987, 12482.0, 13370.130941488773, 13768.518101866586, 13782.862171378358, 14088.647783805282, 19880.50298742514, 19903.203871845253, 19926.800731992495, 19984.90007549953, 20027.399178024683, 7257.8548429031125, 7308.993339562417, 7355.705771769176, 7477.70089196426, 7517.932568543694, 1007.7631756537207, 1012.7468132966758, 1040.942748148844, 1068.2041878800187, 1092.792369449802, 31781.682183178335, 32254.83872580669, 32414.513782293285, 32732.509012364833, 32953.67046329506, 1119.8432219489277, 1130.1749722702473, 1161.4425075963584, 1191.3149938785234, 1257.3775980889518, 16855.747163792552, 16890.0, 17017.149142543072, 17182.312707491812, 17358.13209339528, 589221.0, 592397.0, 592549.0, 593169.0, 596047.0, 58605.0, 58988.70505647444, 59140.11289830656, 59140.11289830656, 59286.70356648189, 1269.3780047776522, 1349.8312710911136, 1353.5262658069794, 1407.5214427094836, 1416.6895621550232, 30501.847490762404, 32360.676393235768, 32368.792057032435, 32732.509012364357, 33077.0, 49788.75105624449, 50364.49635503598, 50382.2442663353, 50487.0, 50502.0, 456245.0, 459644.0, 460897.0, 461979.0, 486502.0, 27710.0, 28543.14370568886, 28653.713462865937, 30009.3998120032, 30010.24974375658, 46359.536404635524, 46849.53150468451, 47016.529834701214, 47929.0, 48159.5184048169, 39793.40309895412, 40099.1980160401, 40111.39832902567, 43668.34497482604, 44848.32727509155, 39634.0, 40481.797591011855, 41121.38317925293, 41802.58197417987, 42594.36108458437, 41864.0, 41992.79003604963, 42517.0, 43402.782986084865, 43544.129117416844, 34397.312053759284, 36361.0, 36649.267014659024, 36805.44791828071, 37200.44199336958, 27167.592486112328, 27828.72171278261, 27910.44179116447, 28168.43663126685, 28351.71648283491], "value": 20596.486959152564, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.5962340483979, 387.7430646206211, 394.773005521825, 395.436502983249, 411.2351027089613, 17696.0, 18875.811241887575, 19228.327008554705, 19285.614287714256, 19457.0, 17743.73384399235, 17880.731789023175, 18307.0, 18326.0, 18468.907655461702, 5501.889962200774, 5584.4136365681625, 5720.79977200798, 5767.36558978512, 5805.042168042268, 5783.161441590967, 5789.739461724212, 5812.505936995361, 5821.243238379005, 5823.505002074829, 5491.395946445888, 5770.19217309577, 5775.797847075353, 5814.4185581441725, 5817.680027598481, 5647.774089036413, 5693.544516438696, 5702.0021496238405, 5709.0580054290995, 5733.799317023905, 5412.621116521845, 5670.716464176775, 5705.686187259699, 5711.02912504871, 5715.399883012307, 12388.504459821595, 12656.240625562403, 12665.303408312539, 20010.0, 21154.15383384678, 2163.935081947544, 2193.802557769792, 2327.5461285049423, 2328.836981411302, 2699.8650067496546, 9750.90249097514, 9767.0, 9791.608335666564, 10200.438975856325, 10246.6413675521, 1871.756671632679, 1932.2657390191778, 1942.1260432805152, 1988.2643421933833, 1998.7601487821555, 74029.0, 83316.0, 83788.0, 88705.0, 90962.54518727364, 10425.895741042645, 10809.83785243222, 10814.971807893802, 10838.349699018085, 10985.176111791647, 14957.102573845605, 15001.0, 15049.54851354461, 15087.773683394758, 15090.094594324375, 7964.402669799672, 8230.42387032914, 8287.254147126787, 8399.790005249795, 8413.116622754646, 8025.197480251928, 8056.315213206943, 8074.82914977325, 8201.548914809742, 8268.8346233075, 4499.34759459883, 4620.630349572026, 4621.491635920046, 4641.814327426932, 4697.7651117444675, 1774.5918438759159, 1859.5072305838964, 1919.1555715485142, 1948.1915005272936, 1954.5993071420326, 868.4181598329009, 944.2776276148752, 972.8735264415723, 1045.9529321180564, 1075.7794652096302, 18122.63754724898, 18378.0, 18388.540286492676, 18506.537336566693, 18848.52878678044, 979.5689896445683, 993.3493561717087, 994.8457989011715, 1011.6256984915628, 1050.847627094067, 10327.173826093895, 10605.734856628646, 10665.9466702666, 10677.305975111749, 10687.732806679895, 472142.0, 474387.0, 475503.0, 476532.0, 477610.0, 94188.52905735564, 96476.51761741287, 96880.51559742156, 97385.5130724356, 97514.0, 998.286225348879, 1001.9599216031423, 1018.251585084962, 1023.0281232828694, 1028.3983869436313, 15949.0, 16401.42595009169, 16445.0, 16689.332426702797, 16836.410725624544, 31693.683063169072, 33611.49582756309, 41383.37924931189, 42351.1529769409, 42502.14995700007, 53129.734351328, 56060.0, 56111.71944140253, 56575.71712141413, 56874.7156264216, 8265.380096492907, 8361.623726932425, 8532.402731808714, 8682.0, 8821.161989610977, 9483.336166468282, 10420.635277765241, 12528.911912956917, 13199.934000329937, 13219.206847589176, 8270.793230169053, 11785.410729463663, 11868.347240901834, 12005.0, 12127.151099423309, 11716.121290903046, 11919.880801192225, 11935.0, 12016.0, 12345.444454999726, 11652.184347095623, 12296.50813967467, 12315.706850780898, 12323.75352492963, 12388.318642474751, 7479.401647868266, 8507.489550626982, 8705.869411958953, 8999.370044097112, 9007.684731034382, 11558.653240402802, 11662.300261984308, 11678.824817627912, 11712.063034957013, 11765.352905589933], "value": 9019.891805173598, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.0898280186677, 1481.87404070654, 1495.2673190136834, 1638.3774165816988, 1783.2510345654816, 7960.601969901503, 8325.0, 8333.499990000604, 8337.499750014997, 8542.829143417128, 7851.725189618364, 8005.439619226657, 8265.173482651748, 8273.710420135296, 8281.130481299468, 2036.3280117561244, 2271.681964524968, 2285.0859656137595, 2341.391238278043, 2353.599888019041, 2368.846025008369, 2372.6559648850994, 2375.2517956843626, 2378.7502312257225, 2378.845375050616, 2309.7459279479244, 2317.455397981473, 2333.6149535326736, 2336.5560543496767, 2337.275444612167, 1908.332083770683, 2185.267935241696, 2193.7367515898113, 2262.061244583496, 2267.025179172955, 2312.479692069288, 2315.6526521021815, 2334.579775640384, 2335.97664023361, 2336.719593648773, 8509.48943063412, 8558.443701159405, 8567.100454452317, 8579.399442039059, 8581.570921453966, 5094.668846525001, 5255.684658920477, 5257.631965762398, 5258.158694608883, 5262.8684282892855, 3204.583404157468, 3343.164208947763, 3364.8485818138242, 3403.2002479417315, 3404.114930118187, 1113.4822307626991, 1122.5341483284428, 1157.2767020612118, 1157.8321143434155, 2047.6518991771434, 11442.084633229322, 11960.820587691192, 11977.580784672495, 11988.880111198863, 11989.580364687281, 4728.645351598644, 4733.928991065137, 4759.809607615656, 4767.404074490689, 4848.636352273523, 10137.746556336151, 10262.0, 10271.332363396356, 10295.330803497749, 10305.639302624371, 5335.146376579729, 5379.193121031876, 5400.540954018874, 5400.91898621521, 5401.783928642811, 4268.573142685768, 4672.229082201467, 4829.830955916596, 4839.564439200489, 4919.0407870464915, 3950.4074388841905, 4002.3196056670436, 4030.831058992859, 4091.8772436826944, 4109.075458021921, 1256.723520825417, 1271.5994461744706, 1287.7553264879643, 1295.2940647347218, 1301.7136230029569, 886.4592598514901, 941.2846236859899, 941.8963913969458, 945.163530275711, 960.582146766159, 5566.025945459528, 5631.94697465023, 5690.374058853523, 5822.475977161991, 5913.172155898178, 906.859436787299, 921.7050543825911, 956.2159029595665, 1005.2259759984771, 1017.8829434614966, 3697.1681371691157, 3865.0530619997717, 3955.5846636102797, 3967.285888540033, 3996.7402118862183, 10436.165106791439, 10750.247482676294, 10802.459877006118, 10802.567897284178, 10816.891831081746, 10434.68695939123, 10674.946625266824, 10692.305000174963, 10769.353838769699, 10773.138148948065, 7814.492058016211, 7822.06135263772, 7897.05235371759, 7928.246816552533, 7958.04503459577, 5483.61614686984, 5508.55931525485, 5584.525315348241, 5587.525060369914, 5652.0, 9804.068613481708, 9876.259280553844, 9974.950125249326, 9990.350627209207, 9995.0, 9920.702378928643, 9999.800004000024, 10045.748856278651, 10308.536115874653, 10347.379157250589, 6505.674716264262, 6707.396334329934, 6710.4631629470505, 7226.096737907762, 7361.006264154271, 7825.5304681717, 8070.677172913018, 8323.167683231628, 8345.95827020861, 8615.784605384664, 7482.438817088849, 7621.580813055335, 7638.541687498768, 7694.615269236628, 7697.076350837935, 7209.3872020876715, 7211.2428195038765, 7263.309985551364, 7366.852662946604, 7395.260473952777, 6862.451003919575, 6868.9313106870295, 6926.757563485254, 6947.687354068978, 6974.0, 5038.093143234253, 5127.0, 5137.33214682089, 5206.73966301691, 5225.555827754683, 4842.297866809364, 4863.708177509361, 4906.362172917497, 4942.728149951788, 4945.159322915041], "value": 4565.142321268093, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.11257984253393, 332.80530889429684, 335.4816808031591, 337.5004992610934, 339.27733926736056, 5210.505002024802, 5228.503292187245, 5300.204969254613, 5336.146216605344, 5347.54545863602, 5256.894862102765, 5274.4198138204865, 5280.445553216915, 5297.417284098756, 5340.359156901168, 4144.23331683638, 4174.874753757392, 4183.6025577570235, 4197.286461301586, 4198.748075115487, 3892.046448620078, 4005.638083051762, 4159.211539038212, 4198.8320467181275, 4207.768572728514, 4137.110521237933, 4158.08522125132, 4169.520505141902, 4169.7907606794, 4172.582741725818, 4094.7274262784144, 4130.277201489727, 4146.3365861462025, 4157.792110394484, 4167.354060120686, 3449.5688038995127, 3724.6647801697704, 3733.2720119576693, 3738.3831667774784, 3754.455603937441, 5061.659304858776, 5089.847304580869, 5100.515451032146, 5101.668391554575, 5140.563052140536, 4679.479169269966, 4685.203515402356, 4688.601468875149, 4694.694844835075, 4748.382710247645, 5385.138377859524, 5474.39781624021, 5512.751926163332, 5545.417731138213, 5546.694931778791, 3962.93000889761, 3974.0, 3977.7016723745546, 4003.079291762882, 4010.177913527749, 5744.626599271034, 5761.84763047388, 5785.884282314372, 5796.50729687977, 5844.152597873327, 3997.780122093313, 4105.014796448831, 4109.438413402888, 4122.9381559276635, 4124.505059392892, 4141.482314710661, 4144.865394321927, 4157.91684166321, 4159.875203743893, 4168.24971505132, 4742.19382704941, 4752.78803905002, 4761.4524329701835, 4782.354382158364, 4808.687435316763, 5519.116941289374, 5610.85972850682, 5626.212330273765, 5653.095504719226, 5694.288213973254, 1418.7800890861934, 1421.9146851188755, 1432.9641758955902, 1437.2741765408402, 1438.8848892088608, 879.8988116366572, 890.8774943571148, 904.9864052483304, 919.9080091990747, 931.3992474853682, 4765.284497580868, 4769.379980602499, 4799.232122860326, 4802.951970480321, 4809.615230781529, 5046.419661738873, 5069.465267366317, 5078.156232509807, 5100.515451032146, 5107.642465027412, 4755.643326750507, 4786.707588950963, 4793.640476964241, 4843.903121937541, 4990.6506544541535, 3030.1364111228195, 3031.7119873611973, 3033.226527235585, 3040.863161157753, 3044.75641948648, 5907.793227237026, 5912.674802885796, 5914.728333408338, 5923.696786706918, 5926.762929482858, 5579.330480342385, 5793.0, 5819.719661674425, 5830.3586605473365, 5845.210896528914, 5822.301323841166, 5835.708214589254, 5862.472377486047, 5887.76448942046, 5900.704964751745, 5418.455740114048, 5673.234113394639, 5738.684372359393, 5759.366469688414, 5763.221965034834, 5686.4029276926985, 5709.628874123168, 5715.342735585461, 5719.57103217252, 5724.79963201286, 5877.647341159544, 5881.5588830837005, 5897.823065308047, 5906.793262235801, 5914.970425147847, 3668.596454390068, 3874.767513949172, 4023.3964905264443, 4037.8990525237105, 4071.959280407158, 5684.8010319638615, 5688.715564221689, 5701.857453563694, 5707.971460142839, 5709.65742055478, 5558.694271815089, 5561.833145005657, 5572.832815015394, 5576.804811831566, 5602.299712535933, 5339.546138578265, 5589.972050139723, 5591.748371323219, 5627.380988091225, 5633.8309850704545, 5514.228008078792, 5517.675757818175, 5519.571388589008, 5545.639533430314, 5549.7780088796, 5342.9465705342445, 5658.915116273177, 5661.405552416937, 5692.886142277049, 5698.943010569841, 5476.385585513542, 5487.573230959899, 5514.338279406497, 5530.198121272473, 5532.482720362306], "value": 4208.570701970278, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.263857184957, 757.2162811490109, 761.3300295739748, 814.6537721468376, 858.3219256787137, 15723.135227562494, 16023.670650093207, 16462.423815166472, 16578.336866525326, 16602.335906563723, 14531.636709082251, 14583.781243281359, 14711.852881471183, 14722.116672999628, 14814.777778333333, 684.9794506164798, 804.3364224514769, 805.3114587028094, 827.983440331193, 829.9792505187359, 808.1796976069294, 808.7654580171773, 810.0441479054713, 810.469142711522, 814.8777683347515, 842.6545116502235, 843.5950743643025, 844.4933040175907, 846.1622993236713, 848.4103548034119, 704.8766465868453, 837.0750320895414, 850.961706723199, 852.4203541591716, 856.5973992223645, 622.5175488996019, 623.2832242920632, 623.2925629410606, 623.5728525959732, 623.6569886562372, 14883.404663813435, 14958.62603434912, 15007.324670389859, 15025.924870375688, 15038.172900490577, 13608.38762255701, 13754.65613359664, 13754.862451375458, 13982.761797115003, 14080.92959535206, 12493.375331233401, 12675.366231688378, 12740.299283539402, 12833.607661974065, 12949.676258093528, 3757.511523501927, 3815.4086116651965, 3835.884923452301, 3851.4030325299623, 3949.861754838567, 50255.74872125616, 50312.24531632029, 50417.74791126057, 50456.74771626118, 50647.493525064645, 11093.833592495957, 11269.94365028186, 11383.88616113845, 11462.48418821155, 11627.941860290644, 20452.38642840717, 20475.795242047687, 20482.283120091022, 20519.17923283052, 20561.38315850527, 8308.70919517814, 8430.831383372299, 8439.113893041142, 8487.278581320534, 8606.483610983361, 4722.669413141047, 4785.760711964388, 4858.05267972749, 4874.317595536628, 4999.125153098194, 3479.460683594047, 3614.945775813365, 3627.038834708804, 3628.0, 3630.074331045619, 577.206341280739, 646.6508085633799, 651.7067319706151, 652.6997581112741, 690.8514669346115, 634.1660716158237, 689.7310049080862, 723.4357201382929, 765.7664412354285, 799.2167675677869, 9850.80298394028, 10974.428612794578, 11187.832182517268, 11233.775324493465, 11423.657290281139, 632.4529282170981, 688.9242183359827, 693.719043787267, 771.8803585444265, 806.2058872011064, 4843.854684359475, 5057.291979122926, 5073.239014147907, 5099.413567439718, 5264.289320941624, 73347.0, 123487.0, 127266.0, 128114.0, 131568.0, 78180.60909695529, 98596.0, 101446.49276753717, 103048.48475757573, 106212.46893765636, 71024.0, 82814.58592706997, 84046.57976710077, 85967.14032859591, 86246.56876715702, 9639.807203856024, 9935.304528682922, 9950.402975821475, 10009.849852252077, 10130.848037279595, 49085.5380555124, 49618.255726163414, 50305.0, 50805.49194508156, 52132.47867521428, 66857.33142668706, 75586.62206688931, 76382.6180869092, 76701.61649191719, 77116.0, 12963.870361296265, 13010.869891300967, 13333.0, 13487.25820079905, 13505.797413038616, 14993.925030374778, 15046.022008569407, 15185.544433667008, 15359.769603456181, 15418.922905385401, 13670.93164534171, 14089.506867259597, 14173.716525669635, 14206.158768246598, 14268.357923893658, 13937.651558711113, 14158.646033849236, 14252.216128113054, 14575.03237062983, 14969.40122395092, 13957.651058723613, 13990.510332138327, 14004.36980335867, 14230.644233894236, 14483.565493035227, 11120.44397780124, 11374.31754094757, 11544.134189935621, 11663.650090497298, 11887.643370698894, 11698.532058717556, 11985.580504682293, 12160.878391216329, 12218.450169742206, 12234.694132646755], "value": 7584.1242144338585, "unit": "score"}], "name": "dromaeo_css", "value": 7251.040605980692, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 105.0, 110.0, 109.0, 109.0, 109.0, 108.0, 110.0, 110.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 123.0, 136.0, 183.0, 124.0, 126.0, 153.0, 128.0, 196.0, 132.0], "value": 145.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 160.0, 159.0, 160.0, 158.0, 160.0, 160.0, 160.0, 162.0], "value": 159.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 126.0, 75.0, 77.0, 74.0, 75.0, 107.0, 75.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 117.0, 86.0, 84.0, 85.0, 120.0, 85.0, 84.0, 121.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 144.0, 145.0, 146.0, 145.0, 146.0, 145.0, 145.0, 147.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 52.0, 53.0, 53.0, 53.0, 53.0, 52.0, 62.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 62.0, 61.0, 62.0, 61.0, 61.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 78.0, 86.0, 80.0, 81.0, 79.0, 79.0, 115.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 124.0, 133.0, 128.0, 121.0, 124.0, 129.0, 130.0, 152.0, 133.0], "value": 130.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 162.0, 163.0, 163.0, 160.0, 165.0, 168.0, 162.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 63.0, 64.0, 63.0, 63.0, 64.0, 64.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1508.1, "alertThreshold": 2.0}]} 11:19:05 INFO - Return code: 0 11:19:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:19:05 ERROR - # TBPL SUCCESS # 11:19:05 INFO - Running post-action listener: _resource_record_post_action 11:19:05 INFO - ##### 11:19:05 INFO - ##### Finished run-tests step (success) 11:19:05 INFO - ##### 11:19:05 INFO - Running post-run listener: _resource_record_post_run 11:19:05 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540704768; Read time: 12; Write time: 491812 11:19:05 INFO - TinderboxPrint: CPU usage
13.1% 11:19:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:19:05 INFO - TinderboxPrint: I/O write bytes / time
540,704,768 / 491,812 11:19:05 INFO - TinderboxPrint: CPU idle
8,276.7 (86.9%) 11:19:05 INFO - TinderboxPrint: CPU user
1,206.5 (12.7%) 11:19:05 INFO - TinderboxPrint: Swap in / out
0 / 0 11:19:05 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 248004608; Read time: 0; Write time: 192608 11:19:05 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292700160; Read time: 12; Write time: 299204 11:19:06 INFO - Running post-run listener: _upload_blobber_files 11:19:06 INFO - Blob upload gear active. 11:19:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:19:06 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 11:19:06 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:19:06 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:19:06 INFO - (blobuploader) - INFO - Open directory for files ... 11:19:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:19:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:19:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:09 INFO - (blobuploader) - INFO - Done attempting. 11:19:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:19:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:19:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:12 INFO - (blobuploader) - INFO - Done attempting. 11:19:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:19:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:19:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:13 INFO - (blobuploader) - INFO - Done attempting. 11:19:13 INFO - (blobuploader) - INFO - Iteration through files over. 11:19:13 INFO - Return code: 0 11:19:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:19:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:19:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7aa35f3938ef107836680b5870c8fa6b830b08db7c9d27e27ecfb6fc4a47ef93298f51a72d9d00b7da6ece78ad95a6cdb8d3e291c6aba75a043a6cc2b6afa8e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a84b1ee4d11389b18fb5bb4b0476cb1ba47d1c5e9c8f65e155a92857f1dae909184af82d36f22fad12b1dae189d68eb12893a75c7e37b97137c8becb3bda996a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4313534fc748581c4e5a2c4efc931e698655c19c1879008fb91a7ceb01d759eb63f9ac49c12d7109942ecfc0d6028cd9bb7b1e63b669eb468a6dd9414faab557"} 11:19:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:19:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:19:13 INFO - Contents: 11:19:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d7aa35f3938ef107836680b5870c8fa6b830b08db7c9d27e27ecfb6fc4a47ef93298f51a72d9d00b7da6ece78ad95a6cdb8d3e291c6aba75a043a6cc2b6afa8e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a84b1ee4d11389b18fb5bb4b0476cb1ba47d1c5e9c8f65e155a92857f1dae909184af82d36f22fad12b1dae189d68eb12893a75c7e37b97137c8becb3bda996a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4313534fc748581c4e5a2c4efc931e698655c19c1879008fb91a7ceb01d759eb63f9ac49c12d7109942ecfc0d6028cd9bb7b1e63b669eb468a6dd9414faab557"} 11:19:13 INFO - Running post-run listener: copy_logs_to_upload_dir 11:19:13 INFO - Copying logs to upload dir... 11:19:13 INFO - mkdir: /builds/slave/test/build/upload/logs 11:19:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.602181 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-07 11:19:13.222458) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 11:19:13.225730) ========= 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=920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086 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/sha512/d7aa35f3938ef107836680b5870c8fa6b830b08db7c9d27e27ecfb6fc4a47ef93298f51a72d9d00b7da6ece78ad95a6cdb8d3e291c6aba75a043a6cc2b6afa8e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a84b1ee4d11389b18fb5bb4b0476cb1ba47d1c5e9c8f65e155a92857f1dae909184af82d36f22fad12b1dae189d68eb12893a75c7e37b97137c8becb3bda996a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4313534fc748581c4e5a2c4efc931e698655c19c1879008fb91a7ceb01d759eb63f9ac49c12d7109942ecfc0d6028cd9bb7b1e63b669eb468a6dd9414faab557"} build_url:https://queue.taskcluster.net/v1/task/XN9B9UliRYeHHalwucsYXw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011342 build_url: 'https://queue.taskcluster.net/v1/task/XN9B9UliRYeHHalwucsYXw/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/sha512/d7aa35f3938ef107836680b5870c8fa6b830b08db7c9d27e27ecfb6fc4a47ef93298f51a72d9d00b7da6ece78ad95a6cdb8d3e291c6aba75a043a6cc2b6afa8e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a84b1ee4d11389b18fb5bb4b0476cb1ba47d1c5e9c8f65e155a92857f1dae909184af82d36f22fad12b1dae189d68eb12893a75c7e37b97137c8becb3bda996a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4313534fc748581c4e5a2c4efc931e698655c19c1879008fb91a7ceb01d759eb63f9ac49c12d7109942ecfc0d6028cd9bb7b1e63b669eb468a6dd9414faab557"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 11:19:13.253622) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 11:19:13.254237) ========= 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=920470bf432669ad7e3a5387000001ca-1465321607.269432-1209307086 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 11:19:13.335475) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 11:19:13.335799) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 11:19:13.336137) ========= ========= Total master_lag: 0.15 =========