builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1466104345.48 results: success (0) buildid: 20160616093021 builduid: d2374eb4927444028ad6db6f7e1b8a8d revision: ea9d62d5f09b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:25.484653) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:25.485121) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:25.485453) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:25.543838) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:25.544187) ========= 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=eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 12:12:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-06-16 12:12:26 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174826 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:25.739413) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:25.739761) ========= 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=eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020753 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:25.798067) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 12:12:25.798484) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ea9d62d5f09b --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 ea9d62d5f09b --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=eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 12:12:26,139 Setting DEBUG logging. 2016-06-16 12:12:26,139 attempt 1/10 2016-06-16 12:12:26,139 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ea9d62d5f09b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 12:12:27,323 unpacking tar archive at: fx-team-ea9d62d5f09b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.526130 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-16 12:12:27.341242) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:27.341681) ========= script_repo_revision: ea9d62d5f09b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:27.342141) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:27.342604) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:27.353582) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-06-16 12:12:27.353899) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:12:27 INFO - MultiFileLogger online at 20160616 12:12:27 in /builds/slave/test 12:12:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:12:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:12:27 INFO - {'append_to_log': False, 12:12:27 INFO - 'base_work_dir': '/builds/slave/test', 12:12:27 INFO - 'blob_upload_branch': 'Fx-Team', 12:12:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:12:27 INFO - 'branch': 'Fx-Team', 12:12:27 INFO - 'buildbot_json_path': 'buildprops.json', 12:12:27 INFO - 'config_files': ('talos/linux_config.py',), 12:12:27 INFO - 'default_actions': ('clobber', 12:12:27 INFO - 'read-buildbot-config', 12:12:27 INFO - 'download-and-extract', 12:12:27 INFO - 'populate-webroot', 12:12:27 INFO - 'create-virtualenv', 12:12:27 INFO - 'install', 12:12:27 INFO - 'run-tests'), 12:12:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:12:27 INFO - 'download_minidump_stackwalk': True, 12:12:27 INFO - 'download_symbols': 'ondemand', 12:12:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:12:27 INFO - 'tooltool.py': '/tools/tooltool.py', 12:12:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:12:27 INFO - '/tools/misc-python/virtualenv.py')}, 12:12:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:12:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:12:27 INFO - 'installer_path': 'installer.exe', 12:12:27 INFO - 'log_level': 'info', 12:12:27 INFO - 'log_name': 'talos', 12:12:27 INFO - 'log_to_console': True, 12:12:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:12:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:12:27 INFO - 'opt_config_files': (), 12:12:27 INFO - 'pip_index': False, 12:12:27 INFO - 'sps_profile': False, 12:12:27 INFO - 'sps_profile_interval': 0, 12:12:27 INFO - 'suite': 'dromaeojs-e10s', 12:12:27 INFO - 'system_bits': '32', 12:12:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:12:27 INFO - 'title': 'talos-linux64-ix-010', 12:12:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:12:27 INFO - 'use_talos_json': True, 12:12:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:12:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:12:27 INFO - 'work_dir': 'build'} 12:12:27 INFO - ##### 12:12:27 INFO - ##### Running clobber step. 12:12:27 INFO - ##### 12:12:27 INFO - Running pre-action listener: _resource_record_pre_action 12:12:27 INFO - Running main action method: clobber 12:12:27 INFO - rmtree: /builds/slave/test/build 12:12:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:12:28 INFO - Running post-action listener: _resource_record_post_action 12:12:28 INFO - ##### 12:12:28 INFO - ##### Finished clobber step (success) 12:12:28 INFO - ##### 12:12:28 INFO - ##### 12:12:28 INFO - ##### Running read-buildbot-config step. 12:12:28 INFO - ##### 12:12:28 INFO - Running pre-action listener: _resource_record_pre_action 12:12:28 INFO - Running main action method: read_buildbot_config 12:12:28 INFO - Using buildbot properties: 12:12:28 INFO - { 12:12:28 INFO - "project": "", 12:12:28 INFO - "product": "firefox", 12:12:28 INFO - "script_repo_revision": "production", 12:12:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:12:28 INFO - "repository": "", 12:12:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 12:12:28 INFO - "buildid": "20160616093021", 12:12:28 INFO - "pgo_build": "True", 12:12:28 INFO - "basedir": "/builds/slave/test", 12:12:28 INFO - "buildnumber": 480, 12:12:28 INFO - "slavename": "talos-linux64-ix-010", 12:12:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:12:28 INFO - "platform": "ubuntu64_hw", 12:12:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:12:28 INFO - "branch": "fx-team", 12:12:28 INFO - "repo_path": "integration/fx-team", 12:12:28 INFO - "revision": "ea9d62d5f09b", 12:12:28 INFO - "stage_platform": "linux64-pgo", 12:12:28 INFO - "builduid": "d2374eb4927444028ad6db6f7e1b8a8d", 12:12:28 INFO - "slavebuilddir": "test" 12:12:28 INFO - } 12:12:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:12:28 INFO - Running post-action listener: _resource_record_post_action 12:12:28 INFO - ##### 12:12:28 INFO - ##### Finished read-buildbot-config step (success) 12:12:28 INFO - ##### 12:12:28 INFO - ##### 12:12:28 INFO - ##### Running download-and-extract step. 12:12:28 INFO - ##### 12:12:28 INFO - Running pre-action listener: _resource_record_pre_action 12:12:28 INFO - Running main action method: download_and_extract 12:12:28 INFO - mkdir: /builds/slave/test/build/tests 12:12: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')]} 12:12:28 INFO - https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:12:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:12:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:12:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 12:12:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 12:12:29 INFO - retry: attempt #1 caught exception: '' 12:12:29 INFO - retry: Failed, sleeping 30 seconds before retrying 12:12:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 #2 12:13:12 INFO - Downloaded 1361 bytes. 12:13:12 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:13:12 INFO - Using the following test package requirements: 12:13:12 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:13:12 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:13:12 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:13:12 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:12 INFO - u'jsshell-linux-x86_64.zip'], 12:13:12 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:13:12 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:13:12 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:13:12 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:13:12 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:13:12 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:13:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:12 INFO - https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:13:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:13:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:13:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 12:13:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 12:13:19 INFO - Downloaded 24220718 bytes. 12:13:19 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'] 12:13:19 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 12:13:21 INFO - Return code: 0 12:13:21 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 12:13:21 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')]} 12:13:21 INFO - https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:13:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:13:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:13:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 12:13:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 12:13:25 INFO - Downloaded 24220718 bytes. 12:13:25 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'] 12:13:25 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 12:13:26 INFO - Return code: 0 12:13:26 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')]} 12:13:26 INFO - https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:13:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:13:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:13:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 12:13:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 12:13:27 INFO - Downloaded 14405384 bytes. 12:13:27 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'] 12:13:27 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 12:13:28 INFO - Return code: 0 12:13: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')]} 12:13:28 INFO - https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:13:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:13:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:13:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 12:13:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 12:13:29 INFO - Downloaded 60097925 bytes. 12:13:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:13:29 INFO - mkdir: /builds/slave/test/properties 12:13:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:13:29 INFO - Writing to file /builds/slave/test/properties/build_url 12:13:29 INFO - Contents: 12:13:29 INFO - build_url:https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:13:30 INFO - Running post-action listener: _resource_record_post_action 12:13:30 INFO - Running post-action listener: set_extra_try_arguments 12:13:30 INFO - ##### 12:13:30 INFO - ##### Finished download-and-extract step (success) 12:13:30 INFO - ##### 12:13:30 INFO - ##### 12:13:30 INFO - ##### Running populate-webroot step. 12:13:30 INFO - ##### 12:13:30 INFO - Running pre-action listener: _resource_record_pre_action 12:13:30 INFO - Running main action method: populate_webroot 12:13:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:13:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:13:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:13:30 INFO - '--tppagecycles', 12:13:30 INFO - '7'], 12:13:30 INFO - 'tests': ['tsvgm']}}, 12:13:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:13:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:13:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:13:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:13:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:13:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:13:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:30 INFO - 'talos_options': ['--disable-e10s'], 12:13:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:13:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:13:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:30 INFO - 'talos_options': ['--disable-e10s'], 12:13:30 INFO - 'tests': ['damp', 'tps']}, 12:13:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:30 INFO - 'tests': ['damp', 'tps']}, 12:13:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:13:30 INFO - 'tests': ['dromaeo_dom']}, 12:13:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:13:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:13:30 INFO - 'tests': ['basic_compositor_video']}, 12:13:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:13:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:13:30 INFO - 'tests': ['a11yr', 12:13:30 INFO - 'ts_paint', 12:13:30 INFO - 'tpaint', 12:13:30 INFO - 'sessionrestore', 12:13:30 INFO - 'sessionrestore_no_auto_restore', 12:13:30 INFO - 'tabpaint']}, 12:13:30 INFO - 'other-e10s': {'tests': ['a11yr', 12:13:30 INFO - 'ts_paint', 12:13:30 INFO - 'tpaint', 12:13:30 INFO - 'sessionrestore', 12:13:30 INFO - 'sessionrestore_no_auto_restore', 12:13:30 INFO - 'tabpaint']}, 12:13:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:13:30 INFO - 'ts_paint', 12:13:30 INFO - 'tpaint', 12:13:30 INFO - 'sessionrestore', 12:13:30 INFO - 'sessionrestore_no_auto_restore', 12:13:30 INFO - 'tabpaint']}, 12:13:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:13:30 INFO - 'ts_paint', 12:13:30 INFO - 'tpaint', 12:13:30 INFO - 'sessionrestore', 12:13:30 INFO - 'sessionrestore_no_auto_restore', 12:13:30 INFO - 'tabpaint']}, 12:13:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:13:30 INFO - 'tests': ['a11yr', 12:13:30 INFO - 'ts_paint', 12:13:30 INFO - 'tpaint', 12:13:30 INFO - 'sessionrestore', 12:13:30 INFO - 'sessionrestore_no_auto_restore', 12:13:30 INFO - 'tabpaint']}, 12:13:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:13:30 INFO - 'tests': ['a11yr', 12:13:30 INFO - 'ts_paint', 12:13:30 INFO - 'tpaint', 12:13:30 INFO - 'sessionrestore', 12:13:30 INFO - 'sessionrestore_no_auto_restore', 12:13:30 INFO - 'tabpaint']}, 12:13:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:13:30 INFO - 'tests': ['tsvgx', 12:13:30 INFO - 'tsvgr_opacity', 12:13:30 INFO - 'tart', 12:13:30 INFO - 'tscrollx', 12:13:30 INFO - 'cart']}, 12:13:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:13:30 INFO - 'tsvgr_opacity', 12:13:30 INFO - 'tart', 12:13:30 INFO - 'tscrollx', 12:13:30 INFO - 'cart']}, 12:13:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:30 INFO - 'talos_options': ['--disable-e10s'], 12:13:30 INFO - 'tests': ['tp5o']}, 12:13:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:30 INFO - 'tests': ['tp5o']}, 12:13:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:30 INFO - 'talos_options': ['--disable-e10s', 12:13:30 INFO - '--xperf_path', 12:13:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:13:30 INFO - 'tests': ['tp5n']}, 12:13:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:30 INFO - 'talos_options': ['--xperf_path', 12:13:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:13:30 INFO - 'tests': ['tp5n']}}, 12:13:30 INFO - 'talos.zip': {'path': '', 12:13:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:13:30 INFO - Running post-action listener: _resource_record_post_action 12:13:30 INFO - ##### 12:13:30 INFO - ##### Finished populate-webroot step (success) 12:13:30 INFO - ##### 12:13:30 INFO - ##### 12:13:30 INFO - ##### Running create-virtualenv step. 12:13:30 INFO - ##### 12:13:30 INFO - Running pre-action listener: _resource_record_pre_action 12:13:30 INFO - Running main action method: create_virtualenv 12:13:30 INFO - Creating virtualenv /builds/slave/test/build/venv 12:13:30 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 12:13:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:13:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:13:30 INFO - Using real prefix '/usr' 12:13:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:13:31 INFO - Installing distribute.............................................................................................................................................................................................done. 12:13:32 INFO - Installing pip.................done. 12:13:33 INFO - Return code: 0 12:13:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:33 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 0x7ff605a07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b0110>, '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 0x231c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c6c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', '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 12:13:33 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 12:13:33 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 12:13:33 INFO - Using env: {'DISPLAY': ':0', 12:13:33 INFO - 'HOME': '/home/cltbld', 12:13:33 INFO - 'LANG': 'en_US.UTF-8', 12:13:33 INFO - 'LANGUAGE': 'en_US:en', 12:13:33 INFO - 'LOGNAME': 'cltbld', 12:13:33 INFO - 'MAIL': '/var/mail/cltbld', 12:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:33 INFO - 'MOZ_NO_REMOTE': '1', 12:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:33 INFO - 'NO_EM_RESTART': '1', 12:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:33 INFO - 'PWD': '/builds/slave/test', 12:13:33 INFO - 'SHELL': '/bin/bash', 12:13:33 INFO - 'SHLVL': '1', 12:13:33 INFO - 'TERM': 'linux', 12:13:33 INFO - 'TMOUT': '86400', 12:13:33 INFO - 'USER': 'cltbld', 12:13:33 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', 12:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:33 INFO - '_': '/tools/buildbot/bin/python'} 12:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:33 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 12:13:33 INFO - Cleaning up... 12:13:33 INFO - Return code: 0 12:13:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:33 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 0x7ff605a07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b0110>, '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 0x231c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c6c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', '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 12:13:33 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 12:13:33 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 12:13:33 INFO - Using env: {'DISPLAY': ':0', 12:13:33 INFO - 'HOME': '/home/cltbld', 12:13:33 INFO - 'LANG': 'en_US.UTF-8', 12:13:33 INFO - 'LANGUAGE': 'en_US:en', 12:13:33 INFO - 'LOGNAME': 'cltbld', 12:13:33 INFO - 'MAIL': '/var/mail/cltbld', 12:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:33 INFO - 'MOZ_NO_REMOTE': '1', 12:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:33 INFO - 'NO_EM_RESTART': '1', 12:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:33 INFO - 'PWD': '/builds/slave/test', 12:13:33 INFO - 'SHELL': '/bin/bash', 12:13:33 INFO - 'SHLVL': '1', 12:13:33 INFO - 'TERM': 'linux', 12:13:33 INFO - 'TMOUT': '86400', 12:13:33 INFO - 'USER': 'cltbld', 12:13:33 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', 12:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:33 INFO - '_': '/tools/buildbot/bin/python'} 12:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:33 INFO - Downloading/unpacking psutil>=3.1.1 12:13:33 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 12:13:33 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 12:13:33 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 12:13:33 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 12:13:33 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 12:13:33 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 12:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:13:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:13:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:13:35 INFO - Installing collected packages: psutil 12:13:35 INFO - Running setup.py install for psutil 12:13:35 INFO - building 'psutil._psutil_linux' extension 12:13:35 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 12:13:35 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 12:13:35 INFO - building 'psutil._psutil_posix' extension 12:13:35 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 12:13:35 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 12:13:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:13:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:13:35 INFO - Successfully installed psutil 12:13:35 INFO - Cleaning up... 12:13:35 INFO - Return code: 0 12:13:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:13:35 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')]} 12:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:35 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')]} 12:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:35 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 0x7ff605a07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b0110>, '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 0x231c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c6c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', '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 12:13:35 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 12:13:35 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 12:13:35 INFO - Using env: {'DISPLAY': ':0', 12:13:35 INFO - 'HOME': '/home/cltbld', 12:13:35 INFO - 'LANG': 'en_US.UTF-8', 12:13:35 INFO - 'LANGUAGE': 'en_US:en', 12:13:35 INFO - 'LOGNAME': 'cltbld', 12:13:35 INFO - 'MAIL': '/var/mail/cltbld', 12:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:35 INFO - 'MOZ_NO_REMOTE': '1', 12:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:35 INFO - 'NO_EM_RESTART': '1', 12:13:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:35 INFO - 'PWD': '/builds/slave/test', 12:13:35 INFO - 'SHELL': '/bin/bash', 12:13:35 INFO - 'SHLVL': '1', 12:13:35 INFO - 'TERM': 'linux', 12:13:35 INFO - 'TMOUT': '86400', 12:13:35 INFO - 'USER': 'cltbld', 12:13:35 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', 12:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:35 INFO - '_': '/tools/buildbot/bin/python'} 12:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:13:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:13:38 INFO - Installing collected packages: mozsystemmonitor 12:13:38 INFO - Running setup.py install for mozsystemmonitor 12:13:38 INFO - Successfully installed mozsystemmonitor 12:13:38 INFO - Cleaning up... 12:13:38 INFO - Return code: 0 12:13:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:13:38 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')]} 12:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:38 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')]} 12:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:38 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 0x7ff605a07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b0110>, '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 0x231c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c6c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', '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 12:13:38 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 12:13:38 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 12:13:38 INFO - Using env: {'DISPLAY': ':0', 12:13:38 INFO - 'HOME': '/home/cltbld', 12:13:38 INFO - 'LANG': 'en_US.UTF-8', 12:13:38 INFO - 'LANGUAGE': 'en_US:en', 12:13:38 INFO - 'LOGNAME': 'cltbld', 12:13:38 INFO - 'MAIL': '/var/mail/cltbld', 12:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:38 INFO - 'MOZ_NO_REMOTE': '1', 12:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:38 INFO - 'NO_EM_RESTART': '1', 12:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:38 INFO - 'PWD': '/builds/slave/test', 12:13:38 INFO - 'SHELL': '/bin/bash', 12:13:38 INFO - 'SHLVL': '1', 12:13:38 INFO - 'TERM': 'linux', 12:13:38 INFO - 'TMOUT': '86400', 12:13:38 INFO - 'USER': 'cltbld', 12:13:38 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', 12:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:38 INFO - '_': '/tools/buildbot/bin/python'} 12:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:38 INFO - Downloading/unpacking jsonschema==2.5.1 12:13:38 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 12:13:38 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 12:13:38 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 12:13:38 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 12:13:38 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 12:13:38 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 12:13:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:13:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13:40 INFO - Downloading functools32-3.2.3-2.tar.gz 12:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:13:40 INFO - warning: no files found matching '*.txt' 12:13:40 INFO - no previously-included directories found matching 'build' 12:13:40 INFO - no previously-included directories found matching 'dist' 12:13:40 INFO - no previously-included directories found matching '.git*' 12:13:40 INFO - Installing collected packages: jsonschema, functools32 12:13:40 INFO - Running setup.py install for functools32 12:13:40 INFO - warning: no files found matching '*.txt' 12:13:40 INFO - no previously-included directories found matching 'build' 12:13:40 INFO - no previously-included directories found matching 'dist' 12:13:40 INFO - no previously-included directories found matching '.git*' 12:13:40 INFO - Successfully installed jsonschema functools32 12:13:40 INFO - Cleaning up... 12:13:40 INFO - Return code: 0 12:13:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:13: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')]} 12:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13: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')]} 12:13:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:40 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 0x7ff605a07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b0110>, '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 0x231c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c6c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', '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 12:13:40 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 12:13:40 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 12:13:40 INFO - Using env: {'DISPLAY': ':0', 12:13:40 INFO - 'HOME': '/home/cltbld', 12:13:40 INFO - 'LANG': 'en_US.UTF-8', 12:13:40 INFO - 'LANGUAGE': 'en_US:en', 12:13:40 INFO - 'LOGNAME': 'cltbld', 12:13:40 INFO - 'MAIL': '/var/mail/cltbld', 12:13:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:40 INFO - 'MOZ_NO_REMOTE': '1', 12:13:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:40 INFO - 'NO_EM_RESTART': '1', 12:13:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:40 INFO - 'PWD': '/builds/slave/test', 12:13:40 INFO - 'SHELL': '/bin/bash', 12:13:40 INFO - 'SHLVL': '1', 12:13:40 INFO - 'TERM': 'linux', 12:13:40 INFO - 'TMOUT': '86400', 12:13:40 INFO - 'USER': 'cltbld', 12:13:40 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', 12:13:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:40 INFO - '_': '/tools/buildbot/bin/python'} 12:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:41 INFO - Downloading/unpacking blobuploader==1.2.4 12:13:41 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 12:13:41 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 12:13:41 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 12:13:41 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 12:13:41 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 12:13:41 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 12:13:42 INFO - Downloading blobuploader-1.2.4.tar.gz 12:13:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:13:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:13:42 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 12:13:42 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 12:13:42 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 12:13:42 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 12:13:42 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 12:13:42 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 12:13:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:13:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:13:43 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 12:13:43 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 12:13:43 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 12:13:43 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 12:13:43 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 12:13:43 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 12:13:43 INFO - Downloading docopt-0.6.1.tar.gz 12:13:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:13:43 INFO - Installing collected packages: blobuploader, requests, docopt 12:13:43 INFO - Running setup.py install for blobuploader 12:13:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:13:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:13:43 INFO - Running setup.py install for requests 12:13:44 INFO - Running setup.py install for docopt 12:13:44 INFO - Successfully installed blobuploader requests docopt 12:13:44 INFO - Cleaning up... 12:13:44 INFO - Return code: 0 12:13:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:13: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')]} 12:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13: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')]} 12:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:44 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 0x7ff605a07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b0110>, '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 0x231c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c6c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', '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 12:13:44 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 12:13:44 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 12:13:44 INFO - Using env: {'DISPLAY': ':0', 12:13:44 INFO - 'HOME': '/home/cltbld', 12:13:44 INFO - 'LANG': 'en_US.UTF-8', 12:13:44 INFO - 'LANGUAGE': 'en_US:en', 12:13:44 INFO - 'LOGNAME': 'cltbld', 12:13:44 INFO - 'MAIL': '/var/mail/cltbld', 12:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:44 INFO - 'MOZ_NO_REMOTE': '1', 12:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:44 INFO - 'NO_EM_RESTART': '1', 12:13:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:44 INFO - 'PWD': '/builds/slave/test', 12:13:44 INFO - 'SHELL': '/bin/bash', 12:13:44 INFO - 'SHLVL': '1', 12:13:44 INFO - 'TERM': 'linux', 12:13:44 INFO - 'TMOUT': '86400', 12:13:44 INFO - 'USER': 'cltbld', 12:13:44 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', 12:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:44 INFO - '_': '/tools/buildbot/bin/python'} 12:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:13:44 INFO - Running setup.py (path:/tmp/pip-a0S0q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:13:44 INFO - Running setup.py (path:/tmp/pip-pvwQ5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:13:44 INFO - Running setup.py (path:/tmp/pip-Xq0P0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:13:44 INFO - Running setup.py (path:/tmp/pip-RaoPrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:13:44 INFO - Running setup.py (path:/tmp/pip-_owzNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:13:44 INFO - Running setup.py (path:/tmp/pip-xu63B0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:13:44 INFO - Running setup.py (path:/tmp/pip-PzspHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:13:45 INFO - Running setup.py (path:/tmp/pip-GhWZaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:13:45 INFO - Running setup.py (path:/tmp/pip-M1fMOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:13:45 INFO - Running setup.py (path:/tmp/pip-qfzNAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:13:45 INFO - Running setup.py (path:/tmp/pip-3tAUQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:13:45 INFO - Running setup.py (path:/tmp/pip-kn0RtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:13:45 INFO - Running setup.py (path:/tmp/pip-oyZcUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:13:45 INFO - Running setup.py (path:/tmp/pip-98njZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:45 INFO - Running setup.py (path:/tmp/pip-e6M15B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:13:45 INFO - Running setup.py (path:/tmp/pip-jR7xOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:13:45 INFO - Running setup.py (path:/tmp/pip-Bx16dS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:13:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:13:45 INFO - Running setup.py install for manifestparser 12:13:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:13:45 INFO - Running setup.py install for mozcrash 12:13:45 INFO - Running setup.py install for mozdebug 12:13:46 INFO - Running setup.py install for mozdevice 12:13:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:13:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:13:46 INFO - Running setup.py install for mozfile 12:13:46 INFO - Running setup.py install for mozhttpd 12:13:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:13:46 INFO - Running setup.py install for mozinfo 12:13:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:13:46 INFO - Running setup.py install for mozInstall 12:13:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:13:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:13:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:13:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:13:46 INFO - Running setup.py install for mozleak 12:13:46 INFO - Running setup.py install for mozlog 12:13:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:13:46 INFO - Running setup.py install for moznetwork 12:13:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:13:46 INFO - Running setup.py install for mozprocess 12:13:46 INFO - Running setup.py install for mozprofile 12:13:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:13:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:13:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:13:47 INFO - Running setup.py install for mozrunner 12:13:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:13:47 INFO - Running setup.py install for mozscreenshot 12:13:47 INFO - Running setup.py install for moztest 12:13:47 INFO - Running setup.py install for mozversion 12:13:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:13:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:13:47 INFO - Cleaning up... 12:13:47 INFO - Return code: 0 12:13:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:13:47 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')]} 12:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:47 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')]} 12:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:47 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 0x7ff605a07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b0110>, '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 0x231c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c6c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', '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 12:13:47 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 12:13:47 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 12:13:47 INFO - Using env: {'DISPLAY': ':0', 12:13:47 INFO - 'HOME': '/home/cltbld', 12:13:47 INFO - 'LANG': 'en_US.UTF-8', 12:13:47 INFO - 'LANGUAGE': 'en_US:en', 12:13:47 INFO - 'LOGNAME': 'cltbld', 12:13:47 INFO - 'MAIL': '/var/mail/cltbld', 12:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:47 INFO - 'MOZ_NO_REMOTE': '1', 12:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:47 INFO - 'NO_EM_RESTART': '1', 12:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:47 INFO - 'PWD': '/builds/slave/test', 12:13:47 INFO - 'SHELL': '/bin/bash', 12:13:47 INFO - 'SHLVL': '1', 12:13:47 INFO - 'TERM': 'linux', 12:13:47 INFO - 'TMOUT': '86400', 12:13:47 INFO - 'USER': 'cltbld', 12:13:47 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', 12:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:47 INFO - '_': '/tools/buildbot/bin/python'} 12:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:13:47 INFO - Running setup.py (path:/tmp/pip-6Qt8Ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:13:47 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)) 12:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:13:47 INFO - Running setup.py (path:/tmp/pip-gepmjq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:13:47 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)) 12:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:13:47 INFO - Running setup.py (path:/tmp/pip-H1Z447-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:13:47 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)) 12:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:13:48 INFO - Running setup.py (path:/tmp/pip-6BKKhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:13:48 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)) 12:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:13:48 INFO - Running setup.py (path:/tmp/pip-Un58IQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:13:48 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)) 12:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:13:48 INFO - Running setup.py (path:/tmp/pip-xQmbrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:13:48 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)) 12:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:13:48 INFO - Running setup.py (path:/tmp/pip-DKgiA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:13:48 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)) 12:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:13:48 INFO - Running setup.py (path:/tmp/pip-NZlZxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:13:48 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)) 12:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:13:48 INFO - Running setup.py (path:/tmp/pip-bubG2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:13:48 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)) 12:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:13:48 INFO - Running setup.py (path:/tmp/pip-4q8fVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:13:48 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)) 12:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:13:48 INFO - Running setup.py (path:/tmp/pip-j_B_Ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:13:48 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)) 12:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:13:48 INFO - Running setup.py (path:/tmp/pip-wJWDkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:13:48 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)) 12:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:13:48 INFO - Running setup.py (path:/tmp/pip-g5IS9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:13:48 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)) 12:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:13:48 INFO - Running setup.py (path:/tmp/pip-gtpxS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:13:48 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)) 12:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:48 INFO - Running setup.py (path:/tmp/pip-jgduqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:48 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)) 12:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:13:48 INFO - Running setup.py (path:/tmp/pip-WO0aps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:13:48 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)) 12:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:13:48 INFO - Running setup.py (path:/tmp/pip-EJcyb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:13:49 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)) 12:13:49 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)) 12:13:49 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)) 12:13:49 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)) 12:13:49 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)) 12:13:49 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)) 12:13:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:50 INFO - Downloading blessings-1.6.tar.gz 12:13:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:13:50 INFO - Installing collected packages: blessings 12:13:50 INFO - Running setup.py install for blessings 12:13:51 INFO - Successfully installed blessings 12:13:51 INFO - Cleaning up... 12:13:51 INFO - Return code: 0 12:13:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:13:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:13:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:13:51 INFO - Reading from file tmpfile_stdout 12:13:51 INFO - Current package versions: 12:13:51 INFO - argparse == 1.2.1 12:13:51 INFO - blessings == 1.6 12:13:51 INFO - blobuploader == 1.2.4 12:13:51 INFO - docopt == 0.6.1 12:13:51 INFO - functools32 == 3.2.3-2 12:13:51 INFO - jsonschema == 2.5.1 12:13:51 INFO - manifestparser == 1.1 12:13:51 INFO - mozInstall == 1.12 12:13:51 INFO - mozcrash == 0.17 12:13:51 INFO - mozdebug == 0.1 12:13:51 INFO - mozdevice == 0.48 12:13:51 INFO - mozfile == 1.2 12:13:51 INFO - mozhttpd == 0.7 12:13:51 INFO - mozinfo == 0.9 12:13:51 INFO - mozleak == 0.1 12:13:51 INFO - mozlog == 3.2 12:13:51 INFO - moznetwork == 0.27 12:13:51 INFO - mozprocess == 0.22 12:13:51 INFO - mozprofile == 0.28 12:13:51 INFO - mozrunner == 6.11 12:13:51 INFO - mozscreenshot == 0.1 12:13:51 INFO - mozsystemmonitor == 0.3 12:13:51 INFO - moztest == 0.7 12:13:51 INFO - mozversion == 1.4 12:13:51 INFO - psutil == 3.1.1 12:13:51 INFO - requests == 1.2.3 12:13:51 INFO - wsgiref == 0.1.2 12:13:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:51 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 0x7ff605a07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b0110>, '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 0x231c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c6c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', '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 12:13:51 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 12:13:51 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 12:13:51 INFO - Using env: {'DISPLAY': ':0', 12:13:51 INFO - 'HOME': '/home/cltbld', 12:13:51 INFO - 'LANG': 'en_US.UTF-8', 12:13:51 INFO - 'LANGUAGE': 'en_US:en', 12:13:51 INFO - 'LOGNAME': 'cltbld', 12:13:51 INFO - 'MAIL': '/var/mail/cltbld', 12:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:51 INFO - 'MOZ_NO_REMOTE': '1', 12:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:51 INFO - 'NO_EM_RESTART': '1', 12:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:51 INFO - 'PWD': '/builds/slave/test', 12:13:51 INFO - 'SHELL': '/bin/bash', 12:13:51 INFO - 'SHLVL': '1', 12:13:51 INFO - 'TERM': 'linux', 12:13:51 INFO - 'TMOUT': '86400', 12:13:51 INFO - 'USER': 'cltbld', 12:13:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', 12:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:51 INFO - '_': '/tools/buildbot/bin/python'} 12:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:51 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)) 12:13:51 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)) 12:13:51 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)) 12:13:51 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)) 12:13:51 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)) 12:13:51 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)) 12:13:51 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)) 12:13:51 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)) 12:13:51 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)) 12:13:51 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)) 12:13:51 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)) 12:13:51 INFO - Cleaning up... 12:13:51 INFO - Return code: 0 12:13:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:51 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 0x7ff605a07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b0110>, '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 0x231c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c6c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', '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 12:13:51 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 12:13:51 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 12:13:51 INFO - Using env: {'DISPLAY': ':0', 12:13:51 INFO - 'HOME': '/home/cltbld', 12:13:51 INFO - 'LANG': 'en_US.UTF-8', 12:13:51 INFO - 'LANGUAGE': 'en_US:en', 12:13:51 INFO - 'LOGNAME': 'cltbld', 12:13:51 INFO - 'MAIL': '/var/mail/cltbld', 12:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:51 INFO - 'MOZ_NO_REMOTE': '1', 12:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:51 INFO - 'NO_EM_RESTART': '1', 12:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:51 INFO - 'PWD': '/builds/slave/test', 12:13:51 INFO - 'SHELL': '/bin/bash', 12:13:51 INFO - 'SHLVL': '1', 12:13:51 INFO - 'TERM': 'linux', 12:13:51 INFO - 'TMOUT': '86400', 12:13:51 INFO - 'USER': 'cltbld', 12:13:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', 12:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:51 INFO - '_': '/tools/buildbot/bin/python'} 12:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:13:51 INFO - Cleaning up... 12:13:51 INFO - Return code: 0 12:13:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:51 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 0x7ff605a07f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b0110>, '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 0x231c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c6c0>, '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': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', '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 12:13:51 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 12:13:51 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 12:13:51 INFO - Using env: {'DISPLAY': ':0', 12:13:51 INFO - 'HOME': '/home/cltbld', 12:13:51 INFO - 'LANG': 'en_US.UTF-8', 12:13:51 INFO - 'LANGUAGE': 'en_US:en', 12:13:51 INFO - 'LOGNAME': 'cltbld', 12:13:51 INFO - 'MAIL': '/var/mail/cltbld', 12:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:51 INFO - 'MOZ_NO_REMOTE': '1', 12:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:51 INFO - 'NO_EM_RESTART': '1', 12:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:51 INFO - 'PWD': '/builds/slave/test', 12:13:51 INFO - 'SHELL': '/bin/bash', 12:13:51 INFO - 'SHLVL': '1', 12:13:51 INFO - 'TERM': 'linux', 12:13:51 INFO - 'TMOUT': '86400', 12:13:51 INFO - 'USER': 'cltbld', 12:13:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', 12:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:51 INFO - '_': '/tools/buildbot/bin/python'} 12:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:52 INFO - Downloading/unpacking flake8 12:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:13:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:13:53 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 12:13:53 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 12:13:53 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 12:13:53 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 12:13:53 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 12:13:53 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 12:13:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:13:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:13:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:13:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:13:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:13:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:13:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:13:54 INFO - no previously-included directories found matching 'docs/_build' 12:13:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:13:54 INFO - Running setup.py install for pep8 12:13:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:13:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:13:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:13:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:13:54 INFO - no previously-included directories found matching 'docs/_build' 12:13:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:13:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:13:54 INFO - Cleaning up... 12:13:54 INFO - Return code: 0 12:13:54 INFO - Running post-action listener: _resource_record_post_action 12:13:54 INFO - Running post-action listener: _start_resource_monitoring 12:13:54 INFO - Starting resource monitoring. 12:13:54 INFO - ##### 12:13:54 INFO - ##### Finished create-virtualenv step (success) 12:13:54 INFO - ##### 12:13:54 INFO - ##### 12:13:54 INFO - ##### Running install step. 12:13:54 INFO - ##### 12:13:54 INFO - Running pre-action listener: _resource_record_pre_action 12:13:54 INFO - Running main action method: install 12:13:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:13:55 INFO - Reading from file tmpfile_stdout 12:13:55 INFO - Detecting whether we're running mozinstall >=1.0... 12:13:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:13:55 INFO - Reading from file tmpfile_stdout 12:13:55 INFO - Output received: 12:13:55 INFO - Usage: mozinstall [options] installer 12:13:55 INFO - Options: 12:13:55 INFO - -h, --help show this help message and exit 12:13:55 INFO - -d DEST, --destination=DEST 12:13:55 INFO - Directory to install application into. [default: 12:13:55 INFO - "/builds/slave/test"] 12:13:55 INFO - --app=APP Application being installed. [default: firefox] 12:13:55 INFO - mkdir: /builds/slave/test/build/application 12:13:55 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'] 12:13:55 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 12:14:12 INFO - Reading from file tmpfile_stdout 12:14:12 INFO - Output received: 12:14:12 INFO - /builds/slave/test/build/application/firefox/firefox 12:14:12 INFO - Running post-action listener: _resource_record_post_action 12:14:12 INFO - ##### 12:14:12 INFO - ##### Finished install step (success) 12:14:12 INFO - ##### 12:14:12 INFO - ##### 12:14:12 INFO - ##### Running run-tests step. 12:14:12 INFO - ##### 12:14:12 INFO - Running pre-action listener: _resource_record_pre_action 12:14:12 INFO - Running main action method: run_tests 12:14:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:14:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:14:12 INFO - Python 2.7.3 12:14:12 INFO - Return code: 0 12:14:12 INFO - grabbing minidump binary from tooltool 12:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:14:12 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 0x23b0110>, '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 0x231c230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231c6c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:14:12 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 12:14:12 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 12:14:12 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 12:14:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:14:12 INFO - Return code: 0 12:14:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:14:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:14:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:14:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:14:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:14:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:14:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:14:13 INFO - Return code: 0 12:14:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 12:14:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 12:14:13 INFO - Using env: {'DISPLAY': ':0', 12:14:13 INFO - 'HOME': '/home/cltbld', 12:14:13 INFO - 'LANG': 'en_US.UTF-8', 12:14:13 INFO - 'LANGUAGE': 'en_US:en', 12:14:13 INFO - 'LOGNAME': 'cltbld', 12:14:13 INFO - 'MAIL': '/var/mail/cltbld', 12:14:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:14:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:13 INFO - 'MOZ_NO_REMOTE': '1', 12:14:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:14:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:13 INFO - 'NO_EM_RESTART': '1', 12:14:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:13 INFO - 'PWD': '/builds/slave/test', 12:14:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:14:13 INFO - 'SHELL': '/bin/bash', 12:14:13 INFO - 'SHLVL': '1', 12:14:13 INFO - 'TERM': 'linux', 12:14:13 INFO - 'TMOUT': '86400', 12:14:13 INFO - 'USER': 'cltbld', 12:14:13 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033', 12:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:13 INFO - '_': '/tools/buildbot/bin/python'} 12:14:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 12:14:13 INFO - mozversion application_buildid: 20160616093021 12:14:13 INFO - mozversion application_changeset: ea9d62d5f09bbcafdd18290a01c07629e40d69b8 12:14:13 INFO - mozversion application_display_name: Nightly 12:14:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:14:13 INFO - mozversion application_name: Firefox 12:14:13 INFO - mozversion application_remotingname: firefox 12:14:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:14:13 INFO - mozversion application_vendor: Mozilla 12:14:13 INFO - mozversion application_version: 50.0a1 12:14:13 INFO - mozversion platform_buildid: 20160616093021 12:14:13 INFO - mozversion platform_changeset: ea9d62d5f09bbcafdd18290a01c07629e40d69b8 12:14:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:14:13 INFO - mozversion platform_version: 50.0a1 12:14:13 INFO - using testdate: 1466104453 12:14:13 INFO - actual date: 1466104453 12:14:13 INFO - starting webserver on 'localhost:55027' 12:14:13 INFO - SUITE-START | Running 2 tests 12:14:13 INFO - TEST-START | dromaeo_css 12:14:13 INFO - operating with platform_type : linux_ 12:14:13 INFO - Initialising browser for dromaeo_css test... 12:14:13 INFO - TEST-INFO | started process 19877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf9Nvsu/profile http://localhost:55027/getInfo.html) 12:14:18 INFO - PROCESS | 19877 | __metrics Screen width/height:1600/1200 12:14:18 INFO - PROCESS | 19877 | colorDepth:24 12:14:18 INFO - PROCESS | 19877 | Browser inner width/height: 1024/697 12:14:18 INFO - PROCESS | 19877 | __metrics 12:14:19 ERROR - PROCESS | 19877 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 12:14:20 INFO - TEST-INFO | 19877: exit 0 12:14:20 INFO - Browser initialized. 12:14:20 INFO - Running cycle 1/1 for dromaeo_css test... 12:14:20 INFO - TEST-INFO | started process 19998 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpf9Nvsu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:14:32 INFO - PROCESS | 19998 | RSS: Main: 185270272 12:14:32 INFO - PROCESS | 19998 | 12:15:22 INFO - PROCESS | 19998 | 1466104522138 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] 12:17:30 INFO - PROCESS | 19998 | Cycle 1(1): loaded http://localhost:55027/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55027/tests/dromaeo/cssquery-ext.html) 12:17:31 INFO - PROCESS | 19998 | RSS: Main: 188653568 12:17:31 INFO - PROCESS | 19998 | 12:20:33 INFO - PROCESS | 19998 | Cycle 1(1): loaded http://localhost:55027/tests/dromaeo/cssquery-ext.html (next: http://localhost:55027/tests/dromaeo/cssquery-jquery.html) 12:20:33 INFO - PROCESS | 19998 | RSS: Main: 187244544 12:20:33 INFO - PROCESS | 19998 | 12:23:35 INFO - PROCESS | 19998 | Cycle 1(1): loaded http://localhost:55027/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55027/tests/dromaeo/cssquery-mootools.html) 12:23:36 INFO - PROCESS | 19998 | RSS: Main: 188477440 12:23:36 INFO - PROCESS | 19998 | 12:26:38 INFO - PROCESS | 19998 | Cycle 1(1): loaded http://localhost:55027/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55027/tests/dromaeo/cssquery-prototype.html) 12:26:38 INFO - PROCESS | 19998 | RSS: Main: 186228736 12:26:38 INFO - PROCESS | 19998 | 12:29:41 INFO - PROCESS | 19998 | Cycle 1(1): loaded http://localhost:55027/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55027/tests/dromaeo/cssquery-yui.html) 12:29:41 INFO - PROCESS | 19998 | RSS: Main: 188686336 12:29:41 INFO - PROCESS | 19998 | 12:32:44 INFO - PROCESS | 19998 | Cycle 1(1): loaded http://localhost:55027/tests/dromaeo/cssquery-yui.html (next: http://localhost:55027/tests/dromaeo/cssquery-dojo.html) 12:32:44 INFO - PROCESS | 19998 | RSS: Main: 189542400 12:32:44 INFO - PROCESS | 19998 | 12:32:44 INFO - PROCESS | 19998 | __start_tp_report 12:32:44 INFO - PROCESS | 19998 | _x_x_mozilla_page_load 12:32:44 INFO - PROCESS | 19998 | _x_x_mozilla_page_load_details 12:32:44 INFO - PROCESS | 19998 | |i|pagename|runs| 12:32:44 INFO - PROCESS | 19998 | |0;dojo.html;3065.141760307114;3086.5061590145583;3098.333858220483;3105.658377578466;3108.300632357721;5310.76101575429;5366.490183432573;5380.171616636674;5383.246345511627;5433.185022246665;5232.73836308184;5297.496737809902;5334.653247538917;5357.464253574641;5475.616706830513;4815.133276010308;4849.878753031185;4929.827456039039;4999.900001999958;5026.773795179208;392.5433751932978;4785.401824771903;4830.178869592178;4920.655554111214;4967.652264341497;4845.248986407095;4849.127157111719;4887.780049897763;4908.9263661045115;4951.727654978975;4891.486393928657;4914.36113305268;4921.458639549646;4923.483034281385;4964;4786.976065119687;4905.656604037718;4916.139675556763;4951.554360107608;4957.702537847741;5420.593455490854;5463.399026107125;5465.535429488498;5472;5474.644148130359;5497.752601132958;5723.828285151452;5866.120081987693;5913.2608423947;5941.732622032019;5712.200291959129;5744;5784.971075144597;5817.505512031483;5840.15317778924;5362.570994320445;5402.8919421611745;5407.297051383334;5409.29679141709;5445.945540544544;5711.685857277889;5788.739506722208;5910.674912879833;5949.732262048218;5961.642301461926;5623.156526520973;5675.262215911987;5675.460831221028;5688.175214593944;5720.942790572041;5754.395788442237;5757.625754325955;5757.65454072757;5759.539236861041;5769.769209231584;5614.522765564891;5698.686572238566;5716.342620598684;5727.684977326204;5753.741081651336;5700.030994730906;5711.600187986801;5711.971440142773;5716.942830571724;5719.428057194247;4414.936271311422;4424.292113261863;4440.977795111068;4465;4500.977495112504;3942.783146926889;3953.0710283083454;3981.343078392091;3983.24318379507;4000.139969906484;5366.517013468729;5422.40353561108;5437.021336159451;5440.782368705208;5462;5745.741441635137;5763.164341170507;5769.134629805562;5769.740361683735;5774.220480235199;5386.946130538723;5484.670919744828;5516.889662206733;5531.197976293415;5558.138488534284;4815.807367705253;4823.059503396804;4823.710577365369;4839.201531747292;4874.341963834908;5762.279715035621;5965.28416590012;5990.400959904062;5997.850053748604;6012.308584512837;5795.797147099831;5815.505682017076;5818.418158184148;5889.970550147222;5901.940980590139;6045.032794752994;6050.878982420415;6053.757849685963;6062.666553339609;6063.939360606338;5503.091989821634;5667.4332566743;5798.333191682842;5799.8550036249435;5803.216565763568;5784.421557844182;5830;5839.620424672383;5855.151003104611;5905.704714764331;5695.629784064023;5717.056685646821;5722.370539240597;5724.942750572608;5733.197352370755;5439.537639300704;5576.470235327637;5607.243022192115;5701.087825947829;5709.600327977002;5539.972300138474;5552.583556233218;5554.833354999357;5582.078956972054;5610.242617246619;5624.212610234652;5637.069883469182;5680.971595142163;5691.715414229355;5694.345150307768;5458.5087342139395;5559.44405559457;5619.7752089917585;5677.205191273308;5711.571632127524 12:32:44 INFO - PROCESS | 19998 | |1;ext.html;560.2744445942504;603.1224568253191;609.6037575575878;611.2970084402938;648.9772857949966;36810.63189368106;40750.592494075085;41074;41154;41436;41422;41857.58142418575;42352.788236058776;42367.57632423683;42446;8746.781330466742;8866.601002954883;8880.777980550505;8907.910920890772;8914.197722205;8739.563021848882;8784.956075219616;8811.383203175781;8836;8860.20258176764;8776.297896168291;8803.559822008907;8830.955845220766;8832.293416526663;8834.425762325429;8735.43219690718;8741;8743.43167694101;8775.868361974575;8812.603432845537;8668.826623467558;8743.650253989832;8766.868496972551;8786.253168480687;8786.384953053288;39064.60935390638;39256.60743392558;39512.80243598792;39644.20711585781;39833.40249896254;2937.6474823021163;3380.5098260752297;3484.198634314122;3554.4668299755244;4076.9796151019054;28088;30302;30324.54513182304;30610.38779224425;30963.22591935197;4190.916181676349;4225.894352641209;4232.132412855388;4269.743815371087;4276.166147601219;287732;288155.55922220467;289925;290134;290626.9999999979;32494.675053249637;33122.66877331196;33127.66872331294;33138.17154571155;33156;33588.49617255743;35057.82471087679;35537.64462355343;35594.466083008774;37280.62719372771;16127.274272657758;16174.514764557081;16258.918705406633;16284.67430651404;16291.348346066261;11406.657800266004;11507.654770356903;11522.481488333045;11523.48144333507;11543.134264930164;18980.81019189818;18989.240430382906;19087;19098.33155839567;19181.80818191828;6791.2869148739655;6846.085453691807;7027.262137475594;7106.786796396116;7229.313215244649;942.6606421688186;1025.6769117727893;1040.0379648824808;1053.2837670384058;1094.8084085285043;31609.84195079056;31742.06573286086;31976.36047279088;32309.67690323114;32473.837630811693;1100.8148824583195;1131.8698349689726;1155.4049664422828;1166.2419427372276;1235.14774805384;16455.341786328412;16892;17022.744658830128;17036.65926681484;17085.914570427067;535167;540911;543070;544165;544996;55815;57201.71399142977;57397;57504.424955749906;57553.712231439415;1300.6423233610644;1336.224989506084;1347.8113064170827;1357.0500649545359;1368.609946165358;30076.398472030876;30749.53875691911;31103;31184.376312474076;31674.683253168096;50106.74946625243;50315.496845031084;50479.747601261755;50743;50914.490855090975;415850;416483;416788;418763;418992;26965.595516067668;27213.05410715475;27625.723742762315;27635.170944871687;27684;47577;47831.5216847827;47895;48635.5136448631;49002;39323.803380982914;40046.09076488624;40290.798546007085;40984.385234220914;41258.587414126676;39597.22819402614;40027.79986100051;40059;40790.388144178454;40913.59086409217;37361.25277494489;40320.19359612733;40830.59169408268;41132;41398.1720365597;33214.501782473766;38568;38590.4211436823;38622.80688596539;38755.6124438752;27509.31226719348;27528.174154775388;27549.862250688617;27563.586546201423;27765.167044988684 12:32:44 INFO - PROCESS | 19998 | |2;jquery.html;347.473577530042;354.59930278784975;365.62158166297877;370.20590832663953;375.24762850484774;17800.64398712025;18489.7226541602;19171.13729882155;19490.41528754136;19518.21927122917;17560.736588951175;17592.296308147692;18447.907760461214;18448.262069517237;18462;5475.616706830533;5573.8606534836545;5602.747876345554;5661.518770904458;5677.630953987978;5452.945470545304;5512.228288039678;5517.034518959186;5517.972410137943;5518.227448157261;5313.73431328434;5474.452554744514;5479.890402191953;5488.231647569343;5495.725213739317;5453.700046497441;5491.862703432406;5514.558835293167;5520.475554822286;5524.14375771756;4692.8122875084955;4845.733484658343;4864.513548645107;4871.902561948741;4872.123017856784;20248.595028099502;21003.789962100338;21241.150353985977;21242.150313987422;21736.239231626816;2390.4501964548076;2699.5545734953707;3066.23344163959;3070.6468756093113;3076.7077127672837;13915.30423478822;13934.790978135336;14277.785833212407;14532.491362802357;14556.563303100924;1942.689169732836;1949.2495389275089;1965.7837637859825;2040.3470889315424;2050;75842.24157758406;77504.61247693782;77677.61161194158;79947.20052799514;80016.59991700121;9485.336026478219;9700.223982081558;9905.356151850106;10019.198464122852;10049.397036177852;13523.797143042862;13585.252811095286;13645.38595763193;13659.658508537366;13667.658308542366;7683.346915512244;7764;7835.882461763078;7886.5662388568035;7991.680332786624;7828.765137045898;7871.252231038042;7943.205679432011;7987.121416644164;8042.356611471068;6189.288231853395;6283.905741413882;6289.371062893674;6315.715792789336;6488.837779055467;1797.379903933141;1827.8446332061658;1836.5133239691493;1840.3098837935775;1851.9629607407776;909.7816524034316;975.7997662874703;992.1170158558745;1034.5499707627207;1035.6789395287335;18432.81567184338;18834.52913677169;19265.614687706166;19389;19779.20883164686;967.6564819489121;996.6561536269975;1023.1916785739182;1038.159091136167;1066.626680661762;10322;10983.450827458595;11072.114230861513;11193.608223712132;11212.887871121347;428869;429543.78421618504;438772;450822;459486;73824.63087684527;77650;81276.59361703154;84129.57935210408;86351.56824215839;972.6644307713827;979.490664854286;1004.9397036177706;1006.1296978113879;1027.209049032256;17350.652986940444;17553;17617.559561011076;17725.468235952943;17749.201285941905;39045.80477097596;39582.20835583215;39913.80043099882;40126.59873401229;40735.796321018206;56480;56820;57151.714241428526;57867.42132578621;58622.7068864653;8080.878786818085;8260.876086858822;8368.330533557422;8391.748247552583;8407.075221725727;9477.52612369365;13417.731645366843;13594.388252528463;13634.93182534081;13973.371198296305;11395.772084558428;11470.942645286721;11602.47788849487;11629;11879.524819007489;11079.667609971713;11534.250273732181;12021.819672704742;12135.271883687006;12180.330081845583;11648.475818588015;12037.638870833889;12051.156419050581;12221.45921038217;12351.69120771988;8139.186081391814;8214.219649133323;8304.626291816761;8466.703665371682;8656.91343086561;8173.18268173178;11177.385243811668;11914.702132446411;11961.760764784829;12072.75854482923 12:32:44 INFO - PROCESS | 19998 | |3;mootools.html;1404.59968908861;1440.4526280013592;1445.4073829729814;1460.3793387810179;1470.6838029823589;7550.169481357047;8541;8658.393912426132;9163.083691630842;9263.21262692671;8829.117088291168;9091.272698184146;9124.635014599424;9151.77120571986;9159.313051521129;2268.4669102760836;2271.852329598579;2278.9202377916777;2291.106468477287;2302.3093072078395;2288.382136823057;2289.839711220215;2291.2438895164637;2308.722953245613;2324.32594547581;2260.062074239189;2285.2344464604294;2288.3592594073684;2301.9309420717404;2338.5790557699693;2232.6762619420256;2281.4182383492184;2284.1776960294364;2288.164819840763;2292.1862738727764;2255.4023183856293;2258.3789457899043;2258.9322320330416;2272.1706577099403;2278.1570818796986;9259.861102083474;9276.953615231949;9296.349255552113;9321.254299656011;9333.486658233862;5014.323066386028;5146.614003949719;5149.124648809711;5282.709450980195;5325.041492531343;3131.389379071082;3210.11721776511;3392.23674673199;3420.572428446444;3434.227298857762;1135.2280449294476;1142.994285028578;1147.3804145761362;1151.4857961780233;1153.9076873850072;12700.80948785769;12722.427490762939;12741.554045608453;12824.358782060859;12889.742205155844;4464.687471876938;4529.230030894756;4604.263317869192;4629.305604159335;4653.418322709661;10757.623483178051;10786.622468213733;10824.188185885932;10838.837417438745;10857.077148442313;5210.114280572312;5215.348081489814;5244.711540865289;5249.973750131225;5276.630635855453;4037.253108174997;4661.207594708908;4697.459792123949;4793.760311984387;4846.636502262274;3871.806409679561;3883.66988805949;3896.844126234919;3971.1660551283976;3983.7410568312966;1207.5592408770735;1217.5677634439646;1226.7178548933616;1237.7586370657634;1239.535174309634;987.6691308411763;1011.1758916483043;1024.52871679027;1025.5128813813378;1028.7068185567077;6235;6419.775307864203;6436.806895793134;6453.419192272718;6681.365270299314;977.9755506112261;1002.744300203458;1016.7712264740522;1021.5300961557618;1028.783955369366;4186.581341865789;4331;4366.8034938427845;4394.36281739146;4444.2444784386735;11252.774944501065;11425.31448113116;11608.30350178992;11661.708457288636;11722.296662200295;11469.197156198987;11508.94245528767;11614.70963225926;11627.069834413227;11633.825492617618;8054.194580541899;8295.668173273001;8300.626471808782;8491.15088491146;8661.13388661129;6010.158577799024;6242.750289988349;6315.08431277453;6330.936690633035;6336.7148478319505;9764.267679923893;10025.248106391904;10281;10289.485525723834;10336.483175841327;9944.15474684631;10163.18694504423;10241.795164096528;10251.84622230682;10291.382517048702;7536;8332.250097491013;8580.14198580137;8598.484090954562;8743.431676940978;8700.434471759316;8734.56327183651;8876.156765107304;8938.10618938101;8954.104589540993;7784.338331241682;7945.801354966172;7964.2433968772875;8025.9197408025175;8111.716089936824;7632.427567932538;7969.800754981172;8007.1592482788465;8009.479383840032;8093.878591821245;7348.081489813773;7379.852402952019;7380.630968451448;7469.290417410337;7485.70057197706;5177.275181474672;5229.712365819916;5237.266782650356;5289.814856480005;5332.893342133058;5508.614396992172;5592.462072929977;5651.406602306699;5699.857503562444;5721.084626459747 12:32:44 INFO - PROCESS | 19998 | |4;prototype.html;311.82226131105267;315.08782075890315;315.17895881229396;316.09123769163654;316.80041573808495;5505.862353441161;5512.751926163322;5553.861458401028;5585.58108141889;5619.4099619539975;5475.7823081651895;5477.890442191154;5477.972610136953;5507.889842203163;5513.807016754415;4077.3690523790497;4157.210130075291;4271.530131685512;4274.508431530383;4284.314509678452;4253.255680255958;4269.274223382033;4279.72181808183;4297.882550536851;4298.46269216348;4227.365895115742;4257.978710106445;4258.936115958263;4267.359896015591;4327.459067616548;4067.4712287402594;4246.5541118182455;4255.553166917491;4262.701610887239;4337.110892267094;3696.907577310562;3698.7965661888584;3718.0480247869814;3741.7754934703735;3748.83130259139;5486.670799751988;5513.8345849624175;5515.862103447446;5520.972395137998;5530.170474428868;4818.265424447196;4849.684770489942;4887.682300650446;4901.950980490221;4949.975250123726;5752.252207213078;5761.395053519362;5839.481734748953;5841.649501029951;5859.209006784072;4067.247559201557;4089.89775255621;4119.97940010301;4143.8964025899295;4152.1072969311745;5914.674692891889;6075.483583895374;6082.148499210114;6087.634741915499;6174.907376389313;4111.540403156896;4134.214499245134;4136.710430269853;4146.885088604833;4150.501939767187;4181.560936101666;4197.5172855122055;4197.748135111842;4200.474940632421;4203.6637069034405;4643.908681459854;4808.61531077513;4822.927656085161;4890.046440943982;4892.804287828518;5825.126231065374;5835.716142448655;5842.883142337129;5860.267466566679;5878.853028674232;1437.23826372023;1463.1659953826218;1463.1733070814955;1463.2464280895347;1465.296657604356;886.663068034143;909.5725009245645;916.8808054952814;923.4736200365861;940.872982147415;5494.478024587658;5515.393306736256;5551.3893471718075;5559.19391688211;5562.916556251659;5829.679367634821;5945.513621594601;5953.077273022688;5973.581849270597;5990.341062483123;5350.545203657655;5470.56235501159;5541.168824676331;5565.886822635489;5614.887702246014;3126.7498600111935;3149;3191.4414977378865;3206.4709322961917;3208.2300247940793;5865.853353666107;6021.916055110122;6058.545609079337;6122.663253521099;6132.877342453126;6104.816855494342;6116.694165291718;6122.846928826815;6148.354422785543;6159.784407545714;6123.387661233841;6179.938200618026;6202.193714817045;6236.565589914345;6240.469560087353;5739.368669446441;5950.375210602824;5981.401859813984;5990.341062483036;6013.759449621966;5945.167676525203;5970.522358211246;5971.8354920790025;5978.192943952685;6006.189164462741;5925.585209035326;6019.398060193946;6058.757649693963;6169.753209871555;6186.164867742978;4130.401091841726;4153.584641535822;4160.292750232528;4162.646175075031;4166;5956.344802071682;6001.789937352171;6007.249093863267;6033.9698301508215;6050.213472248755;5604.551635869039;5790.957627626899;5814.5463634091475;5827.8834423310445;5835.8832823342445;5801.970990145022;5822.505087067478;5823.1847541343395;5848.766049357978;5864;5643.363424606982;5718.485336319751;5722.856928576819;5779.36426993022;5784.392638773036;5905.881882362414;5938.317093534299;5947.78070495556;5952;5982.760689572368;5522;5774.9133762994425;5777.277840269966;5792.304923409218;5825.446582574648 12:32:44 INFO - PROCESS | 19998 | |5;yui.html;704.1936982155429;714.4891402647106;727.614364386875;743.8437928035113;773.8645736996026;14704.999999999987;15675;15951.042937423763;16093.919530402332;16130.596735081628;14208.715825683481;14571;14582.343794529244;14596.343164557595;14617.342219600117;761.9733309334174;763.0995425398042;776.4060493722307;782.1396463889732;790.7509134622604;771.7723271634882;773.8374941262314;775.499802627305;775.7207405334075;781.0510230070463;820.0610301205116;824.68661908475;825.6243409248807;825.9793505162389;826.4917075998247;815.6166601697192;821.0844907927648;823.19738255201;823.5923218007065;825.2325337436212;600.5585894367637;600.7596961215505;602.16299343912;603.9124326972565;604.4318340759672;15637.530874073796;15698.52904412858;15771.13258770767;15784.447544335893;15824.683506329924;13033.804492932613;13564.253966031863;13797.724045519133;13879.861201387957;13928.164310141323;12018.51925922962;12100.576479823252;12302.630921072292;12334.75330493394;12388.070894682935;3848.7690738555775;3864.632859878307;3877.263319969225;3973.642372186488;4026.577209393001;73928.63035684841;74964.99999999946;75692.62153689197;77965;77976.22023779746;11196.496157672924;11405.030572401272;11418.657440276806;11476.196666233283;11504;20642.896785515975;20644.69032964507;20658.483537911674;20663.276785312744;20682;8433.325333973267;8589.78525536854;8624.827503449897;8844.027157012724;8848.734537963872;4764.142454358249;4898.21628539432;4967.602591792648;5000.949990500048;5123.205903085028;3549.5385599872366;3613.6928361089604;3623.438367053111;3628.510151129564;3641.7814931104217;594.0821430889287;608.7899674612252;611.6635850282327;616.8735409241095;634.9841253968688;644.7002144002968;674.3795707948601;738.7266711316847;745.1244787374812;749.8875168724735;9446.716598502057;9851.901480985242;10085;10114.140298074599;10160.237982151368;589.1869220475716;603.607655024229;741.7292688168887;750.2609929219714;752.1162633905249;4676.368690226844;4894.8042078317185;4931.654784165145;4931.926021109686;4974.656842652464;110694;110817.44591277154;112405.43797280961;113509.43245283721;115620.42189788997;91492;93064;93116.53441732748;93399.53300233591;93426;79231;80274.59862700765;80291.59854200808;80322;80513;9220.124088211878;9302.906970930475;9349.626014959598;9363.297752668714;9423.293253005915;36335.63664363428;44419;49630.503694964034;50436.495635044645;51675.74162129165;69541.3045869555;73494.26505735089;76294.61852690701;76546.23453765392;76964;10932.836007459735;11138.610148644759;11147.186147186108;11527.711807204552;12579.119461637598;12822.102452828212;13615.25116118623;13877.444902203799;14001.081816061462;14104.576862694135;12248.816267755812;12785.296808675612;12902.032347573782;12966.546170883974;13009.674758131123;12369.134160609032;12774.297413642338;12793.36033198355;12903.806442903551;13415.932920335335;12698.873011269769;12938.676533086747;12990.155639883755;13046.54337098197;13085.542006029744;10423.270371073952;10538.093073668717;10588.682339529827;11056.281341712764;11162.274452160584;10939.890601093886;11078.78111485333;11169.944150279522;11316.434178290889;11345.602903898323 12:32:44 INFO - PROCESS | 19998 | __end_tp_report 12:32:44 INFO - PROCESS | 19998 | __start_cc_report 12:32:44 INFO - PROCESS | 19998 | _x_x_mozilla_cycle_collect,348 12:32:44 INFO - PROCESS | 19998 | __end_cc_report 12:32:44 INFO - PROCESS | 19998 | __startTimestamp1466105564541__endTimestamp 12:32:44 INFO - PROCESS | 19998 | 12:32:44 INFO - PROCESS | 19998 | ------- Summary: start ------- 12:32:44 INFO - PROCESS | 19998 | Number of tests: 6 12:32:44 INFO - PROCESS | 19998 | 12:32:44 INFO - PROCESS | 19998 | [#0] dojo.html Cycles:165 Average:5335.86 Median:5559.44 stddev:726.80 (13.1%) stddev-sans-first:706.86 12:32:44 INFO - PROCESS | 19998 | Values: 3065.1 3086.5 3098.3 3105.7 3108.3 5310.8 5366.5 5380.2 5383.2 5433.2 5232.7 5297.5 5334.7 5357.5 5475.6 4815.1 4849.9 4929.8 4999.9 5026.8 392.5 4785.4 4830.2 4920.7 4967.7 4845.2 4849.1 4887.8 4908.9 4951.7 4891.5 4914.4 4921.5 4923.5 4964.0 4787.0 4905.7 4916.1 4951.6 4957.7 5420.6 5463.4 5465.5 5472.0 5474.6 5497.8 5723.8 5866.1 5913.3 5941.7 5712.2 5744.0 5785.0 5817.5 5840.2 5362.6 5402.9 5407.3 5409.3 5445.9 5711.7 5788.7 5910.7 5949.7 5961.6 5623.2 5675.3 5675.5 5688.2 5720.9 5754.4 5757.6 5757.7 5759.5 5769.8 5614.5 5698.7 5716.3 5727.7 5753.7 5700.0 5711.6 5712.0 5716.9 5719.4 4414.9 4424.3 4441.0 4465.0 4501.0 3942.8 3953.1 3981.3 3983.2 4000.1 5366.5 5422.4 5437.0 5440.8 5462.0 5745.7 5763.2 5769.1 5769.7 5774.2 5386.9 5484.7 5516.9 5531.2 5558.1 4815.8 4823.1 4823.7 4839.2 4874.3 5762.3 5965.3 5990.4 5997.9 6012.3 5795.8 5815.5 5818.4 5890.0 5901.9 6045.0 6050.9 6053.8 6062.7 6063.9 5503.1 5667.4 5798.3 5799.9 5803.2 5784.4 5830.0 5839.6 5855.2 5905.7 5695.6 5717.1 5722.4 5724.9 5733.2 5439.5 5576.5 5607.2 5701.1 5709.6 5540.0 5552.6 5554.8 5582.1 5610.2 5624.2 5637.1 5681.0 5691.7 5694.3 5458.5 5559.4 5619.8 5677.2 5711.6 12:32:44 INFO - PROCESS | 19998 | 12:32:44 INFO - PROCESS | 19998 | [#1] ext.html Cycles:180 Average:56316.11 Median:39738.80 stddev:113941.48 (286.7%) stddev-sans-first:114184.22 12:32:44 INFO - PROCESS | 19998 | Values: 560.3 603.1 609.6 611.3 649.0 36810.6 40750.6 41074.0 41154.0 41436.0 41422.0 41857.6 42352.8 42367.6 42446.0 8746.8 8866.6 8880.8 8907.9 8914.2 8739.6 8785.0 8811.4 8836.0 8860.2 8776.3 8803.6 8831.0 8832.3 8834.4 8735.4 8741.0 8743.4 8775.9 8812.6 8668.8 8743.7 8766.9 8786.3 8786.4 39064.6 39256.6 39512.8 39644.2 39833.4 2937.6 3380.5 3484.2 3554.5 4077.0 28088.0 30302.0 30324.5 30610.4 30963.2 4190.9 4225.9 4232.1 4269.7 4276.2 287732.0 288155.6 289925.0 290134.0 290627.0 32494.7 33122.7 33127.7 33138.2 33156.0 33588.5 35057.8 35537.6 35594.5 37280.6 16127.3 16174.5 16258.9 16284.7 16291.3 11406.7 11507.7 11522.5 11523.5 11543.1 18980.8 18989.2 19087.0 19098.3 19181.8 6791.3 6846.1 7027.3 7106.8 7229.3 942.7 1025.7 1040.0 1053.3 1094.8 31609.8 31742.1 31976.4 32309.7 32473.8 1100.8 1131.9 1155.4 1166.2 1235.1 16455.3 16892.0 17022.7 17036.7 17085.9 535167.0 540911.0 543070.0 544165.0 544996.0 55815.0 57201.7 57397.0 57504.4 57553.7 1300.6 1336.2 1347.8 1357.1 1368.6 30076.4 30749.5 31103.0 31184.4 31674.7 50106.7 50315.5 50479.7 50743.0 50914.5 415850.0 416483.0 416788.0 418763.0 418992.0 26965.6 27213.1 27625.7 27635.2 27684.0 47577.0 47831.5 47895.0 48635.5 49002.0 39323.8 40046.1 40290.8 40984.4 41258.6 39597.2 40027.8 40059.0 40790.4 40913.6 37361.3 40320.2 40830.6 41132.0 41398.2 33214.5 38568.0 38590.4 38622.8 38755.6 27509.3 27528.2 27549.9 27563.6 27765.2 12:32:44 INFO - PROCESS | 19998 | 12:32:44 INFO - PROCESS | 19998 | [#2] jquery.html Cycles:180 Average:27113.58 Median:367.91 stddev:72796.41 (19786.3%) stddev-sans-first:72972.88 12:32:44 INFO - PROCESS | 19998 | Values: 347.5 354.6 365.6 370.2 375.2 17800.6 18489.7 19171.1 19490.4 19518.2 17560.7 17592.3 18447.9 18448.3 18462.0 5475.6 5573.9 5602.7 5661.5 5677.6 5452.9 5512.2 5517.0 5518.0 5518.2 5313.7 5474.5 5479.9 5488.2 5495.7 5453.7 5491.9 5514.6 5520.5 5524.1 4692.8 4845.7 4864.5 4871.9 4872.1 20248.6 21003.8 21241.2 21242.2 21736.2 2390.5 2699.6 3066.2 3070.6 3076.7 13915.3 13934.8 14277.8 14532.5 14556.6 1942.7 1949.2 1965.8 2040.3 2050.0 75842.2 77504.6 77677.6 79947.2 80016.6 9485.3 9700.2 9905.4 10019.2 10049.4 13523.8 13585.3 13645.4 13659.7 13667.7 7683.3 7764.0 7835.9 7886.6 7991.7 7828.8 7871.3 7943.2 7987.1 8042.4 6189.3 6283.9 6289.4 6315.7 6488.8 1797.4 1827.8 1836.5 1840.3 1852.0 909.8 975.8 992.1 1034.5 1035.7 18432.8 18834.5 19265.6 19389.0 19779.2 967.7 996.7 1023.2 1038.2 1066.6 10322.0 10983.5 11072.1 11193.6 11212.9 428869.0 429543.8 438772.0 450822.0 459486.0 73824.6 77650.0 81276.6 84129.6 86351.6 972.7 979.5 1004.9 1006.1 1027.2 17350.7 17553.0 17617.6 17725.5 17749.2 39045.8 39582.2 39913.8 40126.6 40735.8 56480.0 56820.0 57151.7 57867.4 58622.7 8080.9 8260.9 8368.3 8391.7 8407.1 9477.5 13417.7 13594.4 13634.9 13973.4 11395.8 11470.9 11602.5 11629.0 11879.5 11079.7 11534.3 12021.8 12135.3 12180.3 11648.5 12037.6 12051.2 12221.5 12351.7 8139.2 8214.2 8304.6 8466.7 8656.9 8173.2 11177.4 11914.7 11961.8 12072.8 12:32:44 INFO - PROCESS | 19998 | 12:32:44 INFO - PROCESS | 19998 | [#3] mootools.html Cycles:180 Average:5970.18 Median:4419.30 stddev:3460.31 (78.3%) stddev-sans-first:3453.01 12:32:44 INFO - PROCESS | 19998 | Values: 1404.6 1440.5 1445.4 1460.4 1470.7 7550.2 8541.0 8658.4 9163.1 9263.2 8829.1 9091.3 9124.6 9151.8 9159.3 2268.5 2271.9 2278.9 2291.1 2302.3 2288.4 2289.8 2291.2 2308.7 2324.3 2260.1 2285.2 2288.4 2301.9 2338.6 2232.7 2281.4 2284.2 2288.2 2292.2 2255.4 2258.4 2258.9 2272.2 2278.2 9259.9 9277.0 9296.3 9321.3 9333.5 5014.3 5146.6 5149.1 5282.7 5325.0 3131.4 3210.1 3392.2 3420.6 3434.2 1135.2 1143.0 1147.4 1151.5 1153.9 12700.8 12722.4 12741.6 12824.4 12889.7 4464.7 4529.2 4604.3 4629.3 4653.4 10757.6 10786.6 10824.2 10838.8 10857.1 5210.1 5215.3 5244.7 5250.0 5276.6 4037.3 4661.2 4697.5 4793.8 4846.6 3871.8 3883.7 3896.8 3971.2 3983.7 1207.6 1217.6 1226.7 1237.8 1239.5 987.7 1011.2 1024.5 1025.5 1028.7 6235.0 6419.8 6436.8 6453.4 6681.4 978.0 1002.7 1016.8 1021.5 1028.8 4186.6 4331.0 4366.8 4394.4 4444.2 11252.8 11425.3 11608.3 11661.7 11722.3 11469.2 11508.9 11614.7 11627.1 11633.8 8054.2 8295.7 8300.6 8491.2 8661.1 6010.2 6242.8 6315.1 6330.9 6336.7 9764.3 10025.2 10281.0 10289.5 10336.5 9944.2 10163.2 10241.8 10251.8 10291.4 7536.0 8332.3 8580.1 8598.5 8743.4 8700.4 8734.6 8876.2 8938.1 8954.1 7784.3 7945.8 7964.2 8025.9 8111.7 7632.4 7969.8 8007.2 8009.5 8093.9 7348.1 7379.9 7380.6 7469.3 7485.7 5177.3 5229.7 5237.3 5289.8 5332.9 5508.6 5592.5 5651.4 5699.9 5721.1 12:32:44 INFO - PROCESS | 19998 | 12:32:44 INFO - PROCESS | 19998 | [#4] prototype.html Cycles:180 Average:4875.66 Median:5561.06 stddev:1463.68 (26.3%) stddev-sans-first:1427.14 12:32:44 INFO - PROCESS | 19998 | Values: 311.8 315.1 315.2 316.1 316.8 5505.9 5512.8 5553.9 5585.6 5619.4 5475.8 5477.9 5478.0 5507.9 5513.8 4077.4 4157.2 4271.5 4274.5 4284.3 4253.3 4269.3 4279.7 4297.9 4298.5 4227.4 4258.0 4258.9 4267.4 4327.5 4067.5 4246.6 4255.6 4262.7 4337.1 3696.9 3698.8 3718.0 3741.8 3748.8 5486.7 5513.8 5515.9 5521.0 5530.2 4818.3 4849.7 4887.7 4902.0 4950.0 5752.3 5761.4 5839.5 5841.6 5859.2 4067.2 4089.9 4120.0 4143.9 4152.1 5914.7 6075.5 6082.1 6087.6 6174.9 4111.5 4134.2 4136.7 4146.9 4150.5 4181.6 4197.5 4197.7 4200.5 4203.7 4643.9 4808.6 4822.9 4890.0 4892.8 5825.1 5835.7 5842.9 5860.3 5878.9 1437.2 1463.2 1463.2 1463.2 1465.3 886.7 909.6 916.9 923.5 940.9 5494.5 5515.4 5551.4 5559.2 5562.9 5829.7 5945.5 5953.1 5973.6 5990.3 5350.5 5470.6 5541.2 5565.9 5614.9 3126.7 3149.0 3191.4 3206.5 3208.2 5865.9 6021.9 6058.5 6122.7 6132.9 6104.8 6116.7 6122.8 6148.4 6159.8 6123.4 6179.9 6202.2 6236.6 6240.5 5739.4 5950.4 5981.4 5990.3 6013.8 5945.2 5970.5 5971.8 5978.2 6006.2 5925.6 6019.4 6058.8 6169.8 6186.2 4130.4 4153.6 4160.3 4162.6 4166.0 5956.3 6001.8 6007.2 6034.0 6050.2 5604.6 5791.0 5814.5 5827.9 5835.9 5802.0 5822.5 5823.2 5848.8 5864.0 5643.4 5718.5 5722.9 5779.4 5784.4 5905.9 5938.3 5947.8 5952.0 5982.8 5522.0 5774.9 5777.3 5792.3 5825.4 12:32:44 INFO - PROCESS | 19998 | 12:32:44 INFO - PROCESS | 19998 | [#5] yui.html Cycles:180 Average:20116.72 Median:4720.26 stddev:28813.12 (610.4%) stddev-sans-first:28857.08 12:32:44 INFO - PROCESS | 19998 | Values: 704.2 714.5 727.6 743.8 773.9 14705.0 15675.0 15951.0 16093.9 16130.6 14208.7 14571.0 14582.3 14596.3 14617.3 762.0 763.1 776.4 782.1 790.8 771.8 773.8 775.5 775.7 781.1 820.1 824.7 825.6 826.0 826.5 815.6 821.1 823.2 823.6 825.2 600.6 600.8 602.2 603.9 604.4 15637.5 15698.5 15771.1 15784.4 15824.7 13033.8 13564.3 13797.7 13879.9 13928.2 12018.5 12100.6 12302.6 12334.8 12388.1 3848.8 3864.6 3877.3 3973.6 4026.6 73928.6 74965.0 75692.6 77965.0 77976.2 11196.5 11405.0 11418.7 11476.2 11504.0 20642.9 20644.7 20658.5 20663.3 20682.0 8433.3 8589.8 8624.8 8844.0 8848.7 4764.1 4898.2 4967.6 5000.9 5123.2 3549.5 3613.7 3623.4 3628.5 3641.8 594.1 608.8 611.7 616.9 635.0 644.7 674.4 738.7 745.1 749.9 9446.7 9851.9 10085.0 10114.1 10160.2 589.2 603.6 741.7 750.3 752.1 4676.4 4894.8 4931.7 4931.9 4974.7 110694.0 110817.4 112405.4 113509.4 115620.4 91492.0 93064.0 93116.5 93399.5 93426.0 79231.0 80274.6 80291.6 80322.0 80513.0 9220.1 9302.9 9349.6 9363.3 9423.3 36335.6 44419.0 49630.5 50436.5 51675.7 69541.3 73494.3 76294.6 76546.2 76964.0 10932.8 11138.6 11147.2 11527.7 12579.1 12822.1 13615.3 13877.4 14001.1 14104.6 12248.8 12785.3 12902.0 12966.5 13009.7 12369.1 12774.3 12793.4 12903.8 13415.9 12698.9 12938.7 12990.2 13046.5 13085.5 10423.3 10538.1 10588.7 11056.3 11162.3 10939.9 11078.8 11169.9 11316.4 11345.6 12:32:44 INFO - PROCESS | 19998 | -------- Summary: end -------- 12:32:44 INFO - PROCESS | 19998 | 12:32:45 INFO - TEST-INFO | 19998: exit 0 12:32:45 INFO - TEST-OK | dromaeo_css | took 1111874ms 12:32:45 INFO - TEST-START | kraken 12:32:45 INFO - operating with platform_type : linux_ 12:32:45 INFO - Initialising browser for kraken test... 12:32:45 INFO - TEST-INFO | started process 20235 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJjWKj1/profile http://localhost:55027/getInfo.html) 12:32:50 INFO - PROCESS | 20235 | __metrics Screen width/height:1600/1200 12:32:50 INFO - PROCESS | 20235 | colorDepth:24 12:32:50 INFO - PROCESS | 20235 | Browser inner width/height: 1024/697 12:32:50 INFO - PROCESS | 20235 | __metrics 12:32:51 ERROR - PROCESS | 20235 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 12:32:51 INFO - TEST-INFO | 20235: exit 0 12:32:51 INFO - Browser initialized. 12:32:51 INFO - Running cycle 1/1 for kraken test... 12:32:51 INFO - TEST-INFO | started process 20356 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJjWKj1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:33:03 INFO - PROCESS | 20356 | RSS: Main: 185188352 12:33:03 INFO - PROCESS | 20356 | 12:33:06 INFO - PROCESS | 20356 | Cycle 1(1): loaded http://localhost:55027/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55027/tests/kraken/driver.html?testName=audio-beat-detection) 12:33:07 INFO - PROCESS | 20356 | RSS: Main: 191295488 12:33:07 INFO - PROCESS | 20356 | 12:33:10 INFO - PROCESS | 20356 | Cycle 1(1): loaded http://localhost:55027/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55027/tests/kraken/driver.html?testName=audio-dft) 12:33:10 INFO - PROCESS | 20356 | RSS: Main: 190550016 12:33:10 INFO - PROCESS | 20356 | 12:33:13 INFO - PROCESS | 20356 | Cycle 1(1): loaded http://localhost:55027/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55027/tests/kraken/driver.html?testName=audio-fft) 12:33:14 INFO - PROCESS | 20356 | RSS: Main: 184971264 12:33:14 INFO - PROCESS | 20356 | 12:33:16 INFO - PROCESS | 20356 | Cycle 1(1): loaded http://localhost:55027/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55027/tests/kraken/driver.html?testName=audio-oscillator) 12:33:16 INFO - PROCESS | 20356 | RSS: Main: 186093568 12:33:16 INFO - PROCESS | 20356 | 12:33:19 INFO - PROCESS | 20356 | Cycle 1(1): loaded http://localhost:55027/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55027/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:33:19 INFO - PROCESS | 20356 | RSS: Main: 186118144 12:33:19 INFO - PROCESS | 20356 | 12:33:22 INFO - PROCESS | 20356 | Cycle 1(1): loaded http://localhost:55027/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55027/tests/kraken/driver.html?testName=imaging-darkroom) 12:33:23 INFO - PROCESS | 20356 | RSS: Main: 186028032 12:33:23 INFO - PROCESS | 20356 | 12:33:27 INFO - PROCESS | 20356 | Cycle 1(1): loaded http://localhost:55027/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55027/tests/kraken/driver.html?testName=imaging-desaturate) 12:33:27 INFO - PROCESS | 20356 | RSS: Main: 183783424 12:33:27 INFO - PROCESS | 20356 | 12:33:30 INFO - PROCESS | 20356 | Cycle 1(1): loaded http://localhost:55027/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55027/tests/kraken/driver.html?testName=json-parse-financial) 12:33:31 INFO - PROCESS | 20356 | RSS: Main: 185282560 12:33:31 INFO - PROCESS | 20356 | 12:33:32 INFO - PROCESS | 20356 | Cycle 1(1): loaded http://localhost:55027/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55027/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:33:33 INFO - PROCESS | 20356 | RSS: Main: 185954304 12:33:33 INFO - PROCESS | 20356 | 12:33:35 INFO - PROCESS | 20356 | Cycle 1(1): loaded http://localhost:55027/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55027/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:33:35 INFO - PROCESS | 20356 | RSS: Main: 186077184 12:33:35 INFO - PROCESS | 20356 | 12:33:37 INFO - PROCESS | 20356 | Cycle 1(1): loaded http://localhost:55027/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55027/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:33:38 INFO - PROCESS | 20356 | RSS: Main: 186630144 12:33:38 INFO - PROCESS | 20356 | 12:33:41 INFO - PROCESS | 20356 | Cycle 1(1): loaded http://localhost:55027/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:33:41 INFO - PROCESS | 20356 | RSS: Main: 186626048 12:33:41 INFO - PROCESS | 20356 | 12:33:44 INFO - PROCESS | 20356 | Cycle 1(1): loaded http://localhost:55027/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:33:45 INFO - PROCESS | 20356 | RSS: Main: 186171392 12:33:45 INFO - PROCESS | 20356 | 12:33:46 INFO - PROCESS | 20356 | Cycle 1(1): loaded http://localhost:55027/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55027/tests/kraken/driver.html?testName=ai-astar) 12:33:47 INFO - PROCESS | 20356 | RSS: Main: 187498496 12:33:47 INFO - PROCESS | 20356 | 12:33:47 INFO - PROCESS | 20356 | __start_tp_report 12:33:47 INFO - PROCESS | 20356 | _x_x_mozilla_page_load 12:33:47 INFO - PROCESS | 20356 | _x_x_mozilla_page_load_details 12:33:47 INFO - PROCESS | 20356 | |i|pagename|runs| 12:33:47 INFO - PROCESS | 20356 | |0;ai-astar;111;107;112;111;112;112;110;109;111;110 12:33:47 INFO - PROCESS | 20356 | |1;audio-beat-detection;157;126;158;185;128;157;157;128;194;127 12:33:47 INFO - PROCESS | 20356 | |2;audio-dft;168;165;166;162;165;166;160;163;163;160 12:33:47 INFO - PROCESS | 20356 | |3;audio-fft;74;75;75;157;77;75;74;76;180;75 12:33:47 INFO - PROCESS | 20356 | |4;audio-oscillator;87;85;152;85;85;86;141;86;86;147 12:33:47 INFO - PROCESS | 20356 | |5;imaging-gaussian-blur;117;118;118;117;118;118;118;118;117;118 12:33:47 INFO - PROCESS | 20356 | |6;imaging-darkroom;147;148;148;147;149;148;150;148;146;149 12:33:47 INFO - PROCESS | 20356 | |7;imaging-desaturate;97;96;95;96;97;96;97;97;96;96 12:33:47 INFO - PROCESS | 20356 | |8;json-parse-financial;57;53;54;53;55;53;53;57;52;53 12:33:47 INFO - PROCESS | 20356 | |9;json-stringify-tinderbox;64;61;62;62;62;62;62;62;63;63 12:33:47 INFO - PROCESS | 20356 | |10;stanford-crypto-aes;85;82;80;80;83;81;82;80;105;87 12:33:47 INFO - PROCESS | 20356 | |11;stanford-crypto-ccm;125;128;133;127;123;125;131;133;146;128 12:33:47 INFO - PROCESS | 20356 | |12;stanford-crypto-pbkdf2;166;162;164;177;163;161;165;164;163;164 12:33:47 INFO - PROCESS | 20356 | |13;stanford-crypto-sha256-iterative;63;64;64;63;64;64;63;62;63;63 12:33:47 INFO - PROCESS | 20356 | __end_tp_report 12:33:47 INFO - PROCESS | 20356 | __start_cc_report 12:33:47 INFO - PROCESS | 20356 | _x_x_mozilla_cycle_collect,908 12:33:47 INFO - PROCESS | 20356 | __end_cc_report 12:33:47 INFO - PROCESS | 20356 | __startTimestamp1466105627061__endTimestamp 12:33:47 INFO - PROCESS | 20356 | 12:33:47 INFO - PROCESS | 20356 | ------- Summary: start ------- 12:33:47 INFO - PROCESS | 20356 | Number of tests: 14 12:33:47 INFO - PROCESS | 20356 | 12:33:47 INFO - PROCESS | 20356 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.58 (1.4%) stddev-sans-first:1.67 12:33:47 INFO - PROCESS | 20356 | Values: 111.0 107.0 112.0 111.0 112.0 112.0 110.0 109.0 111.0 110.0 12:33:47 INFO - PROCESS | 20356 | 12:33:47 INFO - PROCESS | 20356 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:157.00 stddev:24.53 (15.6%) stddev-sans-first:25.94 12:33:47 INFO - PROCESS | 20356 | Values: 157.0 126.0 158.0 185.0 128.0 157.0 157.0 128.0 194.0 127.0 12:33:47 INFO - PROCESS | 20356 | 12:33:47 INFO - PROCESS | 20356 | [#2] audio-dft Cycles:10 Average:163.80 Median:165.00 stddev:2.66 (1.6%) stddev-sans-first:2.35 12:33:47 INFO - PROCESS | 20356 | Values: 168.0 165.0 166.0 162.0 165.0 166.0 160.0 163.0 163.0 160.0 12:33:47 INFO - PROCESS | 20356 | 12:33:47 INFO - PROCESS | 20356 | [#3] audio-fft Cycles:10 Average:93.80 Median:75.00 stddev:39.75 (53.0%) stddev-sans-first:41.51 12:33:47 INFO - PROCESS | 20356 | Values: 74.0 75.0 75.0 157.0 77.0 75.0 74.0 76.0 180.0 75.0 12:33:47 INFO - PROCESS | 20356 | 12:33:47 INFO - PROCESS | 20356 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:85.50 stddev:29.56 (34.6%) stddev-sans-first:30.71 12:33:47 INFO - PROCESS | 20356 | Values: 87.0 85.0 152.0 85.0 85.0 86.0 141.0 86.0 86.0 147.0 12:33:47 INFO - PROCESS | 20356 | 12:33:47 INFO - PROCESS | 20356 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 12:33:47 INFO - PROCESS | 20356 | Values: 117.0 118.0 118.0 117.0 118.0 118.0 118.0 118.0 117.0 118.0 12:33:47 INFO - PROCESS | 20356 | 12:33:47 INFO - PROCESS | 20356 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:1.15 (0.8%) stddev-sans-first:1.17 12:33:47 INFO - PROCESS | 20356 | Values: 147.0 148.0 148.0 147.0 149.0 148.0 150.0 148.0 146.0 149.0 12:33:47 INFO - PROCESS | 20356 | 12:33:47 INFO - PROCESS | 20356 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 12:33:47 INFO - PROCESS | 20356 | Values: 97.0 96.0 95.0 96.0 97.0 96.0 97.0 97.0 96.0 96.0 12:33:47 INFO - PROCESS | 20356 | 12:33:47 INFO - PROCESS | 20356 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:53.50 stddev:1.76 (3.3%) stddev-sans-first:1.50 12:33:47 INFO - PROCESS | 20356 | Values: 57.0 53.0 54.0 53.0 55.0 53.0 53.0 57.0 52.0 53.0 12:33:47 INFO - PROCESS | 20356 | 12:33:47 INFO - PROCESS | 20356 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.60 12:33:47 INFO - PROCESS | 20356 | Values: 64.0 61.0 62.0 62.0 62.0 62.0 62.0 62.0 63.0 63.0 12:33:47 INFO - PROCESS | 20356 | 12:33:47 INFO - PROCESS | 20356 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:82.00 stddev:7.56 (9.2%) stddev-sans-first:8.02 12:33:47 INFO - PROCESS | 20356 | Values: 85.0 82.0 80.0 80.0 83.0 81.0 82.0 80.0 105.0 87.0 12:33:47 INFO - PROCESS | 20356 | 12:33:47 INFO - PROCESS | 20356 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:129.50 stddev:6.59 (5.1%) stddev-sans-first:6.75 12:33:47 INFO - PROCESS | 20356 | Values: 125.0 128.0 133.0 127.0 123.0 125.0 131.0 133.0 146.0 128.0 12:33:47 INFO - PROCESS | 20356 | 12:33:47 INFO - PROCESS | 20356 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.90 Median:164.00 stddev:4.48 (2.7%) stddev-sans-first:4.74 12:33:47 INFO - PROCESS | 20356 | Values: 166.0 162.0 164.0 177.0 163.0 161.0 165.0 164.0 163.0 164.0 12:33:47 INFO - PROCESS | 20356 | 12:33:47 INFO - PROCESS | 20356 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 12:33:47 INFO - PROCESS | 20356 | Values: 63.0 64.0 64.0 63.0 64.0 64.0 63.0 62.0 63.0 63.0 12:33:47 INFO - PROCESS | 20356 | -------- Summary: end -------- 12:33:47 INFO - PROCESS | 20356 | 12:33:48 INFO - TEST-INFO | 20356: exit 0 12:33:48 INFO - TEST-OK | kraken | took 62746ms 12:33:48 INFO - SUITE-END | took 1174s 12:33:48 INFO - Completed test suite (00:19:34) 12:33:48 INFO - javascript benchmark 12:33:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7216.921585734437, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3065.141760307114, 3086.5061590145583, 3098.333858220483, 3105.658377578466, 3108.300632357721, 5310.76101575429, 5366.490183432573, 5380.171616636674, 5383.246345511627, 5433.185022246665, 5232.73836308184, 5297.496737809902, 5334.653247538917, 5357.464253574641, 5475.616706830513, 4815.133276010308, 4849.878753031185, 4929.827456039039, 4999.900001999958, 5026.773795179208, 392.5433751932978, 4785.401824771903, 4830.178869592178, 4920.655554111214, 4967.652264341497, 4845.248986407095, 4849.127157111719, 4887.780049897763, 4908.9263661045115, 4951.727654978975, 4891.486393928657, 4914.36113305268, 4921.458639549646, 4923.483034281385, 4964.0, 4786.976065119687, 4905.656604037718, 4916.139675556763, 4951.554360107608, 4957.702537847741, 5420.593455490854, 5463.399026107125, 5465.535429488498, 5472.0, 5474.644148130359, 5497.752601132958, 5723.828285151452, 5866.120081987693, 5913.2608423947, 5941.732622032019, 5712.200291959129, 5744.0, 5784.971075144597, 5817.505512031483, 5840.15317778924, 5362.570994320445, 5402.8919421611745, 5407.297051383334, 5409.29679141709, 5445.945540544544, 5711.685857277889, 5788.739506722208, 5910.674912879833, 5949.732262048218, 5961.642301461926, 5623.156526520973, 5675.262215911987, 5675.460831221028, 5688.175214593944, 5720.942790572041, 5754.395788442237, 5757.625754325955, 5757.65454072757, 5759.539236861041, 5769.769209231584, 5614.522765564891, 5698.686572238566, 5716.342620598684, 5727.684977326204, 5753.741081651336, 5700.030994730906, 5711.600187986801, 5711.971440142773, 5716.942830571724, 5719.428057194247, 4414.936271311422, 4424.292113261863, 4440.977795111068, 4465.0, 4500.977495112504, 3942.783146926889, 3953.0710283083454, 3981.343078392091, 3983.24318379507, 4000.139969906484, 5366.517013468729, 5422.40353561108, 5437.021336159451, 5440.782368705208, 5462.0, 5745.741441635137, 5763.164341170507, 5769.134629805562, 5769.740361683735, 5774.220480235199, 5386.946130538723, 5484.670919744828, 5516.889662206733, 5531.197976293415, 5558.138488534284, 4815.807367705253, 4823.059503396804, 4823.710577365369, 4839.201531747292, 4874.341963834908, 5762.279715035621, 5965.28416590012, 5990.400959904062, 5997.850053748604, 6012.308584512837, 5795.797147099831, 5815.505682017076, 5818.418158184148, 5889.970550147222, 5901.940980590139, 6045.032794752994, 6050.878982420415, 6053.757849685963, 6062.666553339609, 6063.939360606338, 5503.091989821634, 5667.4332566743, 5798.333191682842, 5799.8550036249435, 5803.216565763568, 5784.421557844182, 5830.0, 5839.620424672383, 5855.151003104611, 5905.704714764331, 5695.629784064023, 5717.056685646821, 5722.370539240597, 5724.942750572608, 5733.197352370755, 5439.537639300704, 5576.470235327637, 5607.243022192115, 5701.087825947829, 5709.600327977002, 5539.972300138474, 5552.583556233218, 5554.833354999357, 5582.078956972054, 5610.242617246619, 5624.212610234652, 5637.069883469182, 5680.971595142163, 5691.715414229355, 5694.345150307768, 5458.5087342139395, 5559.44405559457, 5619.7752089917585, 5677.205191273308, 5711.571632127524], "value": 5288.326080262715, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.2744445942504, 603.1224568253191, 609.6037575575878, 611.2970084402938, 648.9772857949966, 36810.63189368106, 40750.592494075085, 41074.0, 41154.0, 41436.0, 41422.0, 41857.58142418575, 42352.788236058776, 42367.57632423683, 42446.0, 8746.781330466742, 8866.601002954883, 8880.777980550505, 8907.910920890772, 8914.197722205, 8739.563021848882, 8784.956075219616, 8811.383203175781, 8836.0, 8860.20258176764, 8776.297896168291, 8803.559822008907, 8830.955845220766, 8832.293416526663, 8834.425762325429, 8735.43219690718, 8741.0, 8743.43167694101, 8775.868361974575, 8812.603432845537, 8668.826623467558, 8743.650253989832, 8766.868496972551, 8786.253168480687, 8786.384953053288, 39064.60935390638, 39256.60743392558, 39512.80243598792, 39644.20711585781, 39833.40249896254, 2937.6474823021163, 3380.5098260752297, 3484.198634314122, 3554.4668299755244, 4076.9796151019054, 28088.0, 30302.0, 30324.54513182304, 30610.38779224425, 30963.22591935197, 4190.916181676349, 4225.894352641209, 4232.132412855388, 4269.743815371087, 4276.166147601219, 287732.0, 288155.55922220467, 289925.0, 290134.0, 290626.9999999979, 32494.675053249637, 33122.66877331196, 33127.66872331294, 33138.17154571155, 33156.0, 33588.49617255743, 35057.82471087679, 35537.64462355343, 35594.466083008774, 37280.62719372771, 16127.274272657758, 16174.514764557081, 16258.918705406633, 16284.67430651404, 16291.348346066261, 11406.657800266004, 11507.654770356903, 11522.481488333045, 11523.48144333507, 11543.134264930164, 18980.81019189818, 18989.240430382906, 19087.0, 19098.33155839567, 19181.80818191828, 6791.2869148739655, 6846.085453691807, 7027.262137475594, 7106.786796396116, 7229.313215244649, 942.6606421688186, 1025.6769117727893, 1040.0379648824808, 1053.2837670384058, 1094.8084085285043, 31609.84195079056, 31742.06573286086, 31976.36047279088, 32309.67690323114, 32473.837630811693, 1100.8148824583195, 1131.8698349689726, 1155.4049664422828, 1166.2419427372276, 1235.14774805384, 16455.341786328412, 16892.0, 17022.744658830128, 17036.65926681484, 17085.914570427067, 535167.0, 540911.0, 543070.0, 544165.0, 544996.0, 55815.0, 57201.71399142977, 57397.0, 57504.424955749906, 57553.712231439415, 1300.6423233610644, 1336.224989506084, 1347.8113064170827, 1357.0500649545359, 1368.609946165358, 30076.398472030876, 30749.53875691911, 31103.0, 31184.376312474076, 31674.683253168096, 50106.74946625243, 50315.496845031084, 50479.747601261755, 50743.0, 50914.490855090975, 415850.0, 416483.0, 416788.0, 418763.0, 418992.0, 26965.595516067668, 27213.05410715475, 27625.723742762315, 27635.170944871687, 27684.0, 47577.0, 47831.5216847827, 47895.0, 48635.5136448631, 49002.0, 39323.803380982914, 40046.09076488624, 40290.798546007085, 40984.385234220914, 41258.587414126676, 39597.22819402614, 40027.79986100051, 40059.0, 40790.388144178454, 40913.59086409217, 37361.25277494489, 40320.19359612733, 40830.59169408268, 41132.0, 41398.1720365597, 33214.501782473766, 38568.0, 38590.4211436823, 38622.80688596539, 38755.6124438752, 27509.31226719348, 27528.174154775388, 27549.862250688617, 27563.586546201423, 27765.167044988684], "value": 19079.371637841854, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.473577530042, 354.59930278784975, 365.62158166297877, 370.20590832663953, 375.24762850484774, 17800.64398712025, 18489.7226541602, 19171.13729882155, 19490.41528754136, 19518.21927122917, 17560.736588951175, 17592.296308147692, 18447.907760461214, 18448.262069517237, 18462.0, 5475.616706830533, 5573.8606534836545, 5602.747876345554, 5661.518770904458, 5677.630953987978, 5452.945470545304, 5512.228288039678, 5517.034518959186, 5517.972410137943, 5518.227448157261, 5313.73431328434, 5474.452554744514, 5479.890402191953, 5488.231647569343, 5495.725213739317, 5453.700046497441, 5491.862703432406, 5514.558835293167, 5520.475554822286, 5524.14375771756, 4692.8122875084955, 4845.733484658343, 4864.513548645107, 4871.902561948741, 4872.123017856784, 20248.595028099502, 21003.789962100338, 21241.150353985977, 21242.150313987422, 21736.239231626816, 2390.4501964548076, 2699.5545734953707, 3066.23344163959, 3070.6468756093113, 3076.7077127672837, 13915.30423478822, 13934.790978135336, 14277.785833212407, 14532.491362802357, 14556.563303100924, 1942.689169732836, 1949.2495389275089, 1965.7837637859825, 2040.3470889315424, 2050.0, 75842.24157758406, 77504.61247693782, 77677.61161194158, 79947.20052799514, 80016.59991700121, 9485.336026478219, 9700.223982081558, 9905.356151850106, 10019.198464122852, 10049.397036177852, 13523.797143042862, 13585.252811095286, 13645.38595763193, 13659.658508537366, 13667.658308542366, 7683.346915512244, 7764.0, 7835.882461763078, 7886.5662388568035, 7991.680332786624, 7828.765137045898, 7871.252231038042, 7943.205679432011, 7987.121416644164, 8042.356611471068, 6189.288231853395, 6283.905741413882, 6289.371062893674, 6315.715792789336, 6488.837779055467, 1797.379903933141, 1827.8446332061658, 1836.5133239691493, 1840.3098837935775, 1851.9629607407776, 909.7816524034316, 975.7997662874703, 992.1170158558745, 1034.5499707627207, 1035.6789395287335, 18432.81567184338, 18834.52913677169, 19265.614687706166, 19389.0, 19779.20883164686, 967.6564819489121, 996.6561536269975, 1023.1916785739182, 1038.159091136167, 1066.626680661762, 10322.0, 10983.450827458595, 11072.114230861513, 11193.608223712132, 11212.887871121347, 428869.0, 429543.78421618504, 438772.0, 450822.0, 459486.0, 73824.63087684527, 77650.0, 81276.59361703154, 84129.57935210408, 86351.56824215839, 972.6644307713827, 979.490664854286, 1004.9397036177706, 1006.1296978113879, 1027.209049032256, 17350.652986940444, 17553.0, 17617.559561011076, 17725.468235952943, 17749.201285941905, 39045.80477097596, 39582.20835583215, 39913.80043099882, 40126.59873401229, 40735.796321018206, 56480.0, 56820.0, 57151.714241428526, 57867.42132578621, 58622.7068864653, 8080.878786818085, 8260.876086858822, 8368.330533557422, 8391.748247552583, 8407.075221725727, 9477.52612369365, 13417.731645366843, 13594.388252528463, 13634.93182534081, 13973.371198296305, 11395.772084558428, 11470.942645286721, 11602.47788849487, 11629.0, 11879.524819007489, 11079.667609971713, 11534.250273732181, 12021.819672704742, 12135.271883687006, 12180.330081845583, 11648.475818588015, 12037.638870833889, 12051.156419050581, 12221.45921038217, 12351.69120771988, 8139.186081391814, 8214.219649133323, 8304.626291816761, 8466.703665371682, 8656.91343086561, 8173.18268173178, 11177.385243811668, 11914.702132446411, 11961.760764784829, 12072.75854482923], "value": 9111.72130409827, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.59968908861, 1440.4526280013592, 1445.4073829729814, 1460.3793387810179, 1470.6838029823589, 7550.169481357047, 8541.0, 8658.393912426132, 9163.083691630842, 9263.21262692671, 8829.117088291168, 9091.272698184146, 9124.635014599424, 9151.77120571986, 9159.313051521129, 2268.4669102760836, 2271.852329598579, 2278.9202377916777, 2291.106468477287, 2302.3093072078395, 2288.382136823057, 2289.839711220215, 2291.2438895164637, 2308.722953245613, 2324.32594547581, 2260.062074239189, 2285.2344464604294, 2288.3592594073684, 2301.9309420717404, 2338.5790557699693, 2232.6762619420256, 2281.4182383492184, 2284.1776960294364, 2288.164819840763, 2292.1862738727764, 2255.4023183856293, 2258.3789457899043, 2258.9322320330416, 2272.1706577099403, 2278.1570818796986, 9259.861102083474, 9276.953615231949, 9296.349255552113, 9321.254299656011, 9333.486658233862, 5014.323066386028, 5146.614003949719, 5149.124648809711, 5282.709450980195, 5325.041492531343, 3131.389379071082, 3210.11721776511, 3392.23674673199, 3420.572428446444, 3434.227298857762, 1135.2280449294476, 1142.994285028578, 1147.3804145761362, 1151.4857961780233, 1153.9076873850072, 12700.80948785769, 12722.427490762939, 12741.554045608453, 12824.358782060859, 12889.742205155844, 4464.687471876938, 4529.230030894756, 4604.263317869192, 4629.305604159335, 4653.418322709661, 10757.623483178051, 10786.622468213733, 10824.188185885932, 10838.837417438745, 10857.077148442313, 5210.114280572312, 5215.348081489814, 5244.711540865289, 5249.973750131225, 5276.630635855453, 4037.253108174997, 4661.207594708908, 4697.459792123949, 4793.760311984387, 4846.636502262274, 3871.806409679561, 3883.66988805949, 3896.844126234919, 3971.1660551283976, 3983.7410568312966, 1207.5592408770735, 1217.5677634439646, 1226.7178548933616, 1237.7586370657634, 1239.535174309634, 987.6691308411763, 1011.1758916483043, 1024.52871679027, 1025.5128813813378, 1028.7068185567077, 6235.0, 6419.775307864203, 6436.806895793134, 6453.419192272718, 6681.365270299314, 977.9755506112261, 1002.744300203458, 1016.7712264740522, 1021.5300961557618, 1028.783955369366, 4186.581341865789, 4331.0, 4366.8034938427845, 4394.36281739146, 4444.2444784386735, 11252.774944501065, 11425.31448113116, 11608.30350178992, 11661.708457288636, 11722.296662200295, 11469.197156198987, 11508.94245528767, 11614.70963225926, 11627.069834413227, 11633.825492617618, 8054.194580541899, 8295.668173273001, 8300.626471808782, 8491.15088491146, 8661.13388661129, 6010.158577799024, 6242.750289988349, 6315.08431277453, 6330.936690633035, 6336.7148478319505, 9764.267679923893, 10025.248106391904, 10281.0, 10289.485525723834, 10336.483175841327, 9944.15474684631, 10163.18694504423, 10241.795164096528, 10251.84622230682, 10291.382517048702, 7536.0, 8332.250097491013, 8580.14198580137, 8598.484090954562, 8743.431676940978, 8700.434471759316, 8734.56327183651, 8876.156765107304, 8938.10618938101, 8954.104589540993, 7784.338331241682, 7945.801354966172, 7964.2433968772875, 8025.9197408025175, 8111.716089936824, 7632.427567932538, 7969.800754981172, 8007.1592482788465, 8009.479383840032, 8093.878591821245, 7348.081489813773, 7379.852402952019, 7380.630968451448, 7469.290417410337, 7485.70057197706, 5177.275181474672, 5229.712365819916, 5237.266782650356, 5289.814856480005, 5332.893342133058, 5508.614396992172, 5592.462072929977, 5651.406602306699, 5699.857503562444, 5721.084626459747], "value": 4732.274660246751, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.82226131105267, 315.08782075890315, 315.17895881229396, 316.09123769163654, 316.80041573808495, 5505.862353441161, 5512.751926163322, 5553.861458401028, 5585.58108141889, 5619.4099619539975, 5475.7823081651895, 5477.890442191154, 5477.972610136953, 5507.889842203163, 5513.807016754415, 4077.3690523790497, 4157.210130075291, 4271.530131685512, 4274.508431530383, 4284.314509678452, 4253.255680255958, 4269.274223382033, 4279.72181808183, 4297.882550536851, 4298.46269216348, 4227.365895115742, 4257.978710106445, 4258.936115958263, 4267.359896015591, 4327.459067616548, 4067.4712287402594, 4246.5541118182455, 4255.553166917491, 4262.701610887239, 4337.110892267094, 3696.907577310562, 3698.7965661888584, 3718.0480247869814, 3741.7754934703735, 3748.83130259139, 5486.670799751988, 5513.8345849624175, 5515.862103447446, 5520.972395137998, 5530.170474428868, 4818.265424447196, 4849.684770489942, 4887.682300650446, 4901.950980490221, 4949.975250123726, 5752.252207213078, 5761.395053519362, 5839.481734748953, 5841.649501029951, 5859.209006784072, 4067.247559201557, 4089.89775255621, 4119.97940010301, 4143.8964025899295, 4152.1072969311745, 5914.674692891889, 6075.483583895374, 6082.148499210114, 6087.634741915499, 6174.907376389313, 4111.540403156896, 4134.214499245134, 4136.710430269853, 4146.885088604833, 4150.501939767187, 4181.560936101666, 4197.5172855122055, 4197.748135111842, 4200.474940632421, 4203.6637069034405, 4643.908681459854, 4808.61531077513, 4822.927656085161, 4890.046440943982, 4892.804287828518, 5825.126231065374, 5835.716142448655, 5842.883142337129, 5860.267466566679, 5878.853028674232, 1437.23826372023, 1463.1659953826218, 1463.1733070814955, 1463.2464280895347, 1465.296657604356, 886.663068034143, 909.5725009245645, 916.8808054952814, 923.4736200365861, 940.872982147415, 5494.478024587658, 5515.393306736256, 5551.3893471718075, 5559.19391688211, 5562.916556251659, 5829.679367634821, 5945.513621594601, 5953.077273022688, 5973.581849270597, 5990.341062483123, 5350.545203657655, 5470.56235501159, 5541.168824676331, 5565.886822635489, 5614.887702246014, 3126.7498600111935, 3149.0, 3191.4414977378865, 3206.4709322961917, 3208.2300247940793, 5865.853353666107, 6021.916055110122, 6058.545609079337, 6122.663253521099, 6132.877342453126, 6104.816855494342, 6116.694165291718, 6122.846928826815, 6148.354422785543, 6159.784407545714, 6123.387661233841, 6179.938200618026, 6202.193714817045, 6236.565589914345, 6240.469560087353, 5739.368669446441, 5950.375210602824, 5981.401859813984, 5990.341062483036, 6013.759449621966, 5945.167676525203, 5970.522358211246, 5971.8354920790025, 5978.192943952685, 6006.189164462741, 5925.585209035326, 6019.398060193946, 6058.757649693963, 6169.753209871555, 6186.164867742978, 4130.401091841726, 4153.584641535822, 4160.292750232528, 4162.646175075031, 4166.0, 5956.344802071682, 6001.789937352171, 6007.249093863267, 6033.9698301508215, 6050.213472248755, 5604.551635869039, 5790.957627626899, 5814.5463634091475, 5827.8834423310445, 5835.8832823342445, 5801.970990145022, 5822.505087067478, 5823.1847541343395, 5848.766049357978, 5864.0, 5643.363424606982, 5718.485336319751, 5722.856928576819, 5779.36426993022, 5784.392638773036, 5905.881882362414, 5938.317093534299, 5947.78070495556, 5952.0, 5982.760689572368, 5522.0, 5774.9133762994425, 5777.277840269966, 5792.304923409218, 5825.446582574648], "value": 4394.009773138714, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.1936982155429, 714.4891402647106, 727.614364386875, 743.8437928035113, 773.8645736996026, 14704.999999999987, 15675.0, 15951.042937423763, 16093.919530402332, 16130.596735081628, 14208.715825683481, 14571.0, 14582.343794529244, 14596.343164557595, 14617.342219600117, 761.9733309334174, 763.0995425398042, 776.4060493722307, 782.1396463889732, 790.7509134622604, 771.7723271634882, 773.8374941262314, 775.499802627305, 775.7207405334075, 781.0510230070463, 820.0610301205116, 824.68661908475, 825.6243409248807, 825.9793505162389, 826.4917075998247, 815.6166601697192, 821.0844907927648, 823.19738255201, 823.5923218007065, 825.2325337436212, 600.5585894367637, 600.7596961215505, 602.16299343912, 603.9124326972565, 604.4318340759672, 15637.530874073796, 15698.52904412858, 15771.13258770767, 15784.447544335893, 15824.683506329924, 13033.804492932613, 13564.253966031863, 13797.724045519133, 13879.861201387957, 13928.164310141323, 12018.51925922962, 12100.576479823252, 12302.630921072292, 12334.75330493394, 12388.070894682935, 3848.7690738555775, 3864.632859878307, 3877.263319969225, 3973.642372186488, 4026.577209393001, 73928.63035684841, 74964.99999999946, 75692.62153689197, 77965.0, 77976.22023779746, 11196.496157672924, 11405.030572401272, 11418.657440276806, 11476.196666233283, 11504.0, 20642.896785515975, 20644.69032964507, 20658.483537911674, 20663.276785312744, 20682.0, 8433.325333973267, 8589.78525536854, 8624.827503449897, 8844.027157012724, 8848.734537963872, 4764.142454358249, 4898.21628539432, 4967.602591792648, 5000.949990500048, 5123.205903085028, 3549.5385599872366, 3613.6928361089604, 3623.438367053111, 3628.510151129564, 3641.7814931104217, 594.0821430889287, 608.7899674612252, 611.6635850282327, 616.8735409241095, 634.9841253968688, 644.7002144002968, 674.3795707948601, 738.7266711316847, 745.1244787374812, 749.8875168724735, 9446.716598502057, 9851.901480985242, 10085.0, 10114.140298074599, 10160.237982151368, 589.1869220475716, 603.607655024229, 741.7292688168887, 750.2609929219714, 752.1162633905249, 4676.368690226844, 4894.8042078317185, 4931.654784165145, 4931.926021109686, 4974.656842652464, 110694.0, 110817.44591277154, 112405.43797280961, 113509.43245283721, 115620.42189788997, 91492.0, 93064.0, 93116.53441732748, 93399.53300233591, 93426.0, 79231.0, 80274.59862700765, 80291.59854200808, 80322.0, 80513.0, 9220.124088211878, 9302.906970930475, 9349.626014959598, 9363.297752668714, 9423.293253005915, 36335.63664363428, 44419.0, 49630.503694964034, 50436.495635044645, 51675.74162129165, 69541.3045869555, 73494.26505735089, 76294.61852690701, 76546.23453765392, 76964.0, 10932.836007459735, 11138.610148644759, 11147.186147186108, 11527.711807204552, 12579.119461637598, 12822.102452828212, 13615.25116118623, 13877.444902203799, 14001.081816061462, 14104.576862694135, 12248.816267755812, 12785.296808675612, 12902.032347573782, 12966.546170883974, 13009.674758131123, 12369.134160609032, 12774.297413642338, 12793.36033198355, 12903.806442903551, 13415.932920335335, 12698.873011269769, 12938.676533086747, 12990.155639883755, 13046.54337098197, 13085.542006029744, 10423.270371073952, 10538.093073668717, 10588.682339529827, 11056.281341712764, 11162.274452160584, 10939.890601093886, 11078.78111485333, 11169.944150279522, 11316.434178290889, 11345.602903898323], "value": 7390.220304571706, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 107.0, 112.0, 111.0, 112.0, 112.0, 110.0, 109.0, 111.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 158.0, 185.0, 128.0, 157.0, 157.0, 128.0, 194.0, 127.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 166.0, 162.0, 165.0, 166.0, 160.0, 163.0, 163.0, 160.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 157.0, 77.0, 75.0, 74.0, 76.0, 180.0, 75.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 152.0, 85.0, 85.0, 86.0, 141.0, 86.0, 86.0, 147.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 149.0, 148.0, 150.0, 148.0, 146.0, 149.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 96.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 54.0, 53.0, 55.0, 53.0, 53.0, 57.0, 52.0, 53.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 63.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 80.0, 80.0, 83.0, 81.0, 82.0, 80.0, 105.0, 87.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 128.0, 133.0, 127.0, 123.0, 125.0, 131.0, 133.0, 146.0, 128.0], "value": 129.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 164.0, 177.0, 163.0, 161.0, 165.0, 164.0, 163.0, 164.0], "value": 164.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 62.0, 63.0, 63.0], "value": 63.3, "unit": "score"}]}]} 12:33:48 INFO - Return code: 0 12:33:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:33:48 ERROR - # TBPL SUCCESS # 12:33:48 INFO - Running post-action listener: _resource_record_post_action 12:33:48 INFO - ##### 12:33:48 INFO - ##### Finished run-tests step (success) 12:33:48 INFO - ##### 12:33:48 INFO - Running post-run listener: _resource_record_post_run 12:33:48 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550838272; Read time: 28; Write time: 577788 12:33:48 INFO - TinderboxPrint: CPU usage
13.5% 12:33:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 12:33:48 INFO - TinderboxPrint: I/O write bytes / time
550,838,272 / 577,788 12:33:48 INFO - TinderboxPrint: CPU idle
8,233.4 (86.5%) 12:33:48 INFO - TinderboxPrint: CPU user
1,222.3 (12.8%) 12:33:48 INFO - TinderboxPrint: Swap in / out
0 / 0 12:33:48 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256094208; Read time: 0; Write time: 264632 12:33:48 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288251904; Read time: 28; Write time: 312388 12:33:48 INFO - Running post-run listener: _upload_blobber_files 12:33:48 INFO - Blob upload gear active. 12:33:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:33:48 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 12:33:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:33:49 INFO - (blobuploader) - INFO - Open directory for files ... 12:33:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:33:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:33:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:33:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:33:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:33:53 INFO - (blobuploader) - INFO - Done attempting. 12:33:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:33:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:33:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:33:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:33:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:33:54 INFO - (blobuploader) - INFO - Done attempting. 12:33:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:33:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:33:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:33:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:33:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:33:55 INFO - (blobuploader) - INFO - Done attempting. 12:33:55 INFO - (blobuploader) - INFO - Iteration through files over. 12:33:55 INFO - Return code: 0 12:33:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:33:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:33:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9c3e31cdfcdd5d5cc39add97b8433cdabda7a0e4035ce4637baeff9ecf9f761a98e857001cebae147d4af9b4354b79d8ff56bdab86d8f9304d39f5f33e6f787", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11e9bc858619e8dd8a34a4d69b9bc0a283c54204916ef174b99b379fbdad9be4c6c317ca21ec6764fd6d9a842863586c0d7d315cb5e1cd2b3584063ad1eed6dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5edee86fb0472266a9d49485e2ecd18f34bb2d2607689222449a5944c99be7d90cb2ba50ef45b27101c60a42ddaaaa365464307067af74825c85a6102425e91"} 12:33:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:33:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:33:55 INFO - Contents: 12:33:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9c3e31cdfcdd5d5cc39add97b8433cdabda7a0e4035ce4637baeff9ecf9f761a98e857001cebae147d4af9b4354b79d8ff56bdab86d8f9304d39f5f33e6f787", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11e9bc858619e8dd8a34a4d69b9bc0a283c54204916ef174b99b379fbdad9be4c6c317ca21ec6764fd6d9a842863586c0d7d315cb5e1cd2b3584063ad1eed6dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5edee86fb0472266a9d49485e2ecd18f34bb2d2607689222449a5944c99be7d90cb2ba50ef45b27101c60a42ddaaaa365464307067af74825c85a6102425e91"} 12:33:55 INFO - Running post-run listener: copy_logs_to_upload_dir 12:33:55 INFO - Copying logs to upload dir... 12:33:55 INFO - mkdir: /builds/slave/test/build/upload/logs 12:33:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.568110 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-06-16 12:33:54.934296) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 12:33:54.938331) ========= 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=eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033 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/sha512/e9c3e31cdfcdd5d5cc39add97b8433cdabda7a0e4035ce4637baeff9ecf9f761a98e857001cebae147d4af9b4354b79d8ff56bdab86d8f9304d39f5f33e6f787", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11e9bc858619e8dd8a34a4d69b9bc0a283c54204916ef174b99b379fbdad9be4c6c317ca21ec6764fd6d9a842863586c0d7d315cb5e1cd2b3584063ad1eed6dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5edee86fb0472266a9d49485e2ecd18f34bb2d2607689222449a5944c99be7d90cb2ba50ef45b27101c60a42ddaaaa365464307067af74825c85a6102425e91"} build_url:https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011230 build_url: 'https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/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/sha512/e9c3e31cdfcdd5d5cc39add97b8433cdabda7a0e4035ce4637baeff9ecf9f761a98e857001cebae147d4af9b4354b79d8ff56bdab86d8f9304d39f5f33e6f787", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/11e9bc858619e8dd8a34a4d69b9bc0a283c54204916ef174b99b379fbdad9be4c6c317ca21ec6764fd6d9a842863586c0d7d315cb5e1cd2b3584063ad1eed6dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5edee86fb0472266a9d49485e2ecd18f34bb2d2607689222449a5944c99be7d90cb2ba50ef45b27101c60a42ddaaaa365464307067af74825c85a6102425e91"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 12:33:54.964808) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:33:54.965247) ========= 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=eca2ab57546de7b41f256b19000001ef-1466101256.823443-256916033 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004378 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:33:55.050681) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 12:33:55.051014) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 12:33:55.051338) ========= ========= Total master_lag: 0.18 =========