builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1467060493.29 results: success (0) buildid: 20160627131816 builduid: dbb5fff3dfaa4e3fabcdf876a40f7863 revision: b27893d49f113acfbfe2e7e46b45b4771fcef9b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 13:48:13.287045) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 13:48:13.287918) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 13:48:13.288497) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 13:48:13.306662) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:48:13.307343) ========= 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=232498196343f89f466a4a9a000001c8-1467060493.211297-172304931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 13:48:13-- 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% 16.5M=0.001s 2016-06-27 13:48:14 (16.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079940 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:48:13.403291) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:48:13.403627) ========= 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=232498196343f89f466a4a9a000001c8-1467060493.211297-172304931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015722 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:48:13.453831) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:48:13.454243) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b27893d49f113acfbfe2e7e46b45b4771fcef9b8 --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 b27893d49f113acfbfe2e7e46b45b4771fcef9b8 --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=232498196343f89f466a4a9a000001c8-1467060493.211297-172304931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 13:48:14,159 truncating revision to first 12 chars 2016-06-27 13:48:14,159 Setting DEBUG logging. 2016-06-27 13:48:14,159 attempt 1/10 2016-06-27 13:48:14,159 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b27893d49f11?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 13:48:14,462 unpacking tar archive at: fx-team-b27893d49f11/testing/mozharness/ program finished with exit code 0 elapsedTime=0.619938 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 13:48:14.088015) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 13:48:14.088427) ========= script_repo_revision: b27893d49f113acfbfe2e7e46b45b4771fcef9b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 13:48:14.088861) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 13:48:14.089186) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 13:48:14.100746) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-27 13:48:14.101167) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1467060493.211297-172304931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:48:14 INFO - MultiFileLogger online at 20160627 13:48:14 in /builds/slave/test 13:48:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:48:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:48:14 INFO - {'append_to_log': False, 13:48:14 INFO - 'base_work_dir': '/builds/slave/test', 13:48:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:48:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:48:14 INFO - 'branch': 'Fx-Team-Non-PGO', 13:48:14 INFO - 'buildbot_json_path': 'buildprops.json', 13:48:14 INFO - 'config_files': ('talos/linux_config.py',), 13:48:14 INFO - 'default_actions': ('clobber', 13:48:14 INFO - 'read-buildbot-config', 13:48:14 INFO - 'download-and-extract', 13:48:14 INFO - 'populate-webroot', 13:48:14 INFO - 'create-virtualenv', 13:48:14 INFO - 'install', 13:48:14 INFO - 'run-tests'), 13:48:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:48:14 INFO - 'download_minidump_stackwalk': True, 13:48:14 INFO - 'download_symbols': 'ondemand', 13:48:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:48:14 INFO - 'tooltool.py': '/tools/tooltool.py', 13:48:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:48:14 INFO - '/tools/misc-python/virtualenv.py')}, 13:48:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:48:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:48:14 INFO - 'installer_path': 'installer.exe', 13:48:14 INFO - 'log_level': 'info', 13:48:14 INFO - 'log_name': 'talos', 13:48:14 INFO - 'log_to_console': True, 13:48:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:48:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:48:14 INFO - 'opt_config_files': (), 13:48:14 INFO - 'pip_index': False, 13:48:14 INFO - 'sps_profile': False, 13:48:14 INFO - 'sps_profile_interval': 0, 13:48:14 INFO - 'suite': 'dromaeojs-e10s', 13:48:14 INFO - 'system_bits': '32', 13:48:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:48:14 INFO - 'title': 'talos-linux64-ix-025', 13:48:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:48:14 INFO - 'use_talos_json': True, 13:48:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:48:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:48:14 INFO - 'work_dir': 'build'} 13:48:14 INFO - ##### 13:48:14 INFO - ##### Running clobber step. 13:48:14 INFO - ##### 13:48:14 INFO - Running pre-action listener: _resource_record_pre_action 13:48:14 INFO - Running main action method: clobber 13:48:14 INFO - rmtree: /builds/slave/test/build 13:48:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:48:15 INFO - Running post-action listener: _resource_record_post_action 13:48:15 INFO - ##### 13:48:15 INFO - ##### Finished clobber step (success) 13:48:15 INFO - ##### 13:48:15 INFO - ##### 13:48:15 INFO - ##### Running read-buildbot-config step. 13:48:15 INFO - ##### 13:48:15 INFO - Running pre-action listener: _resource_record_pre_action 13:48:15 INFO - Running main action method: read_buildbot_config 13:48:15 INFO - Using buildbot properties: 13:48:15 INFO - { 13:48:15 INFO - "project": "", 13:48:15 INFO - "product": "firefox", 13:48:15 INFO - "script_repo_revision": "production", 13:48:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:48:15 INFO - "repository": "", 13:48:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 13:48:15 INFO - "buildid": "20160627131816", 13:48:15 INFO - "pgo_build": "False", 13:48:15 INFO - "basedir": "/builds/slave/test", 13:48:15 INFO - "buildnumber": 1388, 13:48:15 INFO - "slavename": "talos-linux64-ix-025", 13:48:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:48:15 INFO - "platform": "ubuntu64_hw", 13:48:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:48:15 INFO - "branch": "fx-team", 13:48:15 INFO - "repo_path": "integration/fx-team", 13:48:15 INFO - "revision": "b27893d49f113acfbfe2e7e46b45b4771fcef9b8", 13:48:15 INFO - "stage_platform": "linux64", 13:48:15 INFO - "builduid": "dbb5fff3dfaa4e3fabcdf876a40f7863", 13:48:15 INFO - "slavebuilddir": "test" 13:48:15 INFO - } 13:48:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:48:15 INFO - Running post-action listener: _resource_record_post_action 13:48:15 INFO - ##### 13:48:15 INFO - ##### Finished read-buildbot-config step (success) 13:48:15 INFO - ##### 13:48:15 INFO - ##### 13:48:15 INFO - ##### Running download-and-extract step. 13:48:15 INFO - ##### 13:48:15 INFO - Running pre-action listener: _resource_record_pre_action 13:48:15 INFO - Running main action method: download_and_extract 13:48:15 INFO - mkdir: /builds/slave/test/build/tests 13:48:15 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')]} 13:48:15 INFO - https://queue.taskcluster.net/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:48:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:48:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:48:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJ93TSgvTFSIfWZULTVKcg/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 13:48:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJ93TSgvTFSIfWZULTVKcg/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 13:48:16 INFO - Downloaded 1361 bytes. 13:48:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:48:16 INFO - Using the following test package requirements: 13:48:16 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:48:16 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:48:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:48:16 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:48:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:48:16 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:48:16 INFO - u'jsshell-linux-x86_64.zip'], 13:48:16 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:48:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:48:16 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:48:16 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:48:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:48:16 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:48:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:48:16 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:48:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:48:16 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:48:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:48:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:16 INFO - https://queue.taskcluster.net/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:48:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:48:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:48:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJ93TSgvTFSIfWZULTVKcg/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 13:48:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJ93TSgvTFSIfWZULTVKcg/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 13:48:18 INFO - Downloaded 22713224 bytes. 13:48:18 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'] 13:48:18 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 13:48:19 INFO - Return code: 0 13:48:19 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 13:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:19 INFO - https://queue.taskcluster.net/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:48:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:48:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:48:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJ93TSgvTFSIfWZULTVKcg/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 13:48:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJ93TSgvTFSIfWZULTVKcg/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 13:48:35 INFO - Downloaded 22713224 bytes. 13:48:35 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'] 13:48:35 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 13:48:36 INFO - Return code: 0 13:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:36 INFO - https://queue.taskcluster.net/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:48:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:48:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:48:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJ93TSgvTFSIfWZULTVKcg/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 13:48:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJ93TSgvTFSIfWZULTVKcg/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 13:48:38 INFO - Downloaded 14405245 bytes. 13:48:38 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'] 13:48:38 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 13:48:38 INFO - Return code: 0 13:48: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')]} 13:48:38 INFO - https://queue.taskcluster.net/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:48:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:48:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:48:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJ93TSgvTFSIfWZULTVKcg/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 13:48:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NJ93TSgvTFSIfWZULTVKcg/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 13:48:40 INFO - Downloaded 56287531 bytes. 13:48:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:48:40 INFO - mkdir: /builds/slave/test/properties 13:48:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:48:40 INFO - Writing to file /builds/slave/test/properties/build_url 13:48:40 INFO - Contents: 13:48:40 INFO - build_url:https://queue.taskcluster.net/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:48:41 INFO - Running post-action listener: _resource_record_post_action 13:48:41 INFO - Running post-action listener: set_extra_try_arguments 13:48:41 INFO - ##### 13:48:41 INFO - ##### Finished download-and-extract step (success) 13:48:41 INFO - ##### 13:48:41 INFO - ##### 13:48:41 INFO - ##### Running populate-webroot step. 13:48:41 INFO - ##### 13:48:41 INFO - Running pre-action listener: _resource_record_pre_action 13:48:41 INFO - Running main action method: populate_webroot 13:48:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:48:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:48:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:48:41 INFO - '--tppagecycles', 13:48:41 INFO - '7'], 13:48:41 INFO - 'tests': ['tsvgm']}}, 13:48:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:48:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:48:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:48:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:48:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:48:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:48:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:41 INFO - 'talos_options': ['--disable-e10s'], 13:48:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:48:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:48:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:41 INFO - 'talos_options': ['--disable-e10s'], 13:48:41 INFO - 'tests': ['damp', 'tps']}, 13:48:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:41 INFO - 'tests': ['damp', 'tps']}, 13:48:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:48:41 INFO - 'tests': ['dromaeo_dom']}, 13:48:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:48:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:48:41 INFO - 'tests': ['basic_compositor_video']}, 13:48:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:48:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:48:41 INFO - 'tests': ['a11yr', 13:48:41 INFO - 'ts_paint', 13:48:41 INFO - 'tpaint', 13:48:41 INFO - 'sessionrestore', 13:48:41 INFO - 'sessionrestore_no_auto_restore', 13:48:41 INFO - 'tabpaint']}, 13:48:41 INFO - 'other-e10s': {'tests': ['a11yr', 13:48:41 INFO - 'ts_paint', 13:48:41 INFO - 'tpaint', 13:48:41 INFO - 'sessionrestore', 13:48:41 INFO - 'sessionrestore_no_auto_restore', 13:48:41 INFO - 'tabpaint']}, 13:48:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:48:41 INFO - 'ts_paint', 13:48:41 INFO - 'tpaint', 13:48:41 INFO - 'sessionrestore', 13:48:41 INFO - 'sessionrestore_no_auto_restore', 13:48:41 INFO - 'tabpaint']}, 13:48:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:48:41 INFO - 'ts_paint', 13:48:41 INFO - 'tpaint', 13:48:41 INFO - 'sessionrestore', 13:48:41 INFO - 'sessionrestore_no_auto_restore', 13:48:41 INFO - 'tabpaint']}, 13:48:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:48:41 INFO - 'tests': ['a11yr', 13:48:41 INFO - 'ts_paint', 13:48:41 INFO - 'tpaint', 13:48:41 INFO - 'sessionrestore', 13:48:41 INFO - 'sessionrestore_no_auto_restore', 13:48:41 INFO - 'tabpaint']}, 13:48:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:48:41 INFO - 'tests': ['a11yr', 13:48:41 INFO - 'ts_paint', 13:48:41 INFO - 'tpaint', 13:48:41 INFO - 'sessionrestore', 13:48:41 INFO - 'sessionrestore_no_auto_restore', 13:48:41 INFO - 'tabpaint']}, 13:48:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:48:41 INFO - 'tests': ['tsvgx', 13:48:41 INFO - 'tsvgr_opacity', 13:48:41 INFO - 'tart', 13:48:41 INFO - 'tscrollx', 13:48:41 INFO - 'cart']}, 13:48:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:48:41 INFO - 'tsvgr_opacity', 13:48:41 INFO - 'tart', 13:48:41 INFO - 'tscrollx', 13:48:41 INFO - 'cart']}, 13:48:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:41 INFO - 'talos_options': ['--disable-e10s'], 13:48:41 INFO - 'tests': ['tp5o']}, 13:48:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:41 INFO - 'tests': ['tp5o']}, 13:48:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:41 INFO - 'talos_options': ['--disable-e10s', 13:48:41 INFO - '--xperf_path', 13:48:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:48:41 INFO - 'tests': ['tp5n']}, 13:48:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:41 INFO - 'talos_options': ['--xperf_path', 13:48:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:48:41 INFO - 'tests': ['tp5n']}}, 13:48:41 INFO - 'talos.zip': {'path': '', 13:48:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:48:41 INFO - Running post-action listener: _resource_record_post_action 13:48:41 INFO - ##### 13:48:41 INFO - ##### Finished populate-webroot step (success) 13:48:41 INFO - ##### 13:48:41 INFO - ##### 13:48:41 INFO - ##### Running create-virtualenv step. 13:48:41 INFO - ##### 13:48:41 INFO - Running pre-action listener: _resource_record_pre_action 13:48:41 INFO - Running main action method: create_virtualenv 13:48:41 INFO - Creating virtualenv /builds/slave/test/build/venv 13:48:41 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 13:48:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:48:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:48:41 INFO - Using real prefix '/usr' 13:48:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:48:42 INFO - Installing distribute.............................................................................................................................................................................................done. 13:48:44 INFO - Installing pip.................done. 13:48:44 INFO - Return code: 0 13:48:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:48: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')]} 13:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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')]} 13:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:44 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 0x7f8aee65af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f6f0>, '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 0xd805f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80aa0>, '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': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', '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 13:48:44 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 13:48:44 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 13:48:44 INFO - Using env: {'DISPLAY': ':0', 13:48:44 INFO - 'HOME': '/home/cltbld', 13:48:44 INFO - 'LANG': 'en_US.UTF-8', 13:48:44 INFO - 'LANGUAGE': 'en_US:en', 13:48:44 INFO - 'LOGNAME': 'cltbld', 13:48:44 INFO - 'MAIL': '/var/mail/cltbld', 13:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:44 INFO - 'MOZ_NO_REMOTE': '1', 13:48:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:44 INFO - 'NO_EM_RESTART': '1', 13:48:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:44 INFO - 'PWD': '/builds/slave/test', 13:48:44 INFO - 'SHELL': '/bin/bash', 13:48:44 INFO - 'SHLVL': '1', 13:48:44 INFO - 'TERM': 'linux', 13:48:44 INFO - 'TMOUT': '86400', 13:48:44 INFO - 'USER': 'cltbld', 13:48:44 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', 13:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:44 INFO - '_': '/tools/buildbot/bin/python'} 13:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:44 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 13:48:44 INFO - Cleaning up... 13:48:44 INFO - Return code: 0 13:48:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:48: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')]} 13:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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')]} 13:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:44 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 0x7f8aee65af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f6f0>, '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 0xd805f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80aa0>, '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': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', '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 13:48:44 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 13:48:44 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 13:48:44 INFO - Using env: {'DISPLAY': ':0', 13:48:44 INFO - 'HOME': '/home/cltbld', 13:48:44 INFO - 'LANG': 'en_US.UTF-8', 13:48:44 INFO - 'LANGUAGE': 'en_US:en', 13:48:44 INFO - 'LOGNAME': 'cltbld', 13:48:44 INFO - 'MAIL': '/var/mail/cltbld', 13:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:44 INFO - 'MOZ_NO_REMOTE': '1', 13:48:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:44 INFO - 'NO_EM_RESTART': '1', 13:48:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:44 INFO - 'PWD': '/builds/slave/test', 13:48:44 INFO - 'SHELL': '/bin/bash', 13:48:44 INFO - 'SHLVL': '1', 13:48:44 INFO - 'TERM': 'linux', 13:48:44 INFO - 'TMOUT': '86400', 13:48:44 INFO - 'USER': 'cltbld', 13:48:44 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', 13:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:44 INFO - '_': '/tools/buildbot/bin/python'} 13:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:44 INFO - Downloading/unpacking psutil>=3.1.1 13:48:44 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 13:48:44 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 13:48:44 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 13:48:44 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 13:48:44 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 13:48:44 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 13:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:48:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:48:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:48:46 INFO - Installing collected packages: psutil 13:48:46 INFO - Running setup.py install for psutil 13:48:46 INFO - building 'psutil._psutil_linux' extension 13:48:46 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 13:48:46 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 13:48:47 INFO - building 'psutil._psutil_posix' extension 13:48:47 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 13:48:47 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 13:48:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:48:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:48:47 INFO - Successfully installed psutil 13:48:47 INFO - Cleaning up... 13:48:47 INFO - Return code: 0 13:48:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:48: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')]} 13:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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')]} 13:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:47 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 0x7f8aee65af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f6f0>, '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 0xd805f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80aa0>, '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': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', '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 13:48:47 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 13:48:47 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 13:48:47 INFO - Using env: {'DISPLAY': ':0', 13:48:47 INFO - 'HOME': '/home/cltbld', 13:48:47 INFO - 'LANG': 'en_US.UTF-8', 13:48:47 INFO - 'LANGUAGE': 'en_US:en', 13:48:47 INFO - 'LOGNAME': 'cltbld', 13:48:47 INFO - 'MAIL': '/var/mail/cltbld', 13:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:47 INFO - 'MOZ_NO_REMOTE': '1', 13:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:47 INFO - 'NO_EM_RESTART': '1', 13:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:47 INFO - 'PWD': '/builds/slave/test', 13:48:47 INFO - 'SHELL': '/bin/bash', 13:48:47 INFO - 'SHLVL': '1', 13:48:47 INFO - 'TERM': 'linux', 13:48:47 INFO - 'TMOUT': '86400', 13:48:47 INFO - 'USER': 'cltbld', 13:48:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', 13:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:47 INFO - '_': '/tools/buildbot/bin/python'} 13:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:48:47 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 13:48:47 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 13:48:47 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 13:48:47 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 13:48:47 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 13:48:47 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 13:48:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:48:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:48:49 INFO - Installing collected packages: mozsystemmonitor 13:48:49 INFO - Running setup.py install for mozsystemmonitor 13:48:49 INFO - Successfully installed mozsystemmonitor 13:48:49 INFO - Cleaning up... 13:48:49 INFO - Return code: 0 13:48:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8aee65af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f6f0>, '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 0xd805f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80aa0>, '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': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', '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 13:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:48:49 INFO - Using env: {'DISPLAY': ':0', 13:48:49 INFO - 'HOME': '/home/cltbld', 13:48:49 INFO - 'LANG': 'en_US.UTF-8', 13:48:49 INFO - 'LANGUAGE': 'en_US:en', 13:48:49 INFO - 'LOGNAME': 'cltbld', 13:48:49 INFO - 'MAIL': '/var/mail/cltbld', 13:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:49 INFO - 'MOZ_NO_REMOTE': '1', 13:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:49 INFO - 'NO_EM_RESTART': '1', 13:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:49 INFO - 'PWD': '/builds/slave/test', 13:48:49 INFO - 'SHELL': '/bin/bash', 13:48:49 INFO - 'SHLVL': '1', 13:48:49 INFO - 'TERM': 'linux', 13:48:49 INFO - 'TMOUT': '86400', 13:48:49 INFO - 'USER': 'cltbld', 13:48:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', 13:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:49 INFO - '_': '/tools/buildbot/bin/python'} 13:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:49 INFO - Downloading/unpacking jsonschema==2.5.1 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:48:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:48:51 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 13:48:51 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 13:48:51 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 13:48:51 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 13:48:51 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 13:48:51 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 13:48:51 INFO - Downloading functools32-3.2.3-2.tar.gz 13:48:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:48:51 INFO - warning: no files found matching '*.txt' 13:48:51 INFO - no previously-included directories found matching 'build' 13:48:51 INFO - no previously-included directories found matching 'dist' 13:48:51 INFO - no previously-included directories found matching '.git*' 13:48:51 INFO - Installing collected packages: jsonschema, functools32 13:48:52 INFO - Running setup.py install for functools32 13:48:52 INFO - warning: no files found matching '*.txt' 13:48:52 INFO - no previously-included directories found matching 'build' 13:48:52 INFO - no previously-included directories found matching 'dist' 13:48:52 INFO - no previously-included directories found matching '.git*' 13:48:52 INFO - Successfully installed jsonschema functools32 13:48:52 INFO - Cleaning up... 13:48:52 INFO - Return code: 0 13:48:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8aee65af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f6f0>, '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 0xd805f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80aa0>, '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': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', '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 13:48:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:48:52 INFO - Using env: {'DISPLAY': ':0', 13:48:52 INFO - 'HOME': '/home/cltbld', 13:48:52 INFO - 'LANG': 'en_US.UTF-8', 13:48:52 INFO - 'LANGUAGE': 'en_US:en', 13:48:52 INFO - 'LOGNAME': 'cltbld', 13:48:52 INFO - 'MAIL': '/var/mail/cltbld', 13:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:52 INFO - 'MOZ_NO_REMOTE': '1', 13:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:52 INFO - 'NO_EM_RESTART': '1', 13:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:52 INFO - 'PWD': '/builds/slave/test', 13:48:52 INFO - 'SHELL': '/bin/bash', 13:48:52 INFO - 'SHLVL': '1', 13:48:52 INFO - 'TERM': 'linux', 13:48:52 INFO - 'TMOUT': '86400', 13:48:52 INFO - 'USER': 'cltbld', 13:48:52 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', 13:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:52 INFO - '_': '/tools/buildbot/bin/python'} 13:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:52 INFO - Downloading/unpacking blobuploader==1.2.4 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:54 INFO - Downloading blobuploader-1.2.4.tar.gz 13:48:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:48:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:48:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48: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 13:48:54 INFO - Downloading docopt-0.6.1.tar.gz 13:48:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:48:55 INFO - Installing collected packages: blobuploader, requests, docopt 13:48:55 INFO - Running setup.py install for blobuploader 13:48:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:48:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:48:55 INFO - Running setup.py install for requests 13:48:55 INFO - Running setup.py install for docopt 13:48:55 INFO - Successfully installed blobuploader requests docopt 13:48:55 INFO - Cleaning up... 13:48:55 INFO - Return code: 0 13:48:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:48:55 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')]} 13:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:55 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')]} 13:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:55 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 0x7f8aee65af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f6f0>, '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 0xd805f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80aa0>, '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': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', '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 13:48:55 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 13:48:55 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 13:48:55 INFO - Using env: {'DISPLAY': ':0', 13:48:55 INFO - 'HOME': '/home/cltbld', 13:48:55 INFO - 'LANG': 'en_US.UTF-8', 13:48:55 INFO - 'LANGUAGE': 'en_US:en', 13:48:55 INFO - 'LOGNAME': 'cltbld', 13:48:55 INFO - 'MAIL': '/var/mail/cltbld', 13:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:55 INFO - 'MOZ_NO_REMOTE': '1', 13:48:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:55 INFO - 'NO_EM_RESTART': '1', 13:48:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:55 INFO - 'PWD': '/builds/slave/test', 13:48:55 INFO - 'SHELL': '/bin/bash', 13:48:55 INFO - 'SHLVL': '1', 13:48:55 INFO - 'TERM': 'linux', 13:48:55 INFO - 'TMOUT': '86400', 13:48:55 INFO - 'USER': 'cltbld', 13:48:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', 13:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:55 INFO - '_': '/tools/buildbot/bin/python'} 13:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:48:55 INFO - Running setup.py (path:/tmp/pip-s56K4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:48:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:48:55 INFO - Running setup.py (path:/tmp/pip-ptQpzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:48:56 INFO - Running setup.py (path:/tmp/pip-kMPOGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:48:56 INFO - Running setup.py (path:/tmp/pip-JAOwCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:48:56 INFO - Running setup.py (path:/tmp/pip-69k_dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:48:56 INFO - Running setup.py (path:/tmp/pip-Q5psow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:48:56 INFO - Running setup.py (path:/tmp/pip-mq6UXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:48:56 INFO - Running setup.py (path:/tmp/pip-C5jBzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:48:56 INFO - Running setup.py (path:/tmp/pip-RnBDZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:48:56 INFO - Running setup.py (path:/tmp/pip-n8jX07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:48:56 INFO - Running setup.py (path:/tmp/pip-Ep7vLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:48:56 INFO - Running setup.py (path:/tmp/pip-CUdvOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:48:56 INFO - Running setup.py (path:/tmp/pip-j1dkhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:48:56 INFO - Running setup.py (path:/tmp/pip-du8qsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:48:56 INFO - Running setup.py (path:/tmp/pip-iTIXJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:48:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:48:56 INFO - Running setup.py (path:/tmp/pip-n9JhA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:48:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:48:57 INFO - Running setup.py (path:/tmp/pip-LkEDxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:48:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:48:57 INFO - Running setup.py install for manifestparser 13:48:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:48:57 INFO - Running setup.py install for mozcrash 13:48:57 INFO - Running setup.py install for mozdebug 13:48:57 INFO - Running setup.py install for mozdevice 13:48:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:48:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:48:57 INFO - Running setup.py install for mozfile 13:48:57 INFO - Running setup.py install for mozhttpd 13:48:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:48:57 INFO - Running setup.py install for mozinfo 13:48:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:48:57 INFO - Running setup.py install for mozInstall 13:48:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:48:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:48:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:48:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:48:57 INFO - Running setup.py install for mozleak 13:48:58 INFO - Running setup.py install for mozlog 13:48:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:48:58 INFO - Running setup.py install for moznetwork 13:48:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:48:58 INFO - Running setup.py install for mozprocess 13:48:58 INFO - Running setup.py install for mozprofile 13:48:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:48:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:48:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:48:58 INFO - Running setup.py install for mozrunner 13:48:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:48:58 INFO - Running setup.py install for mozscreenshot 13:48:58 INFO - Running setup.py install for moztest 13:48:58 INFO - Running setup.py install for mozversion 13:48:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:48:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:48:58 INFO - Cleaning up... 13:48:58 INFO - Return code: 0 13:48:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:58 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 0x7f8aee65af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f6f0>, '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 0xd805f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80aa0>, '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': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', '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 13:48:58 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 13:48:58 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 13:48:58 INFO - Using env: {'DISPLAY': ':0', 13:48:58 INFO - 'HOME': '/home/cltbld', 13:48:58 INFO - 'LANG': 'en_US.UTF-8', 13:48:58 INFO - 'LANGUAGE': 'en_US:en', 13:48:58 INFO - 'LOGNAME': 'cltbld', 13:48:58 INFO - 'MAIL': '/var/mail/cltbld', 13:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:58 INFO - 'MOZ_NO_REMOTE': '1', 13:48:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:58 INFO - 'NO_EM_RESTART': '1', 13:48:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:58 INFO - 'PWD': '/builds/slave/test', 13:48:58 INFO - 'SHELL': '/bin/bash', 13:48:58 INFO - 'SHLVL': '1', 13:48:58 INFO - 'TERM': 'linux', 13:48:58 INFO - 'TMOUT': '86400', 13:48:58 INFO - 'USER': 'cltbld', 13:48:58 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', 13:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:58 INFO - '_': '/tools/buildbot/bin/python'} 13:48:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:48:59 INFO - Running setup.py (path:/tmp/pip-Y0oZ_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:48:59 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)) 13:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:48:59 INFO - Running setup.py (path:/tmp/pip-imEbRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:48:59 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)) 13:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:48:59 INFO - Running setup.py (path:/tmp/pip-LxN4Ai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:48:59 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)) 13:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:48:59 INFO - Running setup.py (path:/tmp/pip-ERXnWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:48:59 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)) 13:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:48:59 INFO - Running setup.py (path:/tmp/pip-p6C0CD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:48:59 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)) 13:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:48:59 INFO - Running setup.py (path:/tmp/pip-uR7kg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:48:59 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)) 13:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:48:59 INFO - Running setup.py (path:/tmp/pip-2x7I5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:48:59 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)) 13:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:48:59 INFO - Running setup.py (path:/tmp/pip-tZLtyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:48:59 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)) 13:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:48:59 INFO - Running setup.py (path:/tmp/pip-k1OE9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:48:59 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)) 13:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:48:59 INFO - Running setup.py (path:/tmp/pip-J2xmBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:48:59 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)) 13:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:48:59 INFO - Running setup.py (path:/tmp/pip-BoAy2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:48:59 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)) 13:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:48:59 INFO - Running setup.py (path:/tmp/pip-DqxLsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:48:59 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)) 13:48:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:49:00 INFO - Running setup.py (path:/tmp/pip-kMNhkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:49:00 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)) 13:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:49:00 INFO - Running setup.py (path:/tmp/pip-6KKI9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:49:00 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)) 13:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:00 INFO - Running setup.py (path:/tmp/pip-7M_u96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:00 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)) 13:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:49:00 INFO - Running setup.py (path:/tmp/pip-fBKqV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:49:00 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)) 13:49:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:49:00 INFO - Running setup.py (path:/tmp/pip-BWrfsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:49:00 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)) 13:49:00 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)) 13:49:00 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)) 13:49:00 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)) 13:49:00 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)) 13:49:00 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)) 13:49:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:49:00 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 13:49:00 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 13:49:00 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 13:49:00 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 13:49:00 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 13:49:00 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 13:49:02 INFO - Downloading blessings-1.6.tar.gz 13:49:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:49:02 INFO - Installing collected packages: blessings 13:49:02 INFO - Running setup.py install for blessings 13:49:02 INFO - Successfully installed blessings 13:49:02 INFO - Cleaning up... 13:49:02 INFO - Return code: 0 13:49:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:49:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:49:02 INFO - Reading from file tmpfile_stdout 13:49:02 INFO - Current package versions: 13:49:02 INFO - argparse == 1.2.1 13:49:02 INFO - blessings == 1.6 13:49:02 INFO - blobuploader == 1.2.4 13:49:02 INFO - docopt == 0.6.1 13:49:02 INFO - functools32 == 3.2.3-2 13:49:02 INFO - jsonschema == 2.5.1 13:49:02 INFO - manifestparser == 1.1 13:49:02 INFO - mozInstall == 1.12 13:49:02 INFO - mozcrash == 0.17 13:49:02 INFO - mozdebug == 0.1 13:49:02 INFO - mozdevice == 0.48 13:49:02 INFO - mozfile == 1.2 13:49:02 INFO - mozhttpd == 0.7 13:49:02 INFO - mozinfo == 0.9 13:49:02 INFO - mozleak == 0.1 13:49:02 INFO - mozlog == 3.2 13:49:02 INFO - moznetwork == 0.27 13:49:02 INFO - mozprocess == 0.22 13:49:02 INFO - mozprofile == 0.28 13:49:02 INFO - mozrunner == 6.11 13:49:02 INFO - mozscreenshot == 0.1 13:49:02 INFO - mozsystemmonitor == 0.3 13:49:02 INFO - moztest == 0.7 13:49:02 INFO - mozversion == 1.4 13:49:02 INFO - psutil == 3.1.1 13:49:02 INFO - requests == 1.2.3 13:49:02 INFO - wsgiref == 0.1.2 13:49:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:02 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')]} 13:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:02 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')]} 13:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:02 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 0x7f8aee65af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f6f0>, '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 0xd805f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80aa0>, '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': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', '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 13:49:02 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 13:49:02 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 13:49:02 INFO - Using env: {'DISPLAY': ':0', 13:49:02 INFO - 'HOME': '/home/cltbld', 13:49:02 INFO - 'LANG': 'en_US.UTF-8', 13:49:02 INFO - 'LANGUAGE': 'en_US:en', 13:49:02 INFO - 'LOGNAME': 'cltbld', 13:49:02 INFO - 'MAIL': '/var/mail/cltbld', 13:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:02 INFO - 'MOZ_NO_REMOTE': '1', 13:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:02 INFO - 'NO_EM_RESTART': '1', 13:49:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:02 INFO - 'PWD': '/builds/slave/test', 13:49:02 INFO - 'SHELL': '/bin/bash', 13:49:02 INFO - 'SHLVL': '1', 13:49:02 INFO - 'TERM': 'linux', 13:49:02 INFO - 'TMOUT': '86400', 13:49:02 INFO - 'USER': 'cltbld', 13:49:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', 13:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:02 INFO - '_': '/tools/buildbot/bin/python'} 13:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:02 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)) 13:49:02 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)) 13:49:02 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)) 13:49:02 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)) 13:49:02 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)) 13:49:02 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)) 13:49:02 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)) 13:49:02 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)) 13:49:02 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)) 13:49:02 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)) 13:49:02 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)) 13:49:02 INFO - Cleaning up... 13:49:02 INFO - Return code: 0 13:49:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:49:02 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')]} 13:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:02 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')]} 13:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:02 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 0x7f8aee65af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f6f0>, '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 0xd805f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80aa0>, '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': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', '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 13:49:02 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 13:49:02 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 13:49:02 INFO - Using env: {'DISPLAY': ':0', 13:49:02 INFO - 'HOME': '/home/cltbld', 13:49:02 INFO - 'LANG': 'en_US.UTF-8', 13:49:02 INFO - 'LANGUAGE': 'en_US:en', 13:49:02 INFO - 'LOGNAME': 'cltbld', 13:49:02 INFO - 'MAIL': '/var/mail/cltbld', 13:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:02 INFO - 'MOZ_NO_REMOTE': '1', 13:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:02 INFO - 'NO_EM_RESTART': '1', 13:49:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:02 INFO - 'PWD': '/builds/slave/test', 13:49:02 INFO - 'SHELL': '/bin/bash', 13:49:02 INFO - 'SHLVL': '1', 13:49:02 INFO - 'TERM': 'linux', 13:49:02 INFO - 'TMOUT': '86400', 13:49:02 INFO - 'USER': 'cltbld', 13:49:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', 13:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:02 INFO - '_': '/tools/buildbot/bin/python'} 13:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:49:03 INFO - Cleaning up... 13:49:03 INFO - Return code: 0 13:49:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8aee65af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xcf0480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd7f6f0>, '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 0xd805f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80aa0>, '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': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', '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 13:49:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:49:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:49:03 INFO - Using env: {'DISPLAY': ':0', 13:49:03 INFO - 'HOME': '/home/cltbld', 13:49:03 INFO - 'LANG': 'en_US.UTF-8', 13:49:03 INFO - 'LANGUAGE': 'en_US:en', 13:49:03 INFO - 'LOGNAME': 'cltbld', 13:49:03 INFO - 'MAIL': '/var/mail/cltbld', 13:49:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:03 INFO - 'MOZ_NO_REMOTE': '1', 13:49:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:03 INFO - 'NO_EM_RESTART': '1', 13:49:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:03 INFO - 'PWD': '/builds/slave/test', 13:49:03 INFO - 'SHELL': '/bin/bash', 13:49:03 INFO - 'SHLVL': '1', 13:49:03 INFO - 'TERM': 'linux', 13:49:03 INFO - 'TMOUT': '86400', 13:49:03 INFO - 'USER': 'cltbld', 13:49:03 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', 13:49:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:03 INFO - '_': '/tools/buildbot/bin/python'} 13:49:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:03 INFO - Downloading/unpacking flake8 13:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:49:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:49:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:49:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:49:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:49:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:49:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:49:06 INFO - no previously-included directories found matching 'docs/_build' 13:49:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:49:06 INFO - Running setup.py install for pep8 13:49:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:49:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:49:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:49:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:49:06 INFO - no previously-included directories found matching 'docs/_build' 13:49:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:49:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:49:06 INFO - Cleaning up... 13:49:06 INFO - Return code: 0 13:49:06 INFO - Running post-action listener: _resource_record_post_action 13:49:06 INFO - Running post-action listener: _start_resource_monitoring 13:49:06 INFO - Starting resource monitoring. 13:49:06 INFO - ##### 13:49:06 INFO - ##### Finished create-virtualenv step (success) 13:49:06 INFO - ##### 13:49:06 INFO - ##### 13:49:06 INFO - ##### Running install step. 13:49:06 INFO - ##### 13:49:06 INFO - Running pre-action listener: _resource_record_pre_action 13:49:06 INFO - Running main action method: install 13:49:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:49:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:49:06 INFO - Reading from file tmpfile_stdout 13:49:06 INFO - Detecting whether we're running mozinstall >=1.0... 13:49:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:49:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:49:06 INFO - Reading from file tmpfile_stdout 13:49:06 INFO - Output received: 13:49:06 INFO - Usage: mozinstall [options] installer 13:49:06 INFO - Options: 13:49:06 INFO - -h, --help show this help message and exit 13:49:06 INFO - -d DEST, --destination=DEST 13:49:06 INFO - Directory to install application into. [default: 13:49:06 INFO - "/builds/slave/test"] 13:49:06 INFO - --app=APP Application being installed. [default: firefox] 13:49:06 INFO - mkdir: /builds/slave/test/build/application 13:49:06 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'] 13:49:06 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 13:49:22 INFO - Reading from file tmpfile_stdout 13:49:22 INFO - Output received: 13:49:22 INFO - /builds/slave/test/build/application/firefox/firefox 13:49:22 INFO - Running post-action listener: _resource_record_post_action 13:49:22 INFO - ##### 13:49:22 INFO - ##### Finished install step (success) 13:49:22 INFO - ##### 13:49:22 INFO - ##### 13:49:22 INFO - ##### Running run-tests step. 13:49:22 INFO - ##### 13:49:22 INFO - Running pre-action listener: _resource_record_pre_action 13:49:22 INFO - Running main action method: run_tests 13:49:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:49:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:49:22 INFO - Python 2.7.3 13:49:22 INFO - Return code: 0 13:49:22 INFO - grabbing minidump binary from tooltool 13:49:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:49:22 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 0xd7f6f0>, '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 0xd805f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd80aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:49:22 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 13:49:22 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 13:49:22 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 13:49:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:49:22 INFO - Return code: 0 13:49:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:49:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:49:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:49:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:49:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:49:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:49:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:49:23 INFO - Return code: 0 13:49:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 13:49:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 13:49:23 INFO - Using env: {'DISPLAY': ':0', 13:49:23 INFO - 'HOME': '/home/cltbld', 13:49:23 INFO - 'LANG': 'en_US.UTF-8', 13:49:23 INFO - 'LANGUAGE': 'en_US:en', 13:49:23 INFO - 'LOGNAME': 'cltbld', 13:49:23 INFO - 'MAIL': '/var/mail/cltbld', 13:49:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:49:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:23 INFO - 'MOZ_NO_REMOTE': '1', 13:49:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:49:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:49:23 INFO - 'NO_EM_RESTART': '1', 13:49:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:23 INFO - 'PWD': '/builds/slave/test', 13:49:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:49:23 INFO - 'SHELL': '/bin/bash', 13:49:23 INFO - 'SHLVL': '1', 13:49:23 INFO - 'TERM': 'linux', 13:49:23 INFO - 'TMOUT': '86400', 13:49:23 INFO - 'USER': 'cltbld', 13:49:23 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1467060493.211297-172304931', 13:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:23 INFO - '_': '/tools/buildbot/bin/python'} 13:49:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 13:49:23 INFO - mozversion application_buildid: 20160627131816 13:49:23 INFO - mozversion application_changeset: b27893d49f113acfbfe2e7e46b45b4771fcef9b8 13:49:23 INFO - mozversion application_display_name: Nightly 13:49:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:49:23 INFO - mozversion application_name: Firefox 13:49:23 INFO - mozversion application_remotingname: firefox 13:49:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:49:23 INFO - mozversion application_vendor: Mozilla 13:49:23 INFO - mozversion application_version: 50.0a1 13:49:23 INFO - mozversion platform_buildid: 20160627131816 13:49:23 INFO - mozversion platform_changeset: b27893d49f113acfbfe2e7e46b45b4771fcef9b8 13:49:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:49:23 INFO - mozversion platform_version: 50.0a1 13:49:23 INFO - using testdate: 1467060563 13:49:23 INFO - actual date: 1467060563 13:49:23 INFO - starting webserver on 'localhost:57562' 13:49:23 INFO - SUITE-START | Running 2 tests 13:49:23 INFO - TEST-START | dromaeo_css 13:49:23 INFO - operating with platform_type : linux_ 13:49:23 INFO - Initialising browser for dromaeo_css test... 13:49:23 INFO - TEST-INFO | started process 14375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAJy0MB/profile http://localhost:57562/getInfo.html) 13:49:29 INFO - PROCESS | 14375 | __metrics Screen width/height:1600/1200 13:49:29 INFO - PROCESS | 14375 | colorDepth:24 13:49:29 INFO - PROCESS | 14375 | Browser inner width/height: 1024/697 13:49:29 INFO - PROCESS | 14375 | __metrics 13:49:29 ERROR - PROCESS | 14375 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 13:49:30 INFO - TEST-INFO | 14375: exit 0 13:49:30 INFO - Browser initialized. 13:49:30 INFO - Running cycle 1/1 for dromaeo_css test... 13:49:30 INFO - TEST-INFO | started process 14496 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAJy0MB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:49:42 INFO - PROCESS | 14496 | RSS: Main: 186417152 13:49:42 INFO - PROCESS | 14496 | 13:50:32 INFO - PROCESS | 14496 | 1467060632280 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] 13:52:44 INFO - PROCESS | 14496 | Cycle 1(1): loaded http://localhost:57562/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57562/tests/dromaeo/cssquery-ext.html) 13:52:45 INFO - PROCESS | 14496 | RSS: Main: 188698624 13:52:45 INFO - PROCESS | 14496 | 13:55:47 INFO - PROCESS | 14496 | Cycle 1(1): loaded http://localhost:57562/tests/dromaeo/cssquery-ext.html (next: http://localhost:57562/tests/dromaeo/cssquery-jquery.html) 13:55:48 INFO - PROCESS | 14496 | RSS: Main: 188215296 13:55:48 INFO - PROCESS | 14496 | 13:58:50 INFO - PROCESS | 14496 | Cycle 1(1): loaded http://localhost:57562/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57562/tests/dromaeo/cssquery-mootools.html) 13:58:50 INFO - PROCESS | 14496 | RSS: Main: 189616128 13:58:50 INFO - PROCESS | 14496 | 14:01:52 INFO - PROCESS | 14496 | Cycle 1(1): loaded http://localhost:57562/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57562/tests/dromaeo/cssquery-prototype.html) 14:01:53 INFO - PROCESS | 14496 | RSS: Main: 186880000 14:01:53 INFO - PROCESS | 14496 | 14:04:56 INFO - PROCESS | 14496 | Cycle 1(1): loaded http://localhost:57562/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57562/tests/dromaeo/cssquery-yui.html) 14:04:56 INFO - PROCESS | 14496 | RSS: Main: 188796928 14:04:56 INFO - PROCESS | 14496 | 14:07:59 INFO - PROCESS | 14496 | Cycle 1(1): loaded http://localhost:57562/tests/dromaeo/cssquery-yui.html (next: http://localhost:57562/tests/dromaeo/cssquery-dojo.html) 14:07:59 INFO - PROCESS | 14496 | RSS: Main: 189632512 14:07:59 INFO - PROCESS | 14496 | 14:07:59 INFO - PROCESS | 14496 | __start_tp_report 14:07:59 INFO - PROCESS | 14496 | _x_x_mozilla_page_load 14:07:59 INFO - PROCESS | 14496 | _x_x_mozilla_page_load_details 14:07:59 INFO - PROCESS | 14496 | |i|pagename|runs| 14:07:59 INFO - PROCESS | 14496 | |0;dojo.html;2663.0679262258204;2665.160474450549;2690.3005218643148;2713.8236014659046;2717.7689896358806;4877.609791216703;4915.066137433885;4926.669799154226;4971.502849715036;5001.724905130216;4850.054239423313;4968.577670897978;4976.502349765022;4982.775775090121;4995.250712393134;4529.524399938;4544.295634176691;4599.954000460003;4675.438947326325;4708.340832283483;4353.28170851809;4651.069786042788;4709.340692303081;4716.811327546894;4741.122892264942;4535.705179163377;4538.432695913011;4568.200564901129;4600.17196904557;4611.884702882421;4595.080983803253;4603.478736904989;4607.216773148572;4643.6285097192485;4696.553827386427;4487.8429254976245;4588.082383523309;4600.17196904557;4626.375439315683;4683.976580117112;4827.975860120712;4928.457869634337;4948.38145231846;4950.87622809429;4955.157623204064;5330.120530112566;5373.731313434352;5384.273123128367;5385.973070134624;5433.375161856358;5256.579473642099;5299.708516031616;5415.891682166334;5419.566434685215;5421.403645598981;4967;5004.84985450437;5011.6241281904;5015.899682006339;5059.519345662193;5469.945300547023;5514.255575497336;5519.530839878575;5529.336479622471;5563.888722225533;5013.248012798036;5022.573081288058;5098.566621837112;5283.630145889828;5293.655912365684;5132.79468821243;5157.896842063138;5160.277561141444;5179.559737422362;5232.816851410183;5225.503577160163;5265.552428043583;5308.177232528887;5325.840224793263;5347.224652425454;5159.922601160985;5184.040952423814;5265.0259701955265;5303.7348132593215;5321.6540924839765;4604.40142781443;4616.8614941551805;4619.69971951822;4633.142868569325;4641.628669706415;3952;3959.8020098994934;3986.4418981342637;3987.202559488114;4013.8795836124964;4526.932096018562;4587.6788624795945;4616.261398176276;4631.235846085358;4689.882752931204;5383.192521121863;5403.702796346239;5404.675719456845;5410.3778065522965;5410.945890541044;4634.559716826896;4639.141758774637;4652.325412815123;4660.440747110369;4678.76606169697;4746.905061898743;4804.015176888729;4805.711657300573;4833.661643684979;4881.877953051131;5004.374453193351;5011.548960593491;5047.29337892688;5055.317532133115;5059.316992206005;5250.868728281824;5421.295231619864;5444.428335024765;5454.427285135003;5459.126539753779;4919.188333925005;5015.974920125376;5033.823816166417;5040.596752259884;5089.465606111305;5253.395859476056;5273.813391986926;5277.656952298088;5295.073362161684;5321.122014867504;5211.765470553758;5281.049411106038;5285.63000589955;5289.7619607117;5297.735113244245;5020.322256495472;5143.742812859267;5151.072806894795;5202.141646628415;5263.421023687468;5194.818181363634;5206.739663016759;5207.1147904857025;5207.609429292743;5230.424653288059;5027.748612569284;5087.23691446286;5112.769925353294;5140.049090918192;5198.0643484173215;5200.869978250423;5233.973830130825;5277.920831187612;5284.313039304866;5304.389995150607;5091.1854103343285;5121.308623335802;5126.128558145198;5130.281760553451;5209.0363282792805 14:07:59 INFO - PROCESS | 14496 | |1;ext.html;541.4761883627003;579.6435192356702;591.3495155329139;603.0170821560855;609.3145211636909;34618.65381346186;38213.42679859801;38257.426138607945;38304.42543361852;38550.8072459638;38135.618643813556;38468.23063538728;38491.61508384915;38548.61451385485;38825;7741.303282704542;7843.058832940055;7885.487443316195;7898.486598371116;7915.445918785687;7747.690092396298;7756.224377562226;7819.96090019552;7835.373170146403;7838.137804841463;7753.844923101535;7820.491668041559;7834.412419068564;7878.975733154711;7880.763577092668;7755.806104847367;7775.494592851474;7815.531068135873;7826.921730782677;7834.33408160307;7770.922290777076;7815.570143642098;7854.882176767296;7860.056793184797;7865.331446827026;35197.82401087978;35379.82310088459;35545;35592.28815423677;35604.64395356065;2992.2369795701957;3137.952930706041;3201.415299426775;3293.2590167212425;3397.677220664033;29265.268368290752;29459.558106628418;29589.852050739824;29802.403951921056;30503;3047.481928072233;3119.984400077985;3130.874765009397;3155.25851424915;3183.904482865518;245960;246275;246495;246801;247185;30702.84648576743;32013.359732805213;51589.74205129025;51641.48358516442;52237.47762522402;33676.66323336784;33725.66274337225;33743.325133497194;33887.83056084753;33948.151296217795;13229.140105893086;13233.669158271121;13396.598102056954;13410.865891341156;13413.865861341457;11059.94930481603;11119.44402779874;11134.33194008362;11152.163587730953;11186.216964812385;7807.531548107132;7830.41271904598;7873.724419645285;7930.920690793134;7967.721129760431;3096.9714836781945;3103.581016562735;3121.266502371941;3161.0674850919036;3172.2862355969723;884.8982367027745;921.9907800922039;940.1256831147099;950.2493030505823;958.5015791788231;27331;28118.156455305965;28535.0774307696;28565;28956.27609309784;933.2767105493297;970.7864269860619;972.9124378805941;1026.3585259212991;1052.116222373195;14932.477363292233;15008.924955375152;15253;15272.923635381974;15410.656315460392;400505;405990;406861;408077;408489;50064.499355006716;50117.498825012015;50508.747456262485;50819.74590127026;50856.49143508592;1171.1860257121389;1202.81957706343;1202.8436303280519;1209.0992210803183;1214.1136970011942;26941.326466838487;27999.580530628366;28228;28419.857900710365;28629.713702862704;43274.567254327056;43711.78144109259;43762.78118609387;43777;43844.56155438533;264632;266085;267078;267089;269094;24710;25292.367690807878;25443.36391590225;25583.74416255888;25623.743762562135;41805;41958.790206048776;42463;43225;43491;36422.4536631956;36579.451308229865;36715.265694685426;37175.76945383286;37292.627073728916;36215.456768147975;36313.27373452569;36361.27277454383;36608.45087323639;37167.25665486729;31266;31944.8402757994;35424.29151417009;35802.28395432025;36662.266754664226;31609.683903160672;32632.83683581567;32711.509327359632;32825.007245146284;33004.50493242651;25201.621975670747;25386.492270154125;25524.872375638744;25642.871785640953;25662 14:07:59 INFO - PROCESS | 14496 | |2;jquery.html;366.8385910199512;369.8613020117457;372.5994555852459;381.6356525421615;389.12446994262893;15511.379544818208;15896.125713085776;16445.835541644596;16943;16992.235349409275;15821.129837858913;16022.679546409065;16989.57526061846;17003.57491062724;17037.403690870822;5000.7749651265685;5137.152369858987;5169.870753231162;5185.455527169649;5207.583393328525;5059.06407314648;5109.41241757199;5158.716270605115;5173.637845350827;5180.3006594109875;4966.50334966504;5098;5110.591152707793;5116.1814109742445;5130.102232109384;5050.671706339076;5116.079105760961;5119.744012799364;5129.128048231791;5136.409312929024;5189.351331083614;5196.0647083524955;5199.090159222121;5247.291615631879;5249.2388603652635;12276.263424194576;12291.754164916652;12573.559925402658;12582;12681.682957926034;1924.5573518090916;1968.1241847377923;2037.5313677854028;2284.554511870186;2330.5783472082016;8992.685256016008;9021.909780902173;9266.305027122993;9329.300302477273;9358.157765801043;1634.7384418492984;1702.7445883117507;1703.406813627249;1704.3949397963668;1711.2213942656062;64571;66999.66500167469;67175;68232.31767682309;69345.3065469349;9778.364406313567;9854.802903941882;10105.433657782909;10278.383297002203;10768.676939691823;13739.656508587364;13763.449462021606;13866.306684665726;13877.861221387657;13962.790558141636;7091.702358403367;7152.284771522806;7249.565026098451;7328.78013659591;7395.186529481753;6709.127813384229;6751.898721519181;6812.557183783038;6839.384455399038;6844.384005439534;4076.5311989121037;4245.490541135084;4300.741955482681;4407.206702793464;4454.732716037048;1729.3860679458862;1741.7300318450662;1759.9429849741741;1809.3576780243088;1817.9454616361531;775.7556369743513;828.8508068547719;883.6774577279375;927.1609193679731;973.7030205787303;15565.533034008999;16230;16369.263383147787;17036.403725869535;17124.74312885308;821.9054808696957;832.3590835057093;865.0786911938765;878.6836738774036;913.8081002989446;9147.2682185425;9412.952935235417;9500.95489496155;9503.952480237554;9602.519874006271;384226;384235;392721;396364;397292;71470.2852971474;73320;75865.24134758693;76149;76898;852.4160949749441;881.9559022048871;888.1651247827022;894.821035792844;900.2168113741087;14269.785953210503;14773.187474688566;14805;14892.7766083511;15029.624259393602;33854.492182616785;37922.43116353202;38572;38765.41851872281;39963.80018099891;43952.56047439485;50418;51233.48766512287;51657;52233.21650175326;6248.937510625017;6800.591964482147;6804.285550017177;7588.734394296173;7690.807729806799;9115.680951166678;10541.156707463231;10728.785424291627;10741.24846028537;10973;8899.688510902088;8923.41997770143;8998.602236421673;9014.909850901407;9457.668981585886;9217.216536594464;9276.72169834906;9321.766955825888;9374;9500.192483638692;8823;8954.104589540993;9104.180623743894;9125.954370228106;9214.815703686023;6606.702698378681;6706.094677218513;6716.5634233774645;6850.828729281808;6984.79045628632;8206;8979.730608081769;9306.953465232631;9344.579493922925;9451 14:07:59 INFO - PROCESS | 14496 | |3;mootools.html;1368.8288963879515;1385.4388972466152;1474.8525147485245;1678.8656907447398;1683.444463327102;6927.549709268894;7628.923710762891;7666.271704188107;8204.261616454518;8210.220029097227;7774.766756997299;8001.679932802681;8006.079300880386;8032.437729358947;8077.676892924276;2182.8253739700867;2229.665550167472;2238.563480121377;2245;2246;2126.3302059851176;2174.510735084609;2193.9451513712124;2195.264586363562;2206.3491270075365;2175.042981088324;2215.3907675389237;2222.48882756966;2223.54417344444;2225.221172589597;2138.112683236455;2175.184305885293;2198.428408613772;2199.417154454079;2205.029786893778;2146.527763891941;2151.40836270027;2155.137944822068;2163.9783602164093;2172.076867331378;8031.4377993540475;8120.715774947907;8126.10612832588;8132.634031468599;8143.633536490872;4514.729116253003;4616.746078965655;4674.065186962621;4675.438947326308;4685.88285292867;2714.307851497875;2739.260399692092;2748.395353022332;2880.35192081782;2905.5786910898014;913.7578541686458;920.2821798996794;920.4707293306309;939.3847030195165;946.1910066892846;11082.335059896432;11086.667399978014;11094.223404361697;11137.276077054965;11141.220114591983;4174.958250417518;4265.1043280910735;4320.481542214954;4334;4350.73895566267;9305.302102342352;9334.39326443779;9338.766530836783;9387.249020078378;9398.90601093994;4719.197736384823;4725.763711814464;4731.006488637425;4741.241401375763;4742.383490146328;3720.776753394805;4182;4201.789910504463;4267.0825772459075;4320.071184695243;3614.566252049771;3621.1852333224815;3723.2925744108534;3731.8134093295225;3736.439534069911;1176.6293617510457;1183.5443354308482;1184.7452797648548;1186.489809381974;1192.4753108632174;667.9398854103154;792.8731402975611;792.9920700793034;811.6509900742619;818.0796603820702;4815.820124069625;4923.679960802537;5170.6122040847085;5225.790968361299;5282.834769535538;796.303234669664;811.926926576611;831.6590198018783;850.5407080176759;885.7918389178537;3229.5801545798895;3267.39553182662;3294.4234758917096;3345.565076540034;3359.848806803651;9514.666986655433;9657.71026869195;9919.256055795844;9950.701478955643;9954.850677239847;9722.416655000723;9788.265880059023;9812.950935245279;9859.063388978035;9859.950700246596;7153.570785752871;7211.314925082109;7326.597037162901;7353.485256032133;7416.295451932057;4910.582600479;4910.8281210157475;5072.340595722532;5081.364829396325;5093.668911520739;8552.358573107167;9012.143846334588;9154;9174.908250917406;9283.535823208678;9039.276857851488;9076.95615004283;9268.443893366419;9369.672061477815;9433.29250306216;6049.51603871698;6521.184851893513;6837.076994605664;6920.515563910478;7048.9647551763965;7694.345980591488;7698;7721.53670779755;7743.4966727162555;7787.4548781584745;6844.315568443116;7055.541389809646;7071.25751796054;7085.6457177141965;7173.569585824867;6898.344657257552;6956.0609317741455;6968.198657154492;6987.7204911802955;7043.190033146049;5618.129189975561;5891.293044834647;5906.527477801679;6033.728482218223;6143.385661433821;4443.31128675043;4507.143642707875;4540.795664195053;4571.49713531518;4581.67928245033;4383;4428.450042485105;4479.7536135512855;4554.772261386984;4605.539446055368 14:07:59 INFO - PROCESS | 14496 | |4;prototype.html;292.26786898818455;302.97879148459606;309.953506973954;311.4363002964634;313.1607292456218;4963.801447942078;5002.449730529639;5155.613329000326;5226.372835259769;5227.529522342993;5091.643584949055;5114.263868830177;5122.795088196468;5127.230915362688;5150.27896094547;4058.4115303281005;4058.6347228749405;4061.9593804062024;4080.367543030835;4083.734557253784;3881.7476864003747;4048.797560121997;4079.9184016319655;4081.795910204493;4105.897352566195;3982.5818289079666;3992.301347264217;3996.5204175498834;4004.219177260421;4015.2571774221715;3956.9010774730573;4000.4199391088273;4007.699422543321;4017.136315692111;4020.6984476164403;3320;3445.1903802606366;3453.723702103826;3461.8788342408147;3563.768355056913;4979.701217926936;4982.202847544376;4992.276119962585;4997.550220480174;4997.725125118117;4528.117017181651;4535.569120933506;4543.0459603483305;4550.5904468597655;4562;5117.948820511784;5330.733463326818;5375.677459352412;5404.594655400861;5430.728463576806;3876.8643097491736;3883.728139030269;3904.8828535143707;3911.1395492991496;3937.523428714232;5665.773369065232;5695.943040569583;5698;5730.77076916927;5743.310802703702;3871.4386413969814;3973.6622387097423;4023.5574086850424;4027.6979226558124;4034.4381317863367;4094.1811637672586;4094.7747873867224;4095.607493452181;4103.481711766665;4107.158032603309;4595.425571803525;4631.846191520892;4644.745918601959;4664.603508701731;4688.742119183477;5199.506046925536;5305.946940530623;5344.385395679469;5420.997115533639;5493.423190565013;1359.632899117233;1401.9345297573918;1408.1551069358304;1408.204364534035;1421.3035612549984;897.1701176411793;902.1609902790336;924.3344791750063;929.7582628516499;930.851063829784;4152.854650087233;4224.4508213931995;4233.5131459881895;4236.961944323599;4272.700910936267;4919.409670839522;4923.704577725348;4946.851594452172;4958.5372315167115;5002.624803139779;4220.240356735756;4264.914701705949;4269.423627810268;4313;4376.9124617508105;2546.2615841405786;2639.23462195961;2648.1128821844513;2662.786977041832;2712.403271280315;4580.908381832344;4590.42619672541;4591.65562582801;4642.16441040616;4649.930515981343;4817.723947715587;4978.651494395358;4983.476734942778;5014.573761230264;5081.21241207606;4605.217113090783;4608.976955115203;4624.907501850012;4627.213373726542;4700.435947686299;4919.139150648693;4919.3604831371695;4935.309056731989;4944.59079162437;4976.685841083913;4700.271457924027;4836.733979631154;4860.805567777249;4869.342638743866;4887.804487820447;4566.931496027629;4613.930791038204;4668.883277918079;4671.252599584186;4696.671233013656;3718.3678774607843;3732.533433320835;3734.234481931252;3754.3293234511475;3764.0589852536864;5013.699178049329;5024.547790698854;5033.84898453047;5409.323834520685;5435;5288.391834938878;5293.5765138789575;5310.654807437504;5391.272178255886;5419.945800542102;5403.972980135074;5420.159875219348;5429.6199266051;5430.728463576885;5436.374816896107;5080.46655101209;5229.50319719626;5261.447548007557;5264.499872512105;5310.920336195038;5401.540869026177;5418.160185171305;5422.48486393792;5462.726863656881;5475.561955043508;5285.572895318166;5303.708296043755;5316.255724198538;5343.732813359395;5374.677519348852 14:07:59 INFO - PROCESS | 14496 | |5;yui.html;520.6719766547075;537.9650322729022;552.6344561619737;573.4323020209993;595.3837777899874;10706.678799636014;10770.784584308309;10813.729656758585;10824.512896919638;10878.401687907162;11527.365994870279;12914.160579562322;13022.088453808237;13499;13518.188908665486;778.1479280188213;781.468601351081;783.807967048074;786.8111653203247;789.3290702902516;779.5128044971892;786.3119770201074;787.4527203593476;789.1122487201898;790.0361558898135;825.84721826462;830.8006078541167;830.9459885107478;834.1116710703112;837.1335667584052;821.9712310069178;822.1367564057746;825.6821123867294;828.9129641387658;829.4732844643695;602.7588964414225;603.1676286724293;603.3755063509246;603.6317846113867;604.8004158627687;10966.616168434146;11339.262947908443;11467.19729618927;11467.598634047768;11484.827727584094;12528.436220370106;12651.304178270191;12865.099443038991;13041.934790326082;13058.216507009514;10449.79100417995;10576.841347379795;10615.681529554126;10661.621556862343;10732;3327.73378129749;3344.916377090592;3347.129746265964;3370.9494357584654;3446.069561218457;43589.56410435887;53107.20339194915;55004.174937376374;63302.36697633011;64505;9930.801383972424;10337.844932326021;10370.481475926324;10458.267921245591;10667.73330666724;16440.75338869918;16592.419265325654;16599.6680066398;16615.916920415322;16689.83310166907;6959.965200173967;7111.964440177766;7132.393746531499;7258.891116633255;7371.9262807372315;3702.453744143563;3766.924661506809;3799.886003419902;3800.847966081381;3842.346801043829;2874.540073588216;2936.045785119845;2960.422717570053;2971.702829717054;2973.3310005249077;508.4077050236507;512.7461906356377;513.6481510165548;528.2235114381853;535.2265975665205;520.8099043848968;542.7177867508873;543.1201453645041;553.5599198637012;562.1595714406988;7801.609919504115;7933.889255504234;8293.295069919004;8465.830683386297;8621.956890215633;513.2147813844823;534.9759260833272;542.5876333986199;545.492691796625;548.7201527221066;3718.219173973496;3776.4712940188397;3827.732058755916;3841.7310788244554;4027.7986100695434;81804.18195818085;87845.56077219702;90400;90804.54597726969;93515.53242233882;74589.25410745932;77028;77654.72898990496;78015.21984780193;79340;70188;70281.2971870285;70295.64852175809;70382.2961770386;70405.29594703988;7545.660445279866;7787.026621672291;7823.139454660097;7869.763907082796;8038.839223215386;42482;43752;44062;44520;44586;60694.69652651709;64257.35742642514;64358;64573.67713161592;64594.67702661457;9340.859887101564;9350.672726454814;9473.47895865734;9632.807343852943;9717.514124293899;10720.35677859331;10892.945535272273;11047.889521104686;11114.888851111386;11616.303021818718;9779.217662587118;10401.739956500845;10438.425886576311;10638.095761860328;10853.077488413574;9672.516374181403;9986;9986.950065249628;10053.49732513386;10150.13723833453;9875.753106172404;10017.39895606266;10321.793564128826;10587.682369528926;10745.355278683304;8636.654533818577;8654.35935294315;8949.59726812308;9172.44965302084;9217.262618990599;8628.309735221043;8801.51591662439;8864.911350886408;8956.462612243286;9085.727428177166 14:07:59 INFO - PROCESS | 14496 | __end_tp_report 14:07:59 INFO - PROCESS | 14496 | __start_cc_report 14:07:59 INFO - PROCESS | 14496 | _x_x_mozilla_cycle_collect,396 14:07:59 INFO - PROCESS | 14496 | __end_cc_report 14:07:59 INFO - PROCESS | 14496 | __startTimestamp1467061679712__endTimestamp 14:07:59 INFO - PROCESS | 14496 | 14:07:59 INFO - PROCESS | 14496 | ------- Summary: start ------- 14:07:59 INFO - PROCESS | 14496 | Number of tests: 6 14:07:59 INFO - PROCESS | 14496 | 14:07:59 INFO - PROCESS | 14496 | [#0] dojo.html Cycles:165 Average:4929.00 Median:5033.82 stddev:521.92 (10.4%) stddev-sans-first:492.32 14:07:59 INFO - PROCESS | 14496 | Values: 2663.1 2665.2 2690.3 2713.8 2717.8 4877.6 4915.1 4926.7 4971.5 5001.7 4850.1 4968.6 4976.5 4982.8 4995.3 4529.5 4544.3 4600.0 4675.4 4708.3 4353.3 4651.1 4709.3 4716.8 4741.1 4535.7 4538.4 4568.2 4600.2 4611.9 4595.1 4603.5 4607.2 4643.6 4696.6 4487.8 4588.1 4600.2 4626.4 4684.0 4828.0 4928.5 4948.4 4950.9 4955.2 5330.1 5373.7 5384.3 5386.0 5433.4 5256.6 5299.7 5415.9 5419.6 5421.4 4967.0 5004.8 5011.6 5015.9 5059.5 5469.9 5514.3 5519.5 5529.3 5563.9 5013.2 5022.6 5098.6 5283.6 5293.7 5132.8 5157.9 5160.3 5179.6 5232.8 5225.5 5265.6 5308.2 5325.8 5347.2 5159.9 5184.0 5265.0 5303.7 5321.7 4604.4 4616.9 4619.7 4633.1 4641.6 3952.0 3959.8 3986.4 3987.2 4013.9 4526.9 4587.7 4616.3 4631.2 4689.9 5383.2 5403.7 5404.7 5410.4 5410.9 4634.6 4639.1 4652.3 4660.4 4678.8 4746.9 4804.0 4805.7 4833.7 4881.9 5004.4 5011.5 5047.3 5055.3 5059.3 5250.9 5421.3 5444.4 5454.4 5459.1 4919.2 5016.0 5033.8 5040.6 5089.5 5253.4 5273.8 5277.7 5295.1 5321.1 5211.8 5281.0 5285.6 5289.8 5297.7 5020.3 5143.7 5151.1 5202.1 5263.4 5194.8 5206.7 5207.1 5207.6 5230.4 5027.7 5087.2 5112.8 5140.0 5198.1 5200.9 5234.0 5277.9 5284.3 5304.4 5091.2 5121.3 5126.1 5130.3 5209.0 14:07:59 INFO - PROCESS | 14496 | 14:07:59 INFO - PROCESS | 14496 | [#1] ext.html Cycles:180 Average:45052.48 Median:35568.64 stddev:83049.94 (233.5%) stddev-sans-first:83215.68 14:07:59 INFO - PROCESS | 14496 | Values: 541.5 579.6 591.3 603.0 609.3 34618.7 38213.4 38257.4 38304.4 38550.8 38135.6 38468.2 38491.6 38548.6 38825.0 7741.3 7843.1 7885.5 7898.5 7915.4 7747.7 7756.2 7820.0 7835.4 7838.1 7753.8 7820.5 7834.4 7879.0 7880.8 7755.8 7775.5 7815.5 7826.9 7834.3 7770.9 7815.6 7854.9 7860.1 7865.3 35197.8 35379.8 35545.0 35592.3 35604.6 2992.2 3138.0 3201.4 3293.3 3397.7 29265.3 29459.6 29589.9 29802.4 30503.0 3047.5 3120.0 3130.9 3155.3 3183.9 245960.0 246275.0 246495.0 246801.0 247185.0 30702.8 32013.4 51589.7 51641.5 52237.5 33676.7 33725.7 33743.3 33887.8 33948.2 13229.1 13233.7 13396.6 13410.9 13413.9 11059.9 11119.4 11134.3 11152.2 11186.2 7807.5 7830.4 7873.7 7930.9 7967.7 3097.0 3103.6 3121.3 3161.1 3172.3 884.9 922.0 940.1 950.2 958.5 27331.0 28118.2 28535.1 28565.0 28956.3 933.3 970.8 972.9 1026.4 1052.1 14932.5 15008.9 15253.0 15272.9 15410.7 400505.0 405990.0 406861.0 408077.0 408489.0 50064.5 50117.5 50508.7 50819.7 50856.5 1171.2 1202.8 1202.8 1209.1 1214.1 26941.3 27999.6 28228.0 28419.9 28629.7 43274.6 43711.8 43762.8 43777.0 43844.6 264632.0 266085.0 267078.0 267089.0 269094.0 24710.0 25292.4 25443.4 25583.7 25623.7 41805.0 41958.8 42463.0 43225.0 43491.0 36422.5 36579.5 36715.3 37175.8 37292.6 36215.5 36313.3 36361.3 36608.5 37167.3 31266.0 31944.8 35424.3 35802.3 36662.3 31609.7 32632.8 32711.5 32825.0 33004.5 25201.6 25386.5 25524.9 25642.9 25662.0 14:07:59 INFO - PROCESS | 14496 | 14:07:59 INFO - PROCESS | 14496 | [#2] jquery.html Cycles:180 Average:23701.56 Median:28413.44 stddev:64550.85 (227.2%) stddev-sans-first:64708.15 14:07:59 INFO - PROCESS | 14496 | Values: 366.8 369.9 372.6 381.6 389.1 15511.4 15896.1 16445.8 16943.0 16992.2 15821.1 16022.7 16989.6 17003.6 17037.4 5000.8 5137.2 5169.9 5185.5 5207.6 5059.1 5109.4 5158.7 5173.6 5180.3 4966.5 5098.0 5110.6 5116.2 5130.1 5050.7 5116.1 5119.7 5129.1 5136.4 5189.4 5196.1 5199.1 5247.3 5249.2 12276.3 12291.8 12573.6 12582.0 12681.7 1924.6 1968.1 2037.5 2284.6 2330.6 8992.7 9021.9 9266.3 9329.3 9358.2 1634.7 1702.7 1703.4 1704.4 1711.2 64571.0 66999.7 67175.0 68232.3 69345.3 9778.4 9854.8 10105.4 10278.4 10768.7 13739.7 13763.4 13866.3 13877.9 13962.8 7091.7 7152.3 7249.6 7328.8 7395.2 6709.1 6751.9 6812.6 6839.4 6844.4 4076.5 4245.5 4300.7 4407.2 4454.7 1729.4 1741.7 1759.9 1809.4 1817.9 775.8 828.9 883.7 927.2 973.7 15565.5 16230.0 16369.3 17036.4 17124.7 821.9 832.4 865.1 878.7 913.8 9147.3 9413.0 9501.0 9504.0 9602.5 384226.0 384235.0 392721.0 396364.0 397292.0 71470.3 73320.0 75865.2 76149.0 76898.0 852.4 882.0 888.2 894.8 900.2 14269.8 14773.2 14805.0 14892.8 15029.6 33854.5 37922.4 38572.0 38765.4 39963.8 43952.6 50418.0 51233.5 51657.0 52233.2 6248.9 6800.6 6804.3 7588.7 7690.8 9115.7 10541.2 10728.8 10741.2 10973.0 8899.7 8923.4 8998.6 9014.9 9457.7 9217.2 9276.7 9321.8 9374.0 9500.2 8823.0 8954.1 9104.2 9126.0 9214.8 6606.7 6706.1 6716.6 6850.8 6984.8 8206.0 8979.7 9307.0 9344.6 9451.0 14:07:59 INFO - PROCESS | 14496 | 14:07:59 INFO - PROCESS | 14496 | [#3] mootools.html Cycles:180 Average:5185.75 Median:5087.52 stddev:2970.01 (58.4%) stddev-sans-first:2964.49 14:07:59 INFO - PROCESS | 14496 | Values: 1368.8 1385.4 1474.9 1678.9 1683.4 6927.5 7628.9 7666.3 8204.3 8210.2 7774.8 8001.7 8006.1 8032.4 8077.7 2182.8 2229.7 2238.6 2245.0 2246.0 2126.3 2174.5 2193.9 2195.3 2206.3 2175.0 2215.4 2222.5 2223.5 2225.2 2138.1 2175.2 2198.4 2199.4 2205.0 2146.5 2151.4 2155.1 2164.0 2172.1 8031.4 8120.7 8126.1 8132.6 8143.6 4514.7 4616.7 4674.1 4675.4 4685.9 2714.3 2739.3 2748.4 2880.4 2905.6 913.8 920.3 920.5 939.4 946.2 11082.3 11086.7 11094.2 11137.3 11141.2 4175.0 4265.1 4320.5 4334.0 4350.7 9305.3 9334.4 9338.8 9387.2 9398.9 4719.2 4725.8 4731.0 4741.2 4742.4 3720.8 4182.0 4201.8 4267.1 4320.1 3614.6 3621.2 3723.3 3731.8 3736.4 1176.6 1183.5 1184.7 1186.5 1192.5 667.9 792.9 793.0 811.7 818.1 4815.8 4923.7 5170.6 5225.8 5282.8 796.3 811.9 831.7 850.5 885.8 3229.6 3267.4 3294.4 3345.6 3359.8 9514.7 9657.7 9919.3 9950.7 9954.9 9722.4 9788.3 9813.0 9859.1 9860.0 7153.6 7211.3 7326.6 7353.5 7416.3 4910.6 4910.8 5072.3 5081.4 5093.7 8552.4 9012.1 9154.0 9174.9 9283.5 9039.3 9077.0 9268.4 9369.7 9433.3 6049.5 6521.2 6837.1 6920.5 7049.0 7694.3 7698.0 7721.5 7743.5 7787.5 6844.3 7055.5 7071.3 7085.6 7173.6 6898.3 6956.1 6968.2 6987.7 7043.2 5618.1 5891.3 5906.5 6033.7 6143.4 4443.3 4507.1 4540.8 4571.5 4581.7 4383.0 4428.5 4479.8 4554.8 4605.5 14:07:59 INFO - PROCESS | 14496 | 14:07:59 INFO - PROCESS | 14496 | [#4] prototype.html Cycles:180 Average:4316.40 Median:4670.07 stddev:1236.02 (26.5%) stddev-sans-first:1202.01 14:07:59 INFO - PROCESS | 14496 | Values: 292.3 303.0 310.0 311.4 313.2 4963.8 5002.4 5155.6 5226.4 5227.5 5091.6 5114.3 5122.8 5127.2 5150.3 4058.4 4058.6 4062.0 4080.4 4083.7 3881.7 4048.8 4079.9 4081.8 4105.9 3982.6 3992.3 3996.5 4004.2 4015.3 3956.9 4000.4 4007.7 4017.1 4020.7 3320.0 3445.2 3453.7 3461.9 3563.8 4979.7 4982.2 4992.3 4997.6 4997.7 4528.1 4535.6 4543.0 4550.6 4562.0 5117.9 5330.7 5375.7 5404.6 5430.7 3876.9 3883.7 3904.9 3911.1 3937.5 5665.8 5695.9 5698.0 5730.8 5743.3 3871.4 3973.7 4023.6 4027.7 4034.4 4094.2 4094.8 4095.6 4103.5 4107.2 4595.4 4631.8 4644.7 4664.6 4688.7 5199.5 5305.9 5344.4 5421.0 5493.4 1359.6 1401.9 1408.2 1408.2 1421.3 897.2 902.2 924.3 929.8 930.9 4152.9 4224.5 4233.5 4237.0 4272.7 4919.4 4923.7 4946.9 4958.5 5002.6 4220.2 4264.9 4269.4 4313.0 4376.9 2546.3 2639.2 2648.1 2662.8 2712.4 4580.9 4590.4 4591.7 4642.2 4649.9 4817.7 4978.7 4983.5 5014.6 5081.2 4605.2 4609.0 4624.9 4627.2 4700.4 4919.1 4919.4 4935.3 4944.6 4976.7 4700.3 4836.7 4860.8 4869.3 4887.8 4566.9 4613.9 4668.9 4671.3 4696.7 3718.4 3732.5 3734.2 3754.3 3764.1 5013.7 5024.5 5033.8 5409.3 5435.0 5288.4 5293.6 5310.7 5391.3 5419.9 5404.0 5420.2 5429.6 5430.7 5436.4 5080.5 5229.5 5261.4 5264.5 5310.9 5401.5 5418.2 5422.5 5462.7 5475.6 5285.6 5303.7 5316.3 5343.7 5374.7 14:07:59 INFO - PROCESS | 14496 | 14:07:59 INFO - PROCESS | 14496 | [#5] yui.html Cycles:180 Average:16600.12 Median:27776.45 stddev:23682.46 (85.3%) stddev-sans-first:23718.12 14:07:59 INFO - PROCESS | 14496 | Values: 520.7 538.0 552.6 573.4 595.4 10706.7 10770.8 10813.7 10824.5 10878.4 11527.4 12914.2 13022.1 13499.0 13518.2 778.1 781.5 783.8 786.8 789.3 779.5 786.3 787.5 789.1 790.0 825.8 830.8 830.9 834.1 837.1 822.0 822.1 825.7 828.9 829.5 602.8 603.2 603.4 603.6 604.8 10966.6 11339.3 11467.2 11467.6 11484.8 12528.4 12651.3 12865.1 13041.9 13058.2 10449.8 10576.8 10615.7 10661.6 10732.0 3327.7 3344.9 3347.1 3370.9 3446.1 43589.6 53107.2 55004.2 63302.4 64505.0 9930.8 10337.8 10370.5 10458.3 10667.7 16440.8 16592.4 16599.7 16615.9 16689.8 6960.0 7112.0 7132.4 7258.9 7371.9 3702.5 3766.9 3799.9 3800.8 3842.3 2874.5 2936.0 2960.4 2971.7 2973.3 508.4 512.7 513.6 528.2 535.2 520.8 542.7 543.1 553.6 562.2 7801.6 7933.9 8293.3 8465.8 8622.0 513.2 535.0 542.6 545.5 548.7 3718.2 3776.5 3827.7 3841.7 4027.8 81804.2 87845.6 90400.0 90804.5 93515.5 74589.3 77028.0 77654.7 78015.2 79340.0 70188.0 70281.3 70295.6 70382.3 70405.3 7545.7 7787.0 7823.1 7869.8 8038.8 42482.0 43752.0 44062.0 44520.0 44586.0 60694.7 64257.4 64358.0 64573.7 64594.7 9340.9 9350.7 9473.5 9632.8 9717.5 10720.4 10892.9 11047.9 11114.9 11616.3 9779.2 10401.7 10438.4 10638.1 10853.1 9672.5 9986.0 9987.0 10053.5 10150.1 9875.8 10017.4 10321.8 10587.7 10745.4 8636.7 8654.4 8949.6 9172.4 9217.3 8628.3 8801.5 8864.9 8956.5 9085.7 14:07:59 INFO - PROCESS | 14496 | -------- Summary: end -------- 14:07:59 INFO - PROCESS | 14496 | 14:08:00 INFO - TEST-INFO | 14496: exit 0 14:08:00 INFO - TEST-OK | dromaeo_css | took 1116472ms 14:08:00 INFO - TEST-START | kraken 14:08:00 INFO - operating with platform_type : linux_ 14:08:00 INFO - Initialising browser for kraken test... 14:08:00 INFO - TEST-INFO | started process 14729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2dFdgl/profile http://localhost:57562/getInfo.html) 14:08:05 INFO - PROCESS | 14729 | __metrics Screen width/height:1600/1200 14:08:05 INFO - PROCESS | 14729 | colorDepth:24 14:08:05 INFO - PROCESS | 14729 | Browser inner width/height: 1024/697 14:08:05 INFO - PROCESS | 14729 | __metrics 14:08:05 ERROR - PROCESS | 14729 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 14:08:06 INFO - TEST-INFO | 14729: exit 0 14:08:06 INFO - Browser initialized. 14:08:06 INFO - Running cycle 1/1 for kraken test... 14:08:06 INFO - TEST-INFO | started process 14848 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2dFdgl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:08:19 INFO - PROCESS | 14848 | RSS: Main: 186150912 14:08:19 INFO - PROCESS | 14848 | 14:08:21 INFO - PROCESS | 14848 | Cycle 1(1): loaded http://localhost:57562/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57562/tests/kraken/driver.html?testName=audio-beat-detection) 14:08:22 INFO - PROCESS | 14848 | RSS: Main: 190324736 14:08:22 INFO - PROCESS | 14848 | 14:08:25 INFO - PROCESS | 14848 | Cycle 1(1): loaded http://localhost:57562/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57562/tests/kraken/driver.html?testName=audio-dft) 14:08:26 INFO - PROCESS | 14848 | RSS: Main: 190226432 14:08:26 INFO - PROCESS | 14848 | 14:08:29 INFO - PROCESS | 14848 | Cycle 1(1): loaded http://localhost:57562/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57562/tests/kraken/driver.html?testName=audio-fft) 14:08:29 INFO - PROCESS | 14848 | RSS: Main: 186224640 14:08:29 INFO - PROCESS | 14848 | 14:08:31 INFO - PROCESS | 14848 | Cycle 1(1): loaded http://localhost:57562/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57562/tests/kraken/driver.html?testName=audio-oscillator) 14:08:32 INFO - PROCESS | 14848 | RSS: Main: 186855424 14:08:32 INFO - PROCESS | 14848 | 14:08:34 INFO - PROCESS | 14848 | Cycle 1(1): loaded http://localhost:57562/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57562/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:08:35 INFO - PROCESS | 14848 | RSS: Main: 186814464 14:08:35 INFO - PROCESS | 14848 | 14:08:38 INFO - PROCESS | 14848 | Cycle 1(1): loaded http://localhost:57562/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57562/tests/kraken/driver.html?testName=imaging-darkroom) 14:08:39 INFO - PROCESS | 14848 | RSS: Main: 187441152 14:08:39 INFO - PROCESS | 14848 | 14:08:42 INFO - PROCESS | 14848 | Cycle 1(1): loaded http://localhost:57562/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57562/tests/kraken/driver.html?testName=imaging-desaturate) 14:08:43 INFO - PROCESS | 14848 | RSS: Main: 184352768 14:08:43 INFO - PROCESS | 14848 | 14:08:46 INFO - PROCESS | 14848 | Cycle 1(1): loaded http://localhost:57562/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57562/tests/kraken/driver.html?testName=json-parse-financial) 14:08:46 INFO - PROCESS | 14848 | RSS: Main: 186097664 14:08:46 INFO - PROCESS | 14848 | 14:08:48 INFO - PROCESS | 14848 | Cycle 1(1): loaded http://localhost:57562/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57562/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:08:49 INFO - PROCESS | 14848 | RSS: Main: 186761216 14:08:49 INFO - PROCESS | 14848 | 14:08:51 INFO - PROCESS | 14848 | Cycle 1(1): loaded http://localhost:57562/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57562/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:08:51 INFO - PROCESS | 14848 | RSS: Main: 186802176 14:08:51 INFO - PROCESS | 14848 | 14:08:53 INFO - PROCESS | 14848 | Cycle 1(1): loaded http://localhost:57562/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57562/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:08:54 INFO - PROCESS | 14848 | RSS: Main: 186994688 14:08:54 INFO - PROCESS | 14848 | 14:08:57 INFO - PROCESS | 14848 | Cycle 1(1): loaded http://localhost:57562/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57562/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:08:58 INFO - PROCESS | 14848 | RSS: Main: 187207680 14:08:58 INFO - PROCESS | 14848 | 14:09:00 INFO - PROCESS | 14848 | Cycle 1(1): loaded http://localhost:57562/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57562/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:09:01 INFO - PROCESS | 14848 | RSS: Main: 186855424 14:09:01 INFO - PROCESS | 14848 | 14:09:03 INFO - PROCESS | 14848 | Cycle 1(1): loaded http://localhost:57562/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57562/tests/kraken/driver.html?testName=ai-astar) 14:09:03 INFO - PROCESS | 14848 | RSS: Main: 188272640 14:09:03 INFO - PROCESS | 14848 | 14:09:03 INFO - PROCESS | 14848 | __start_tp_report 14:09:03 INFO - PROCESS | 14848 | _x_x_mozilla_page_load 14:09:03 INFO - PROCESS | 14848 | _x_x_mozilla_page_load_details 14:09:03 INFO - PROCESS | 14848 | |i|pagename|runs| 14:09:03 INFO - PROCESS | 14848 | |0;ai-astar;105;114;107;115;114;113;114;112;113;113 14:09:03 INFO - PROCESS | 14848 | |1;audio-beat-detection;160;135;165;212;133;154;171;136;194;132 14:09:03 INFO - PROCESS | 14848 | |2;audio-dft;166;166;177;168;164;165;167;165;163;163 14:09:03 INFO - PROCESS | 14848 | |3;audio-fft;76;76;76;164;75;78;76;76;153;76 14:09:03 INFO - PROCESS | 14848 | |4;audio-oscillator;87;87;140;87;86;88;136;86;86;145 14:09:03 INFO - PROCESS | 14848 | |5;imaging-gaussian-blur;118;118;118;118;118;118;118;118;118;117 14:09:03 INFO - PROCESS | 14848 | |6;imaging-darkroom;149;148;147;149;147;148;148;147;147;147 14:09:03 INFO - PROCESS | 14848 | |7;imaging-desaturate;95;98;95;96;95;96;95;96;97;95 14:09:03 INFO - PROCESS | 14848 | |8;json-parse-financial;63;64;65;64;65;64;65;63;66;64 14:09:03 INFO - PROCESS | 14848 | |9;json-stringify-tinderbox;65;65;65;65;66;66;65;65;65;65 14:09:03 INFO - PROCESS | 14848 | |10;stanford-crypto-aes;84;82;84;84;84;84;84;83;96;83 14:09:03 INFO - PROCESS | 14848 | |11;stanford-crypto-ccm;144;132;133;138;133;141;148;136;148;133 14:09:03 INFO - PROCESS | 14848 | |12;stanford-crypto-pbkdf2;169;174;173;172;171;174;176;171;170;167 14:09:03 INFO - PROCESS | 14848 | |13;stanford-crypto-sha256-iterative;66;67;69;68;67;67;68;67;67;69 14:09:03 INFO - PROCESS | 14848 | __end_tp_report 14:09:03 INFO - PROCESS | 14848 | __start_cc_report 14:09:03 INFO - PROCESS | 14848 | _x_x_mozilla_cycle_collect,956 14:09:03 INFO - PROCESS | 14848 | __end_cc_report 14:09:03 INFO - PROCESS | 14848 | __startTimestamp1467061743647__endTimestamp 14:09:03 INFO - PROCESS | 14848 | 14:09:03 INFO - PROCESS | 14848 | ------- Summary: start ------- 14:09:03 INFO - PROCESS | 14848 | Number of tests: 14 14:09:03 INFO - PROCESS | 14848 | 14:09:03 INFO - PROCESS | 14848 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.50 stddev:3.30 (2.9%) stddev-sans-first:2.33 14:09:03 INFO - PROCESS | 14848 | Values: 105.0 114.0 107.0 115.0 114.0 113.0 114.0 112.0 113.0 113.0 14:09:03 INFO - PROCESS | 14848 | 14:09:03 INFO - PROCESS | 14848 | [#1] audio-beat-detection Cycles:10 Average:159.20 Median:162.50 stddev:27.39 (16.9%) stddev-sans-first:29.04 14:09:03 INFO - PROCESS | 14848 | Values: 160.0 135.0 165.0 212.0 133.0 154.0 171.0 136.0 194.0 132.0 14:09:03 INFO - PROCESS | 14848 | 14:09:03 INFO - PROCESS | 14848 | [#2] audio-dft Cycles:10 Average:166.40 Median:166.00 stddev:4.06 (2.4%) stddev-sans-first:4.30 14:09:03 INFO - PROCESS | 14848 | Values: 166.0 166.0 177.0 168.0 164.0 165.0 167.0 165.0 163.0 163.0 14:09:03 INFO - PROCESS | 14848 | 14:09:03 INFO - PROCESS | 14848 | [#3] audio-fft Cycles:10 Average:92.60 Median:76.00 stddev:34.84 (45.8%) stddev-sans-first:36.43 14:09:03 INFO - PROCESS | 14848 | Values: 76.0 76.0 76.0 164.0 75.0 78.0 76.0 76.0 153.0 76.0 14:09:03 INFO - PROCESS | 14848 | 14:09:03 INFO - PROCESS | 14848 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:86.50 stddev:25.99 (30.1%) stddev-sans-first:26.94 14:09:03 INFO - PROCESS | 14848 | Values: 87.0 87.0 140.0 87.0 86.0 88.0 136.0 86.0 86.0 145.0 14:09:03 INFO - PROCESS | 14848 | 14:09:03 INFO - PROCESS | 14848 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 14:09:03 INFO - PROCESS | 14848 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 14:09:03 INFO - PROCESS | 14848 | 14:09:03 INFO - PROCESS | 14848 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 14:09:03 INFO - PROCESS | 14848 | Values: 149.0 148.0 147.0 149.0 147.0 148.0 148.0 147.0 147.0 147.0 14:09:03 INFO - PROCESS | 14848 | 14:09:03 INFO - PROCESS | 14848 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:1.03 (1.1%) stddev-sans-first:1.05 14:09:03 INFO - PROCESS | 14848 | Values: 95.0 98.0 95.0 96.0 95.0 96.0 95.0 96.0 97.0 95.0 14:09:03 INFO - PROCESS | 14848 | 14:09:03 INFO - PROCESS | 14848 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.50 stddev:0.95 (1.5%) stddev-sans-first:0.88 14:09:03 INFO - PROCESS | 14848 | Values: 63.0 64.0 65.0 64.0 65.0 64.0 65.0 63.0 66.0 64.0 14:09:03 INFO - PROCESS | 14848 | 14:09:03 INFO - PROCESS | 14848 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 14:09:03 INFO - PROCESS | 14848 | Values: 65.0 65.0 65.0 65.0 66.0 66.0 65.0 65.0 65.0 65.0 14:09:03 INFO - PROCESS | 14848 | 14:09:03 INFO - PROCESS | 14848 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:84.00 stddev:3.99 (4.8%) stddev-sans-first:4.23 14:09:03 INFO - PROCESS | 14848 | Values: 84.0 82.0 84.0 84.0 84.0 84.0 84.0 83.0 96.0 83.0 14:09:03 INFO - PROCESS | 14848 | 14:09:03 INFO - PROCESS | 14848 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:139.50 stddev:6.29 (4.5%) stddev-sans-first:6.36 14:09:03 INFO - PROCESS | 14848 | Values: 144.0 132.0 133.0 138.0 133.0 141.0 148.0 136.0 148.0 133.0 14:09:03 INFO - PROCESS | 14848 | 14:09:03 INFO - PROCESS | 14848 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:172.50 stddev:2.67 (1.5%) stddev-sans-first:2.65 14:09:03 INFO - PROCESS | 14848 | Values: 169.0 174.0 173.0 172.0 171.0 174.0 176.0 171.0 170.0 167.0 14:09:03 INFO - PROCESS | 14848 | 14:09:03 INFO - PROCESS | 14848 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:0.97 (1.4%) stddev-sans-first:0.87 14:09:03 INFO - PROCESS | 14848 | Values: 66.0 67.0 69.0 68.0 67.0 67.0 68.0 67.0 67.0 69.0 14:09:03 INFO - PROCESS | 14848 | -------- Summary: end -------- 14:09:03 INFO - PROCESS | 14848 | 14:09:04 INFO - TEST-INFO | 14848: exit 0 14:09:04 INFO - TEST-OK | kraken | took 64270ms 14:09:04 INFO - SUITE-END | took 1180s 14:09:04 INFO - Completed test suite (00:19:40) 14:09:04 INFO - javascript benchmark 14:09:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6313.682079942457, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2663.0679262258204, 2665.160474450549, 2690.3005218643148, 2713.8236014659046, 2717.7689896358806, 4877.609791216703, 4915.066137433885, 4926.669799154226, 4971.502849715036, 5001.724905130216, 4850.054239423313, 4968.577670897978, 4976.502349765022, 4982.775775090121, 4995.250712393134, 4529.524399938, 4544.295634176691, 4599.954000460003, 4675.438947326325, 4708.340832283483, 4353.28170851809, 4651.069786042788, 4709.340692303081, 4716.811327546894, 4741.122892264942, 4535.705179163377, 4538.432695913011, 4568.200564901129, 4600.17196904557, 4611.884702882421, 4595.080983803253, 4603.478736904989, 4607.216773148572, 4643.6285097192485, 4696.553827386427, 4487.8429254976245, 4588.082383523309, 4600.17196904557, 4626.375439315683, 4683.976580117112, 4827.975860120712, 4928.457869634337, 4948.38145231846, 4950.87622809429, 4955.157623204064, 5330.120530112566, 5373.731313434352, 5384.273123128367, 5385.973070134624, 5433.375161856358, 5256.579473642099, 5299.708516031616, 5415.891682166334, 5419.566434685215, 5421.403645598981, 4967.0, 5004.84985450437, 5011.6241281904, 5015.899682006339, 5059.519345662193, 5469.945300547023, 5514.255575497336, 5519.530839878575, 5529.336479622471, 5563.888722225533, 5013.248012798036, 5022.573081288058, 5098.566621837112, 5283.630145889828, 5293.655912365684, 5132.79468821243, 5157.896842063138, 5160.277561141444, 5179.559737422362, 5232.816851410183, 5225.503577160163, 5265.552428043583, 5308.177232528887, 5325.840224793263, 5347.224652425454, 5159.922601160985, 5184.040952423814, 5265.0259701955265, 5303.7348132593215, 5321.6540924839765, 4604.40142781443, 4616.8614941551805, 4619.69971951822, 4633.142868569325, 4641.628669706415, 3952.0, 3959.8020098994934, 3986.4418981342637, 3987.202559488114, 4013.8795836124964, 4526.932096018562, 4587.6788624795945, 4616.261398176276, 4631.235846085358, 4689.882752931204, 5383.192521121863, 5403.702796346239, 5404.675719456845, 5410.3778065522965, 5410.945890541044, 4634.559716826896, 4639.141758774637, 4652.325412815123, 4660.440747110369, 4678.76606169697, 4746.905061898743, 4804.015176888729, 4805.711657300573, 4833.661643684979, 4881.877953051131, 5004.374453193351, 5011.548960593491, 5047.29337892688, 5055.317532133115, 5059.316992206005, 5250.868728281824, 5421.295231619864, 5444.428335024765, 5454.427285135003, 5459.126539753779, 4919.188333925005, 5015.974920125376, 5033.823816166417, 5040.596752259884, 5089.465606111305, 5253.395859476056, 5273.813391986926, 5277.656952298088, 5295.073362161684, 5321.122014867504, 5211.765470553758, 5281.049411106038, 5285.63000589955, 5289.7619607117, 5297.735113244245, 5020.322256495472, 5143.742812859267, 5151.072806894795, 5202.141646628415, 5263.421023687468, 5194.818181363634, 5206.739663016759, 5207.1147904857025, 5207.609429292743, 5230.424653288059, 5027.748612569284, 5087.23691446286, 5112.769925353294, 5140.049090918192, 5198.0643484173215, 5200.869978250423, 5233.973830130825, 5277.920831187612, 5284.313039304866, 5304.389995150607, 5091.1854103343285, 5121.308623335802, 5126.128558145198, 5130.281760553451, 5209.0363282792805], "value": 4894.590461516438, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.4761883627003, 579.6435192356702, 591.3495155329139, 603.0170821560855, 609.3145211636909, 34618.65381346186, 38213.42679859801, 38257.426138607945, 38304.42543361852, 38550.8072459638, 38135.618643813556, 38468.23063538728, 38491.61508384915, 38548.61451385485, 38825.0, 7741.303282704542, 7843.058832940055, 7885.487443316195, 7898.486598371116, 7915.445918785687, 7747.690092396298, 7756.224377562226, 7819.96090019552, 7835.373170146403, 7838.137804841463, 7753.844923101535, 7820.491668041559, 7834.412419068564, 7878.975733154711, 7880.763577092668, 7755.806104847367, 7775.494592851474, 7815.531068135873, 7826.921730782677, 7834.33408160307, 7770.922290777076, 7815.570143642098, 7854.882176767296, 7860.056793184797, 7865.331446827026, 35197.82401087978, 35379.82310088459, 35545.0, 35592.28815423677, 35604.64395356065, 2992.2369795701957, 3137.952930706041, 3201.415299426775, 3293.2590167212425, 3397.677220664033, 29265.268368290752, 29459.558106628418, 29589.852050739824, 29802.403951921056, 30503.0, 3047.481928072233, 3119.984400077985, 3130.874765009397, 3155.25851424915, 3183.904482865518, 245960.0, 246275.0, 246495.0, 246801.0, 247185.0, 30702.84648576743, 32013.359732805213, 51589.74205129025, 51641.48358516442, 52237.47762522402, 33676.66323336784, 33725.66274337225, 33743.325133497194, 33887.83056084753, 33948.151296217795, 13229.140105893086, 13233.669158271121, 13396.598102056954, 13410.865891341156, 13413.865861341457, 11059.94930481603, 11119.44402779874, 11134.33194008362, 11152.163587730953, 11186.216964812385, 7807.531548107132, 7830.41271904598, 7873.724419645285, 7930.920690793134, 7967.721129760431, 3096.9714836781945, 3103.581016562735, 3121.266502371941, 3161.0674850919036, 3172.2862355969723, 884.8982367027745, 921.9907800922039, 940.1256831147099, 950.2493030505823, 958.5015791788231, 27331.0, 28118.156455305965, 28535.0774307696, 28565.0, 28956.27609309784, 933.2767105493297, 970.7864269860619, 972.9124378805941, 1026.3585259212991, 1052.116222373195, 14932.477363292233, 15008.924955375152, 15253.0, 15272.923635381974, 15410.656315460392, 400505.0, 405990.0, 406861.0, 408077.0, 408489.0, 50064.499355006716, 50117.498825012015, 50508.747456262485, 50819.74590127026, 50856.49143508592, 1171.1860257121389, 1202.81957706343, 1202.8436303280519, 1209.0992210803183, 1214.1136970011942, 26941.326466838487, 27999.580530628366, 28228.0, 28419.857900710365, 28629.713702862704, 43274.567254327056, 43711.78144109259, 43762.78118609387, 43777.0, 43844.56155438533, 264632.0, 266085.0, 267078.0, 267089.0, 269094.0, 24710.0, 25292.367690807878, 25443.36391590225, 25583.74416255888, 25623.743762562135, 41805.0, 41958.790206048776, 42463.0, 43225.0, 43491.0, 36422.4536631956, 36579.451308229865, 36715.265694685426, 37175.76945383286, 37292.627073728916, 36215.456768147975, 36313.27373452569, 36361.27277454383, 36608.45087323639, 37167.25665486729, 31266.0, 31944.8402757994, 35424.29151417009, 35802.28395432025, 36662.266754664226, 31609.683903160672, 32632.83683581567, 32711.509327359632, 32825.007245146284, 33004.50493242651, 25201.621975670747, 25386.492270154125, 25524.872375638744, 25642.871785640953, 25662.0], "value": 16325.960546700171, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.8385910199512, 369.8613020117457, 372.5994555852459, 381.6356525421615, 389.12446994262893, 15511.379544818208, 15896.125713085776, 16445.835541644596, 16943.0, 16992.235349409275, 15821.129837858913, 16022.679546409065, 16989.57526061846, 17003.57491062724, 17037.403690870822, 5000.7749651265685, 5137.152369858987, 5169.870753231162, 5185.455527169649, 5207.583393328525, 5059.06407314648, 5109.41241757199, 5158.716270605115, 5173.637845350827, 5180.3006594109875, 4966.50334966504, 5098.0, 5110.591152707793, 5116.1814109742445, 5130.102232109384, 5050.671706339076, 5116.079105760961, 5119.744012799364, 5129.128048231791, 5136.409312929024, 5189.351331083614, 5196.0647083524955, 5199.090159222121, 5247.291615631879, 5249.2388603652635, 12276.263424194576, 12291.754164916652, 12573.559925402658, 12582.0, 12681.682957926034, 1924.5573518090916, 1968.1241847377923, 2037.5313677854028, 2284.554511870186, 2330.5783472082016, 8992.685256016008, 9021.909780902173, 9266.305027122993, 9329.300302477273, 9358.157765801043, 1634.7384418492984, 1702.7445883117507, 1703.406813627249, 1704.3949397963668, 1711.2213942656062, 64571.0, 66999.66500167469, 67175.0, 68232.31767682309, 69345.3065469349, 9778.364406313567, 9854.802903941882, 10105.433657782909, 10278.383297002203, 10768.676939691823, 13739.656508587364, 13763.449462021606, 13866.306684665726, 13877.861221387657, 13962.790558141636, 7091.702358403367, 7152.284771522806, 7249.565026098451, 7328.78013659591, 7395.186529481753, 6709.127813384229, 6751.898721519181, 6812.557183783038, 6839.384455399038, 6844.384005439534, 4076.5311989121037, 4245.490541135084, 4300.741955482681, 4407.206702793464, 4454.732716037048, 1729.3860679458862, 1741.7300318450662, 1759.9429849741741, 1809.3576780243088, 1817.9454616361531, 775.7556369743513, 828.8508068547719, 883.6774577279375, 927.1609193679731, 973.7030205787303, 15565.533034008999, 16230.0, 16369.263383147787, 17036.403725869535, 17124.74312885308, 821.9054808696957, 832.3590835057093, 865.0786911938765, 878.6836738774036, 913.8081002989446, 9147.2682185425, 9412.952935235417, 9500.95489496155, 9503.952480237554, 9602.519874006271, 384226.0, 384235.0, 392721.0, 396364.0, 397292.0, 71470.2852971474, 73320.0, 75865.24134758693, 76149.0, 76898.0, 852.4160949749441, 881.9559022048871, 888.1651247827022, 894.821035792844, 900.2168113741087, 14269.785953210503, 14773.187474688566, 14805.0, 14892.7766083511, 15029.624259393602, 33854.492182616785, 37922.43116353202, 38572.0, 38765.41851872281, 39963.80018099891, 43952.56047439485, 50418.0, 51233.48766512287, 51657.0, 52233.21650175326, 6248.937510625017, 6800.591964482147, 6804.285550017177, 7588.734394296173, 7690.807729806799, 9115.680951166678, 10541.156707463231, 10728.785424291627, 10741.24846028537, 10973.0, 8899.688510902088, 8923.41997770143, 8998.602236421673, 9014.909850901407, 9457.668981585886, 9217.216536594464, 9276.72169834906, 9321.766955825888, 9374.0, 9500.192483638692, 8823.0, 8954.104589540993, 9104.180623743894, 9125.954370228106, 9214.815703686023, 6606.702698378681, 6706.094677218513, 6716.5634233774645, 6850.828729281808, 6984.79045628632, 8206.0, 8979.730608081769, 9306.953465232631, 9344.579493922925, 9451.0], "value": 7836.828457697552, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.8288963879515, 1385.4388972466152, 1474.8525147485245, 1678.8656907447398, 1683.444463327102, 6927.549709268894, 7628.923710762891, 7666.271704188107, 8204.261616454518, 8210.220029097227, 7774.766756997299, 8001.679932802681, 8006.079300880386, 8032.437729358947, 8077.676892924276, 2182.8253739700867, 2229.665550167472, 2238.563480121377, 2245.0, 2246.0, 2126.3302059851176, 2174.510735084609, 2193.9451513712124, 2195.264586363562, 2206.3491270075365, 2175.042981088324, 2215.3907675389237, 2222.48882756966, 2223.54417344444, 2225.221172589597, 2138.112683236455, 2175.184305885293, 2198.428408613772, 2199.417154454079, 2205.029786893778, 2146.527763891941, 2151.40836270027, 2155.137944822068, 2163.9783602164093, 2172.076867331378, 8031.4377993540475, 8120.715774947907, 8126.10612832588, 8132.634031468599, 8143.633536490872, 4514.729116253003, 4616.746078965655, 4674.065186962621, 4675.438947326308, 4685.88285292867, 2714.307851497875, 2739.260399692092, 2748.395353022332, 2880.35192081782, 2905.5786910898014, 913.7578541686458, 920.2821798996794, 920.4707293306309, 939.3847030195165, 946.1910066892846, 11082.335059896432, 11086.667399978014, 11094.223404361697, 11137.276077054965, 11141.220114591983, 4174.958250417518, 4265.1043280910735, 4320.481542214954, 4334.0, 4350.73895566267, 9305.302102342352, 9334.39326443779, 9338.766530836783, 9387.249020078378, 9398.90601093994, 4719.197736384823, 4725.763711814464, 4731.006488637425, 4741.241401375763, 4742.383490146328, 3720.776753394805, 4182.0, 4201.789910504463, 4267.0825772459075, 4320.071184695243, 3614.566252049771, 3621.1852333224815, 3723.2925744108534, 3731.8134093295225, 3736.439534069911, 1176.6293617510457, 1183.5443354308482, 1184.7452797648548, 1186.489809381974, 1192.4753108632174, 667.9398854103154, 792.8731402975611, 792.9920700793034, 811.6509900742619, 818.0796603820702, 4815.820124069625, 4923.679960802537, 5170.6122040847085, 5225.790968361299, 5282.834769535538, 796.303234669664, 811.926926576611, 831.6590198018783, 850.5407080176759, 885.7918389178537, 3229.5801545798895, 3267.39553182662, 3294.4234758917096, 3345.565076540034, 3359.848806803651, 9514.666986655433, 9657.71026869195, 9919.256055795844, 9950.701478955643, 9954.850677239847, 9722.416655000723, 9788.265880059023, 9812.950935245279, 9859.063388978035, 9859.950700246596, 7153.570785752871, 7211.314925082109, 7326.597037162901, 7353.485256032133, 7416.295451932057, 4910.582600479, 4910.8281210157475, 5072.340595722532, 5081.364829396325, 5093.668911520739, 8552.358573107167, 9012.143846334588, 9154.0, 9174.908250917406, 9283.535823208678, 9039.276857851488, 9076.95615004283, 9268.443893366419, 9369.672061477815, 9433.29250306216, 6049.51603871698, 6521.184851893513, 6837.076994605664, 6920.515563910478, 7048.9647551763965, 7694.345980591488, 7698.0, 7721.53670779755, 7743.4966727162555, 7787.4548781584745, 6844.315568443116, 7055.541389809646, 7071.25751796054, 7085.6457177141965, 7173.569585824867, 6898.344657257552, 6956.0609317741455, 6968.198657154492, 6987.7204911802955, 7043.190033146049, 5618.129189975561, 5891.293044834647, 5906.527477801679, 6033.728482218223, 6143.385661433821, 4443.31128675043, 4507.143642707875, 4540.795664195053, 4571.49713531518, 4581.67928245033, 4383.0, 4428.450042485105, 4479.7536135512855, 4554.772261386984, 4605.539446055368], "value": 4146.24143669025, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.26786898818455, 302.97879148459606, 309.953506973954, 311.4363002964634, 313.1607292456218, 4963.801447942078, 5002.449730529639, 5155.613329000326, 5226.372835259769, 5227.529522342993, 5091.643584949055, 5114.263868830177, 5122.795088196468, 5127.230915362688, 5150.27896094547, 4058.4115303281005, 4058.6347228749405, 4061.9593804062024, 4080.367543030835, 4083.734557253784, 3881.7476864003747, 4048.797560121997, 4079.9184016319655, 4081.795910204493, 4105.897352566195, 3982.5818289079666, 3992.301347264217, 3996.5204175498834, 4004.219177260421, 4015.2571774221715, 3956.9010774730573, 4000.4199391088273, 4007.699422543321, 4017.136315692111, 4020.6984476164403, 3320.0, 3445.1903802606366, 3453.723702103826, 3461.8788342408147, 3563.768355056913, 4979.701217926936, 4982.202847544376, 4992.276119962585, 4997.550220480174, 4997.725125118117, 4528.117017181651, 4535.569120933506, 4543.0459603483305, 4550.5904468597655, 4562.0, 5117.948820511784, 5330.733463326818, 5375.677459352412, 5404.594655400861, 5430.728463576806, 3876.8643097491736, 3883.728139030269, 3904.8828535143707, 3911.1395492991496, 3937.523428714232, 5665.773369065232, 5695.943040569583, 5698.0, 5730.77076916927, 5743.310802703702, 3871.4386413969814, 3973.6622387097423, 4023.5574086850424, 4027.6979226558124, 4034.4381317863367, 4094.1811637672586, 4094.7747873867224, 4095.607493452181, 4103.481711766665, 4107.158032603309, 4595.425571803525, 4631.846191520892, 4644.745918601959, 4664.603508701731, 4688.742119183477, 5199.506046925536, 5305.946940530623, 5344.385395679469, 5420.997115533639, 5493.423190565013, 1359.632899117233, 1401.9345297573918, 1408.1551069358304, 1408.204364534035, 1421.3035612549984, 897.1701176411793, 902.1609902790336, 924.3344791750063, 929.7582628516499, 930.851063829784, 4152.854650087233, 4224.4508213931995, 4233.5131459881895, 4236.961944323599, 4272.700910936267, 4919.409670839522, 4923.704577725348, 4946.851594452172, 4958.5372315167115, 5002.624803139779, 4220.240356735756, 4264.914701705949, 4269.423627810268, 4313.0, 4376.9124617508105, 2546.2615841405786, 2639.23462195961, 2648.1128821844513, 2662.786977041832, 2712.403271280315, 4580.908381832344, 4590.42619672541, 4591.65562582801, 4642.16441040616, 4649.930515981343, 4817.723947715587, 4978.651494395358, 4983.476734942778, 5014.573761230264, 5081.21241207606, 4605.217113090783, 4608.976955115203, 4624.907501850012, 4627.213373726542, 4700.435947686299, 4919.139150648693, 4919.3604831371695, 4935.309056731989, 4944.59079162437, 4976.685841083913, 4700.271457924027, 4836.733979631154, 4860.805567777249, 4869.342638743866, 4887.804487820447, 4566.931496027629, 4613.930791038204, 4668.883277918079, 4671.252599584186, 4696.671233013656, 3718.3678774607843, 3732.533433320835, 3734.234481931252, 3754.3293234511475, 3764.0589852536864, 5013.699178049329, 5024.547790698854, 5033.84898453047, 5409.323834520685, 5435.0, 5288.391834938878, 5293.5765138789575, 5310.654807437504, 5391.272178255886, 5419.945800542102, 5403.972980135074, 5420.159875219348, 5429.6199266051, 5430.728463576885, 5436.374816896107, 5080.46655101209, 5229.50319719626, 5261.447548007557, 5264.499872512105, 5310.920336195038, 5401.540869026177, 5418.160185171305, 5422.48486393792, 5462.726863656881, 5475.561955043508, 5285.572895318166, 5303.708296043755, 5316.255724198538, 5343.732813359395, 5374.677519348852], "value": 3926.767870451623, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [520.6719766547075, 537.9650322729022, 552.6344561619737, 573.4323020209993, 595.3837777899874, 10706.678799636014, 10770.784584308309, 10813.729656758585, 10824.512896919638, 10878.401687907162, 11527.365994870279, 12914.160579562322, 13022.088453808237, 13499.0, 13518.188908665486, 778.1479280188213, 781.468601351081, 783.807967048074, 786.8111653203247, 789.3290702902516, 779.5128044971892, 786.3119770201074, 787.4527203593476, 789.1122487201898, 790.0361558898135, 825.84721826462, 830.8006078541167, 830.9459885107478, 834.1116710703112, 837.1335667584052, 821.9712310069178, 822.1367564057746, 825.6821123867294, 828.9129641387658, 829.4732844643695, 602.7588964414225, 603.1676286724293, 603.3755063509246, 603.6317846113867, 604.8004158627687, 10966.616168434146, 11339.262947908443, 11467.19729618927, 11467.598634047768, 11484.827727584094, 12528.436220370106, 12651.304178270191, 12865.099443038991, 13041.934790326082, 13058.216507009514, 10449.79100417995, 10576.841347379795, 10615.681529554126, 10661.621556862343, 10732.0, 3327.73378129749, 3344.916377090592, 3347.129746265964, 3370.9494357584654, 3446.069561218457, 43589.56410435887, 53107.20339194915, 55004.174937376374, 63302.36697633011, 64505.0, 9930.801383972424, 10337.844932326021, 10370.481475926324, 10458.267921245591, 10667.73330666724, 16440.75338869918, 16592.419265325654, 16599.6680066398, 16615.916920415322, 16689.83310166907, 6959.965200173967, 7111.964440177766, 7132.393746531499, 7258.891116633255, 7371.9262807372315, 3702.453744143563, 3766.924661506809, 3799.886003419902, 3800.847966081381, 3842.346801043829, 2874.540073588216, 2936.045785119845, 2960.422717570053, 2971.702829717054, 2973.3310005249077, 508.4077050236507, 512.7461906356377, 513.6481510165548, 528.2235114381853, 535.2265975665205, 520.8099043848968, 542.7177867508873, 543.1201453645041, 553.5599198637012, 562.1595714406988, 7801.609919504115, 7933.889255504234, 8293.295069919004, 8465.830683386297, 8621.956890215633, 513.2147813844823, 534.9759260833272, 542.5876333986199, 545.492691796625, 548.7201527221066, 3718.219173973496, 3776.4712940188397, 3827.732058755916, 3841.7310788244554, 4027.7986100695434, 81804.18195818085, 87845.56077219702, 90400.0, 90804.54597726969, 93515.53242233882, 74589.25410745932, 77028.0, 77654.72898990496, 78015.21984780193, 79340.0, 70188.0, 70281.2971870285, 70295.64852175809, 70382.2961770386, 70405.29594703988, 7545.660445279866, 7787.026621672291, 7823.139454660097, 7869.763907082796, 8038.839223215386, 42482.0, 43752.0, 44062.0, 44520.0, 44586.0, 60694.69652651709, 64257.35742642514, 64358.0, 64573.67713161592, 64594.67702661457, 9340.859887101564, 9350.672726454814, 9473.47895865734, 9632.807343852943, 9717.514124293899, 10720.35677859331, 10892.945535272273, 11047.889521104686, 11114.888851111386, 11616.303021818718, 9779.217662587118, 10401.739956500845, 10438.425886576311, 10638.095761860328, 10853.077488413574, 9672.516374181403, 9986.0, 9986.950065249628, 10053.49732513386, 10150.13723833453, 9875.753106172404, 10017.39895606266, 10321.793564128826, 10587.682369528926, 10745.355278683304, 8636.654533818577, 8654.35935294315, 8949.59726812308, 9172.44965302084, 9217.262618990599, 8628.309735221043, 8801.51591662439, 8864.911350886408, 8956.462612243286, 9085.727428177166], "value": 6211.946767966398, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 107.0, 115.0, 114.0, 113.0, 114.0, 112.0, 113.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 135.0, 165.0, 212.0, 133.0, 154.0, 171.0, 136.0, 194.0, 132.0], "value": 159.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 177.0, 168.0, 164.0, 165.0, 167.0, 165.0, 163.0, 163.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 164.0, 75.0, 78.0, 76.0, 76.0, 153.0, 76.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 140.0, 87.0, 86.0, 88.0, 136.0, 86.0, 86.0, 145.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 149.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 98.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 97.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 64.0, 65.0, 64.0, 65.0, 63.0, 66.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 84.0, 84.0, 84.0, 84.0, 84.0, 83.0, 96.0, 83.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 132.0, 133.0, 138.0, 133.0, 141.0, 148.0, 136.0, 148.0, 133.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 174.0, 173.0, 172.0, 171.0, 174.0, 176.0, 171.0, 170.0, 167.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 69.0, 68.0, 67.0, 67.0, 68.0, 67.0, 67.0, 69.0], "value": 67.5, "unit": "score"}]}]} 14:09:04 INFO - Return code: 0 14:09:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:09:04 ERROR - # TBPL SUCCESS # 14:09:04 INFO - Running post-action listener: _resource_record_post_action 14:09:04 INFO - ##### 14:09:04 INFO - ##### Finished run-tests step (success) 14:09:04 INFO - ##### 14:09:04 INFO - Running post-run listener: _resource_record_post_run 14:09:05 INFO - Total resource usage - Wall time: 1198s; CPU: 14.0%; Read bytes: 4096; Write bytes: 543608832; Read time: 12; Write time: 590032 14:09:05 INFO - TinderboxPrint: CPU usage
13.6% 14:09:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:09:05 INFO - TinderboxPrint: I/O write bytes / time
543,608,832 / 590,032 14:09:05 INFO - TinderboxPrint: CPU idle
8,258.8 (86.4%) 14:09:05 INFO - TinderboxPrint: CPU user
1,240.4 (13.0%) 14:09:05 INFO - TinderboxPrint: Swap in / out
0 / 0 14:09:05 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 255197184; Read time: 0; Write time: 376860 14:09:05 INFO - run-tests - Wall time: 1182s; CPU: 14.0%; Read bytes: 4096; Write bytes: 288411648; Read time: 12; Write time: 213172 14:09:05 INFO - Running post-run listener: _upload_blobber_files 14:09:05 INFO - Blob upload gear active. 14:09:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:09:05 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 14:09:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:09:06 INFO - (blobuploader) - INFO - Open directory for files ... 14:09:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:09:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:09:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:09 INFO - (blobuploader) - INFO - Done attempting. 14:09:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:09:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:09:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:10 INFO - (blobuploader) - INFO - Done attempting. 14:09:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:09:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:09:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:11 INFO - (blobuploader) - INFO - Done attempting. 14:09:11 INFO - (blobuploader) - INFO - Iteration through files over. 14:09:11 INFO - Return code: 0 14:09:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:09:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:09:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/784788a3174013a3f3beb2e22e33a80a92ff96b395a309a20e9e3fb9e077c1d01d111f7c7533756bac4768495618d6d39e9b2d2cd9eddae675a821b2c105e244", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c269a202f2a29512bd950051622d8900ea4eb145ac688285f7c6d26f677185e4fa3cba6998c86865c9701ad992fa5344076a2155ce3d5ee2758709fb8c1a8e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f4c0a3ee5e34f4e7953bb85f237a4ac3b3559a6548fc5c23e9f075dc6e279bd505600c7ca8af686794871bdfc4ad6da0329eec4940bd0e062725bb221f782e2"} 14:09:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:09:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:09:11 INFO - Contents: 14:09:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/784788a3174013a3f3beb2e22e33a80a92ff96b395a309a20e9e3fb9e077c1d01d111f7c7533756bac4768495618d6d39e9b2d2cd9eddae675a821b2c105e244", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c269a202f2a29512bd950051622d8900ea4eb145ac688285f7c6d26f677185e4fa3cba6998c86865c9701ad992fa5344076a2155ce3d5ee2758709fb8c1a8e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f4c0a3ee5e34f4e7953bb85f237a4ac3b3559a6548fc5c23e9f075dc6e279bd505600c7ca8af686794871bdfc4ad6da0329eec4940bd0e062725bb221f782e2"} 14:09:11 INFO - Running post-run listener: copy_logs_to_upload_dir 14:09:11 INFO - Copying logs to upload dir... 14:09:11 INFO - mkdir: /builds/slave/test/build/upload/logs 14:09:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.546320 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-27 14:09:10.654365) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 14:09:10.658052) ========= 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=232498196343f89f466a4a9a000001c8-1467060493.211297-172304931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/784788a3174013a3f3beb2e22e33a80a92ff96b395a309a20e9e3fb9e077c1d01d111f7c7533756bac4768495618d6d39e9b2d2cd9eddae675a821b2c105e244", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c269a202f2a29512bd950051622d8900ea4eb145ac688285f7c6d26f677185e4fa3cba6998c86865c9701ad992fa5344076a2155ce3d5ee2758709fb8c1a8e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f4c0a3ee5e34f4e7953bb85f237a4ac3b3559a6548fc5c23e9f075dc6e279bd505600c7ca8af686794871bdfc4ad6da0329eec4940bd0e062725bb221f782e2"} build_url:https://queue.taskcluster.net/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011382 build_url: 'https://queue.taskcluster.net/v1/task/NJ93TSgvTFSIfWZULTVKcg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/784788a3174013a3f3beb2e22e33a80a92ff96b395a309a20e9e3fb9e077c1d01d111f7c7533756bac4768495618d6d39e9b2d2cd9eddae675a821b2c105e244", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1c269a202f2a29512bd950051622d8900ea4eb145ac688285f7c6d26f677185e4fa3cba6998c86865c9701ad992fa5344076a2155ce3d5ee2758709fb8c1a8e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6f4c0a3ee5e34f4e7953bb85f237a4ac3b3559a6548fc5c23e9f075dc6e279bd505600c7ca8af686794871bdfc4ad6da0329eec4940bd0e062725bb221f782e2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 14:09:10.684587) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 14:09:10.684965) ========= 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=232498196343f89f466a4a9a000001c8-1467060493.211297-172304931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 14:09:10.773021) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 14:09:10.773558) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 14:09:10.774023) ========= ========= Total master_lag: 0.17 =========