builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1465436584.74 results: success (0) buildid: 20160608171431 builduid: b906436fb8f74101a136b91ecb501a45 revision: 8a447c89176fb240f78db350e8d65f62d0a6fabb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 18:43:04.736585) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 18:43:04.744065) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 18:43:04.744365) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 18:43:04.851702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 18:43:04.851965) ========= 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=c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 18:43:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-06-08 18:43:05 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.205782 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 18:43:05.088575) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 18:43:05.088856) ========= 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=c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.104339 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 18:43:05.205454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 18:43:05.205818) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8a447c89176fb240f78db350e8d65f62d0a6fabb --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 8a447c89176fb240f78db350e8d65f62d0a6fabb --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=c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 18:43:05,217 truncating revision to first 12 chars 2016-06-08 18:43:05,217 Setting DEBUG logging. 2016-06-08 18:43:05,217 attempt 1/10 2016-06-08 18:43:05,217 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8a447c89176f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 18:43:06,122 unpacking tar archive at: fx-team-8a447c89176f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.262994 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 18:43:06.481942) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 18:43:06.482253) ========= script_repo_revision: 8a447c89176fb240f78db350e8d65f62d0a6fabb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 18:43:06.482660) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 18:43:06.482936) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 18:43:06.490715) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-08 18:43:06.490991) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:43:06 INFO - MultiFileLogger online at 20160608 18:43:06 in /builds/slave/test 18:43:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 18:43:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:43:06 INFO - {'append_to_log': False, 18:43:06 INFO - 'base_work_dir': '/builds/slave/test', 18:43:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:43:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:43:06 INFO - 'branch': 'Fx-Team-Non-PGO', 18:43:06 INFO - 'buildbot_json_path': 'buildprops.json', 18:43:06 INFO - 'config_files': ('talos/linux_config.py',), 18:43:06 INFO - 'default_actions': ('clobber', 18:43:06 INFO - 'read-buildbot-config', 18:43:06 INFO - 'download-and-extract', 18:43:06 INFO - 'populate-webroot', 18:43:06 INFO - 'create-virtualenv', 18:43:06 INFO - 'install', 18:43:06 INFO - 'run-tests'), 18:43:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:43:06 INFO - 'download_minidump_stackwalk': True, 18:43:06 INFO - 'download_symbols': 'ondemand', 18:43:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:43:06 INFO - 'tooltool.py': '/tools/tooltool.py', 18:43:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:43:06 INFO - '/tools/misc-python/virtualenv.py')}, 18:43:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:43:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:43:06 INFO - 'installer_path': 'installer.exe', 18:43:06 INFO - 'log_level': 'info', 18:43:06 INFO - 'log_name': 'talos', 18:43:06 INFO - 'log_to_console': True, 18:43:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:43:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:43:06 INFO - 'opt_config_files': (), 18:43:06 INFO - 'pip_index': False, 18:43:06 INFO - 'sps_profile': False, 18:43:06 INFO - 'sps_profile_interval': 0, 18:43:06 INFO - 'suite': 'dromaeojs-e10s', 18:43:06 INFO - 'system_bits': '32', 18:43:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:43:06 INFO - 'title': 'talos-linux64-ix-004', 18:43:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:43:06 INFO - 'use_talos_json': True, 18:43:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:43:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:43:06 INFO - 'work_dir': 'build'} 18:43:06 INFO - ##### 18:43:06 INFO - ##### Running clobber step. 18:43:06 INFO - ##### 18:43:06 INFO - Running pre-action listener: _resource_record_pre_action 18:43:06 INFO - Running main action method: clobber 18:43:06 INFO - rmtree: /builds/slave/test/build 18:43:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:43:08 INFO - Running post-action listener: _resource_record_post_action 18:43:08 INFO - ##### 18:43:08 INFO - ##### Finished clobber step (success) 18:43:08 INFO - ##### 18:43:08 INFO - ##### 18:43:08 INFO - ##### Running read-buildbot-config step. 18:43:08 INFO - ##### 18:43:08 INFO - Running pre-action listener: _resource_record_pre_action 18:43:08 INFO - Running main action method: read_buildbot_config 18:43:08 INFO - Using buildbot properties: 18:43:08 INFO - { 18:43:08 INFO - "project": "", 18:43:08 INFO - "product": "firefox", 18:43:08 INFO - "script_repo_revision": "production", 18:43:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:43:08 INFO - "repository": "", 18:43:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:43:08 INFO - "buildid": "20160608171431", 18:43:08 INFO - "pgo_build": "False", 18:43:08 INFO - "basedir": "/builds/slave/test", 18:43:08 INFO - "buildnumber": 1385, 18:43:08 INFO - "slavename": "talos-linux64-ix-004", 18:43:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:43:08 INFO - "platform": "ubuntu64_hw", 18:43:08 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:43:08 INFO - "branch": "fx-team", 18:43:08 INFO - "repo_path": "integration/fx-team", 18:43:08 INFO - "revision": "8a447c89176fb240f78db350e8d65f62d0a6fabb", 18:43:08 INFO - "stage_platform": "linux64", 18:43:08 INFO - "builduid": "b906436fb8f74101a136b91ecb501a45", 18:43:08 INFO - "slavebuilddir": "test" 18:43:08 INFO - } 18:43:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:43:08 INFO - Running post-action listener: _resource_record_post_action 18:43:08 INFO - ##### 18:43:08 INFO - ##### Finished read-buildbot-config step (success) 18:43:08 INFO - ##### 18:43:08 INFO - ##### 18:43:08 INFO - ##### Running download-and-extract step. 18:43:08 INFO - ##### 18:43:08 INFO - Running pre-action listener: _resource_record_pre_action 18:43:08 INFO - Running main action method: download_and_extract 18:43:08 INFO - mkdir: /builds/slave/test/build/tests 18:43: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')]} 18:43:08 INFO - https://queue.taskcluster.net/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:43:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:43:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:43:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjeaXdIfRZCQdNr2b_7oag/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 18:43:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjeaXdIfRZCQdNr2b_7oag/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 18:43:10 INFO - Downloaded 1361 bytes. 18:43:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:43:10 INFO - Using the following test package requirements: 18:43:10 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:43:10 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:43:10 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:43:10 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:10 INFO - u'jsshell-linux-x86_64.zip'], 18:43:10 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:43:10 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:43:10 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:43:10 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:43:10 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:43:10 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:43:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:43:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:43:10 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')]} 18:43:10 INFO - https://queue.taskcluster.net/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:43:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:43:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:43:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjeaXdIfRZCQdNr2b_7oag/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 18:43:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjeaXdIfRZCQdNr2b_7oag/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 18:43:13 INFO - Downloaded 22879062 bytes. 18:43:13 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'] 18:43:13 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 18:43:14 INFO - Return code: 0 18:43:14 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 18:43:14 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')]} 18:43:14 INFO - https://queue.taskcluster.net/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:43:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:43:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:43:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjeaXdIfRZCQdNr2b_7oag/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 18:43:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjeaXdIfRZCQdNr2b_7oag/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 18:43:17 INFO - Downloaded 22879062 bytes. 18:43:17 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'] 18:43:17 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 18:43:19 INFO - Return code: 0 18:43:19 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')]} 18:43:19 INFO - https://queue.taskcluster.net/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:43:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:43:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:43:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjeaXdIfRZCQdNr2b_7oag/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 18:43:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjeaXdIfRZCQdNr2b_7oag/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 18:43:21 INFO - Downloaded 10833369 bytes. 18:43:21 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'] 18:43:21 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 18:43:22 INFO - Return code: 0 18:43:22 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')]} 18:43:22 INFO - https://queue.taskcluster.net/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:43:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:43:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:43:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjeaXdIfRZCQdNr2b_7oag/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 18:43:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UjeaXdIfRZCQdNr2b_7oag/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 18:43:23 INFO - Downloaded 55338139 bytes. 18:43:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:43:23 INFO - mkdir: /builds/slave/test/properties 18:43:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:43:23 INFO - Writing to file /builds/slave/test/properties/build_url 18:43:23 INFO - Contents: 18:43:23 INFO - build_url:https://queue.taskcluster.net/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:43:24 INFO - Running post-action listener: _resource_record_post_action 18:43:24 INFO - Running post-action listener: set_extra_try_arguments 18:43:24 INFO - ##### 18:43:24 INFO - ##### Finished download-and-extract step (success) 18:43:24 INFO - ##### 18:43:24 INFO - ##### 18:43:24 INFO - ##### Running populate-webroot step. 18:43:24 INFO - ##### 18:43:24 INFO - Running pre-action listener: _resource_record_pre_action 18:43:24 INFO - Running main action method: populate_webroot 18:43:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:43:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:43:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:43:24 INFO - '--tppagecycles', 18:43:24 INFO - '7'], 18:43:24 INFO - 'tests': ['tsvgm']}}, 18:43:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:43:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:43:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:43:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:43:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:43:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:43:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:24 INFO - 'talos_options': ['--disable-e10s'], 18:43:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:43:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:43:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:24 INFO - 'talos_options': ['--disable-e10s'], 18:43:24 INFO - 'tests': ['damp', 'tps']}, 18:43:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:24 INFO - 'tests': ['damp', 'tps']}, 18:43:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:43:24 INFO - 'tests': ['dromaeo_dom']}, 18:43:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:43:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:43:24 INFO - 'tests': ['a11yr', 18:43:24 INFO - 'ts_paint', 18:43:24 INFO - 'tpaint', 18:43:24 INFO - 'sessionrestore', 18:43:24 INFO - 'sessionrestore_no_auto_restore', 18:43:24 INFO - 'tabpaint']}, 18:43:24 INFO - 'other-e10s': {'tests': ['a11yr', 18:43:24 INFO - 'ts_paint', 18:43:24 INFO - 'tpaint', 18:43:24 INFO - 'sessionrestore', 18:43:24 INFO - 'sessionrestore_no_auto_restore', 18:43:24 INFO - 'tabpaint']}, 18:43:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:43:24 INFO - 'ts_paint', 18:43:24 INFO - 'tpaint', 18:43:24 INFO - 'sessionrestore', 18:43:24 INFO - 'sessionrestore_no_auto_restore', 18:43:24 INFO - 'tabpaint']}, 18:43:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:43:24 INFO - 'ts_paint', 18:43:24 INFO - 'tpaint', 18:43:24 INFO - 'sessionrestore', 18:43:24 INFO - 'sessionrestore_no_auto_restore', 18:43:24 INFO - 'tabpaint']}, 18:43:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:43:24 INFO - 'tests': ['a11yr', 18:43:24 INFO - 'ts_paint', 18:43:24 INFO - 'tpaint', 18:43:24 INFO - 'sessionrestore', 18:43:24 INFO - 'sessionrestore_no_auto_restore', 18:43:24 INFO - 'tabpaint']}, 18:43:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:43:24 INFO - 'tests': ['a11yr', 18:43:24 INFO - 'ts_paint', 18:43:24 INFO - 'tpaint', 18:43:24 INFO - 'sessionrestore', 18:43:24 INFO - 'sessionrestore_no_auto_restore', 18:43:24 INFO - 'tabpaint']}, 18:43:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:43:24 INFO - 'tests': ['tsvgx', 18:43:24 INFO - 'tsvgr_opacity', 18:43:24 INFO - 'tart', 18:43:24 INFO - 'tscrollx', 18:43:24 INFO - 'cart']}, 18:43:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:43:24 INFO - 'tsvgr_opacity', 18:43:24 INFO - 'tart', 18:43:24 INFO - 'tscrollx', 18:43:24 INFO - 'cart']}, 18:43:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:24 INFO - 'talos_options': ['--disable-e10s'], 18:43:24 INFO - 'tests': ['tp5o']}, 18:43:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:24 INFO - 'tests': ['tp5o']}, 18:43:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:24 INFO - 'talos_options': ['--disable-e10s', 18:43:24 INFO - '--xperf_path', 18:43:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:43:24 INFO - 'tests': ['tp5n']}, 18:43:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:43:24 INFO - 'talos_options': ['--xperf_path', 18:43:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:43:24 INFO - 'tests': ['tp5n']}}, 18:43:24 INFO - 'talos.zip': {'path': '', 18:43:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:43:24 INFO - Running post-action listener: _resource_record_post_action 18:43:24 INFO - ##### 18:43:24 INFO - ##### Finished populate-webroot step (success) 18:43:24 INFO - ##### 18:43:24 INFO - ##### 18:43:24 INFO - ##### Running create-virtualenv step. 18:43:24 INFO - ##### 18:43:24 INFO - Running pre-action listener: _resource_record_pre_action 18:43:24 INFO - Running main action method: create_virtualenv 18:43:24 INFO - Creating virtualenv /builds/slave/test/build/venv 18:43:24 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 18:43:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:43:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:43:24 INFO - Using real prefix '/usr' 18:43:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:43:25 INFO - Installing distribute.............................................................................................................................................................................................done. 18:43:27 INFO - Installing pip.................done. 18:43:27 INFO - Return code: 0 18:43:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:43:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:27 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 0x7fbf47efbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f54020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe62e0>, '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 0x1f52140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f525d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', '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 18:43:27 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 18:43:27 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 18:43:27 INFO - Using env: {'DISPLAY': ':0', 18:43:27 INFO - 'HOME': '/home/cltbld', 18:43:27 INFO - 'LANG': 'en_US.UTF-8', 18:43:27 INFO - 'LANGUAGE': 'en_US:en', 18:43:27 INFO - 'LOGNAME': 'cltbld', 18:43:27 INFO - 'MAIL': '/var/mail/cltbld', 18:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:27 INFO - 'MOZ_NO_REMOTE': '1', 18:43:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:27 INFO - 'NO_EM_RESTART': '1', 18:43:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:27 INFO - 'PWD': '/builds/slave/test', 18:43:27 INFO - 'SHELL': '/bin/bash', 18:43:27 INFO - 'SHLVL': '1', 18:43:27 INFO - 'TERM': 'linux', 18:43:27 INFO - 'TMOUT': '86400', 18:43:27 INFO - 'USER': 'cltbld', 18:43:27 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', 18:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:27 INFO - '_': '/tools/buildbot/bin/python'} 18:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:28 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 18:43:28 INFO - Cleaning up... 18:43:28 INFO - Return code: 0 18:43:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:43: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')]} 18:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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')]} 18:43:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:28 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 0x7fbf47efbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f54020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe62e0>, '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 0x1f52140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f525d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', '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 18:43:28 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 18:43:28 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 18:43:28 INFO - Using env: {'DISPLAY': ':0', 18:43:28 INFO - 'HOME': '/home/cltbld', 18:43:28 INFO - 'LANG': 'en_US.UTF-8', 18:43:28 INFO - 'LANGUAGE': 'en_US:en', 18:43:28 INFO - 'LOGNAME': 'cltbld', 18:43:28 INFO - 'MAIL': '/var/mail/cltbld', 18:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:28 INFO - 'MOZ_NO_REMOTE': '1', 18:43:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:28 INFO - 'NO_EM_RESTART': '1', 18:43:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:28 INFO - 'PWD': '/builds/slave/test', 18:43:28 INFO - 'SHELL': '/bin/bash', 18:43:28 INFO - 'SHLVL': '1', 18:43:28 INFO - 'TERM': 'linux', 18:43:28 INFO - 'TMOUT': '86400', 18:43:28 INFO - 'USER': 'cltbld', 18:43:28 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', 18:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:28 INFO - '_': '/tools/buildbot/bin/python'} 18:43:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:28 INFO - Downloading/unpacking psutil>=3.1.1 18:43:28 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 18:43:28 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 18:43:28 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 18:43:28 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 18:43:28 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 18:43:28 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 18:43:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:43:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:43:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:43:30 INFO - Installing collected packages: psutil 18:43:30 INFO - Running setup.py install for psutil 18:43:30 INFO - building 'psutil._psutil_linux' extension 18:43:30 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 18:43:32 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 18:43:32 INFO - building 'psutil._psutil_posix' extension 18:43:32 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 18:43:32 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 18:43:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:43:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:43:32 INFO - Successfully installed psutil 18:43:32 INFO - Cleaning up... 18:43:32 INFO - Return code: 0 18:43:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:43:32 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')]} 18:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:32 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')]} 18:43:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:32 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 0x7fbf47efbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f54020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe62e0>, '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 0x1f52140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f525d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', '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 18:43:32 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 18:43:32 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 18:43:32 INFO - Using env: {'DISPLAY': ':0', 18:43:32 INFO - 'HOME': '/home/cltbld', 18:43:32 INFO - 'LANG': 'en_US.UTF-8', 18:43:32 INFO - 'LANGUAGE': 'en_US:en', 18:43:32 INFO - 'LOGNAME': 'cltbld', 18:43:32 INFO - 'MAIL': '/var/mail/cltbld', 18:43:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:32 INFO - 'MOZ_NO_REMOTE': '1', 18:43:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:32 INFO - 'NO_EM_RESTART': '1', 18:43:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:32 INFO - 'PWD': '/builds/slave/test', 18:43:32 INFO - 'SHELL': '/bin/bash', 18:43:32 INFO - 'SHLVL': '1', 18:43:32 INFO - 'TERM': 'linux', 18:43:32 INFO - 'TMOUT': '86400', 18:43:32 INFO - 'USER': 'cltbld', 18:43:32 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', 18:43:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:32 INFO - '_': '/tools/buildbot/bin/python'} 18:43:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:43:32 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 18:43:32 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 18:43:32 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 18:43:32 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 18:43:32 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 18:43:32 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 18:43:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:43:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:43:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:43:34 INFO - Installing collected packages: mozsystemmonitor 18:43:34 INFO - Running setup.py install for mozsystemmonitor 18:43:34 INFO - Successfully installed mozsystemmonitor 18:43:34 INFO - Cleaning up... 18:43:34 INFO - Return code: 0 18:43:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:43:34 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')]} 18:43:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:34 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')]} 18:43:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:34 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 0x7fbf47efbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f54020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe62e0>, '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 0x1f52140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f525d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', '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 18:43:34 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 18:43:34 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 18:43:34 INFO - Using env: {'DISPLAY': ':0', 18:43:34 INFO - 'HOME': '/home/cltbld', 18:43:34 INFO - 'LANG': 'en_US.UTF-8', 18:43:34 INFO - 'LANGUAGE': 'en_US:en', 18:43:34 INFO - 'LOGNAME': 'cltbld', 18:43:34 INFO - 'MAIL': '/var/mail/cltbld', 18:43:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:34 INFO - 'MOZ_NO_REMOTE': '1', 18:43:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:34 INFO - 'NO_EM_RESTART': '1', 18:43:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:34 INFO - 'PWD': '/builds/slave/test', 18:43:34 INFO - 'SHELL': '/bin/bash', 18:43:34 INFO - 'SHLVL': '1', 18:43:34 INFO - 'TERM': 'linux', 18:43:34 INFO - 'TMOUT': '86400', 18:43:34 INFO - 'USER': 'cltbld', 18:43:34 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', 18:43:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:34 INFO - '_': '/tools/buildbot/bin/python'} 18:43:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:35 INFO - Downloading/unpacking jsonschema==2.5.1 18:43:35 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 18:43:35 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 18:43:35 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 18:43:35 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 18:43:35 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 18:43:35 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 18:43:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:43:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:43:36 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 18:43:36 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 18:43:36 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 18:43:36 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 18:43:36 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 18:43:36 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 18:43:37 INFO - Downloading functools32-3.2.3-2.tar.gz 18:43:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:43:37 INFO - warning: no files found matching '*.txt' 18:43:37 INFO - no previously-included directories found matching 'build' 18:43:37 INFO - no previously-included directories found matching 'dist' 18:43:37 INFO - no previously-included directories found matching '.git*' 18:43:37 INFO - Installing collected packages: jsonschema, functools32 18:43:37 INFO - Running setup.py install for functools32 18:43:37 INFO - warning: no files found matching '*.txt' 18:43:37 INFO - no previously-included directories found matching 'build' 18:43:37 INFO - no previously-included directories found matching 'dist' 18:43:37 INFO - no previously-included directories found matching '.git*' 18:43:37 INFO - Successfully installed jsonschema functools32 18:43:37 INFO - Cleaning up... 18:43:37 INFO - Return code: 0 18:43:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:43:37 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')]} 18:43:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:37 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')]} 18:43:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:37 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 0x7fbf47efbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f54020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe62e0>, '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 0x1f52140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f525d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', '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 18:43:37 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 18:43:37 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 18:43:37 INFO - Using env: {'DISPLAY': ':0', 18:43:37 INFO - 'HOME': '/home/cltbld', 18:43:37 INFO - 'LANG': 'en_US.UTF-8', 18:43:37 INFO - 'LANGUAGE': 'en_US:en', 18:43:37 INFO - 'LOGNAME': 'cltbld', 18:43:37 INFO - 'MAIL': '/var/mail/cltbld', 18:43:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:37 INFO - 'MOZ_NO_REMOTE': '1', 18:43:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:37 INFO - 'NO_EM_RESTART': '1', 18:43:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:37 INFO - 'PWD': '/builds/slave/test', 18:43:37 INFO - 'SHELL': '/bin/bash', 18:43:37 INFO - 'SHLVL': '1', 18:43:37 INFO - 'TERM': 'linux', 18:43:37 INFO - 'TMOUT': '86400', 18:43:37 INFO - 'USER': 'cltbld', 18:43:37 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', 18:43:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:37 INFO - '_': '/tools/buildbot/bin/python'} 18:43:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:37 INFO - Downloading/unpacking blobuploader==1.2.4 18:43:37 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 18:43:37 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 18:43:37 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 18:43:37 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 18:43:37 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 18:43:37 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 18:43:39 INFO - Downloading blobuploader-1.2.4.tar.gz 18:43:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:43:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:43:39 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 18:43:39 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 18:43:39 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 18:43:39 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 18:43:39 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 18:43:39 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 18:43:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:43:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:43:40 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 18:43:40 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 18:43:40 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 18:43:40 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 18:43:40 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 18:43:40 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 18:43:40 INFO - Downloading docopt-0.6.1.tar.gz 18:43:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:43:40 INFO - Installing collected packages: blobuploader, requests, docopt 18:43:40 INFO - Running setup.py install for blobuploader 18:43:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:43:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:43:40 INFO - Running setup.py install for requests 18:43:40 INFO - Running setup.py install for docopt 18:43:40 INFO - Successfully installed blobuploader requests docopt 18:43:40 INFO - Cleaning up... 18:43:40 INFO - Return code: 0 18:43:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:43:40 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')]} 18:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:40 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')]} 18:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:40 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 0x7fbf47efbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f54020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe62e0>, '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 0x1f52140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f525d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', '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 18:43:40 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 18:43:40 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 18:43:40 INFO - Using env: {'DISPLAY': ':0', 18:43:40 INFO - 'HOME': '/home/cltbld', 18:43:40 INFO - 'LANG': 'en_US.UTF-8', 18:43:40 INFO - 'LANGUAGE': 'en_US:en', 18:43:40 INFO - 'LOGNAME': 'cltbld', 18:43:40 INFO - 'MAIL': '/var/mail/cltbld', 18:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:40 INFO - 'MOZ_NO_REMOTE': '1', 18:43:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:40 INFO - 'NO_EM_RESTART': '1', 18:43:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:40 INFO - 'PWD': '/builds/slave/test', 18:43:40 INFO - 'SHELL': '/bin/bash', 18:43:40 INFO - 'SHLVL': '1', 18:43:40 INFO - 'TERM': 'linux', 18:43:40 INFO - 'TMOUT': '86400', 18:43:40 INFO - 'USER': 'cltbld', 18:43:40 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', 18:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:40 INFO - '_': '/tools/buildbot/bin/python'} 18:43:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:43:41 INFO - Running setup.py (path:/tmp/pip-BazhVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:43:41 INFO - Running setup.py (path:/tmp/pip-wxpm1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:43:41 INFO - Running setup.py (path:/tmp/pip-2ajQEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:43:41 INFO - Running setup.py (path:/tmp/pip-Jbb1Q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:43:41 INFO - Running setup.py (path:/tmp/pip-sAyEr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:43:41 INFO - Running setup.py (path:/tmp/pip-Hbqa7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:43:41 INFO - Running setup.py (path:/tmp/pip-RM2A4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:43:41 INFO - Running setup.py (path:/tmp/pip-RY0qlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:43:41 INFO - Running setup.py (path:/tmp/pip-OkyTlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:43:41 INFO - Running setup.py (path:/tmp/pip-HJ1HYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:43:41 INFO - Running setup.py (path:/tmp/pip-BM4uen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:43:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:43:41 INFO - Running setup.py (path:/tmp/pip-YYDm9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:43:42 INFO - Running setup.py (path:/tmp/pip-QOfI8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:43:42 INFO - Running setup.py (path:/tmp/pip-ntU30e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:43:42 INFO - Running setup.py (path:/tmp/pip-qawWon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:43:42 INFO - Running setup.py (path:/tmp/pip-f9vT9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:43:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:43:42 INFO - Running setup.py (path:/tmp/pip-rBIqCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:43:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:43:42 INFO - Running setup.py install for manifestparser 18:43:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:43:42 INFO - Running setup.py install for mozcrash 18:43:42 INFO - Running setup.py install for mozdebug 18:43:42 INFO - Running setup.py install for mozdevice 18:43:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:43:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:43:42 INFO - Running setup.py install for mozfile 18:43:42 INFO - Running setup.py install for mozhttpd 18:43:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:43:43 INFO - Running setup.py install for mozinfo 18:43:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:43:43 INFO - Running setup.py install for mozInstall 18:43:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:43:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:43:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:43:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:43:43 INFO - Running setup.py install for mozleak 18:43:43 INFO - Running setup.py install for mozlog 18:43:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:43:43 INFO - Running setup.py install for moznetwork 18:43:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:43:43 INFO - Running setup.py install for mozprocess 18:43:43 INFO - Running setup.py install for mozprofile 18:43:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:43:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:43:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:43:43 INFO - Running setup.py install for mozrunner 18:43:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:43:43 INFO - Running setup.py install for mozscreenshot 18:43:43 INFO - Running setup.py install for moztest 18:43:44 INFO - Running setup.py install for mozversion 18:43:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:43:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:43:44 INFO - Cleaning up... 18:43:44 INFO - Return code: 0 18:43:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:43: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')]} 18:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43: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')]} 18:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:44 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 0x7fbf47efbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f54020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe62e0>, '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 0x1f52140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f525d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', '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 18:43:44 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 18:43:44 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 18:43:44 INFO - Using env: {'DISPLAY': ':0', 18:43:44 INFO - 'HOME': '/home/cltbld', 18:43:44 INFO - 'LANG': 'en_US.UTF-8', 18:43:44 INFO - 'LANGUAGE': 'en_US:en', 18:43:44 INFO - 'LOGNAME': 'cltbld', 18:43:44 INFO - 'MAIL': '/var/mail/cltbld', 18:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:44 INFO - 'MOZ_NO_REMOTE': '1', 18:43:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:44 INFO - 'NO_EM_RESTART': '1', 18:43:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:44 INFO - 'PWD': '/builds/slave/test', 18:43:44 INFO - 'SHELL': '/bin/bash', 18:43:44 INFO - 'SHLVL': '1', 18:43:44 INFO - 'TERM': 'linux', 18:43:44 INFO - 'TMOUT': '86400', 18:43:44 INFO - 'USER': 'cltbld', 18:43:44 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', 18:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:44 INFO - '_': '/tools/buildbot/bin/python'} 18:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:43:44 INFO - Running setup.py (path:/tmp/pip-qqejev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:43:44 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)) 18:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:43:44 INFO - Running setup.py (path:/tmp/pip-Tkbbiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:43:44 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)) 18:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:43:44 INFO - Running setup.py (path:/tmp/pip-VUYWC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:43:44 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)) 18:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:43:44 INFO - Running setup.py (path:/tmp/pip-O3DIOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:43:44 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)) 18:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:43:44 INFO - Running setup.py (path:/tmp/pip-uqQsBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:43:44 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)) 18:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:43:44 INFO - Running setup.py (path:/tmp/pip-u58ViU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:43:44 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)) 18:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:43:44 INFO - Running setup.py (path:/tmp/pip-8w6VQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:43:44 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)) 18:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:43:44 INFO - Running setup.py (path:/tmp/pip-xDkxvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:43:44 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)) 18:43:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:43:44 INFO - Running setup.py (path:/tmp/pip-0e8bsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:43:45 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)) 18:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:43:45 INFO - Running setup.py (path:/tmp/pip-63zDU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:43:45 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)) 18:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:43:45 INFO - Running setup.py (path:/tmp/pip-BzIBKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:43:45 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)) 18:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:43:45 INFO - Running setup.py (path:/tmp/pip-0xl86D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:43:45 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)) 18:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:43:45 INFO - Running setup.py (path:/tmp/pip-raBvei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:43:45 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)) 18:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:43:45 INFO - Running setup.py (path:/tmp/pip-rekrqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:43:45 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)) 18:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:43:45 INFO - Running setup.py (path:/tmp/pip-51J6CQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:43:45 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)) 18:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:43:45 INFO - Running setup.py (path:/tmp/pip-DikG9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:43:45 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)) 18:43:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:43:45 INFO - Running setup.py (path:/tmp/pip-7wtDAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:43:45 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)) 18:43:45 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)) 18:43:45 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)) 18:43:45 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)) 18:43:45 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)) 18:43:45 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)) 18:43:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:43:45 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 18:43:45 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 18:43:45 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 18:43:45 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 18:43:45 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 18:43:45 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 18:43:47 INFO - Downloading blessings-1.6.tar.gz 18:43:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:43:47 INFO - Installing collected packages: blessings 18:43:47 INFO - Running setup.py install for blessings 18:43:47 INFO - Successfully installed blessings 18:43:47 INFO - Cleaning up... 18:43:47 INFO - Return code: 0 18:43:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:43:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:43:48 INFO - Reading from file tmpfile_stdout 18:43:48 INFO - Current package versions: 18:43:48 INFO - argparse == 1.2.1 18:43:48 INFO - blessings == 1.6 18:43:48 INFO - blobuploader == 1.2.4 18:43:48 INFO - docopt == 0.6.1 18:43:48 INFO - functools32 == 3.2.3-2 18:43:48 INFO - jsonschema == 2.5.1 18:43:48 INFO - manifestparser == 1.1 18:43:48 INFO - mozInstall == 1.12 18:43:48 INFO - mozcrash == 0.17 18:43:48 INFO - mozdebug == 0.1 18:43:48 INFO - mozdevice == 0.48 18:43:48 INFO - mozfile == 1.2 18:43:48 INFO - mozhttpd == 0.7 18:43:48 INFO - mozinfo == 0.9 18:43:48 INFO - mozleak == 0.1 18:43:48 INFO - mozlog == 3.2 18:43:48 INFO - moznetwork == 0.27 18:43:48 INFO - mozprocess == 0.22 18:43:48 INFO - mozprofile == 0.28 18:43:48 INFO - mozrunner == 6.11 18:43:48 INFO - mozscreenshot == 0.1 18:43:48 INFO - mozsystemmonitor == 0.3 18:43:48 INFO - moztest == 0.7 18:43:48 INFO - mozversion == 1.4 18:43:48 INFO - psutil == 3.1.1 18:43:48 INFO - requests == 1.2.3 18:43:48 INFO - wsgiref == 0.1.2 18:43:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:43:48 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')]} 18:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:48 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')]} 18:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:48 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 0x7fbf47efbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f54020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe62e0>, '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 0x1f52140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f525d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', '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 18:43:48 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 18:43:48 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 18:43:48 INFO - Using env: {'DISPLAY': ':0', 18:43:48 INFO - 'HOME': '/home/cltbld', 18:43:48 INFO - 'LANG': 'en_US.UTF-8', 18:43:48 INFO - 'LANGUAGE': 'en_US:en', 18:43:48 INFO - 'LOGNAME': 'cltbld', 18:43:48 INFO - 'MAIL': '/var/mail/cltbld', 18:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:48 INFO - 'MOZ_NO_REMOTE': '1', 18:43:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:48 INFO - 'NO_EM_RESTART': '1', 18:43:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:48 INFO - 'PWD': '/builds/slave/test', 18:43:48 INFO - 'SHELL': '/bin/bash', 18:43:48 INFO - 'SHLVL': '1', 18:43:48 INFO - 'TERM': 'linux', 18:43:48 INFO - 'TMOUT': '86400', 18:43:48 INFO - 'USER': 'cltbld', 18:43:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', 18:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:48 INFO - '_': '/tools/buildbot/bin/python'} 18:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:48 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)) 18:43:48 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)) 18:43:48 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)) 18:43:48 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)) 18:43:48 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)) 18:43:48 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)) 18:43:48 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)) 18:43:48 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)) 18:43:48 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)) 18:43:48 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)) 18:43:48 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)) 18:43:48 INFO - Cleaning up... 18:43:48 INFO - Return code: 0 18:43:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:43:48 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')]} 18:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:48 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')]} 18:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:48 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 0x7fbf47efbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f54020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe62e0>, '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 0x1f52140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f525d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', '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 18:43:48 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 18:43:48 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 18:43:48 INFO - Using env: {'DISPLAY': ':0', 18:43:48 INFO - 'HOME': '/home/cltbld', 18:43:48 INFO - 'LANG': 'en_US.UTF-8', 18:43:48 INFO - 'LANGUAGE': 'en_US:en', 18:43:48 INFO - 'LOGNAME': 'cltbld', 18:43:48 INFO - 'MAIL': '/var/mail/cltbld', 18:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:48 INFO - 'MOZ_NO_REMOTE': '1', 18:43:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:48 INFO - 'NO_EM_RESTART': '1', 18:43:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:48 INFO - 'PWD': '/builds/slave/test', 18:43:48 INFO - 'SHELL': '/bin/bash', 18:43:48 INFO - 'SHLVL': '1', 18:43:48 INFO - 'TERM': 'linux', 18:43:48 INFO - 'TMOUT': '86400', 18:43:48 INFO - 'USER': 'cltbld', 18:43:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', 18:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:48 INFO - '_': '/tools/buildbot/bin/python'} 18:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:43:48 INFO - Cleaning up... 18:43:48 INFO - Return code: 0 18:43:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:43:48 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')]} 18:43:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:43:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:48 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')]} 18:43:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:43:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:43:48 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 0x7fbf47efbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e878a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f54020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe62e0>, '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 0x1f52140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f525d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', '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 18:43:48 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 18:43:48 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 18:43:48 INFO - Using env: {'DISPLAY': ':0', 18:43:48 INFO - 'HOME': '/home/cltbld', 18:43:48 INFO - 'LANG': 'en_US.UTF-8', 18:43:48 INFO - 'LANGUAGE': 'en_US:en', 18:43:48 INFO - 'LOGNAME': 'cltbld', 18:43:48 INFO - 'MAIL': '/var/mail/cltbld', 18:43:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:43:48 INFO - 'MOZ_NO_REMOTE': '1', 18:43:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:43:48 INFO - 'NO_EM_RESTART': '1', 18:43:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:43:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:43:48 INFO - 'PWD': '/builds/slave/test', 18:43:48 INFO - 'SHELL': '/bin/bash', 18:43:48 INFO - 'SHLVL': '1', 18:43:48 INFO - 'TERM': 'linux', 18:43:48 INFO - 'TMOUT': '86400', 18:43:48 INFO - 'USER': 'cltbld', 18:43:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', 18:43:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:43:48 INFO - '_': '/tools/buildbot/bin/python'} 18:43:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:43:48 INFO - Downloading/unpacking flake8 18:43:48 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 18:43:48 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 18:43:48 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 18:43:48 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 18:43:48 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 18:43:48 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 18:43:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:43:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:43:50 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 18:43:50 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 18:43:50 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 18:43:50 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 18:43:50 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 18:43:50 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 18:43:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:43:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:43:50 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 18:43:50 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 18:43:50 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 18:43:50 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 18:43:50 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 18:43:50 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 18:43:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:43:50 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 18:43:50 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 18:43:50 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 18:43:50 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 18:43:50 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 18:43:50 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 18:43:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:43:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:43:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:43:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:43:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:43:51 INFO - no previously-included directories found matching 'docs/_build' 18:43:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:43:51 INFO - Running setup.py install for pep8 18:43:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:43:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:43:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:43:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:43:51 INFO - no previously-included directories found matching 'docs/_build' 18:43:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:43:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:43:51 INFO - Cleaning up... 18:43:51 INFO - Return code: 0 18:43:51 INFO - Running post-action listener: _resource_record_post_action 18:43:51 INFO - Running post-action listener: _start_resource_monitoring 18:43:51 INFO - Starting resource monitoring. 18:43:51 INFO - ##### 18:43:51 INFO - ##### Finished create-virtualenv step (success) 18:43:51 INFO - ##### 18:43:51 INFO - ##### 18:43:51 INFO - ##### Running install step. 18:43:51 INFO - ##### 18:43:51 INFO - Running pre-action listener: _resource_record_pre_action 18:43:51 INFO - Running main action method: install 18:43:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:43:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:43:51 INFO - Reading from file tmpfile_stdout 18:43:51 INFO - Detecting whether we're running mozinstall >=1.0... 18:43:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:43:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:43:51 INFO - Reading from file tmpfile_stdout 18:43:51 INFO - Output received: 18:43:51 INFO - Usage: mozinstall [options] installer 18:43:51 INFO - Options: 18:43:51 INFO - -h, --help show this help message and exit 18:43:51 INFO - -d DEST, --destination=DEST 18:43:51 INFO - Directory to install application into. [default: 18:43:51 INFO - "/builds/slave/test"] 18:43:51 INFO - --app=APP Application being installed. [default: firefox] 18:43:51 INFO - mkdir: /builds/slave/test/build/application 18:43:51 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'] 18:43:51 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 18:44:07 INFO - Reading from file tmpfile_stdout 18:44:07 INFO - Output received: 18:44:07 INFO - /builds/slave/test/build/application/firefox/firefox 18:44:07 INFO - Running post-action listener: _resource_record_post_action 18:44:07 INFO - ##### 18:44:07 INFO - ##### Finished install step (success) 18:44:07 INFO - ##### 18:44:07 INFO - ##### 18:44:07 INFO - ##### Running run-tests step. 18:44:07 INFO - ##### 18:44:07 INFO - Running pre-action listener: _resource_record_pre_action 18:44:07 INFO - Running main action method: run_tests 18:44:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:44:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:44:07 INFO - Python 2.7.3 18:44:07 INFO - Return code: 0 18:44:07 INFO - grabbing minidump binary from tooltool 18:44: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')]} 18:44:07 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 0x1fe62e0>, '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 0x1f52140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f525d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:44:07 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 18:44:07 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 18:44:07 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 18:44:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:44:08 INFO - Return code: 0 18:44:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:44:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:44:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:44:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:44:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:44:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:44:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:44:09 INFO - Return code: 0 18:44:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:44:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:44:09 INFO - Using env: {'DISPLAY': ':0', 18:44:09 INFO - 'HOME': '/home/cltbld', 18:44:09 INFO - 'LANG': 'en_US.UTF-8', 18:44:09 INFO - 'LANGUAGE': 'en_US:en', 18:44:09 INFO - 'LOGNAME': 'cltbld', 18:44:09 INFO - 'MAIL': '/var/mail/cltbld', 18:44:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:44:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:44:09 INFO - 'MOZ_NO_REMOTE': '1', 18:44:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:44:09 INFO - 'NO_EM_RESTART': '1', 18:44:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:44:09 INFO - 'PWD': '/builds/slave/test', 18:44:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:44:09 INFO - 'SHELL': '/bin/bash', 18:44:09 INFO - 'SHLVL': '1', 18:44:09 INFO - 'TERM': 'linux', 18:44:09 INFO - 'TMOUT': '86400', 18:44:09 INFO - 'USER': 'cltbld', 18:44:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090', 18:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:44:09 INFO - '_': '/tools/buildbot/bin/python'} 18:44:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:44:09 INFO - mozversion application_buildid: 20160608171431 18:44:09 INFO - mozversion application_changeset: 8a447c89176fb240f78db350e8d65f62d0a6fabb 18:44:09 INFO - mozversion application_display_name: Nightly 18:44:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:44:09 INFO - mozversion application_name: Firefox 18:44:09 INFO - mozversion application_remotingname: firefox 18:44:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:44:09 INFO - mozversion application_vendor: Mozilla 18:44:09 INFO - mozversion application_version: 50.0a1 18:44:09 INFO - mozversion platform_buildid: 20160608171431 18:44:09 INFO - mozversion platform_changeset: 8a447c89176fb240f78db350e8d65f62d0a6fabb 18:44:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:44:09 INFO - mozversion platform_version: 50.0a1 18:44:09 INFO - using testdate: 1465436649 18:44:09 INFO - actual date: 1465436649 18:44:09 INFO - starting webserver on 'localhost:35308' 18:44:09 INFO - SUITE-START | Running 2 tests 18:44:09 INFO - TEST-START | dromaeo_css 18:44:09 INFO - operating with platform_type : linux_ 18:44:09 INFO - Initialising browser for dromaeo_css test... 18:44:09 INFO - TEST-INFO | started process 3316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUgdIjn/profile http://localhost:35308/getInfo.html) 18:44:16 INFO - PROCESS | 3316 | __metrics Screen width/height:1600/1200 18:44:16 INFO - PROCESS | 3316 | colorDepth:24 18:44:16 INFO - PROCESS | 3316 | Browser inner width/height: 1024/697 18:44:16 INFO - PROCESS | 3316 | __metrics 18:44:16 ERROR - PROCESS | 3316 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 18:44:17 INFO - TEST-INFO | 3316: exit 0 18:44:17 INFO - Browser initialized. 18:44:17 INFO - Running cycle 1/1 for dromaeo_css test... 18:44:17 INFO - TEST-INFO | started process 3433 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUgdIjn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:44:29 INFO - PROCESS | 3433 | RSS: Main: 168251392 18:44:29 INFO - PROCESS | 3433 | 18:45:19 INFO - PROCESS | 3433 | 1465436719464 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] 18:47:31 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:35308/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35308/tests/dromaeo/cssquery-ext.html) 18:47:32 INFO - PROCESS | 3433 | RSS: Main: 170573824 18:47:32 INFO - PROCESS | 3433 | 18:50:34 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:35308/tests/dromaeo/cssquery-ext.html (next: http://localhost:35308/tests/dromaeo/cssquery-jquery.html) 18:50:35 INFO - PROCESS | 3433 | RSS: Main: 170504192 18:50:35 INFO - PROCESS | 3433 | 18:53:37 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:35308/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35308/tests/dromaeo/cssquery-mootools.html) 18:53:37 INFO - PROCESS | 3433 | RSS: Main: 171470848 18:53:37 INFO - PROCESS | 3433 | 18:56:39 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:35308/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35308/tests/dromaeo/cssquery-prototype.html) 18:56:40 INFO - PROCESS | 3433 | RSS: Main: 168767488 18:56:40 INFO - PROCESS | 3433 | 18:59:42 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:35308/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35308/tests/dromaeo/cssquery-yui.html) 18:59:43 INFO - PROCESS | 3433 | RSS: Main: 170549248 18:59:43 INFO - PROCESS | 3433 | 19:02:46 INFO - PROCESS | 3433 | Cycle 1(1): loaded http://localhost:35308/tests/dromaeo/cssquery-yui.html (next: http://localhost:35308/tests/dromaeo/cssquery-dojo.html) 19:02:46 INFO - PROCESS | 3433 | RSS: Main: 171810816 19:02:46 INFO - PROCESS | 3433 | 19:02:46 INFO - PROCESS | 3433 | __start_tp_report 19:02:46 INFO - PROCESS | 3433 | _x_x_mozilla_page_load 19:02:46 INFO - PROCESS | 3433 | _x_x_mozilla_page_load_details 19:02:46 INFO - PROCESS | 3433 | |i|pagename|runs| 19:02:46 INFO - PROCESS | 3433 | |0;dojo.html;2616.7906567474597;2695.016319043549;2695.231858920208;2703.0269103122882;2703.0809524761576;4692.906141877161;4711.057788442313;4712.976435117824;4799.088173247081;4840.854774356766;4632.420947381577;4717.834875779348;4718.245080787075;4719.457262414823;4751.287306903966;4320.1575692739925;4338.479382474107;4433.578810013044;4445.22208613493;4445.955540444586;4127.463429754128;4492.146492166478;4524.140413321475;4540.772961351936;4541.863744087666;4250.744955302661;4339.218940590708;4347.282698354799;4376.6498680105515;4464.799084041226;4316.028893498969;4317.97841010796;4335.891602709926;4352.129574085164;4387.802548885308;4332.4801023877335;4372.344148377737;4379.189849877783;4381.123775244963;4422.982713975772;4618.468876079227;4675.836345727917;4691.929621055687;4696.060787842445;4727.409073865767;5158.9484105158845;5178.197379406198;5190.039842629126;5191.402988656315;5229.215617657382;4973.353464049686;5209.322788037569;5227.059129356714;5235.240890070956;5240.423553409122;4667.603253723403;4716.646251531149;4717.315989181549;4725.0077483728455;4729.6689231754135;5141.76862041209;5157.355330583677;5189.55888749453;5198.506141916512;5221.503957124067;4854.781534830941;4948.703077815343;4969.27945447908;4976.377952755905;5020.422651395063;5019.623528235397;5039.143345631178;5075.3148324975655;5084.059449001947;5127.102757017507;4904.043711476228;4966.8758281043265;4967.925481117786;5022.146235140035;5022.773975171126;4906.681065730716;4948.727819969864;4950.18321976877;4988.6757360771435;4999.125153098194;4253;4260.147970405931;4261.169072030924;4271.829126834954;4311.805968731414;3600.0279924420784;3618.81905904709;3625.8912232633065;3625.9093522662142;3694.9076273093387;4217.768022758778;4218.114196018871;4238.745675259494;4276.657867370665;4287.2711639021445;4892.0705066037335;4893.314935908976;4900.411950565884;4954.455009948902;5012.949870501321;4385.868423947287;4411.1618792429335;4457.665675074318;4465.732056076581;4471.32930060487;4578.839740609063;4605.608523275492;4606.677532572688;4624.260118381043;4686.671932964659;4672.08894265615;4833.9606984498505;4868.9756551217015;4870.634702397405;4921.212605983097;5118.820841270538;5156.303898973591;5166.689998600096;5187.144121219956;5193.195054766517;4868.294097355934;4881.609471242221;4902.117618828645;4909.312696222603;4934.654574179773;5063.721495317645;5080.745962701924;5088.796448142033;5091.170250967467;5113.897722045613;5194.766235519335;5210.166373380241;5219.947800521946;5248.947510524846;5285.075111855487;5039.143345631325;5053.772580233972;5054.090263752413;5077.492250774893;5089.05852417304;4732.716037037789;4805.111054454937;5014.648974571745;5030.295758593873;5037.370328708911;4924.655274130777;4943.901121977612;4950.331705219894;4980.551750342486;5032.446430892672;5105.821296254613;5155.845324640267;5159.122949098587;5165.535101840853;5217.582593392595;4845.394325709286;4871.464138944642;4903.901921961469;4914.164592019437;5033.521815427529 19:02:46 INFO - PROCESS | 3433 | |1;ext.html;538.7911218991928;566.3713278261131;579.8608333999839;596.9523486281576;603.3755063509269;36394;40855.59144408555;40914.97712557184;41014.79492602533;41066.58933410665;40776.18447631053;41109.38335924964;41146.58853411465;41231;41350;7756.340711039568;7868.842623147533;7900.32847207988;7903.367730581568;7922.326602238817;7805.4536182467255;7828.5694286814205;7834.843303133963;7881.487703299267;7902.130765615806;7827.334676552471;7852.803679908019;7867.095284042322;7909.485883417559;7920.366370690331;7822.33510151635;7835.177306382861;7869.763907082796;7888.80277993049;7908.406869484812;7728.7681369559;7773.067231932205;7777.922220777777;7780.961095194544;7804.219578042207;30039;37956;38278.61721382806;38575.22849542993;38579.807100964594;2960.7039296070434;2975.3602975360186;3078.3073808392933;3255.690709382605;3455.153487395579;27697.584536231974;30380.392392152255;30545.847270763505;30568.847155764302;30794.53808192879;3566.3402270580027;3587.515685382492;3605.6214097519646;3649.489071529988;3679.337719210541;261597;269260;269687;270851;271301;58332;59435.70282148562;59550;59643.105353419734;59658.70170649119;34226.48660270098;35206;35411.82294088513;36519;36555;15811.13038782878;15944.920275398548;15957.122358270406;16000.679986400439;16040.358385664676;11675.065994720402;11771.352575608253;11803.881961180277;11810.350430726392;11891.989180919545;19486.928218948095;19524.511887202934;19610.313639022566;19692.90153549223;19761.209551618063;7410.740624078131;7604.148444333375;7606.619669016527;7614.505057171266;7722.652480638385;819.8647223208224;919.8134406615392;924.653255029364;945.5886689290181;965.1892410375178;27998.72001280002;28176.71823281741;28455.146345609664;28904;29034.41931161407;976.3799987008301;983.321508159382;985.5170966226498;991.3853410885154;1027.712240572641;14614.100166978225;14768.852311476963;14826.777598336033;14894.92552537252;15109.773353399707;387258;390129;391306;392174;392665;50642.24036639454;50789.23816142761;51033.74483127635;51151.23273150906;51168.74415627898;1196.2731871001067;1208.5045131496045;1210.878912108782;1216.4100411300512;1246.4764798784531;26864.462710746066;27716.861415692794;27820.44359112766;28120.71879281263;28421.57367639446;44056.559434405244;44105.77947110244;44409.333859992774;44686.3297050551;44896.32655510105;275740;275778;276588;276916;328569;26181.60727589126;26307;26735.598966015135;26766.59850102289;26876.59685104686;42091.7895410521;43195.40516918467;43832.78083609689;44039.119217614825;44277.11445771131;37364.439533406476;38208;38438.23123537458;38642.6135738639;38865.41701874418;36379;36816.26367472582;37049;37507.24985500329;37794.62205377911;31929.20176995501;36854.07864803401;37004.074898127765;37115;38724.2255154901;33331.166720832174;34237.48643770296;34721.652783472855;34907.30185396227;34986.300273994886;25957.480850383265;26046.348841278363;26101.869490653185;26294;26654.46691066129 19:02:46 INFO - PROCESS | 3433 | |2;jquery.html;361.98552057917686;362.69533591782897;367.2306517845115;371.153769405755;375.97744135351866;15517.534473965785;16602.086885221324;17450.3019879205;17640.294388224487;17695.73456398155;14229.288535573232;15065.493450654929;15074.924625376858;15078.019928704627;15093.92453037736;4290.635295999836;4588.77056147193;4592.540745925414;4650.953490465085;4661.510541393139;3529.0824385659785;4603.148417542749;5126.512981266792;5422.728863556826;5430.0768869292115;5465.535429488498;5474.151506516497;5485.204645326426;5486.204500347447;5499.945000550003;5346.198070289468;6011.909821352683;6029.065494848283;6030.96984515079;6040.5469589780505;5102.540771330561;5298.92051619226;5313.043652142613;5317.707526086064;5339.893202135935;12160.452779624939;12328.32194229317;12360.938195309056;12390.442430090667;12430.813537796941;1827.5431142214447;1922.4713203868907;1957.080172319022;2003.0485519378324;2032.9631887737212;9100.226480749145;9378.249740020781;9630.422174669542;10180.592776288939;13063.477460901553;1753.684336819372;1763.1713094845402;1765.3821162593117;1782.1427505298645;1782.9286828526974;65944.67027664879;68552;69803.30196698019;70536.6473167636;70889.2911070893;9657.806843863083;9801.803963920682;10187.54156062979;10226.28416010872;10228.693139205836;13741.175529468264;13848.238346890816;13881.305934703427;13897.930510347383;13942.721145577032;7443.218462061405;7560.432967527458;7664.6934122635585;7689.538627682357;7720;7375.926240737524;7446.590437525988;7608.467407281437;7629.771106866803;7657.042869641295;4214.578542145761;4263.76549289792;4306.4832220133785;4353.499347575006;4360.629346505519;1607.429362576292;1612.065002298664;1720.234495649424;1736;1797.8381945624956;812.6708682983401;823.0370466554147;843.6751850537587;893.4996402014763;958.3004406783087;14892.851071489147;16028.599285017968;16644.83355166457;16650.3339866404;17147.657046858993;849.3078141314809;856.4176360075085;860.9009963854237;865.2169786343369;872.7905302727299;9122.817543649222;9396.154346108746;9498.14516693501;9606.183474404614;9653.71038868835;363241;377168;381890;382389;387280;75148;75687;76118.61940690261;76554;78445;916.867054277126;919.8758167647281;931.9207867331353;934.5047125023748;940.2008292950937;14851.554453366416;14902.478413255483;14922.85077149258;15181.696366072838;15228.769540472435;34562.481562776076;35384.93845184649;36090.4586431209;36223;36474.08814779545;48174;48329.27506087341;49568.256476153605;49596.25605615991;49618;6726.091977582963;7026.262242464468;7294.307040831112;7315.561066336037;7579.962100189464;8786.297096232414;11159.553617855196;11249.887501125211;12145.69635759113;12269.263844169378;10549.472526373804;10613.893861061291;10659.520321585393;10802.08182304513;11008.834867476835;10563.683089507327;10628.84056739134;10790.082842958123;10819.459027048773;11251.15616328795;8343.916560834557;10732.551105600643;10827.350358978487;11015.559377624806;11094.611688590861;6766.424853887278;7131.42948564124;7205.207427182901;7961.681532738858;8067.55628440418;10589.735256618646;10646.148308135485;10952.452377381258;11053.226274161054;11168.441577920908 19:02:46 INFO - PROCESS | 3433 | |3;mootools.html;1378.903476756627;1414.6887684709363;1506.8794496440287;1619.2146808797738;1660.501849445166;6577.309382514839;7344.853102937938;7513.248675132484;8004.399670024757;8024.117347091823;7318.158411782647;7530.58581778002;7598.164201937782;7600.96199519003;7614.428917831157;2106.9999999999964;2145.0240140735928;2145.1097794415377;2145.3778404262744;2148.344754849778;2069.2550681754556;2090.602785470763;2122.8514004019726;2136.5299634080557;2140.347194105797;2099.1708275231276;2108.4096452993185;2112.7570329412083;2117.502386939068;2135.6369417199035;2085.7288552488153;2085.9165633374646;2089.9477513062143;2091.2576035507327;2092.393205970267;2034.8168664820237;2076.4601203687;2108.0829839020075;2112.0812446585783;2118.5868755592664;7513.54918704874;7606.277403646644;7611.923880761177;7632.465727399084;7634.656440460192;4292.055747735493;4414.9337759933305;4415.536368681274;4416.624586910117;4417.823287068513;2753.917382478529;2814.1698199031334;2864.427114577093;2880.5247134222827;2883.1494709060876;895.194325107402;896.4710820615803;916.5234078279258;922.7600823785864;944.9905500944972;10621.84067238992;10644.946775266151;10658.840117398246;10673.679789606324;10719.785604287948;3909.8240579174008;4022.1754540319166;4041.818118184689;4074;4102;8909.064548222474;9011.729648110568;9033.548322583845;9084.182423581777;9108.954455227682;4505.5719706627815;4529.682922195415;4581.839635612804;4594.2419500782;4613.215753321943;3354.0943945134677;4036.3541833307117;4170.124273902454;4201.936970945439;4215.178040282177;3642.635736426389;3646.252518233756;3740.495033170542;3754.4931434256027;3781.3949768036982;1136.9147313951487;1194.2177873492876;1206.0592737664635;1208.7670576012417;1215.7325388414536;858.750962220949;861.2636196052285;870.6734974384606;870.9085546017577;899.9370044096981;5170.948290517122;5185;5200.037992971313;5209.140491818807;5210.6613070150315;415.5532802237607;422.8900485873695;426.132819711891;429.81732763575354;439.59118020240845;3608.404613238786;3646.762960407565;3717.200801827566;3725.1618385863508;3758.661720445173;8944.5080520572;9387.62449502026;9422.575984080733;9439.858402123973;9461.858072128924;9153.450792952444;9306.72079837606;9321.44071355721;9343.439393636403;9347.859782103274;7058.188308344504;7199.100112486044;7241.818954526179;7247.891281630779;7253.637318134072;5043.117454445531;5112.463191365002;5127;5178.585713142864;5181.870453238699;8715.825683486422;8729.694460693845;8747.562621869009;8766.386352955233;8837.469751814911;8609.268212201783;8788.07725188846;8831;8893.866592001255;8938.821223575622;5733.913991290051;6322.8735425290315;6543;6736.393724564813;6775.051492791112;7510.136334321623;7621.542707437571;7636.31273185416;7639.541627502367;7669.233076692286;6737.921932490778;6884.690188941409;6913.688884000131;6962.895556566757;6973.163220413583;6628.436582890508;6724.058631791651;6730.629815360202;6746.4265537429865;6879.724811007503;6375.362463753773;6381.744730210925;6439.517036222396;6461.709223085067;6491.642959637265;4637.953620463887;4646.372739680235;4707.976460117678;4767.73777442244;4768.856934291976;4690.296455531698;4739.549742774431;4749.26386410107;4766.642501812447;4791.664583479123 19:02:46 INFO - PROCESS | 3433 | |4;prototype.html;273.19543943087604;276.237584267422;280;285.4690276086479;288.7978415109424;4845.733484658343;4925.43357513886;4976.875578110545;5042.873928151798;5064.442911279761;4916.729579873106;4929.186684197103;4941.431735350427;4963.975180124104;4969.527894849993;3816.7213983315623;3857.6913846892253;3861.1891502784447;3881.7088718346095;3890.8054597270166;3579.1410061585293;3876.8643097491595;3883.8834834954855;3893.4354518594787;3897.2205558888195;3730.3844865597143;3756.1173124315765;3771.17034252464;3785.62143785622;3792.2605092006934;3742.8128593570486;3759.492468516756;3764;3773.7169712271416;3789.2042671039117;3270.525773762815;3315.53582498448;3321.2693207494312;3323.2522682396266;3329.900102996914;4672.3692301539195;4730.810767569293;4773.665843390964;4806.9810679514685;4808.519148085164;4300.569943005706;4309.59058889405;4310.935335969963;4316.892077698083;4342.305231162999;5134.845954621367;5157.922631160535;5207.218917162418;5212.556932660728;5230.137027390476;3493;3586.941852153621;3591.838367273479;3612.02475331659;3614.8011859347725;5398.2982212312545;5447.891042179134;5457;5491.643043202179;5505.504504594565;3630.3102410541915;3634.672879440863;3640.4903313536124;3643.617420170897;3649.3066317399607;3663.9267214655556;3679.9264014719556;3687.5574931007914;3688.5204923359793;3690.8189379398336;4148.460700108966;4198.6221240087925;4203.978980105141;4221.641160501392;4302.548232435612;5139.820106296262;5150.995555866645;5155.896882062413;5167.405748338914;5190.247414125006;1183.650823007215;1239.6776838022179;1266.5630357526638;1267.2396562062872;1275.3368248510722;784.1609477858636;788.6553426407961;807.3299161695778;815.7348861619879;816.2245866426919;4018.4374187613757;4052.3111071117983;4064.837406503766;4093.3655283431117;4114.670826333886;4657.6506761992305;4673.976630116896;4689.460712018162;4692.835750748707;4740.525947405232;4069.206504731549;4077.429159917614;4084.203580301872;4087.6116768906904;4101.815418306183;2360.8465449745713;2514.861682607474;2518.2067648690604;2525.368657835541;2536.1884197057134;4393.934090988638;4410.735355878657;4421.73302762829;4431.778411079433;4520.18636645407;4741.881452963635;4762.4283986284445;4793.448753393404;4824.372831531879;4833.250846118857;4440.911181776346;4468.776561171929;4691.62467002639;5124.410692770379;5140.537351638296;5393.381985404285;5419.022056949264;5420;5428.70142142186;5438.45615438453;5341.157300731242;5341.305630268041;5343.519083282523;5356.919646205232;5356.9911283268775;4958.206686930074;5093.159628661229;5095.643304968617;5096.210087436453;5140.820071297487;3641.9817900910325;3659.1949771050326;3682.3187710273687;3693.5567731872347;3732.9253414931004;5198.246254293182;5463.508284254436;5477.178423236546;5478.643888147258;5486.643368181056;5117.948820511896;5229.450907654642;5229.738513074407;5236.921446178234;5244.606654500852;5205.219217117463;5235.947640523546;5244.160934250502;5245.527902488794;5245.842624721265;5052.43803118793;5065.746712664426;5123.129068058513;5137.845864624067;5168.689878607295;5220.7128607926925;5236.198633730935;5243.265942768092;5268.552173065333;5325.760340784752;5122.513361230677;5146.794128234978;5151.356080489939;5157.252198431282;5157.510036546522 19:02:46 INFO - PROCESS | 3433 | |5;yui.html;636.5925807483211;719.7121151539384;746.4103358346906;746.7274444827638;761.3224230434918;12904.161229520074;14044.368003439844;14072.155670659742;14086.436542538311;14088.084274522174;12640.810387844189;12727.554535591256;12805.679858003554;12835.358232088405;12882.355882205899;622.0855342646303;776.8562815879052;778.6340420002618;788.1015642167905;797.1988151907354;791.6674996501455;793.1037927142321;796.0924546017544;798.1101072304368;798.632628990662;829.9709510167145;835.1856939484015;840.8234270803108;840.9369297302696;844.4764246167384;827.2637352756052;836.782436566497;839.9412041157121;840.155643578203;840.2689659995813;606.4663096475118;606.851321426249;609.2262826210732;611.2878496551513;611.5077362723006;12413.689657758538;12448.75102497954;12464.937675311656;12469.563565275172;12506.187097838703;13352.332383380792;13654.931725341408;13795.310234488335;13884.375203115884;13911.721765564633;9151.496667683276;9303.953480232556;9372.625094996192;9406.1064198901;9409.76475588109;3352.4468462703867;3367.44437167867;3372.19067423819;3389.86440542378;3489.145159435929;56083.43916560823;56348.718256408865;56831.43168568303;59205.703971480296;59256.70371648114;10545.209109316833;10548;10590.947045264724;10674.679759607225;10785.946070269598;19872.801271987384;19903.800961990484;19923.900380498293;19934.202631894852;20305.898470507847;7079.256678048834;7081.362677359062;7106.076210092759;7178.892316615255;7230.566166030055;3612.187257866959;3665.8350374233223;3734.8506059757847;3738.345789486829;3778.886633401002;2733.7949653776045;2832.7025662305573;2849.0313293480317;2857.914262572126;2857.9428411431654;459.60014787135407;459.6116281741923;469.17893686049416;472.1925507382346;473.2806134675274;553.7452771725052;581.982540523785;602.5270162922172;605.6608299352376;608.8782243551308;8183.918160818315;8211.548364839991;8445.1977062179;8453.15468453162;8530.957345213234;487.4248386903488;499.7825945713626;539.2531344088387;572.4676051272356;602.7920367473215;3965.92068158641;4002.819873105659;4026.8926045337766;4029.6977726670616;4111.8560850370095;53021;76628.61685691535;83702;88985;92093.5395323019;80958.59520702477;81330.71350362207;81961.18038819655;82477;82938;69772.3022769776;69846.30153698398;70385;70797.2920270801;70817.99999999897;7466.178720340867;7471.701131954878;7618.961905190438;7699.499532530368;7777.611119443892;42320.365194522725;43476.56523434852;45796;45872.54127458816;46283.305750414445;60940.39059609525;63851.68074159599;63925;64465.67767161134;65004;8994.955025224832;8997.865032024656;9760.46317452547;10241;10470.319429237075;11829.881701183222;12454.377281135725;13140.342982850629;13179;13300.933495332849;11439.142064345373;11470.483828227583;11523;11686.357250350971;12095.758084838079;11891.702707432038;12090.75818483643;12240.326782027074;12260.08049396281;12671.619851404472;11253.831192532283;11546.884531154581;11654.41727913584;11675.474603643026;11683.357415342238;9039.412438191497;9488.383255088396;9792.902070979198;9810.65662701802;9939;9255.722328330161;9397.342186046912;9494.098060684224;9828.705138845846;9892.950535247277 19:02:46 INFO - PROCESS | 3433 | __end_tp_report 19:02:46 INFO - PROCESS | 3433 | __start_cc_report 19:02:46 INFO - PROCESS | 3433 | _x_x_mozilla_cycle_collect,386 19:02:46 INFO - PROCESS | 3433 | __end_cc_report 19:02:46 INFO - PROCESS | 3433 | __startTimestamp1465437766272__endTimestamp 19:02:46 INFO - PROCESS | 3433 | 19:02:46 INFO - PROCESS | 3433 | ------- Summary: start ------- 19:02:46 INFO - PROCESS | 3433 | Number of tests: 6 19:02:46 INFO - PROCESS | 3433 | 19:02:46 INFO - PROCESS | 3433 | [#0] dojo.html Cycles:165 Average:4707.42 Median:4868.98 stddev:511.93 (10.5%) stddev-sans-first:486.52 19:02:46 INFO - PROCESS | 3433 | Values: 2616.8 2695.0 2695.2 2703.0 2703.1 4692.9 4711.1 4713.0 4799.1 4840.9 4632.4 4717.8 4718.2 4719.5 4751.3 4320.2 4338.5 4433.6 4445.2 4446.0 4127.5 4492.1 4524.1 4540.8 4541.9 4250.7 4339.2 4347.3 4376.6 4464.8 4316.0 4318.0 4335.9 4352.1 4387.8 4332.5 4372.3 4379.2 4381.1 4423.0 4618.5 4675.8 4691.9 4696.1 4727.4 5158.9 5178.2 5190.0 5191.4 5229.2 4973.4 5209.3 5227.1 5235.2 5240.4 4667.6 4716.6 4717.3 4725.0 4729.7 5141.8 5157.4 5189.6 5198.5 5221.5 4854.8 4948.7 4969.3 4976.4 5020.4 5019.6 5039.1 5075.3 5084.1 5127.1 4904.0 4966.9 4967.9 5022.1 5022.8 4906.7 4948.7 4950.2 4988.7 4999.1 4253.0 4260.1 4261.2 4271.8 4311.8 3600.0 3618.8 3625.9 3625.9 3694.9 4217.8 4218.1 4238.7 4276.7 4287.3 4892.1 4893.3 4900.4 4954.5 5012.9 4385.9 4411.2 4457.7 4465.7 4471.3 4578.8 4605.6 4606.7 4624.3 4686.7 4672.1 4834.0 4869.0 4870.6 4921.2 5118.8 5156.3 5166.7 5187.1 5193.2 4868.3 4881.6 4902.1 4909.3 4934.7 5063.7 5080.7 5088.8 5091.2 5113.9 5194.8 5210.2 5219.9 5248.9 5285.1 5039.1 5053.8 5054.1 5077.5 5089.1 4732.7 4805.1 5014.6 5030.3 5037.4 4924.7 4943.9 4950.3 4980.6 5032.4 5105.8 5155.8 5159.1 5165.5 5217.6 4845.4 4871.5 4903.9 4914.2 5033.5 19:02:46 INFO - PROCESS | 3433 | 19:02:46 INFO - PROCESS | 3433 | [#1] ext.html Cycles:180 Average:47287.56 Median:37435.84 stddev:84141.69 (224.8%) stddev-sans-first:84304.52 19:02:46 INFO - PROCESS | 3433 | Values: 538.8 566.4 579.9 597.0 603.4 36394.0 40855.6 40915.0 41014.8 41066.6 40776.2 41109.4 41146.6 41231.0 41350.0 7756.3 7868.8 7900.3 7903.4 7922.3 7805.5 7828.6 7834.8 7881.5 7902.1 7827.3 7852.8 7867.1 7909.5 7920.4 7822.3 7835.2 7869.8 7888.8 7908.4 7728.8 7773.1 7777.9 7781.0 7804.2 30039.0 37956.0 38278.6 38575.2 38579.8 2960.7 2975.4 3078.3 3255.7 3455.2 27697.6 30380.4 30545.8 30568.8 30794.5 3566.3 3587.5 3605.6 3649.5 3679.3 261597.0 269260.0 269687.0 270851.0 271301.0 58332.0 59435.7 59550.0 59643.1 59658.7 34226.5 35206.0 35411.8 36519.0 36555.0 15811.1 15944.9 15957.1 16000.7 16040.4 11675.1 11771.4 11803.9 11810.4 11892.0 19486.9 19524.5 19610.3 19692.9 19761.2 7410.7 7604.1 7606.6 7614.5 7722.7 819.9 919.8 924.7 945.6 965.2 27998.7 28176.7 28455.1 28904.0 29034.4 976.4 983.3 985.5 991.4 1027.7 14614.1 14768.9 14826.8 14894.9 15109.8 387258.0 390129.0 391306.0 392174.0 392665.0 50642.2 50789.2 51033.7 51151.2 51168.7 1196.3 1208.5 1210.9 1216.4 1246.5 26864.5 27716.9 27820.4 28120.7 28421.6 44056.6 44105.8 44409.3 44686.3 44896.3 275740.0 275778.0 276588.0 276916.0 328569.0 26181.6 26307.0 26735.6 26766.6 26876.6 42091.8 43195.4 43832.8 44039.1 44277.1 37364.4 38208.0 38438.2 38642.6 38865.4 36379.0 36816.3 37049.0 37507.2 37794.6 31929.2 36854.1 37004.1 37115.0 38724.2 33331.2 34237.5 34721.7 34907.3 34986.3 25957.5 26046.3 26101.9 26294.0 26654.5 19:02:46 INFO - PROCESS | 3433 | 19:02:46 INFO - PROCESS | 3433 | [#2] jquery.html Cycles:180 Average:23620.51 Median:4277.20 stddev:62554.93 (1462.5%) stddev-sans-first:62706.03 19:02:46 INFO - PROCESS | 3433 | Values: 362.0 362.7 367.2 371.2 376.0 15517.5 16602.1 17450.3 17640.3 17695.7 14229.3 15065.5 15074.9 15078.0 15093.9 4290.6 4588.8 4592.5 4651.0 4661.5 3529.1 4603.1 5126.5 5422.7 5430.1 5465.5 5474.2 5485.2 5486.2 5499.9 5346.2 6011.9 6029.1 6031.0 6040.5 5102.5 5298.9 5313.0 5317.7 5339.9 12160.5 12328.3 12360.9 12390.4 12430.8 1827.5 1922.5 1957.1 2003.0 2033.0 9100.2 9378.2 9630.4 10180.6 13063.5 1753.7 1763.2 1765.4 1782.1 1782.9 65944.7 68552.0 69803.3 70536.6 70889.3 9657.8 9801.8 10187.5 10226.3 10228.7 13741.2 13848.2 13881.3 13897.9 13942.7 7443.2 7560.4 7664.7 7689.5 7720.0 7375.9 7446.6 7608.5 7629.8 7657.0 4214.6 4263.8 4306.5 4353.5 4360.6 1607.4 1612.1 1720.2 1736.0 1797.8 812.7 823.0 843.7 893.5 958.3 14892.9 16028.6 16644.8 16650.3 17147.7 849.3 856.4 860.9 865.2 872.8 9122.8 9396.2 9498.1 9606.2 9653.7 363241.0 377168.0 381890.0 382389.0 387280.0 75148.0 75687.0 76118.6 76554.0 78445.0 916.9 919.9 931.9 934.5 940.2 14851.6 14902.5 14922.9 15181.7 15228.8 34562.5 35384.9 36090.5 36223.0 36474.1 48174.0 48329.3 49568.3 49596.3 49618.0 6726.1 7026.3 7294.3 7315.6 7580.0 8786.3 11159.6 11249.9 12145.7 12269.3 10549.5 10613.9 10659.5 10802.1 11008.8 10563.7 10628.8 10790.1 10819.5 11251.2 8343.9 10732.6 10827.4 11015.6 11094.6 6766.4 7131.4 7205.2 7961.7 8067.6 10589.7 10646.1 10952.5 11053.2 11168.4 19:02:46 INFO - PROCESS | 3433 | 19:02:46 INFO - PROCESS | 3433 | [#3] mootools.html Cycles:180 Average:5063.58 Median:5077.79 stddev:2847.60 (56.1%) stddev-sans-first:2842.13 19:02:46 INFO - PROCESS | 3433 | Values: 1378.9 1414.7 1506.9 1619.2 1660.5 6577.3 7344.9 7513.2 8004.4 8024.1 7318.2 7530.6 7598.2 7601.0 7614.4 2107.0 2145.0 2145.1 2145.4 2148.3 2069.3 2090.6 2122.9 2136.5 2140.3 2099.2 2108.4 2112.8 2117.5 2135.6 2085.7 2085.9 2089.9 2091.3 2092.4 2034.8 2076.5 2108.1 2112.1 2118.6 7513.5 7606.3 7611.9 7632.5 7634.7 4292.1 4414.9 4415.5 4416.6 4417.8 2753.9 2814.2 2864.4 2880.5 2883.1 895.2 896.5 916.5 922.8 945.0 10621.8 10644.9 10658.8 10673.7 10719.8 3909.8 4022.2 4041.8 4074.0 4102.0 8909.1 9011.7 9033.5 9084.2 9109.0 4505.6 4529.7 4581.8 4594.2 4613.2 3354.1 4036.4 4170.1 4201.9 4215.2 3642.6 3646.3 3740.5 3754.5 3781.4 1136.9 1194.2 1206.1 1208.8 1215.7 858.8 861.3 870.7 870.9 899.9 5170.9 5185.0 5200.0 5209.1 5210.7 415.6 422.9 426.1 429.8 439.6 3608.4 3646.8 3717.2 3725.2 3758.7 8944.5 9387.6 9422.6 9439.9 9461.9 9153.5 9306.7 9321.4 9343.4 9347.9 7058.2 7199.1 7241.8 7247.9 7253.6 5043.1 5112.5 5127.0 5178.6 5181.9 8715.8 8729.7 8747.6 8766.4 8837.5 8609.3 8788.1 8831.0 8893.9 8938.8 5733.9 6322.9 6543.0 6736.4 6775.1 7510.1 7621.5 7636.3 7639.5 7669.2 6737.9 6884.7 6913.7 6962.9 6973.2 6628.4 6724.1 6730.6 6746.4 6879.7 6375.4 6381.7 6439.5 6461.7 6491.6 4638.0 4646.4 4708.0 4767.7 4768.9 4690.3 4739.5 4749.3 4766.6 4791.7 19:02:46 INFO - PROCESS | 3433 | 19:02:46 INFO - PROCESS | 3433 | [#4] prototype.html Cycles:180 Average:4195.09 Median:4690.54 stddev:1265.54 (27.0%) stddev-sans-first:1234.38 19:02:46 INFO - PROCESS | 3433 | Values: 273.2 276.2 280.0 285.5 288.8 4845.7 4925.4 4976.9 5042.9 5064.4 4916.7 4929.2 4941.4 4964.0 4969.5 3816.7 3857.7 3861.2 3881.7 3890.8 3579.1 3876.9 3883.9 3893.4 3897.2 3730.4 3756.1 3771.2 3785.6 3792.3 3742.8 3759.5 3764.0 3773.7 3789.2 3270.5 3315.5 3321.3 3323.3 3329.9 4672.4 4730.8 4773.7 4807.0 4808.5 4300.6 4309.6 4310.9 4316.9 4342.3 5134.8 5157.9 5207.2 5212.6 5230.1 3493.0 3586.9 3591.8 3612.0 3614.8 5398.3 5447.9 5457.0 5491.6 5505.5 3630.3 3634.7 3640.5 3643.6 3649.3 3663.9 3679.9 3687.6 3688.5 3690.8 4148.5 4198.6 4204.0 4221.6 4302.5 5139.8 5151.0 5155.9 5167.4 5190.2 1183.7 1239.7 1266.6 1267.2 1275.3 784.2 788.7 807.3 815.7 816.2 4018.4 4052.3 4064.8 4093.4 4114.7 4657.7 4674.0 4689.5 4692.8 4740.5 4069.2 4077.4 4084.2 4087.6 4101.8 2360.8 2514.9 2518.2 2525.4 2536.2 4393.9 4410.7 4421.7 4431.8 4520.2 4741.9 4762.4 4793.4 4824.4 4833.3 4440.9 4468.8 4691.6 5124.4 5140.5 5393.4 5419.0 5420.0 5428.7 5438.5 5341.2 5341.3 5343.5 5356.9 5357.0 4958.2 5093.2 5095.6 5096.2 5140.8 3642.0 3659.2 3682.3 3693.6 3732.9 5198.2 5463.5 5477.2 5478.6 5486.6 5117.9 5229.5 5229.7 5236.9 5244.6 5205.2 5235.9 5244.2 5245.5 5245.8 5052.4 5065.7 5123.1 5137.8 5168.7 5220.7 5236.2 5243.3 5268.6 5325.8 5122.5 5146.8 5151.4 5157.3 5157.5 19:02:46 INFO - PROCESS | 3433 | 19:02:46 INFO - PROCESS | 3433 | [#5] yui.html Cycles:180 Average:16948.06 Median:577.23 stddev:23337.77 (4043.1%) stddev-sans-first:23371.10 19:02:46 INFO - PROCESS | 3433 | Values: 636.6 719.7 746.4 746.7 761.3 12904.2 14044.4 14072.2 14086.4 14088.1 12640.8 12727.6 12805.7 12835.4 12882.4 622.1 776.9 778.6 788.1 797.2 791.7 793.1 796.1 798.1 798.6 830.0 835.2 840.8 840.9 844.5 827.3 836.8 839.9 840.2 840.3 606.5 606.9 609.2 611.3 611.5 12413.7 12448.8 12464.9 12469.6 12506.2 13352.3 13654.9 13795.3 13884.4 13911.7 9151.5 9304.0 9372.6 9406.1 9409.8 3352.4 3367.4 3372.2 3389.9 3489.1 56083.4 56348.7 56831.4 59205.7 59256.7 10545.2 10548.0 10590.9 10674.7 10785.9 19872.8 19903.8 19923.9 19934.2 20305.9 7079.3 7081.4 7106.1 7178.9 7230.6 3612.2 3665.8 3734.9 3738.3 3778.9 2733.8 2832.7 2849.0 2857.9 2857.9 459.6 459.6 469.2 472.2 473.3 553.7 582.0 602.5 605.7 608.9 8183.9 8211.5 8445.2 8453.2 8531.0 487.4 499.8 539.3 572.5 602.8 3965.9 4002.8 4026.9 4029.7 4111.9 53021.0 76628.6 83702.0 88985.0 92093.5 80958.6 81330.7 81961.2 82477.0 82938.0 69772.3 69846.3 70385.0 70797.3 70818.0 7466.2 7471.7 7619.0 7699.5 7777.6 42320.4 43476.6 45796.0 45872.5 46283.3 60940.4 63851.7 63925.0 64465.7 65004.0 8995.0 8997.9 9760.5 10241.0 10470.3 11829.9 12454.4 13140.3 13179.0 13300.9 11439.1 11470.5 11523.0 11686.4 12095.8 11891.7 12090.8 12240.3 12260.1 12671.6 11253.8 11546.9 11654.4 11675.5 11683.4 9039.4 9488.4 9792.9 9810.7 9939.0 9255.7 9397.3 9494.1 9828.7 9893.0 19:02:46 INFO - PROCESS | 3433 | -------- Summary: end -------- 19:02:46 INFO - PROCESS | 3433 | 19:02:47 INFO - TEST-INFO | 3433: exit 0 19:02:47 INFO - TEST-OK | dromaeo_css | took 1117765ms 19:02:47 INFO - TEST-START | kraken 19:02:47 INFO - operating with platform_type : linux_ 19:02:47 INFO - Initialising browser for kraken test... 19:02:47 INFO - TEST-INFO | started process 3672 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTRdqLW/profile http://localhost:35308/getInfo.html) 19:02:51 INFO - PROCESS | 3672 | __metrics Screen width/height:1600/1200 19:02:51 INFO - PROCESS | 3672 | colorDepth:24 19:02:51 INFO - PROCESS | 3672 | Browser inner width/height: 1024/697 19:02:51 INFO - PROCESS | 3672 | __metrics 19:02:52 ERROR - PROCESS | 3672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 19:02:53 INFO - TEST-INFO | 3672: exit 0 19:02:53 INFO - Browser initialized. 19:02:53 INFO - Running cycle 1/1 for kraken test... 19:02:53 INFO - TEST-INFO | started process 3790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTRdqLW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:03:05 INFO - PROCESS | 3790 | RSS: Main: 168288256 19:03:05 INFO - PROCESS | 3790 | 19:03:08 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35308/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35308/tests/kraken/driver.html?testName=audio-beat-detection) 19:03:09 INFO - PROCESS | 3790 | RSS: Main: 173203456 19:03:09 INFO - PROCESS | 3790 | 19:03:11 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35308/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35308/tests/kraken/driver.html?testName=audio-dft) 19:03:12 INFO - PROCESS | 3790 | RSS: Main: 173711360 19:03:12 INFO - PROCESS | 3790 | 19:03:15 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35308/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35308/tests/kraken/driver.html?testName=audio-fft) 19:03:16 INFO - PROCESS | 3790 | RSS: Main: 168079360 19:03:16 INFO - PROCESS | 3790 | 19:03:18 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35308/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35308/tests/kraken/driver.html?testName=audio-oscillator) 19:03:18 INFO - PROCESS | 3790 | RSS: Main: 168366080 19:03:18 INFO - PROCESS | 3790 | 19:03:21 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35308/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35308/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:03:21 INFO - PROCESS | 3790 | RSS: Main: 168779776 19:03:21 INFO - PROCESS | 3790 | 19:03:24 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35308/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35308/tests/kraken/driver.html?testName=imaging-darkroom) 19:03:25 INFO - PROCESS | 3790 | RSS: Main: 168935424 19:03:25 INFO - PROCESS | 3790 | 19:03:29 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35308/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35308/tests/kraken/driver.html?testName=imaging-desaturate) 19:03:29 INFO - PROCESS | 3790 | RSS: Main: 166883328 19:03:29 INFO - PROCESS | 3790 | 19:03:32 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35308/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35308/tests/kraken/driver.html?testName=json-parse-financial) 19:03:33 INFO - PROCESS | 3790 | RSS: Main: 168431616 19:03:33 INFO - PROCESS | 3790 | 19:03:35 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35308/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35308/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:03:35 INFO - PROCESS | 3790 | RSS: Main: 168345600 19:03:35 INFO - PROCESS | 3790 | 19:03:37 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35308/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35308/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:03:38 INFO - PROCESS | 3790 | RSS: Main: 168914944 19:03:38 INFO - PROCESS | 3790 | 19:03:40 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35308/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35308/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:03:41 INFO - PROCESS | 3790 | RSS: Main: 169058304 19:03:41 INFO - PROCESS | 3790 | 19:03:43 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35308/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35308/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:03:44 INFO - PROCESS | 3790 | RSS: Main: 169545728 19:03:44 INFO - PROCESS | 3790 | 19:03:47 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35308/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35308/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:03:48 INFO - PROCESS | 3790 | RSS: Main: 169062400 19:03:48 INFO - PROCESS | 3790 | 19:03:49 INFO - PROCESS | 3790 | Cycle 1(1): loaded http://localhost:35308/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35308/tests/kraken/driver.html?testName=ai-astar) 19:03:50 INFO - PROCESS | 3790 | RSS: Main: 169902080 19:03:50 INFO - PROCESS | 3790 | 19:03:50 INFO - PROCESS | 3790 | __start_tp_report 19:03:50 INFO - PROCESS | 3790 | _x_x_mozilla_page_load 19:03:50 INFO - PROCESS | 3790 | _x_x_mozilla_page_load_details 19:03:50 INFO - PROCESS | 3790 | |i|pagename|runs| 19:03:50 INFO - PROCESS | 3790 | |0;ai-astar;114;108;114;115;115;114;115;116;113;113 19:03:50 INFO - PROCESS | 3790 | |1;audio-beat-detection;162;135;158;185;131;152;156;132;189;132 19:03:50 INFO - PROCESS | 3790 | |2;audio-dft;161;164;166;168;167;173;162;161;161;163 19:03:50 INFO - PROCESS | 3790 | |3;audio-fft;75;76;78;154;77;77;76;75;163;76 19:03:50 INFO - PROCESS | 3790 | |4;audio-oscillator;89;86;147;86;90;86;131;88;88;143 19:03:50 INFO - PROCESS | 3790 | |5;imaging-gaussian-blur;118;118;117;118;117;118;118;117;118;118 19:03:50 INFO - PROCESS | 3790 | |6;imaging-darkroom;148;149;148;148;149;149;147;148;149;147 19:03:50 INFO - PROCESS | 3790 | |7;imaging-desaturate;96;95;96;96;96;96;95;95;96;96 19:03:50 INFO - PROCESS | 3790 | |8;json-parse-financial;64;63;65;64;64;65;64;63;64;63 19:03:50 INFO - PROCESS | 3790 | |9;json-stringify-tinderbox;65;66;65;65;65;65;66;65;66;67 19:03:50 INFO - PROCESS | 3790 | |10;stanford-crypto-aes;84;83;91;86;92;92;87;85;123;84 19:03:50 INFO - PROCESS | 3790 | |11;stanford-crypto-ccm;134;141;136;154;146;140;147;134;135;133 19:03:50 INFO - PROCESS | 3790 | |12;stanford-crypto-pbkdf2;171;172;171;176;185;171;173;169;169;175 19:03:50 INFO - PROCESS | 3790 | |13;stanford-crypto-sha256-iterative;67;70;68;69;71;67;68;67;66;70 19:03:50 INFO - PROCESS | 3790 | __end_tp_report 19:03:50 INFO - PROCESS | 3790 | __start_cc_report 19:03:50 INFO - PROCESS | 3790 | _x_x_mozilla_cycle_collect,996 19:03:50 INFO - PROCESS | 3790 | __end_cc_report 19:03:50 INFO - PROCESS | 3790 | __startTimestamp1465437830167__endTimestamp 19:03:50 INFO - PROCESS | 3790 | 19:03:50 INFO - PROCESS | 3790 | ------- Summary: start ------- 19:03:50 INFO - PROCESS | 3790 | Number of tests: 14 19:03:50 INFO - PROCESS | 3790 | 19:03:50 INFO - PROCESS | 3790 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.50 stddev:2.21 (1.9%) stddev-sans-first:2.35 19:03:50 INFO - PROCESS | 3790 | Values: 114.0 108.0 114.0 115.0 115.0 114.0 115.0 116.0 113.0 113.0 19:03:50 INFO - PROCESS | 3790 | 19:03:50 INFO - PROCESS | 3790 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:157.00 stddev:21.41 (13.6%) stddev-sans-first:22.47 19:03:50 INFO - PROCESS | 3790 | Values: 162.0 135.0 158.0 185.0 131.0 152.0 156.0 132.0 189.0 132.0 19:03:50 INFO - PROCESS | 3790 | 19:03:50 INFO - PROCESS | 3790 | [#2] audio-dft Cycles:10 Average:164.60 Median:165.00 stddev:3.92 (2.4%) stddev-sans-first:3.94 19:03:50 INFO - PROCESS | 3790 | Values: 161.0 164.0 166.0 168.0 167.0 173.0 162.0 161.0 161.0 163.0 19:03:50 INFO - PROCESS | 3790 | 19:03:50 INFO - PROCESS | 3790 | [#3] audio-fft Cycles:10 Average:92.70 Median:76.00 stddev:34.76 (45.7%) stddev-sans-first:36.27 19:03:50 INFO - PROCESS | 3790 | Values: 75.0 76.0 78.0 154.0 77.0 77.0 76.0 75.0 163.0 76.0 19:03:50 INFO - PROCESS | 3790 | 19:03:50 INFO - PROCESS | 3790 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:87.00 stddev:25.82 (29.7%) stddev-sans-first:26.86 19:03:50 INFO - PROCESS | 3790 | Values: 89.0 86.0 147.0 86.0 90.0 86.0 131.0 88.0 88.0 143.0 19:03:50 INFO - PROCESS | 3790 | 19:03:50 INFO - PROCESS | 3790 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:03:50 INFO - PROCESS | 3790 | Values: 118.0 118.0 117.0 118.0 117.0 118.0 118.0 117.0 118.0 118.0 19:03:50 INFO - PROCESS | 3790 | 19:03:50 INFO - PROCESS | 3790 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 19:03:50 INFO - PROCESS | 3790 | Values: 148.0 149.0 148.0 148.0 149.0 149.0 147.0 148.0 149.0 147.0 19:03:50 INFO - PROCESS | 3790 | 19:03:50 INFO - PROCESS | 3790 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 19:03:50 INFO - PROCESS | 3790 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 19:03:50 INFO - PROCESS | 3790 | 19:03:50 INFO - PROCESS | 3790 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 19:03:50 INFO - PROCESS | 3790 | Values: 64.0 63.0 65.0 64.0 64.0 65.0 64.0 63.0 64.0 63.0 19:03:50 INFO - PROCESS | 3790 | 19:03:50 INFO - PROCESS | 3790 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 19:03:50 INFO - PROCESS | 3790 | Values: 65.0 66.0 65.0 65.0 65.0 65.0 66.0 65.0 66.0 67.0 19:03:50 INFO - PROCESS | 3790 | 19:03:50 INFO - PROCESS | 3790 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:86.50 stddev:11.85 (13.7%) stddev-sans-first:12.32 19:03:50 INFO - PROCESS | 3790 | Values: 84.0 83.0 91.0 86.0 92.0 92.0 87.0 85.0 123.0 84.0 19:03:50 INFO - PROCESS | 3790 | 19:03:50 INFO - PROCESS | 3790 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:140.50 stddev:7.02 (5.0%) stddev-sans-first:7.11 19:03:50 INFO - PROCESS | 3790 | Values: 134.0 141.0 136.0 154.0 146.0 140.0 147.0 134.0 135.0 133.0 19:03:50 INFO - PROCESS | 3790 | 19:03:50 INFO - PROCESS | 3790 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:172.50 stddev:4.73 (2.7%) stddev-sans-first:4.95 19:03:50 INFO - PROCESS | 3790 | Values: 171.0 172.0 171.0 176.0 185.0 171.0 173.0 169.0 169.0 175.0 19:03:50 INFO - PROCESS | 3790 | 19:03:50 INFO - PROCESS | 3790 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.64 (2.4%) stddev-sans-first:1.67 19:03:50 INFO - PROCESS | 3790 | Values: 67.0 70.0 68.0 69.0 71.0 67.0 68.0 67.0 66.0 70.0 19:03:50 INFO - PROCESS | 3790 | -------- Summary: end -------- 19:03:50 INFO - PROCESS | 3790 | 19:03:51 INFO - TEST-INFO | 3790: exit 0 19:03:51 INFO - TEST-OK | kraken | took 64159ms 19:03:51 INFO - SUITE-END | took 1181s 19:03:51 INFO - Completed test suite (00:19:42) 19:03:51 INFO - javascript benchmark 19:03:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6352.506980722381, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2616.7906567474597, 2695.016319043549, 2695.231858920208, 2703.0269103122882, 2703.0809524761576, 4692.906141877161, 4711.057788442313, 4712.976435117824, 4799.088173247081, 4840.854774356766, 4632.420947381577, 4717.834875779348, 4718.245080787075, 4719.457262414823, 4751.287306903966, 4320.1575692739925, 4338.479382474107, 4433.578810013044, 4445.22208613493, 4445.955540444586, 4127.463429754128, 4492.146492166478, 4524.140413321475, 4540.772961351936, 4541.863744087666, 4250.744955302661, 4339.218940590708, 4347.282698354799, 4376.6498680105515, 4464.799084041226, 4316.028893498969, 4317.97841010796, 4335.891602709926, 4352.129574085164, 4387.802548885308, 4332.4801023877335, 4372.344148377737, 4379.189849877783, 4381.123775244963, 4422.982713975772, 4618.468876079227, 4675.836345727917, 4691.929621055687, 4696.060787842445, 4727.409073865767, 5158.9484105158845, 5178.197379406198, 5190.039842629126, 5191.402988656315, 5229.215617657382, 4973.353464049686, 5209.322788037569, 5227.059129356714, 5235.240890070956, 5240.423553409122, 4667.603253723403, 4716.646251531149, 4717.315989181549, 4725.0077483728455, 4729.6689231754135, 5141.76862041209, 5157.355330583677, 5189.55888749453, 5198.506141916512, 5221.503957124067, 4854.781534830941, 4948.703077815343, 4969.27945447908, 4976.377952755905, 5020.422651395063, 5019.623528235397, 5039.143345631178, 5075.3148324975655, 5084.059449001947, 5127.102757017507, 4904.043711476228, 4966.8758281043265, 4967.925481117786, 5022.146235140035, 5022.773975171126, 4906.681065730716, 4948.727819969864, 4950.18321976877, 4988.6757360771435, 4999.125153098194, 4253.0, 4260.147970405931, 4261.169072030924, 4271.829126834954, 4311.805968731414, 3600.0279924420784, 3618.81905904709, 3625.8912232633065, 3625.9093522662142, 3694.9076273093387, 4217.768022758778, 4218.114196018871, 4238.745675259494, 4276.657867370665, 4287.2711639021445, 4892.0705066037335, 4893.314935908976, 4900.411950565884, 4954.455009948902, 5012.949870501321, 4385.868423947287, 4411.1618792429335, 4457.665675074318, 4465.732056076581, 4471.32930060487, 4578.839740609063, 4605.608523275492, 4606.677532572688, 4624.260118381043, 4686.671932964659, 4672.08894265615, 4833.9606984498505, 4868.9756551217015, 4870.634702397405, 4921.212605983097, 5118.820841270538, 5156.303898973591, 5166.689998600096, 5187.144121219956, 5193.195054766517, 4868.294097355934, 4881.609471242221, 4902.117618828645, 4909.312696222603, 4934.654574179773, 5063.721495317645, 5080.745962701924, 5088.796448142033, 5091.170250967467, 5113.897722045613, 5194.766235519335, 5210.166373380241, 5219.947800521946, 5248.947510524846, 5285.075111855487, 5039.143345631325, 5053.772580233972, 5054.090263752413, 5077.492250774893, 5089.05852417304, 4732.716037037789, 4805.111054454937, 5014.648974571745, 5030.295758593873, 5037.370328708911, 4924.655274130777, 4943.901121977612, 4950.331705219894, 4980.551750342486, 5032.446430892672, 5105.821296254613, 5155.845324640267, 5159.122949098587, 5165.535101840853, 5217.582593392595, 4845.394325709286, 4871.464138944642, 4903.901921961469, 4914.164592019437, 5033.521815427529], "value": 4674.069989184721, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.7911218991928, 566.3713278261131, 579.8608333999839, 596.9523486281576, 603.3755063509269, 36394.0, 40855.59144408555, 40914.97712557184, 41014.79492602533, 41066.58933410665, 40776.18447631053, 41109.38335924964, 41146.58853411465, 41231.0, 41350.0, 7756.340711039568, 7868.842623147533, 7900.32847207988, 7903.367730581568, 7922.326602238817, 7805.4536182467255, 7828.5694286814205, 7834.843303133963, 7881.487703299267, 7902.130765615806, 7827.334676552471, 7852.803679908019, 7867.095284042322, 7909.485883417559, 7920.366370690331, 7822.33510151635, 7835.177306382861, 7869.763907082796, 7888.80277993049, 7908.406869484812, 7728.7681369559, 7773.067231932205, 7777.922220777777, 7780.961095194544, 7804.219578042207, 30039.0, 37956.0, 38278.61721382806, 38575.22849542993, 38579.807100964594, 2960.7039296070434, 2975.3602975360186, 3078.3073808392933, 3255.690709382605, 3455.153487395579, 27697.584536231974, 30380.392392152255, 30545.847270763505, 30568.847155764302, 30794.53808192879, 3566.3402270580027, 3587.515685382492, 3605.6214097519646, 3649.489071529988, 3679.337719210541, 261597.0, 269260.0, 269687.0, 270851.0, 271301.0, 58332.0, 59435.70282148562, 59550.0, 59643.105353419734, 59658.70170649119, 34226.48660270098, 35206.0, 35411.82294088513, 36519.0, 36555.0, 15811.13038782878, 15944.920275398548, 15957.122358270406, 16000.679986400439, 16040.358385664676, 11675.065994720402, 11771.352575608253, 11803.881961180277, 11810.350430726392, 11891.989180919545, 19486.928218948095, 19524.511887202934, 19610.313639022566, 19692.90153549223, 19761.209551618063, 7410.740624078131, 7604.148444333375, 7606.619669016527, 7614.505057171266, 7722.652480638385, 819.8647223208224, 919.8134406615392, 924.653255029364, 945.5886689290181, 965.1892410375178, 27998.72001280002, 28176.71823281741, 28455.146345609664, 28904.0, 29034.41931161407, 976.3799987008301, 983.321508159382, 985.5170966226498, 991.3853410885154, 1027.712240572641, 14614.100166978225, 14768.852311476963, 14826.777598336033, 14894.92552537252, 15109.773353399707, 387258.0, 390129.0, 391306.0, 392174.0, 392665.0, 50642.24036639454, 50789.23816142761, 51033.74483127635, 51151.23273150906, 51168.74415627898, 1196.2731871001067, 1208.5045131496045, 1210.878912108782, 1216.4100411300512, 1246.4764798784531, 26864.462710746066, 27716.861415692794, 27820.44359112766, 28120.71879281263, 28421.57367639446, 44056.559434405244, 44105.77947110244, 44409.333859992774, 44686.3297050551, 44896.32655510105, 275740.0, 275778.0, 276588.0, 276916.0, 328569.0, 26181.60727589126, 26307.0, 26735.598966015135, 26766.59850102289, 26876.59685104686, 42091.7895410521, 43195.40516918467, 43832.78083609689, 44039.119217614825, 44277.11445771131, 37364.439533406476, 38208.0, 38438.23123537458, 38642.6135738639, 38865.41701874418, 36379.0, 36816.26367472582, 37049.0, 37507.24985500329, 37794.62205377911, 31929.20176995501, 36854.07864803401, 37004.074898127765, 37115.0, 38724.2255154901, 33331.166720832174, 34237.48643770296, 34721.652783472855, 34907.30185396227, 34986.300273994886, 25957.480850383265, 26046.348841278363, 26101.869490653185, 26294.0, 26654.46691066129], "value": 17783.717477540646, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.98552057917686, 362.69533591782897, 367.2306517845115, 371.153769405755, 375.97744135351866, 15517.534473965785, 16602.086885221324, 17450.3019879205, 17640.294388224487, 17695.73456398155, 14229.288535573232, 15065.493450654929, 15074.924625376858, 15078.019928704627, 15093.92453037736, 4290.635295999836, 4588.77056147193, 4592.540745925414, 4650.953490465085, 4661.510541393139, 3529.0824385659785, 4603.148417542749, 5126.512981266792, 5422.728863556826, 5430.0768869292115, 5465.535429488498, 5474.151506516497, 5485.204645326426, 5486.204500347447, 5499.945000550003, 5346.198070289468, 6011.909821352683, 6029.065494848283, 6030.96984515079, 6040.5469589780505, 5102.540771330561, 5298.92051619226, 5313.043652142613, 5317.707526086064, 5339.893202135935, 12160.452779624939, 12328.32194229317, 12360.938195309056, 12390.442430090667, 12430.813537796941, 1827.5431142214447, 1922.4713203868907, 1957.080172319022, 2003.0485519378324, 2032.9631887737212, 9100.226480749145, 9378.249740020781, 9630.422174669542, 10180.592776288939, 13063.477460901553, 1753.684336819372, 1763.1713094845402, 1765.3821162593117, 1782.1427505298645, 1782.9286828526974, 65944.67027664879, 68552.0, 69803.30196698019, 70536.6473167636, 70889.2911070893, 9657.806843863083, 9801.803963920682, 10187.54156062979, 10226.28416010872, 10228.693139205836, 13741.175529468264, 13848.238346890816, 13881.305934703427, 13897.930510347383, 13942.721145577032, 7443.218462061405, 7560.432967527458, 7664.6934122635585, 7689.538627682357, 7720.0, 7375.926240737524, 7446.590437525988, 7608.467407281437, 7629.771106866803, 7657.042869641295, 4214.578542145761, 4263.76549289792, 4306.4832220133785, 4353.499347575006, 4360.629346505519, 1607.429362576292, 1612.065002298664, 1720.234495649424, 1736.0, 1797.8381945624956, 812.6708682983401, 823.0370466554147, 843.6751850537587, 893.4996402014763, 958.3004406783087, 14892.851071489147, 16028.599285017968, 16644.83355166457, 16650.3339866404, 17147.657046858993, 849.3078141314809, 856.4176360075085, 860.9009963854237, 865.2169786343369, 872.7905302727299, 9122.817543649222, 9396.154346108746, 9498.14516693501, 9606.183474404614, 9653.71038868835, 363241.0, 377168.0, 381890.0, 382389.0, 387280.0, 75148.0, 75687.0, 76118.61940690261, 76554.0, 78445.0, 916.867054277126, 919.8758167647281, 931.9207867331353, 934.5047125023748, 940.2008292950937, 14851.554453366416, 14902.478413255483, 14922.85077149258, 15181.696366072838, 15228.769540472435, 34562.481562776076, 35384.93845184649, 36090.4586431209, 36223.0, 36474.08814779545, 48174.0, 48329.27506087341, 49568.256476153605, 49596.25605615991, 49618.0, 6726.091977582963, 7026.262242464468, 7294.307040831112, 7315.561066336037, 7579.962100189464, 8786.297096232414, 11159.553617855196, 11249.887501125211, 12145.69635759113, 12269.263844169378, 10549.472526373804, 10613.893861061291, 10659.520321585393, 10802.08182304513, 11008.834867476835, 10563.683089507327, 10628.84056739134, 10790.082842958123, 10819.459027048773, 11251.15616328795, 8343.916560834557, 10732.551105600643, 10827.350358978487, 11015.559377624806, 11094.611688590861, 6766.424853887278, 7131.42948564124, 7205.207427182901, 7961.681532738858, 8067.55628440418, 10589.735256618646, 10646.148308135485, 10952.452377381258, 11053.226274161054, 11168.441577920908], "value": 8040.681074360538, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.903476756627, 1414.6887684709363, 1506.8794496440287, 1619.2146808797738, 1660.501849445166, 6577.309382514839, 7344.853102937938, 7513.248675132484, 8004.399670024757, 8024.117347091823, 7318.158411782647, 7530.58581778002, 7598.164201937782, 7600.96199519003, 7614.428917831157, 2106.9999999999964, 2145.0240140735928, 2145.1097794415377, 2145.3778404262744, 2148.344754849778, 2069.2550681754556, 2090.602785470763, 2122.8514004019726, 2136.5299634080557, 2140.347194105797, 2099.1708275231276, 2108.4096452993185, 2112.7570329412083, 2117.502386939068, 2135.6369417199035, 2085.7288552488153, 2085.9165633374646, 2089.9477513062143, 2091.2576035507327, 2092.393205970267, 2034.8168664820237, 2076.4601203687, 2108.0829839020075, 2112.0812446585783, 2118.5868755592664, 7513.54918704874, 7606.277403646644, 7611.923880761177, 7632.465727399084, 7634.656440460192, 4292.055747735493, 4414.9337759933305, 4415.536368681274, 4416.624586910117, 4417.823287068513, 2753.917382478529, 2814.1698199031334, 2864.427114577093, 2880.5247134222827, 2883.1494709060876, 895.194325107402, 896.4710820615803, 916.5234078279258, 922.7600823785864, 944.9905500944972, 10621.84067238992, 10644.946775266151, 10658.840117398246, 10673.679789606324, 10719.785604287948, 3909.8240579174008, 4022.1754540319166, 4041.818118184689, 4074.0, 4102.0, 8909.064548222474, 9011.729648110568, 9033.548322583845, 9084.182423581777, 9108.954455227682, 4505.5719706627815, 4529.682922195415, 4581.839635612804, 4594.2419500782, 4613.215753321943, 3354.0943945134677, 4036.3541833307117, 4170.124273902454, 4201.936970945439, 4215.178040282177, 3642.635736426389, 3646.252518233756, 3740.495033170542, 3754.4931434256027, 3781.3949768036982, 1136.9147313951487, 1194.2177873492876, 1206.0592737664635, 1208.7670576012417, 1215.7325388414536, 858.750962220949, 861.2636196052285, 870.6734974384606, 870.9085546017577, 899.9370044096981, 5170.948290517122, 5185.0, 5200.037992971313, 5209.140491818807, 5210.6613070150315, 415.5532802237607, 422.8900485873695, 426.132819711891, 429.81732763575354, 439.59118020240845, 3608.404613238786, 3646.762960407565, 3717.200801827566, 3725.1618385863508, 3758.661720445173, 8944.5080520572, 9387.62449502026, 9422.575984080733, 9439.858402123973, 9461.858072128924, 9153.450792952444, 9306.72079837606, 9321.44071355721, 9343.439393636403, 9347.859782103274, 7058.188308344504, 7199.100112486044, 7241.818954526179, 7247.891281630779, 7253.637318134072, 5043.117454445531, 5112.463191365002, 5127.0, 5178.585713142864, 5181.870453238699, 8715.825683486422, 8729.694460693845, 8747.562621869009, 8766.386352955233, 8837.469751814911, 8609.268212201783, 8788.07725188846, 8831.0, 8893.866592001255, 8938.821223575622, 5733.913991290051, 6322.8735425290315, 6543.0, 6736.393724564813, 6775.051492791112, 7510.136334321623, 7621.542707437571, 7636.31273185416, 7639.541627502367, 7669.233076692286, 6737.921932490778, 6884.690188941409, 6913.688884000131, 6962.895556566757, 6973.163220413583, 6628.436582890508, 6724.058631791651, 6730.629815360202, 6746.4265537429865, 6879.724811007503, 6375.362463753773, 6381.744730210925, 6439.517036222396, 6461.709223085067, 6491.642959637265, 4637.953620463887, 4646.372739680235, 4707.976460117678, 4767.73777442244, 4768.856934291976, 4690.296455531698, 4739.549742774431, 4749.26386410107, 4766.642501812447, 4791.664583479123], "value": 4019.177928729885, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.19543943087604, 276.237584267422, 280.0, 285.4690276086479, 288.7978415109424, 4845.733484658343, 4925.43357513886, 4976.875578110545, 5042.873928151798, 5064.442911279761, 4916.729579873106, 4929.186684197103, 4941.431735350427, 4963.975180124104, 4969.527894849993, 3816.7213983315623, 3857.6913846892253, 3861.1891502784447, 3881.7088718346095, 3890.8054597270166, 3579.1410061585293, 3876.8643097491595, 3883.8834834954855, 3893.4354518594787, 3897.2205558888195, 3730.3844865597143, 3756.1173124315765, 3771.17034252464, 3785.62143785622, 3792.2605092006934, 3742.8128593570486, 3759.492468516756, 3764.0, 3773.7169712271416, 3789.2042671039117, 3270.525773762815, 3315.53582498448, 3321.2693207494312, 3323.2522682396266, 3329.900102996914, 4672.3692301539195, 4730.810767569293, 4773.665843390964, 4806.9810679514685, 4808.519148085164, 4300.569943005706, 4309.59058889405, 4310.935335969963, 4316.892077698083, 4342.305231162999, 5134.845954621367, 5157.922631160535, 5207.218917162418, 5212.556932660728, 5230.137027390476, 3493.0, 3586.941852153621, 3591.838367273479, 3612.02475331659, 3614.8011859347725, 5398.2982212312545, 5447.891042179134, 5457.0, 5491.643043202179, 5505.504504594565, 3630.3102410541915, 3634.672879440863, 3640.4903313536124, 3643.617420170897, 3649.3066317399607, 3663.9267214655556, 3679.9264014719556, 3687.5574931007914, 3688.5204923359793, 3690.8189379398336, 4148.460700108966, 4198.6221240087925, 4203.978980105141, 4221.641160501392, 4302.548232435612, 5139.820106296262, 5150.995555866645, 5155.896882062413, 5167.405748338914, 5190.247414125006, 1183.650823007215, 1239.6776838022179, 1266.5630357526638, 1267.2396562062872, 1275.3368248510722, 784.1609477858636, 788.6553426407961, 807.3299161695778, 815.7348861619879, 816.2245866426919, 4018.4374187613757, 4052.3111071117983, 4064.837406503766, 4093.3655283431117, 4114.670826333886, 4657.6506761992305, 4673.976630116896, 4689.460712018162, 4692.835750748707, 4740.525947405232, 4069.206504731549, 4077.429159917614, 4084.203580301872, 4087.6116768906904, 4101.815418306183, 2360.8465449745713, 2514.861682607474, 2518.2067648690604, 2525.368657835541, 2536.1884197057134, 4393.934090988638, 4410.735355878657, 4421.73302762829, 4431.778411079433, 4520.18636645407, 4741.881452963635, 4762.4283986284445, 4793.448753393404, 4824.372831531879, 4833.250846118857, 4440.911181776346, 4468.776561171929, 4691.62467002639, 5124.410692770379, 5140.537351638296, 5393.381985404285, 5419.022056949264, 5420.0, 5428.70142142186, 5438.45615438453, 5341.157300731242, 5341.305630268041, 5343.519083282523, 5356.919646205232, 5356.9911283268775, 4958.206686930074, 5093.159628661229, 5095.643304968617, 5096.210087436453, 5140.820071297487, 3641.9817900910325, 3659.1949771050326, 3682.3187710273687, 3693.5567731872347, 3732.9253414931004, 5198.246254293182, 5463.508284254436, 5477.178423236546, 5478.643888147258, 5486.643368181056, 5117.948820511896, 5229.450907654642, 5229.738513074407, 5236.921446178234, 5244.606654500852, 5205.219217117463, 5235.947640523546, 5244.160934250502, 5245.527902488794, 5245.842624721265, 5052.43803118793, 5065.746712664426, 5123.129068058513, 5137.845864624067, 5168.689878607295, 5220.7128607926925, 5236.198633730935, 5243.265942768092, 5268.552173065333, 5325.760340784752, 5122.513361230677, 5146.794128234978, 5151.356080489939, 5157.252198431282, 5157.510036546522], "value": 3783.56877616753, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.5925807483211, 719.7121151539384, 746.4103358346906, 746.7274444827638, 761.3224230434918, 12904.161229520074, 14044.368003439844, 14072.155670659742, 14086.436542538311, 14088.084274522174, 12640.810387844189, 12727.554535591256, 12805.679858003554, 12835.358232088405, 12882.355882205899, 622.0855342646303, 776.8562815879052, 778.6340420002618, 788.1015642167905, 797.1988151907354, 791.6674996501455, 793.1037927142321, 796.0924546017544, 798.1101072304368, 798.632628990662, 829.9709510167145, 835.1856939484015, 840.8234270803108, 840.9369297302696, 844.4764246167384, 827.2637352756052, 836.782436566497, 839.9412041157121, 840.155643578203, 840.2689659995813, 606.4663096475118, 606.851321426249, 609.2262826210732, 611.2878496551513, 611.5077362723006, 12413.689657758538, 12448.75102497954, 12464.937675311656, 12469.563565275172, 12506.187097838703, 13352.332383380792, 13654.931725341408, 13795.310234488335, 13884.375203115884, 13911.721765564633, 9151.496667683276, 9303.953480232556, 9372.625094996192, 9406.1064198901, 9409.76475588109, 3352.4468462703867, 3367.44437167867, 3372.19067423819, 3389.86440542378, 3489.145159435929, 56083.43916560823, 56348.718256408865, 56831.43168568303, 59205.703971480296, 59256.70371648114, 10545.209109316833, 10548.0, 10590.947045264724, 10674.679759607225, 10785.946070269598, 19872.801271987384, 19903.800961990484, 19923.900380498293, 19934.202631894852, 20305.898470507847, 7079.256678048834, 7081.362677359062, 7106.076210092759, 7178.892316615255, 7230.566166030055, 3612.187257866959, 3665.8350374233223, 3734.8506059757847, 3738.345789486829, 3778.886633401002, 2733.7949653776045, 2832.7025662305573, 2849.0313293480317, 2857.914262572126, 2857.9428411431654, 459.60014787135407, 459.6116281741923, 469.17893686049416, 472.1925507382346, 473.2806134675274, 553.7452771725052, 581.982540523785, 602.5270162922172, 605.6608299352376, 608.8782243551308, 8183.918160818315, 8211.548364839991, 8445.1977062179, 8453.15468453162, 8530.957345213234, 487.4248386903488, 499.7825945713626, 539.2531344088387, 572.4676051272356, 602.7920367473215, 3965.92068158641, 4002.819873105659, 4026.8926045337766, 4029.6977726670616, 4111.8560850370095, 53021.0, 76628.61685691535, 83702.0, 88985.0, 92093.5395323019, 80958.59520702477, 81330.71350362207, 81961.18038819655, 82477.0, 82938.0, 69772.3022769776, 69846.30153698398, 70385.0, 70797.2920270801, 70817.99999999897, 7466.178720340867, 7471.701131954878, 7618.961905190438, 7699.499532530368, 7777.611119443892, 42320.365194522725, 43476.56523434852, 45796.0, 45872.54127458816, 46283.305750414445, 60940.39059609525, 63851.68074159599, 63925.0, 64465.67767161134, 65004.0, 8994.955025224832, 8997.865032024656, 9760.46317452547, 10241.0, 10470.319429237075, 11829.881701183222, 12454.377281135725, 13140.342982850629, 13179.0, 13300.933495332849, 11439.142064345373, 11470.483828227583, 11523.0, 11686.357250350971, 12095.758084838079, 11891.702707432038, 12090.75818483643, 12240.326782027074, 12260.08049396281, 12671.619851404472, 11253.831192532283, 11546.884531154581, 11654.41727913584, 11675.474603643026, 11683.357415342238, 9039.412438191497, 9488.383255088396, 9792.902070979198, 9810.65662701802, 9939.0, 9255.722328330161, 9397.342186046912, 9494.098060684224, 9828.705138845846, 9892.950535247277], "value": 6465.02618179285, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1590.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 114.0, 115.0, 115.0, 114.0, 115.0, 116.0, 113.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 135.0, 158.0, 185.0, 131.0, 152.0, 156.0, 132.0, 189.0, 132.0], "value": 153.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 166.0, 168.0, 167.0, 173.0, 162.0, 161.0, 161.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 78.0, 154.0, 77.0, 77.0, 76.0, 75.0, 163.0, 76.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 147.0, 86.0, 90.0, 86.0, 131.0, 88.0, 88.0, 143.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 148.0, 149.0, 149.0, 147.0, 148.0, 149.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 64.0, 64.0, 65.0, 64.0, 63.0, 64.0, 63.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 67.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 91.0, 86.0, 92.0, 92.0, 87.0, 85.0, 123.0, 84.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 141.0, 136.0, 154.0, 146.0, 140.0, 147.0, 134.0, 135.0, 133.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 171.0, 176.0, 185.0, 171.0, 173.0, 169.0, 169.0, 175.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 68.0, 69.0, 71.0, 67.0, 68.0, 67.0, 66.0, 70.0], "value": 68.3, "unit": "score"}]}]} 19:03:51 INFO - Return code: 0 19:03:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:03:51 ERROR - # TBPL SUCCESS # 19:03:51 INFO - Running post-action listener: _resource_record_post_action 19:03:51 INFO - ##### 19:03:51 INFO - ##### Finished run-tests step (success) 19:03:51 INFO - ##### 19:03:51 INFO - Running post-run listener: _resource_record_post_run 19:03:51 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 7667712; Write bytes: 435634176; Read time: 944; Write time: 398152 19:03:51 INFO - TinderboxPrint: CPU usage
13.5% 19:03:51 INFO - TinderboxPrint: I/O read bytes / time
7,667,712 / 944 19:03:51 INFO - TinderboxPrint: I/O write bytes / time
435,634,176 / 398,152 19:03:51 INFO - TinderboxPrint: CPU idle
8,277.7 (86.5%) 19:03:51 INFO - TinderboxPrint: CPU user
1,232.1 (12.9%) 19:03:51 INFO - TinderboxPrint: Swap in / out
0 / 0 19:03:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 29401088; Read time: 16; Write time: 5552 19:03:51 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 5902336; Write bytes: 351600640; Read time: 680; Write time: 326784 19:03:52 INFO - Running post-run listener: _upload_blobber_files 19:03:52 INFO - Blob upload gear active. 19:03:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:03:52 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 19:03:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:03:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:03:52 INFO - (blobuploader) - INFO - Open directory for files ... 19:03:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:03:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:03:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:03:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:03:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:03:53 INFO - (blobuploader) - INFO - Done attempting. 19:03:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:03:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:03:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:03:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:03:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:03:54 INFO - (blobuploader) - INFO - Done attempting. 19:03:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:03:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:03:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:03:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:03:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:03:57 INFO - (blobuploader) - INFO - Done attempting. 19:03:57 INFO - (blobuploader) - INFO - Iteration through files over. 19:03:57 INFO - Return code: 0 19:03:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:03:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:03:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/37dfea771520458260c87752acda069e3769571dfa09da33f4c6746a0915f313be84efa0d0a66f3d74674d2f7861d946062987489ec01fbf67fda5b95f519f1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/443006038b0a21f802f91ac35bde2cebda145d7ed8bd3bb804be6148da49f55b291caaeed5f009ac20f9e809aea91daafc75e6bf9c15b063795c2ea0dd333ff8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c0bd8e859606f0b5a87e6512fa3621e92feb337ece639cd04f64264d9b02b68caa1f2d9b1f4ca099961d2919920c3ebf8fafcd0a49d78a9420de27292174afdf"} 19:03:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:03:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:03:57 INFO - Contents: 19:03:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/37dfea771520458260c87752acda069e3769571dfa09da33f4c6746a0915f313be84efa0d0a66f3d74674d2f7861d946062987489ec01fbf67fda5b95f519f1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/443006038b0a21f802f91ac35bde2cebda145d7ed8bd3bb804be6148da49f55b291caaeed5f009ac20f9e809aea91daafc75e6bf9c15b063795c2ea0dd333ff8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c0bd8e859606f0b5a87e6512fa3621e92feb337ece639cd04f64264d9b02b68caa1f2d9b1f4ca099961d2919920c3ebf8fafcd0a49d78a9420de27292174afdf"} 19:03:57 INFO - Running post-run listener: copy_logs_to_upload_dir 19:03:57 INFO - Copying logs to upload dir... 19:03:57 INFO - mkdir: /builds/slave/test/build/upload/logs 19:03:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.904220 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-08 19:03:57.423756) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 19:03:57.427871) ========= 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=c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/37dfea771520458260c87752acda069e3769571dfa09da33f4c6746a0915f313be84efa0d0a66f3d74674d2f7861d946062987489ec01fbf67fda5b95f519f1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/443006038b0a21f802f91ac35bde2cebda145d7ed8bd3bb804be6148da49f55b291caaeed5f009ac20f9e809aea91daafc75e6bf9c15b063795c2ea0dd333ff8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c0bd8e859606f0b5a87e6512fa3621e92feb337ece639cd04f64264d9b02b68caa1f2d9b1f4ca099961d2919920c3ebf8fafcd0a49d78a9420de27292174afdf"} build_url:https://queue.taskcluster.net/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011207 build_url: 'https://queue.taskcluster.net/v1/task/UjeaXdIfRZCQdNr2b_7oag/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/37dfea771520458260c87752acda069e3769571dfa09da33f4c6746a0915f313be84efa0d0a66f3d74674d2f7861d946062987489ec01fbf67fda5b95f519f1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/443006038b0a21f802f91ac35bde2cebda145d7ed8bd3bb804be6148da49f55b291caaeed5f009ac20f9e809aea91daafc75e6bf9c15b063795c2ea0dd333ff8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c0bd8e859606f0b5a87e6512fa3621e92feb337ece639cd04f64264d9b02b68caa1f2d9b1f4ca099961d2919920c3ebf8fafcd0a49d78a9420de27292174afdf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 19:03:57.454995) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 19:03:57.455505) ========= 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=c6927cf182745ad25b1d38b9000001fe-1465435051.299511-259094090 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 19:03:57.542013) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 19:03:57.542596) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 19:03:57.543207) ========= ========= Total master_lag: 0.18 =========