builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-042 starttime: 1466769039.32 results: success (0) buildid: 20160624013003 builduid: 60b12b67fba24d5ea5c6b3163190e8ac revision: f7b09506d96f69b2da2de2a5934328e1d294cba8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 04:50:39.323995) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 04:50:39.324725) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 04:50:39.325207) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 04:50:39.401073) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 04:50:39.401561) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 04:50:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.5M=0s 2016-06-24 04:50:40 (37.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082908 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 04:50:39.502583) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 04:50:39.503280) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017147 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 04:50:39.555781) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 04:50:39.556431) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f7b09506d96f69b2da2de2a5934328e1d294cba8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f7b09506d96f69b2da2de2a5934328e1d294cba8 --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=74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 04:50:40,756 truncating revision to first 12 chars 2016-06-24 04:50:40,756 Setting DEBUG logging. 2016-06-24 04:50:40,756 attempt 1/10 2016-06-24 04:50:40,756 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f7b09506d96f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 04:50:41,106 unpacking tar archive at: mozilla-inbound-f7b09506d96f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.703291 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 04:50:40.274450) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 04:50:40.274788) ========= script_repo_revision: f7b09506d96f69b2da2de2a5934328e1d294cba8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 04:50:40.275251) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 04:50:40.275554) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 04:50:40.286703) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-24 04:50:40.287010) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:50:41 INFO - MultiFileLogger online at 20160624 04:50:41 in /builds/slave/test 04:50:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:50:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:50:41 INFO - {'append_to_log': False, 04:50:41 INFO - 'base_work_dir': '/builds/slave/test', 04:50:41 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:50:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:50:41 INFO - 'branch': 'Mozilla-Inbound', 04:50:41 INFO - 'buildbot_json_path': 'buildprops.json', 04:50:41 INFO - 'config_files': ('talos/linux_config.py',), 04:50:41 INFO - 'default_actions': ('clobber', 04:50:41 INFO - 'read-buildbot-config', 04:50:41 INFO - 'download-and-extract', 04:50:41 INFO - 'populate-webroot', 04:50:41 INFO - 'create-virtualenv', 04:50:41 INFO - 'install', 04:50:41 INFO - 'run-tests'), 04:50:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:50:41 INFO - 'download_minidump_stackwalk': True, 04:50:41 INFO - 'download_symbols': 'ondemand', 04:50:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:50:41 INFO - 'tooltool.py': '/tools/tooltool.py', 04:50:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:50:41 INFO - '/tools/misc-python/virtualenv.py')}, 04:50:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:50:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:50:41 INFO - 'installer_path': 'installer.exe', 04:50:41 INFO - 'log_level': 'info', 04:50:41 INFO - 'log_name': 'talos', 04:50:41 INFO - 'log_to_console': True, 04:50:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:50:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:50:41 INFO - 'opt_config_files': (), 04:50:41 INFO - 'pip_index': False, 04:50:41 INFO - 'sps_profile': False, 04:50:41 INFO - 'sps_profile_interval': 0, 04:50:41 INFO - 'suite': 'dromaeojs-e10s', 04:50:41 INFO - 'system_bits': '32', 04:50:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:50:41 INFO - 'title': 'talos-linux64-ix-042', 04:50:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:50:41 INFO - 'use_talos_json': True, 04:50:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:50:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:50:41 INFO - 'work_dir': 'build'} 04:50:41 INFO - ##### 04:50:41 INFO - ##### Running clobber step. 04:50:41 INFO - ##### 04:50:41 INFO - Running pre-action listener: _resource_record_pre_action 04:50:41 INFO - Running main action method: clobber 04:50:41 INFO - rmtree: /builds/slave/test/build 04:50:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:50:42 INFO - Running post-action listener: _resource_record_post_action 04:50:42 INFO - ##### 04:50:42 INFO - ##### Finished clobber step (success) 04:50:42 INFO - ##### 04:50:42 INFO - ##### 04:50:42 INFO - ##### Running read-buildbot-config step. 04:50:42 INFO - ##### 04:50:42 INFO - Running pre-action listener: _resource_record_pre_action 04:50:42 INFO - Running main action method: read_buildbot_config 04:50:42 INFO - Using buildbot properties: 04:50:42 INFO - { 04:50:42 INFO - "project": "", 04:50:42 INFO - "product": "firefox", 04:50:42 INFO - "script_repo_revision": "production", 04:50:42 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 04:50:42 INFO - "repository": "", 04:50:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 04:50:42 INFO - "buildid": "20160624013003", 04:50:42 INFO - "pgo_build": "True", 04:50:42 INFO - "basedir": "/builds/slave/test", 04:50:42 INFO - "buildnumber": 1205, 04:50:42 INFO - "slavename": "talos-linux64-ix-042", 04:50:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:50:42 INFO - "platform": "ubuntu64_hw", 04:50:42 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:50:42 INFO - "branch": "mozilla-inbound", 04:50:42 INFO - "repo_path": "integration/mozilla-inbound", 04:50:42 INFO - "revision": "f7b09506d96f69b2da2de2a5934328e1d294cba8", 04:50:42 INFO - "stage_platform": "linux64-pgo", 04:50:42 INFO - "builduid": "60b12b67fba24d5ea5c6b3163190e8ac", 04:50:42 INFO - "slavebuilddir": "test" 04:50:42 INFO - } 04:50:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:50:42 INFO - Running post-action listener: _resource_record_post_action 04:50:42 INFO - ##### 04:50:42 INFO - ##### Finished read-buildbot-config step (success) 04:50:42 INFO - ##### 04:50:42 INFO - ##### 04:50:42 INFO - ##### Running download-and-extract step. 04:50:42 INFO - ##### 04:50:42 INFO - Running pre-action listener: _resource_record_pre_action 04:50:42 INFO - Running main action method: download_and_extract 04:50:42 INFO - mkdir: /builds/slave/test/build/tests 04:50:42 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')]} 04:50:42 INFO - https://queue.taskcluster.net/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:50:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:50:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:50:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZlk3obISy-GXGaqYLdgCQ/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 04:50:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZlk3obISy-GXGaqYLdgCQ/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 04:50:43 INFO - Downloaded 1361 bytes. 04:50:43 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:50:43 INFO - Using the following test package requirements: 04:50:43 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:50:43 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:50:43 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:50:43 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:43 INFO - u'jsshell-linux-x86_64.zip'], 04:50:43 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:50:43 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:50:43 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:50:43 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:50:43 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:50:43 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:50:43 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:50:43 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:43 INFO - https://queue.taskcluster.net/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:50:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:50:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:50:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZlk3obISy-GXGaqYLdgCQ/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 04:50:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZlk3obISy-GXGaqYLdgCQ/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 04:50:44 INFO - Downloaded 24270952 bytes. 04:50:44 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'] 04:50:44 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 04:50:45 INFO - Return code: 0 04:50:45 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 04:50:45 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')]} 04:50:45 INFO - https://queue.taskcluster.net/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:50:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:50:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:50:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZlk3obISy-GXGaqYLdgCQ/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 04:50:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZlk3obISy-GXGaqYLdgCQ/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 04:50:47 INFO - Downloaded 24270952 bytes. 04:50:47 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'] 04:50:47 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 04:50:48 INFO - Return code: 0 04:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:48 INFO - https://queue.taskcluster.net/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:50:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:50:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:50:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZlk3obISy-GXGaqYLdgCQ/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 04:50:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZlk3obISy-GXGaqYLdgCQ/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 04:50:49 INFO - Downloaded 14405188 bytes. 04:50:49 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'] 04:50:49 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 04:50:49 INFO - Return code: 0 04:50: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')]} 04:50:49 INFO - https://queue.taskcluster.net/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:50:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:50:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:50:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZlk3obISy-GXGaqYLdgCQ/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 04:50:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KZlk3obISy-GXGaqYLdgCQ/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 04:50:51 INFO - Downloaded 60130251 bytes. 04:50:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:50:51 INFO - mkdir: /builds/slave/test/properties 04:50:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:50:51 INFO - Writing to file /builds/slave/test/properties/build_url 04:50:51 INFO - Contents: 04:50:51 INFO - build_url:https://queue.taskcluster.net/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:50:51 INFO - Running post-action listener: _resource_record_post_action 04:50:51 INFO - Running post-action listener: set_extra_try_arguments 04:50:51 INFO - ##### 04:50:51 INFO - ##### Finished download-and-extract step (success) 04:50:51 INFO - ##### 04:50:51 INFO - ##### 04:50:51 INFO - ##### Running populate-webroot step. 04:50:51 INFO - ##### 04:50:51 INFO - Running pre-action listener: _resource_record_pre_action 04:50:51 INFO - Running main action method: populate_webroot 04:50:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:50:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:50:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:50:51 INFO - '--tppagecycles', 04:50:51 INFO - '7'], 04:50:51 INFO - 'tests': ['tsvgm']}}, 04:50:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:50:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:50:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:50:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:50:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:50:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:50:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:51 INFO - 'talos_options': ['--disable-e10s'], 04:50:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:50:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:50:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:51 INFO - 'talos_options': ['--disable-e10s'], 04:50:51 INFO - 'tests': ['damp', 'tps']}, 04:50:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:51 INFO - 'tests': ['damp', 'tps']}, 04:50:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:50:51 INFO - 'tests': ['dromaeo_dom']}, 04:50:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:50:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:50:51 INFO - 'tests': ['basic_compositor_video']}, 04:50:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:50:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:50:51 INFO - 'tests': ['a11yr', 04:50:51 INFO - 'ts_paint', 04:50:51 INFO - 'tpaint', 04:50:51 INFO - 'sessionrestore', 04:50:51 INFO - 'sessionrestore_no_auto_restore', 04:50:51 INFO - 'tabpaint']}, 04:50:51 INFO - 'other-e10s': {'tests': ['a11yr', 04:50:51 INFO - 'ts_paint', 04:50:51 INFO - 'tpaint', 04:50:51 INFO - 'sessionrestore', 04:50:51 INFO - 'sessionrestore_no_auto_restore', 04:50:51 INFO - 'tabpaint']}, 04:50:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:50:51 INFO - 'ts_paint', 04:50:51 INFO - 'tpaint', 04:50:51 INFO - 'sessionrestore', 04:50:51 INFO - 'sessionrestore_no_auto_restore', 04:50:51 INFO - 'tabpaint']}, 04:50:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:50:51 INFO - 'ts_paint', 04:50:51 INFO - 'tpaint', 04:50:51 INFO - 'sessionrestore', 04:50:51 INFO - 'sessionrestore_no_auto_restore', 04:50:51 INFO - 'tabpaint']}, 04:50:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:50:51 INFO - 'tests': ['a11yr', 04:50:51 INFO - 'ts_paint', 04:50:51 INFO - 'tpaint', 04:50:51 INFO - 'sessionrestore', 04:50:51 INFO - 'sessionrestore_no_auto_restore', 04:50:51 INFO - 'tabpaint']}, 04:50:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:50:51 INFO - 'tests': ['a11yr', 04:50:51 INFO - 'ts_paint', 04:50:51 INFO - 'tpaint', 04:50:51 INFO - 'sessionrestore', 04:50:51 INFO - 'sessionrestore_no_auto_restore', 04:50:51 INFO - 'tabpaint']}, 04:50:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:50:51 INFO - 'tests': ['tsvgx', 04:50:51 INFO - 'tsvgr_opacity', 04:50:51 INFO - 'tart', 04:50:51 INFO - 'tscrollx', 04:50:51 INFO - 'cart']}, 04:50:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:50:51 INFO - 'tsvgr_opacity', 04:50:51 INFO - 'tart', 04:50:51 INFO - 'tscrollx', 04:50:51 INFO - 'cart']}, 04:50:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:51 INFO - 'talos_options': ['--disable-e10s'], 04:50:51 INFO - 'tests': ['tp5o']}, 04:50:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:51 INFO - 'tests': ['tp5o']}, 04:50:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:51 INFO - 'talos_options': ['--disable-e10s', 04:50:51 INFO - '--xperf_path', 04:50:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:50:51 INFO - 'tests': ['tp5n']}, 04:50:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:50:51 INFO - 'talos_options': ['--xperf_path', 04:50:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:50:51 INFO - 'tests': ['tp5n']}}, 04:50:51 INFO - 'talos.zip': {'path': '', 04:50:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:50:51 INFO - Running post-action listener: _resource_record_post_action 04:50:51 INFO - ##### 04:50:51 INFO - ##### Finished populate-webroot step (success) 04:50:51 INFO - ##### 04:50:51 INFO - ##### 04:50:51 INFO - ##### Running create-virtualenv step. 04:50:51 INFO - ##### 04:50:51 INFO - Running pre-action listener: _resource_record_pre_action 04:50:51 INFO - Running main action method: create_virtualenv 04:50:51 INFO - Creating virtualenv /builds/slave/test/build/venv 04:50:51 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 04:50:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:50:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:50:52 INFO - Using real prefix '/usr' 04:50:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:50:52 INFO - Installing distribute.............................................................................................................................................................................................done. 04:50:54 INFO - Installing pip.................done. 04:50:54 INFO - Return code: 0 04:50:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f58ca6e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12de020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13702e0>, '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 0x12dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc5d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', '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 04:50:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:50:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:50:54 INFO - Using env: {'DISPLAY': ':0', 04:50:54 INFO - 'HOME': '/home/cltbld', 04:50:54 INFO - 'LANG': 'en_US.UTF-8', 04:50:54 INFO - 'LANGUAGE': 'en_US:en', 04:50:54 INFO - 'LOGNAME': 'cltbld', 04:50:54 INFO - 'MAIL': '/var/mail/cltbld', 04:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:54 INFO - 'MOZ_NO_REMOTE': '1', 04:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:54 INFO - 'NO_EM_RESTART': '1', 04:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:54 INFO - 'PWD': '/builds/slave/test', 04:50:54 INFO - 'SHELL': '/bin/bash', 04:50:54 INFO - 'SHLVL': '1', 04:50:54 INFO - 'TERM': 'linux', 04:50:54 INFO - 'TMOUT': '86400', 04:50:54 INFO - 'USER': 'cltbld', 04:50:54 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', 04:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:54 INFO - '_': '/tools/buildbot/bin/python'} 04:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:54 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 04:50:54 INFO - Cleaning up... 04:50:54 INFO - Return code: 0 04:50:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f58ca6e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12de020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13702e0>, '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 0x12dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc5d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', '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 04:50:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:50:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:50:54 INFO - Using env: {'DISPLAY': ':0', 04:50:54 INFO - 'HOME': '/home/cltbld', 04:50:54 INFO - 'LANG': 'en_US.UTF-8', 04:50:54 INFO - 'LANGUAGE': 'en_US:en', 04:50:54 INFO - 'LOGNAME': 'cltbld', 04:50:54 INFO - 'MAIL': '/var/mail/cltbld', 04:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:54 INFO - 'MOZ_NO_REMOTE': '1', 04:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:54 INFO - 'NO_EM_RESTART': '1', 04:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:54 INFO - 'PWD': '/builds/slave/test', 04:50:54 INFO - 'SHELL': '/bin/bash', 04:50:54 INFO - 'SHLVL': '1', 04:50:54 INFO - 'TERM': 'linux', 04:50:54 INFO - 'TMOUT': '86400', 04:50:54 INFO - 'USER': 'cltbld', 04:50:54 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', 04:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:54 INFO - '_': '/tools/buildbot/bin/python'} 04:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:54 INFO - Downloading/unpacking psutil>=3.1.1 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:50:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:50:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:50:56 INFO - Installing collected packages: psutil 04:50:56 INFO - Running setup.py install for psutil 04:50:57 INFO - building 'psutil._psutil_linux' extension 04:50:57 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 04:50:57 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 04:50:57 INFO - building 'psutil._psutil_posix' extension 04:50:57 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 04:50:57 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 04:50:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:50:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:50:57 INFO - Successfully installed psutil 04:50:57 INFO - Cleaning up... 04:50:57 INFO - Return code: 0 04:50:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f58ca6e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12de020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13702e0>, '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 0x12dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc5d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', '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 04:50:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:50:57 INFO - Using env: {'DISPLAY': ':0', 04:50:57 INFO - 'HOME': '/home/cltbld', 04:50:57 INFO - 'LANG': 'en_US.UTF-8', 04:50:57 INFO - 'LANGUAGE': 'en_US:en', 04:50:57 INFO - 'LOGNAME': 'cltbld', 04:50:57 INFO - 'MAIL': '/var/mail/cltbld', 04:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:57 INFO - 'MOZ_NO_REMOTE': '1', 04:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:57 INFO - 'NO_EM_RESTART': '1', 04:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:57 INFO - 'PWD': '/builds/slave/test', 04:50:57 INFO - 'SHELL': '/bin/bash', 04:50:57 INFO - 'SHLVL': '1', 04:50:57 INFO - 'TERM': 'linux', 04:50:57 INFO - 'TMOUT': '86400', 04:50:57 INFO - 'USER': 'cltbld', 04:50:57 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', 04:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:57 INFO - '_': '/tools/buildbot/bin/python'} 04:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:50:59 INFO - Installing collected packages: mozsystemmonitor 04:50:59 INFO - Running setup.py install for mozsystemmonitor 04:50:59 INFO - Successfully installed mozsystemmonitor 04:50:59 INFO - Cleaning up... 04:50:59 INFO - Return code: 0 04:50:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:50:59 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')]} 04:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:59 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')]} 04:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:59 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 0x7f58ca6e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12de020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13702e0>, '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 0x12dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc5d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', '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 04:50:59 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 04:50:59 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 04:50:59 INFO - Using env: {'DISPLAY': ':0', 04:50:59 INFO - 'HOME': '/home/cltbld', 04:50:59 INFO - 'LANG': 'en_US.UTF-8', 04:50:59 INFO - 'LANGUAGE': 'en_US:en', 04:50:59 INFO - 'LOGNAME': 'cltbld', 04:50:59 INFO - 'MAIL': '/var/mail/cltbld', 04:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:59 INFO - 'MOZ_NO_REMOTE': '1', 04:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:59 INFO - 'NO_EM_RESTART': '1', 04:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:59 INFO - 'PWD': '/builds/slave/test', 04:50:59 INFO - 'SHELL': '/bin/bash', 04:50:59 INFO - 'SHLVL': '1', 04:50:59 INFO - 'TERM': 'linux', 04:50:59 INFO - 'TMOUT': '86400', 04:50:59 INFO - 'USER': 'cltbld', 04:50:59 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', 04:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:59 INFO - '_': '/tools/buildbot/bin/python'} 04:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:59 INFO - Downloading/unpacking jsonschema==2.5.1 04:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:51:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:02 INFO - Downloading functools32-3.2.3-2.tar.gz 04:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:51:02 INFO - warning: no files found matching '*.txt' 04:51:02 INFO - no previously-included directories found matching 'build' 04:51:02 INFO - no previously-included directories found matching 'dist' 04:51:02 INFO - no previously-included directories found matching '.git*' 04:51:02 INFO - Installing collected packages: jsonschema, functools32 04:51:02 INFO - Running setup.py install for functools32 04:51:02 INFO - warning: no files found matching '*.txt' 04:51:02 INFO - no previously-included directories found matching 'build' 04:51:02 INFO - no previously-included directories found matching 'dist' 04:51:02 INFO - no previously-included directories found matching '.git*' 04:51:02 INFO - Successfully installed jsonschema functools32 04:51:02 INFO - Cleaning up... 04:51:02 INFO - Return code: 0 04:51:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:51: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')]} 04:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51: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')]} 04:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51: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', '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 0x7f58ca6e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12de020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13702e0>, '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 0x12dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc5d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', '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 04:51: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:51: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 blobuploader==1.2.4 04:51:02 INFO - Using env: {'DISPLAY': ':0', 04:51:02 INFO - 'HOME': '/home/cltbld', 04:51:02 INFO - 'LANG': 'en_US.UTF-8', 04:51:02 INFO - 'LANGUAGE': 'en_US:en', 04:51:02 INFO - 'LOGNAME': 'cltbld', 04:51:02 INFO - 'MAIL': '/var/mail/cltbld', 04:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:02 INFO - 'MOZ_NO_REMOTE': '1', 04:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:02 INFO - 'NO_EM_RESTART': '1', 04:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:02 INFO - 'PWD': '/builds/slave/test', 04:51:02 INFO - 'SHELL': '/bin/bash', 04:51:02 INFO - 'SHLVL': '1', 04:51:02 INFO - 'TERM': 'linux', 04:51:02 INFO - 'TMOUT': '86400', 04:51:02 INFO - 'USER': 'cltbld', 04:51:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', 04:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:02 INFO - '_': '/tools/buildbot/bin/python'} 04:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:02 INFO - Downloading/unpacking blobuploader==1.2.4 04:51:02 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 04:51:02 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 04:51:02 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 04:51:02 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 04:51:02 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 04:51:02 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 04:51:04 INFO - Downloading blobuploader-1.2.4.tar.gz 04:51:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:51:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:51:04 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 04:51:04 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 04:51:04 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 04:51:04 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 04:51:04 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 04:51:04 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 04:51:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:51:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:51:04 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 04:51:04 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 04:51:04 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 04:51:04 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 04:51:04 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 04:51:04 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 04:51:05 INFO - Downloading docopt-0.6.1.tar.gz 04:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:51:05 INFO - Installing collected packages: blobuploader, requests, docopt 04:51:05 INFO - Running setup.py install for blobuploader 04:51:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:51:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:51:05 INFO - Running setup.py install for requests 04:51:05 INFO - Running setup.py install for docopt 04:51:05 INFO - Successfully installed blobuploader requests docopt 04:51:05 INFO - Cleaning up... 04:51:05 INFO - Return code: 0 04:51:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:51:05 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')]} 04:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:05 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')]} 04:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:05 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 0x7f58ca6e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12de020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13702e0>, '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 0x12dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc5d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', '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 04:51:05 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 04:51:05 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 04:51:05 INFO - Using env: {'DISPLAY': ':0', 04:51:05 INFO - 'HOME': '/home/cltbld', 04:51:05 INFO - 'LANG': 'en_US.UTF-8', 04:51:05 INFO - 'LANGUAGE': 'en_US:en', 04:51:05 INFO - 'LOGNAME': 'cltbld', 04:51:05 INFO - 'MAIL': '/var/mail/cltbld', 04:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:05 INFO - 'MOZ_NO_REMOTE': '1', 04:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:05 INFO - 'NO_EM_RESTART': '1', 04:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:05 INFO - 'PWD': '/builds/slave/test', 04:51:05 INFO - 'SHELL': '/bin/bash', 04:51:05 INFO - 'SHLVL': '1', 04:51:05 INFO - 'TERM': 'linux', 04:51:05 INFO - 'TMOUT': '86400', 04:51:05 INFO - 'USER': 'cltbld', 04:51:05 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', 04:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:05 INFO - '_': '/tools/buildbot/bin/python'} 04:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:51:06 INFO - Running setup.py (path:/tmp/pip-rNwPeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:51:06 INFO - Running setup.py (path:/tmp/pip-c2lwUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:51:06 INFO - Running setup.py (path:/tmp/pip-ahFbCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:51:06 INFO - Running setup.py (path:/tmp/pip-79lDQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:51:06 INFO - Running setup.py (path:/tmp/pip-jtVSo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:51:06 INFO - Running setup.py (path:/tmp/pip-mO7gY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:51:06 INFO - Running setup.py (path:/tmp/pip-v7fXIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:51:06 INFO - Running setup.py (path:/tmp/pip-reR9KR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:51:06 INFO - Running setup.py (path:/tmp/pip-IuEyNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:51:06 INFO - Running setup.py (path:/tmp/pip-wBrVAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:51:06 INFO - Running setup.py (path:/tmp/pip-yUqnlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:51:06 INFO - Running setup.py (path:/tmp/pip-Xx7L2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:51:06 INFO - Running setup.py (path:/tmp/pip-nvYEEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:51:06 INFO - Running setup.py (path:/tmp/pip-f5Iq92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:07 INFO - Running setup.py (path:/tmp/pip-wZjkCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:51:07 INFO - Running setup.py (path:/tmp/pip-hR34pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:51:07 INFO - Running setup.py (path:/tmp/pip-vPlmpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:51:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:51:07 INFO - Running setup.py install for manifestparser 04:51:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:51:07 INFO - Running setup.py install for mozcrash 04:51:07 INFO - Running setup.py install for mozdebug 04:51:07 INFO - Running setup.py install for mozdevice 04:51:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:51:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:51:07 INFO - Running setup.py install for mozfile 04:51:07 INFO - Running setup.py install for mozhttpd 04:51:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:51:07 INFO - Running setup.py install for mozinfo 04:51:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:51:07 INFO - Running setup.py install for mozInstall 04:51:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:51:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:51:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:51:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:51:08 INFO - Running setup.py install for mozleak 04:51:08 INFO - Running setup.py install for mozlog 04:51:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:51:08 INFO - Running setup.py install for moznetwork 04:51:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:51:08 INFO - Running setup.py install for mozprocess 04:51:08 INFO - Running setup.py install for mozprofile 04:51:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:51:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:51:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:51:08 INFO - Running setup.py install for mozrunner 04:51:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:51:08 INFO - Running setup.py install for mozscreenshot 04:51:08 INFO - Running setup.py install for moztest 04:51:08 INFO - Running setup.py install for mozversion 04:51:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:51:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:51:09 INFO - Cleaning up... 04:51:09 INFO - Return code: 0 04:51:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:09 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 0x7f58ca6e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12de020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13702e0>, '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 0x12dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc5d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', '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 04:51:09 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 04:51:09 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 04:51:09 INFO - Using env: {'DISPLAY': ':0', 04:51:09 INFO - 'HOME': '/home/cltbld', 04:51:09 INFO - 'LANG': 'en_US.UTF-8', 04:51:09 INFO - 'LANGUAGE': 'en_US:en', 04:51:09 INFO - 'LOGNAME': 'cltbld', 04:51:09 INFO - 'MAIL': '/var/mail/cltbld', 04:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:09 INFO - 'MOZ_NO_REMOTE': '1', 04:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:09 INFO - 'NO_EM_RESTART': '1', 04:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:09 INFO - 'PWD': '/builds/slave/test', 04:51:09 INFO - 'SHELL': '/bin/bash', 04:51:09 INFO - 'SHLVL': '1', 04:51:09 INFO - 'TERM': 'linux', 04:51:09 INFO - 'TMOUT': '86400', 04:51:09 INFO - 'USER': 'cltbld', 04:51:09 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', 04:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:09 INFO - '_': '/tools/buildbot/bin/python'} 04:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:51:09 INFO - Running setup.py (path:/tmp/pip-aPIX2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:51:09 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)) 04:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:51:09 INFO - Running setup.py (path:/tmp/pip-LL2TTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:51:09 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)) 04:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:51:09 INFO - Running setup.py (path:/tmp/pip-9zwHKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:51:09 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)) 04:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:51:09 INFO - Running setup.py (path:/tmp/pip-z8avUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:51:09 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)) 04:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:51:09 INFO - Running setup.py (path:/tmp/pip-wVZgsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:51:09 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)) 04:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:51:09 INFO - Running setup.py (path:/tmp/pip-oPMOLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:51:09 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)) 04:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:51:09 INFO - Running setup.py (path:/tmp/pip-EasOJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:51:09 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)) 04:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:51:09 INFO - Running setup.py (path:/tmp/pip-K7fClG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:51:09 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)) 04:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:51:09 INFO - Running setup.py (path:/tmp/pip-ZNbUOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:51:09 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)) 04:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:51:09 INFO - Running setup.py (path:/tmp/pip-5JlZeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:51:09 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)) 04:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:51:09 INFO - Running setup.py (path:/tmp/pip-87Jovv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:51:10 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)) 04:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:51:10 INFO - Running setup.py (path:/tmp/pip-8H0ZLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:51:10 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)) 04:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:51:10 INFO - Running setup.py (path:/tmp/pip-T76E6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:51:10 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)) 04:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:51:10 INFO - Running setup.py (path:/tmp/pip-1lmAm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:51:10 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)) 04:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:10 INFO - Running setup.py (path:/tmp/pip-72YYIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:51:10 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)) 04:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:51:10 INFO - Running setup.py (path:/tmp/pip-dG5jok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:51:10 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)) 04:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:51:10 INFO - Running setup.py (path:/tmp/pip-FW7LkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:51:10 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)) 04:51:10 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)) 04:51:10 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)) 04:51:10 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)) 04:51:10 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)) 04:51:10 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)) 04:51:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:51:12 INFO - Downloading blessings-1.6.tar.gz 04:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:51:12 INFO - Installing collected packages: blessings 04:51:12 INFO - Running setup.py install for blessings 04:51:12 INFO - Successfully installed blessings 04:51:12 INFO - Cleaning up... 04:51:12 INFO - Return code: 0 04:51:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:51:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:51:12 INFO - Reading from file tmpfile_stdout 04:51:12 INFO - Current package versions: 04:51:12 INFO - argparse == 1.2.1 04:51:12 INFO - blessings == 1.6 04:51:12 INFO - blobuploader == 1.2.4 04:51:12 INFO - docopt == 0.6.1 04:51:12 INFO - functools32 == 3.2.3-2 04:51:12 INFO - jsonschema == 2.5.1 04:51:12 INFO - manifestparser == 1.1 04:51:12 INFO - mozInstall == 1.12 04:51:12 INFO - mozcrash == 0.17 04:51:12 INFO - mozdebug == 0.1 04:51:12 INFO - mozdevice == 0.48 04:51:12 INFO - mozfile == 1.2 04:51:12 INFO - mozhttpd == 0.7 04:51:12 INFO - mozinfo == 0.9 04:51:12 INFO - mozleak == 0.1 04:51:12 INFO - mozlog == 3.2 04:51:12 INFO - moznetwork == 0.27 04:51:12 INFO - mozprocess == 0.22 04:51:12 INFO - mozprofile == 0.28 04:51:12 INFO - mozrunner == 6.11 04:51:12 INFO - mozscreenshot == 0.1 04:51:12 INFO - mozsystemmonitor == 0.3 04:51:12 INFO - moztest == 0.7 04:51:12 INFO - mozversion == 1.4 04:51:12 INFO - psutil == 3.1.1 04:51:12 INFO - requests == 1.2.3 04:51:12 INFO - wsgiref == 0.1.2 04:51:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:12 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 0x7f58ca6e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12de020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13702e0>, '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 0x12dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc5d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', '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 04:51:12 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 04:51:12 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 04:51:12 INFO - Using env: {'DISPLAY': ':0', 04:51:12 INFO - 'HOME': '/home/cltbld', 04:51:12 INFO - 'LANG': 'en_US.UTF-8', 04:51:12 INFO - 'LANGUAGE': 'en_US:en', 04:51:12 INFO - 'LOGNAME': 'cltbld', 04:51:12 INFO - 'MAIL': '/var/mail/cltbld', 04:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:12 INFO - 'MOZ_NO_REMOTE': '1', 04:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:12 INFO - 'NO_EM_RESTART': '1', 04:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:12 INFO - 'PWD': '/builds/slave/test', 04:51:12 INFO - 'SHELL': '/bin/bash', 04:51:12 INFO - 'SHLVL': '1', 04:51:12 INFO - 'TERM': 'linux', 04:51:12 INFO - 'TMOUT': '86400', 04:51:12 INFO - 'USER': 'cltbld', 04:51:12 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', 04:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:12 INFO - '_': '/tools/buildbot/bin/python'} 04:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:13 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)) 04:51:13 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)) 04:51:13 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)) 04:51:13 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)) 04:51:13 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)) 04:51:13 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)) 04:51:13 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)) 04:51:13 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)) 04:51:13 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)) 04:51:13 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)) 04:51:13 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)) 04:51:13 INFO - Cleaning up... 04:51:13 INFO - Return code: 0 04:51:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:51:13 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')]} 04:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:13 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')]} 04:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:13 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 0x7f58ca6e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12de020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13702e0>, '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 0x12dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc5d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', '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 04:51:13 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 04:51:13 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 04:51:13 INFO - Using env: {'DISPLAY': ':0', 04:51:13 INFO - 'HOME': '/home/cltbld', 04:51:13 INFO - 'LANG': 'en_US.UTF-8', 04:51:13 INFO - 'LANGUAGE': 'en_US:en', 04:51:13 INFO - 'LOGNAME': 'cltbld', 04:51:13 INFO - 'MAIL': '/var/mail/cltbld', 04:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:13 INFO - 'MOZ_NO_REMOTE': '1', 04:51:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:13 INFO - 'NO_EM_RESTART': '1', 04:51:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:13 INFO - 'PWD': '/builds/slave/test', 04:51:13 INFO - 'SHELL': '/bin/bash', 04:51:13 INFO - 'SHLVL': '1', 04:51:13 INFO - 'TERM': 'linux', 04:51:13 INFO - 'TMOUT': '86400', 04:51:13 INFO - 'USER': 'cltbld', 04:51:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', 04:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:13 INFO - '_': '/tools/buildbot/bin/python'} 04:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:51:13 INFO - Cleaning up... 04:51:13 INFO - Return code: 0 04:51:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:51:13 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')]} 04:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:13 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')]} 04:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:51:13 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 0x7f58ca6e5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12de020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13702e0>, '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 0x12dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc5d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', '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 04:51:13 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 04:51:13 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 04:51:13 INFO - Using env: {'DISPLAY': ':0', 04:51:13 INFO - 'HOME': '/home/cltbld', 04:51:13 INFO - 'LANG': 'en_US.UTF-8', 04:51:13 INFO - 'LANGUAGE': 'en_US:en', 04:51:13 INFO - 'LOGNAME': 'cltbld', 04:51:13 INFO - 'MAIL': '/var/mail/cltbld', 04:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:13 INFO - 'MOZ_NO_REMOTE': '1', 04:51:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:13 INFO - 'NO_EM_RESTART': '1', 04:51:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:13 INFO - 'PWD': '/builds/slave/test', 04:51:13 INFO - 'SHELL': '/bin/bash', 04:51:13 INFO - 'SHLVL': '1', 04:51:13 INFO - 'TERM': 'linux', 04:51:13 INFO - 'TMOUT': '86400', 04:51:13 INFO - 'USER': 'cltbld', 04:51:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', 04:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:13 INFO - '_': '/tools/buildbot/bin/python'} 04:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:51:13 INFO - Downloading/unpacking flake8 04:51:13 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 04:51:13 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 04:51:13 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 04:51:13 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 04:51:13 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 04:51:13 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 04:51:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:51:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:51:15 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 04:51:15 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 04:51:15 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 04:51:15 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 04:51:15 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 04:51:15 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 04:51:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:51:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:51:15 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 04:51:15 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 04:51:15 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 04:51:15 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 04:51:15 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 04:51:15 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 04:51:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:51:15 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 04:51:15 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 04:51:15 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 04:51:15 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 04:51:15 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 04:51:15 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 04:51:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:51:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:51:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:51:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:51:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:51:16 INFO - no previously-included directories found matching 'docs/_build' 04:51:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:51:16 INFO - Running setup.py install for pep8 04:51:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:51:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:51:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:51:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:51:16 INFO - no previously-included directories found matching 'docs/_build' 04:51:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:51:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:51:16 INFO - Cleaning up... 04:51:16 INFO - Return code: 0 04:51:16 INFO - Running post-action listener: _resource_record_post_action 04:51:16 INFO - Running post-action listener: _start_resource_monitoring 04:51:16 INFO - Starting resource monitoring. 04:51:16 INFO - ##### 04:51:16 INFO - ##### Finished create-virtualenv step (success) 04:51:16 INFO - ##### 04:51:16 INFO - ##### 04:51:16 INFO - ##### Running install step. 04:51:16 INFO - ##### 04:51:16 INFO - Running pre-action listener: _resource_record_pre_action 04:51:16 INFO - Running main action method: install 04:51:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:51:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:51:16 INFO - Reading from file tmpfile_stdout 04:51:16 INFO - Detecting whether we're running mozinstall >=1.0... 04:51:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:51:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:51:16 INFO - Reading from file tmpfile_stdout 04:51:16 INFO - Output received: 04:51:16 INFO - Usage: mozinstall [options] installer 04:51:16 INFO - Options: 04:51:16 INFO - -h, --help show this help message and exit 04:51:16 INFO - -d DEST, --destination=DEST 04:51:16 INFO - Directory to install application into. [default: 04:51:16 INFO - "/builds/slave/test"] 04:51:16 INFO - --app=APP Application being installed. [default: firefox] 04:51:16 INFO - mkdir: /builds/slave/test/build/application 04:51:16 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'] 04:51:16 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 04:51:33 INFO - Reading from file tmpfile_stdout 04:51:33 INFO - Output received: 04:51:33 INFO - /builds/slave/test/build/application/firefox/firefox 04:51:33 INFO - Running post-action listener: _resource_record_post_action 04:51:33 INFO - ##### 04:51:33 INFO - ##### Finished install step (success) 04:51:33 INFO - ##### 04:51:33 INFO - ##### 04:51:33 INFO - ##### Running run-tests step. 04:51:33 INFO - ##### 04:51:33 INFO - Running pre-action listener: _resource_record_pre_action 04:51:33 INFO - Running main action method: run_tests 04:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:51:33 INFO - Python 2.7.3 04:51:33 INFO - Return code: 0 04:51:33 INFO - grabbing minidump binary from tooltool 04:51:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:51:33 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 0x13702e0>, '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 0x12dc140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:51:33 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 04:51:33 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 04:51:33 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 04:51:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:51:33 INFO - Return code: 0 04:51:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:51:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:51:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:51:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:51:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:51:34 INFO - Return code: 0 04:51:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 04:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 04:51:34 INFO - Using env: {'DISPLAY': ':0', 04:51:34 INFO - 'HOME': '/home/cltbld', 04:51:34 INFO - 'LANG': 'en_US.UTF-8', 04:51:34 INFO - 'LANGUAGE': 'en_US:en', 04:51:34 INFO - 'LOGNAME': 'cltbld', 04:51:34 INFO - 'MAIL': '/var/mail/cltbld', 04:51:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:51:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:34 INFO - 'MOZ_NO_REMOTE': '1', 04:51:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:51:34 INFO - 'NO_EM_RESTART': '1', 04:51:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:34 INFO - 'PWD': '/builds/slave/test', 04:51:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:51:34 INFO - 'SHELL': '/bin/bash', 04:51:34 INFO - 'SHLVL': '1', 04:51:34 INFO - 'TERM': 'linux', 04:51:34 INFO - 'TMOUT': '86400', 04:51:34 INFO - 'USER': 'cltbld', 04:51:34 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671', 04:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:34 INFO - '_': '/tools/buildbot/bin/python'} 04:51:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 04:51:34 INFO - mozversion application_buildid: 20160624013003 04:51:34 INFO - mozversion application_changeset: f7b09506d96f69b2da2de2a5934328e1d294cba8 04:51:34 INFO - mozversion application_display_name: Nightly 04:51:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:51:34 INFO - mozversion application_name: Firefox 04:51:34 INFO - mozversion application_remotingname: firefox 04:51:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:51:34 INFO - mozversion application_vendor: Mozilla 04:51:34 INFO - mozversion application_version: 50.0a1 04:51:34 INFO - mozversion platform_buildid: 20160624013003 04:51:34 INFO - mozversion platform_changeset: f7b09506d96f69b2da2de2a5934328e1d294cba8 04:51:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:51:34 INFO - mozversion platform_version: 50.0a1 04:51:34 INFO - using testdate: 1466769094 04:51:34 INFO - actual date: 1466769094 04:51:34 INFO - starting webserver on 'localhost:38195' 04:51:34 INFO - SUITE-START | Running 2 tests 04:51:34 INFO - TEST-START | dromaeo_css 04:51:34 INFO - operating with platform_type : linux_ 04:51:34 INFO - Initialising browser for dromaeo_css test... 04:51:34 INFO - TEST-INFO | started process 22434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDCShoS/profile http://localhost:38195/getInfo.html) 04:51:40 INFO - PROCESS | 22434 | __metrics Screen width/height:1600/1200 04:51:40 INFO - PROCESS | 22434 | colorDepth:24 04:51:40 INFO - PROCESS | 22434 | Browser inner width/height: 1024/697 04:51:40 INFO - PROCESS | 22434 | __metrics 04:51:40 ERROR - PROCESS | 22434 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 04:51:41 INFO - TEST-INFO | 22434: exit 0 04:51:41 INFO - Browser initialized. 04:51:41 INFO - Running cycle 1/1 for dromaeo_css test... 04:51:41 INFO - TEST-INFO | started process 22556 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDCShoS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:53 INFO - PROCESS | 22556 | RSS: Main: 185061376 04:51:53 INFO - PROCESS | 22556 | 04:52:43 INFO - PROCESS | 22556 | 1466769163158 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] 04:54:51 INFO - PROCESS | 22556 | Cycle 1(1): loaded http://localhost:38195/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38195/tests/dromaeo/cssquery-ext.html) 04:54:52 INFO - PROCESS | 22556 | RSS: Main: 188801024 04:54:52 INFO - PROCESS | 22556 | 04:57:54 INFO - PROCESS | 22556 | Cycle 1(1): loaded http://localhost:38195/tests/dromaeo/cssquery-ext.html (next: http://localhost:38195/tests/dromaeo/cssquery-jquery.html) 04:57:54 INFO - PROCESS | 22556 | RSS: Main: 187539456 04:57:54 INFO - PROCESS | 22556 | 05:00:56 INFO - PROCESS | 22556 | Cycle 1(1): loaded http://localhost:38195/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38195/tests/dromaeo/cssquery-mootools.html) 05:00:57 INFO - PROCESS | 22556 | RSS: Main: 189345792 05:00:57 INFO - PROCESS | 22556 | 05:03:59 INFO - PROCESS | 22556 | Cycle 1(1): loaded http://localhost:38195/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38195/tests/dromaeo/cssquery-prototype.html) 05:03:59 INFO - PROCESS | 22556 | RSS: Main: 186789888 05:03:59 INFO - PROCESS | 22556 | 05:07:02 INFO - PROCESS | 22556 | Cycle 1(1): loaded http://localhost:38195/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38195/tests/dromaeo/cssquery-yui.html) 05:07:02 INFO - PROCESS | 22556 | RSS: Main: 188747776 05:07:02 INFO - PROCESS | 22556 | 05:10:05 INFO - PROCESS | 22556 | Cycle 1(1): loaded http://localhost:38195/tests/dromaeo/cssquery-yui.html (next: http://localhost:38195/tests/dromaeo/cssquery-dojo.html) 05:10:05 INFO - PROCESS | 22556 | RSS: Main: 189464576 05:10:05 INFO - PROCESS | 22556 | 05:10:05 INFO - PROCESS | 22556 | __start_tp_report 05:10:05 INFO - PROCESS | 22556 | _x_x_mozilla_page_load 05:10:05 INFO - PROCESS | 22556 | _x_x_mozilla_page_load_details 05:10:05 INFO - PROCESS | 22556 | |i|pagename|runs| 05:10:05 INFO - PROCESS | 22556 | |0;dojo.html;3071.585335979643;3116.0184541869316;3126.640436349819;3146.2449012237043;3156.8263745493987;5315.548178404831;5320.866978325539;5371.355437347519;5381.704006279653;5383.703896285702;5188.2995795567585;5310.70791106489;5374.247605335247;5380.623356365056;5411.83764487065;4811.13399588074;4883.072216278913;4970.403551573798;4976.900461990758;5043.319151914499;572.3277798040552;4763;4869.269609558577;4882.170031094704;4976.900461990776;4921.458639549646;4937.851864444073;4946.208606622941;4954.009198160383;4963.751812409401;4952.455229924742;4961.4542400336295;4965.602751779849;4978.2034874419915;4982.252662100677;4748.907751217205;4845.951540484621;4853.150698627726;4871.732054736988;4872.537108974641;5258.526732594085;5323.813666521692;5327.706976116312;5344.091504444254;5347.144456886879;5563.109902415594;5646.915296270559;5743.856403589902;5745.166950792153;5784.219130417382;5733.3406658234;5748.770049198069;5773.191753154561;5773.538116950675;5825.504832089277;5390.730463476811;5391.676499410009;5391.892162156774;5394.379646340682;5400.648957817729;5747.885042299131;5874.765009399662;5879.441453062038;5889.558283128783;5933.317668468181;5683.8010669626365;5704.3154821421695;5714.485696287354;5744.281964754406;5757.971210144006;5779.768809247583;5783.306003279633;5792.768289268466;5799.768009279666;5803.941960580424;5587.608867379245;5627.549796016309;5790.305163380422;5795.971020144872;5815.447532484407;5802.622829516068;5808.477237048686;5810.360860305363;5831.737571809279;5860.970695146497;4431.667624928079;4437;4465.263231566755;4466.196084704719;4492.415985921809;3932.4494570760116;3971.62269584389;3988.7008474363956;4010.839566417311;4041.81811818463;5476.452354764491;5486.533644640251;5543.1408131739645;5544.584156188302;5550.306211723535;5762.135679648086;5856.238688970407;5860.355360910296;5864.384239654775;5869.178315035899;5390.380106287827;5447.700376479332;5593.916091258634;5603.271574695264;5611.466910643482;5038;5061.898762024813;5082.059818933509;5095.847124586268;5123.436421993578;6042.607230530001;6061.605995610271;6115.785947491817;6126.6017708848785;6132.141500189977;5575;5665;5763.567732420169;5782.913256301159;5794.217780599565;6102.03483898519;6113.693598638453;6114.019547345639;6118.497354392036;6118.862843289846;5698.800541981177;5698.829035128787;5700.629459085146;5707.971460142673;5729.799457019151;5510.228568000403;5666.603337766482;5712.514436272797;5721.914171287517;5747.453991870766;5583.106702927512;5635.239242702182;5639.295088113986;5640.520555752807;5651.124075768263;5578.49793518569;5599.8880022400135;5600.69196194197;5614.04561224601;5630.127330263816;5354.678719276856;5510.0632892409185;5574.052411090205;5585.720713964367;5627.296587926509;5679.062954612443;5696.971515142398;5723.456271654186;5741.799037033851;5753.367129615823;5330.893382132258;5571.303587051619;5574.777008919597;5584.46947539983;5596.048671725735 05:10:05 INFO - PROCESS | 22556 | |1;ext.html;582.3681305783225;601.6360102138207;614.1095411653102;618.2642655240261;619.408464916005;39964.200715985666;41086.38370424442;41299.38050929239;41545.37681934766;45400.772996134976;42649.14701705972;43364;43431.13137737251;43983.56016439835;44103.117937641226;8799.956000220005;8897.955510222473;8922.509261990588;8944.508052057134;8964.686235981742;8803.779905502382;8809.735707928772;8811.074837142103;8827.73516794494;8887.73336799897;8877.20105190536;8877.289816814671;8883.911160888372;8884.289256859469;8899.599518021705;8484.745457636282;8516.318694504456;8518.23335899772;8521.786955326104;8530;8672.349573781992;8742.519161446118;8751.474911505331;8781.07798681142;8782.209601135864;41265.1746965059;41728.58271417277;41828;41863.7906810467;41873.581264187276;3166.493361062242;3310.751693622964;3336.2993771308056;3342.197872510604;3409.5226668266464;28152.436951261065;28461.57307640387;28949.565756513668;29006;29153.70846291531;4360.520342762294;4367.58507941745;4466.263066594008;4548.204064288736;4574.947762014755;242054;243432;243602;245608;246753.9999999982;33537.496937545955;34357.82821085879;34373.82813085918;53852.46147538474;54724.72637636866;35913.46129808055;36257;36356.81821590875;36425.817870910476;36531.634683653356;13717.45130194781;13757.724845503235;13787;13917.443302267797;13923.58229253124;11488.597899073493;11541.884581154249;11578.536858525564;11584.884151158549;11592.362420066976;7281.490295679358;7285.70857165718;7389.408847292311;7461.328480436787;7474.252574742591;3137.325475022881;3186.713195812342;3201.791883527563;3234;3243.821589812536;928.5171710710528;962.2206013129388;1097.3854641400842;1118.3625333559955;1140.5323817234894;31589.684103159136;31997.360052798813;32054.519182211818;32207.51688724671;32614.184645383582;973.4451362723321;984.6159997600942;1053.7892421515728;1078.4715489410132;1095.2169199022737;15852.52442426729;16292.185390730654;16359.263833127538;16423.83576164247;16563;601884.9811501916;605553;609674;610645;611316;56026.71986640041;57260.42739572634;57749.42250577525;57873.71063144657;57933.131003034985;1289.2715615677112;1307.7706955461836;1308.5812539987303;1314.8750868667653;1325.9801102983463;29407.411851762416;29925;30972.690273097884;31155.065348039596;31370;48945.510544894096;49172.26241606307;49594;49694.75152624214;49717.254241185685;358150;358554;486266;487565;488176;27472.313192170357;27825.16524504268;28034.579481308203;28066.736996834785;28129;45109.548904510535;46997.295040573736;48311.37664675234;48323.27515087206;48355;40179;40210.79894600508;40872.56946006876;41588.01988746383;41790;40812.38781418222;40914.18171636491;41255.1748965013;41490.37764433475;41807;40273.39589906095;40761.184776303715;41226;41519.377209342485;43650;34197.65802341945;37239.255214895005;37610.247795044495;37795.81102094472;38146.42780358352;27990.720092798812;28266.2933426666;28692.282692932844;28722.856385717936;28860 05:10:05 INFO - PROCESS | 22556 | |2;jquery.html;383.6087191065113;387.755713900243;391.9745216560922;393.5886998086999;412.64512519233455;13601.38793754281;15309.846901530982;17602.735958960628;19182.90408547957;19351;14365.569032929003;16373.91813040933;16745.330186792515;16864.241109150087;17487.300507979664;5625.887482250352;5784;5815.505682017034;5852.887951289263;5875.588708790387;5653;5740.024195886688;5751.338596061465;5756;5778.422157784209;5315.415304316522;5629.240052592909;5633.859153521174;5674.489295963363;5677.432256774331;5653.632513886605;5725;6342.175517182783;6360.872782544369;6361.872762544724;4872.3422337984275;5614.242077319551;5747.56893233005;5761.020626493506;5777.62445441045;12887.935560322232;13052.15161014531;13167.60497185086;13194.340282985811;14259.928700356535;1970.2808474906556;2041.8672786268844;2131.8827464489445;2289.8511596746157;2665.0405853892585;9412.670556530556;9581.233501319877;9582.952085239598;13443.26062066586;14401;1751.3344928927054;1752.4589345449021;1761.7093179625347;1779.0570997371415;1822.1618055694396;76611;76723;76932.61533692296;77128;78546.21453785447;10429.68710938658;10430.322029068086;10490.580376784843;10541.420221887869;10715.517801698943;14418.206998614967;14436;14489.20309382973;14500.274986250855;14515.274236288144;7011.54424962386;7057.858842823115;7189.1013623297085;7440.330370266702;7672.846543069108;6839.247682754893;6851.828704282433;6856.828579285558;7040.9647951760935;7114.324139206767;4375.146846364928;4391.890202744893;4395.373711726682;4398.164348773723;4542.182407166676;1874.9625007499774;1952.8730632508841;1955.3645065353817;2002.3392280547384;2017.7982201779705;886.7916039730658;970.45169479244;979.3389462113046;996.8155891160159;1011.6863772230632;18257.908710456628;18752.34366797183;18964.905175474036;19097.427077187705;19135.52161195981;870.5516658920661;984.5667906121283;1016.5730393234859;1018.1600179851652;1058.4496062047692;10358.223133264884;10513.632022879163;10555.313904596176;10878.72803179911;10933.398663073449;520815;524169;533488;533896.9577281642;534563;55349.446505534426;74577;91424.54287728519;92102;99931;965.5896244096231;970.6554173268529;986.3292960786733;991.5290237137447;998.9211651416452;17323.82676173222;17477.861741393153;18106.637867242844;18187.18157682881;18217.817821822144;29721.554176686936;34400.82799585986;36680.266394671424;41180.1763964725;42015;55921.72039139778;56513;59478.70260648842;59493.405065948784;59732.70133649478;8057.798555036171;8149.7147599833725;8418.410711250153;8486.533240671575;8494.830103397773;9545.761355966157;13794;14101.365438555085;14245.572632821031;14253.857461425254;11638.476268567765;11762.3530705812;11927.522899083939;11982.700432489257;12054.638360849189;11879.80223658626;11904.285742855456;12138.150329476852;12178.451969661564;12260.14179007461;12095.879041209828;12202.20685655465;12218.633440996784;12415.503379864704;12415.93792031034;8113.553754543321;8219.383546234176;8287.875681864656;8404.705835295736;8423.620937057725;8702.91297087021;10739.355638661393;11420.086393088699;11599.478023488795;12378.44297006655 05:10:05 INFO - PROCESS | 22556 | |3;mootools.html;1439.7984282200493;1475.2107622422004;1546.5128484527372;1680.8739344549163;1689.9915500422503;7833.882491762628;8381.32949364051;8453.57732113395;8950.373473856824;8966.686165984192;8511.489310641366;8710.34672399571;8798.42810217337;8806.427582207152;8828.29373650108;2332.7200735911674;2351.95296094078;2364.598018336887;2367.6685264062958;2368.4670949036417;2326.464913069995;2355.0815182079004;2386.200622791367;2386.2483317754936;2390.95218095638;2306.1813056365;2313.3869524575916;2339.7543257957923;2339.894704738291;2342.812574994005;2235.832312576555;2258.6612008198904;2280.1563421533974;2298.276043046435;2315.363275099353;2352.776486233805;2354.4937838364835;2377.702787151606;2382.583047966616;2389.569877422063;8694.956525217396;8752.21230089295;8809;8829.779255518664;8836.072212417668;4940.604751619861;4957.553820156168;5052.216906379517;5078.974605126988;5080.923786143211;3359.96640033599;3430.6397828227928;3466.2027733621157;3518.66572675598;3541.5218945442293;1098.8516550265772;1147;1155.7341811383428;1182.2788099259444;1185.0993245133761;12263.509459621604;12435.813462798065;12466.065045121652;12482.687932801662;12533;4463.330500424897;4515.277555591089;4600.608948239437;4607.44710634726;4615.100055489147;10246.333988290737;10322.380657160595;10336.896631033744;10339.224558158168;10401.53193106312;5097.082525145435;5107.719075450812;5122.129238029544;5146.022255771391;5154.201098829687;4244.957550424518;4603.58567728906;4667.439907211156;4737.24204127338;4773.832915847998;3812.694984401241;3884.4950156479476;3893.902652433655;3999.320115580358;4036.2936486114813;1268.7969924811987;1272.6500212441467;1286.4339690536135;1286.5561381323428;1288.1626942487271;751.1812124784012;845.6110189312861;899.5771987166022;916.8258030974093;917.8393781088283;5581;5613;5627.12202915921;5720.313562372458;5866.442687944638;905.5336501701629;929.5212965322864;934.8734774596595;951.9333646644668;972.1882228339274;3740.3080430120513;3898.142408670088;3934.252492026506;3939.1727737174942;3947.940780888289;10677.83983240252;11062.004419602274;11096;11105.666829995112;11112.611058612909;10686.786264274671;11202.551897924155;11258.83111753308;11260.718482037852;11265.887341126649;8332.958335208285;8411.873821892677;8423.410361274775;8458.661653533789;8487.618057187441;5575.526080283222;5655.4344565543115;5702.45826646468;5737.426257374396;5853.970730146322;10245.897541024495;10281;10411.895881041395;10432.321899076536;10455.059044686015;10251.12865406419;10356.896431035895;10379.377237365783;10533.683989480327;10633.680989570325;6832.965835170792;7295.927040729737;7308.342249197598;7407.8148046299275;7524;8692.0438751736;8722.520261385685;8727.170918762708;8813.030566637794;8813.294936404944;7282.745103921337;7429.33136017761;7638.312551870358;7693.384529237535;8006.999125109362;7629.46593738433;7678.270564296383;7687.192844751445;7760.068791745027;7761.495502792301;7243.45674074457;7258.673359698932;7284.963575182091;7311.524750891175;7320.1215854097845;4951.603871690329;4966.478519755374;5057.342545469065;5136.768845402041;5210.036143313499;5130.333056702605;5188.22176673502;5188.247704082963;5188.766505507186;5208.869778255574 05:10:05 INFO - PROCESS | 22556 | |4;prototype.html;302.7683821876265;306.26190879979254;306.602949180811;313.60172580822353;314.19252521020974;5572.804951826682;5610.663360198391;5611.607187496877;5624.268845050143;5728.42715728427;5533.363663178736;5553.694546799924;5562.163296718672;5590.552755779538;5616.241807356006;4123.443335149761;4123.9793801030955;4212.473440819897;4237.724547904377;4265.338872474771;4205.474315710536;4232.936505952398;4237.38557909103;4243.957560424403;4261.573842615745;4231.788410579474;4255.829766809324;4260.850870219543;4279.764612946286;4299.462567179103;4019.919601607981;4236.216299984513;4253.29820579604;4265.274903266452;4271.103068355649;3723.515942927429;3723.7393382463238;3744.925101497982;3750.6497660842074;3754.3054534910857;5424.918626220609;5454.53636440903;5454.672719636835;5455.699936503491;5509.256250406224;4764.690295130806;4850.223964165716;4850.889862909646;4873.01280046853;4906.828261010847;5712.285964254468;5756.33802112754;5764.5676574257095;5769.826905192851;5783.537317014629;4044.8382064717375;4046.9477935736627;4059.857904973341;4072.9796351018053;4079.5920407959266;5789.913151302734;6004;6007.609505382136;6020.4581587656885;6042.818715438544;4123.8556650517685;4125.5874412558505;4144.3990621359735;4172.165566886635;4173.33066773287;4224.471941007374;4225.070484493406;4237.385579091015;4249.128928569636;4255.170241802881;4727.338172655831;4900.681455705368;4906.386701662293;4916.852494425173;4919.827806026843;5768.711564421846;5785.27684039495;5815.709214539341;5888.234529511136;5899;1402.4039783092146;1422.07565082695;1426.2298358886085;1431.8496557861274;1433.519770876747;897.9236764874928;911.5761171055491;913.6847787513298;930.5719369090294;963.7012526116927;5512.200730893998;5631.831045068655;5635.239242702265;5636.323641163087;5670.121131224667;5773.74018169175;5864.266966629171;5901.940980590139;5910.704464776744;5916.881662366814;5281;5524.613277070647;5533.75490514631;5606.159076138611;5616.269884914935;3108.4870996285813;3130.577372054789;3143.764217683683;3152.3537674776617;3160.668129846379;5803.5357171426185;6125.264968203844;6127.5404344674325;6153.538484613672;6172.783952561639;5881.9705901470215;5929.851753706192;5938.287405511366;5952.5833191676165;5964.940350596526;6021.638701677914;6103.084537319438;6116.78591249313;6140.89463896494;6169.167162433104;5622;5694.601377903507;5783.768649253982;5798.318487638538;5863.149843272787;5735.827925162252;5780;5823.030254570284;5827.155062515827;5850.356460789395;6038.215032045806;6072.514198864169;6131.202943617302;6131.344536975081;6313.43179113882;4171.520275168395;4203.97898010508;4210.45264115663;4238.36424536322;4256.616904478488;6048.699529600981;6084.904717150778;6094.2077529920825;6103.115048318058;6109.525642114951;5686.9715651421475;5868.911966320423;5882.882342353215;5915.497182739516;5928.584999050025;5839.080459770115;5859.296884373903;5872.911906321494;5893.5874488785375;5911.7635294587735;5567.972160139173;5571.498565129158;5706.885862282814;5790.681512516852;5824.184614153937;5865.120231965239;5887.881302552501;5900.229931020763;5928.762849485972;5935.940640593712;5579.19101730255;5748.476653686693;5753.597248192754;5759.222504961944;5802.4197580241635 05:10:05 INFO - PROCESS | 22556 | |5;yui.html;749.4042236422044;764.5298141642888;786.893769341139;806.681360862459;843.2452954605626;13672.658183545416;13887.513937012207;13890.722185556282;13900.235487048209;13962.790558141623;14333.426662933496;14333.928330358334;14362.497312594036;14363.71272574548;14384.856151438482;734.8750712378882;759.9430042746789;793.0562630469751;799.168864381046;803;779.6335722210551;784.9882251766228;785.0540099180474;789.8775689768095;791.7110254757001;815.7756616930362;823.1480417767611;824.789678631948;826.2522417212432;827.3546633625751;810.7000409848364;812.959352032399;813.324940299553;819.1030821250721;819.2053707903324;591.6006695480534;596.1564386393248;596.8836076964993;597.7818096394784;598.6408155106901;14190.787138192936;14248.287585620781;14294.92852535741;14296.428142874272;14297.71404571913;14341.524513897186;14444.133351998913;14586.854131458762;14678.192699401528;14779.482718104922;11623.94188029063;11719.824202636883;11786.116041296851;11829.467673954692;11896.167268291223;3699.2416554606243;3771.4719939208535;3937.1338305572726;3965.167314863882;3986.382110772806;72691.63654181748;73216;73341;74468.25531744667;75571.62214188949;11088.722781930517;11400.315981041163;11495.137864660184;11497.310161390176;11755.412229388496;20255.898720506597;20277.79722202759;20295.18819247243;20343.389698309074;20387.082581283878;8290.502569845828;8398.370122240856;8472.110428405053;8494;8553.486790792573;4793.376861008047;4822.9758851205515;4852.902941941142;4922.261660750916;4990.500949905053;3264.6735326467638;3357.7649564530248;3368.427367347557;3368.494725791151;3379.4761811919193;600.5195843325322;619.6591874469024;627.9058141278845;638.7700427845972;641.2241188162376;584.9502792262621;659.4197106546304;673.7574473189648;680.2517231045908;685.5671646259342;8477.576121193915;8668.566571671392;8708.433951793113;8718;8730.86903696445;615.6521565315672;632.9841753956188;636.2746469025315;655.2333769489709;694.5416025423197;4350.282203436461;4627.167109920247;4673.395638629284;4705.7411842349;4795.640326975491;105047.4747626257;109723;113009.43495282636;113358.49811264189;113424;101035;101348.49325753324;102212.48893755632;102642;103093;70879.64560177166;85199;86201.56899215464;86243;86791;8507.191816777397;8772.429792063751;8841.336899732674;9037.41256818331;9193.54032298369;50655.24017139672;50956;51182;51772.74113629408;53028.901676307716;74530.2546974545;75884.62057689676;79145;79888;81693.18306816855;11399.373034483184;11761.529538818351;11807.940960295487;11850.170488065753;12454.813177802522;13505.257210853497;13656;13679.726405471636;14359.712805744035;14519.637009074857;12621.87378126207;12829.93585032069;13294.268815215257;13470.124441911245;13495.797563036365;12292.569760058355;13125.081244312807;13467.797983030066;13526.458941642224;13684.973626977817;12713.87286127127;13224.206547607175;13273.137246079361;13456.25990570528;13482.944165477144;9409.623615055321;9570.808583828424;9597.328187026842;9643.614255429704;9803.558839852367;10019.749506262402;10707.357558546511;10898.346099234072;10946.45267736594;11004.779904402027 05:10:05 INFO - PROCESS | 22556 | __end_tp_report 05:10:05 INFO - PROCESS | 22556 | __start_cc_report 05:10:05 INFO - PROCESS | 22556 | _x_x_mozilla_cycle_collect,358 05:10:05 INFO - PROCESS | 22556 | __end_cc_report 05:10:05 INFO - PROCESS | 22556 | __startTimestamp1466770205837__endTimestamp 05:10:05 INFO - PROCESS | 22556 | 05:10:05 INFO - PROCESS | 22556 | ------- Summary: start ------- 05:10:05 INFO - PROCESS | 22556 | Number of tests: 6 05:10:05 INFO - PROCESS | 22556 | 05:10:05 INFO - PROCESS | 22556 | [#0] dojo.html Cycles:165 Average:5344.16 Median:5584.47 stddev:713.01 (12.8%) stddev-sans-first:692.55 05:10:05 INFO - PROCESS | 22556 | Values: 3071.6 3116.0 3126.6 3146.2 3156.8 5315.5 5320.9 5371.4 5381.7 5383.7 5188.3 5310.7 5374.2 5380.6 5411.8 4811.1 4883.1 4970.4 4976.9 5043.3 572.3 4763.0 4869.3 4882.2 4976.9 4921.5 4937.9 4946.2 4954.0 4963.8 4952.5 4961.5 4965.6 4978.2 4982.3 4748.9 4846.0 4853.2 4871.7 4872.5 5258.5 5323.8 5327.7 5344.1 5347.1 5563.1 5646.9 5743.9 5745.2 5784.2 5733.3 5748.8 5773.2 5773.5 5825.5 5390.7 5391.7 5391.9 5394.4 5400.6 5747.9 5874.8 5879.4 5889.6 5933.3 5683.8 5704.3 5714.5 5744.3 5758.0 5779.8 5783.3 5792.8 5799.8 5803.9 5587.6 5627.5 5790.3 5796.0 5815.4 5802.6 5808.5 5810.4 5831.7 5861.0 4431.7 4437.0 4465.3 4466.2 4492.4 3932.4 3971.6 3988.7 4010.8 4041.8 5476.5 5486.5 5543.1 5544.6 5550.3 5762.1 5856.2 5860.4 5864.4 5869.2 5390.4 5447.7 5593.9 5603.3 5611.5 5038.0 5061.9 5082.1 5095.8 5123.4 6042.6 6061.6 6115.8 6126.6 6132.1 5575.0 5665.0 5763.6 5782.9 5794.2 6102.0 6113.7 6114.0 6118.5 6118.9 5698.8 5698.8 5700.6 5708.0 5729.8 5510.2 5666.6 5712.5 5721.9 5747.5 5583.1 5635.2 5639.3 5640.5 5651.1 5578.5 5599.9 5600.7 5614.0 5630.1 5354.7 5510.1 5574.1 5585.7 5627.3 5679.1 5697.0 5723.5 5741.8 5753.4 5330.9 5571.3 5574.8 5584.5 5596.0 05:10:05 INFO - PROCESS | 22556 | 05:10:05 INFO - PROCESS | 22556 | [#1] ext.html Cycles:180 Average:57333.32 Median:41240.59 stddev:122035.43 (295.9%) stddev-sans-first:122303.39 05:10:05 INFO - PROCESS | 22556 | Values: 582.4 601.6 614.1 618.3 619.4 39964.2 41086.4 41299.4 41545.4 45400.8 42649.1 43364.0 43431.1 43983.6 44103.1 8800.0 8898.0 8922.5 8944.5 8964.7 8803.8 8809.7 8811.1 8827.7 8887.7 8877.2 8877.3 8883.9 8884.3 8899.6 8484.7 8516.3 8518.2 8521.8 8530.0 8672.3 8742.5 8751.5 8781.1 8782.2 41265.2 41728.6 41828.0 41863.8 41873.6 3166.5 3310.8 3336.3 3342.2 3409.5 28152.4 28461.6 28949.6 29006.0 29153.7 4360.5 4367.6 4466.3 4548.2 4574.9 242054.0 243432.0 243602.0 245608.0 246754.0 33537.5 34357.8 34373.8 53852.5 54724.7 35913.5 36257.0 36356.8 36425.8 36531.6 13717.5 13757.7 13787.0 13917.4 13923.6 11488.6 11541.9 11578.5 11584.9 11592.4 7281.5 7285.7 7389.4 7461.3 7474.3 3137.3 3186.7 3201.8 3234.0 3243.8 928.5 962.2 1097.4 1118.4 1140.5 31589.7 31997.4 32054.5 32207.5 32614.2 973.4 984.6 1053.8 1078.5 1095.2 15852.5 16292.2 16359.3 16423.8 16563.0 601885.0 605553.0 609674.0 610645.0 611316.0 56026.7 57260.4 57749.4 57873.7 57933.1 1289.3 1307.8 1308.6 1314.9 1326.0 29407.4 29925.0 30972.7 31155.1 31370.0 48945.5 49172.3 49594.0 49694.8 49717.3 358150.0 358554.0 486266.0 487565.0 488176.0 27472.3 27825.2 28034.6 28066.7 28129.0 45109.5 46997.3 48311.4 48323.3 48355.0 40179.0 40210.8 40872.6 41588.0 41790.0 40812.4 40914.2 41255.2 41490.4 41807.0 40273.4 40761.2 41226.0 41519.4 43650.0 34197.7 37239.3 37610.2 37795.8 38146.4 27990.7 28266.3 28692.3 28722.9 28860.0 05:10:05 INFO - PROCESS | 22556 | 05:10:05 INFO - PROCESS | 22556 | [#2] jquery.html Cycles:180 Average:29118.35 Median:20786.88 stddev:86961.91 (418.3%) stddev-sans-first:87179.10 05:10:05 INFO - PROCESS | 22556 | Values: 383.6 387.8 392.0 393.6 412.6 13601.4 15309.8 17602.7 19182.9 19351.0 14365.6 16373.9 16745.3 16864.2 17487.3 5625.9 5784.0 5815.5 5852.9 5875.6 5653.0 5740.0 5751.3 5756.0 5778.4 5315.4 5629.2 5633.9 5674.5 5677.4 5653.6 5725.0 6342.2 6360.9 6361.9 4872.3 5614.2 5747.6 5761.0 5777.6 12887.9 13052.2 13167.6 13194.3 14259.9 1970.3 2041.9 2131.9 2289.9 2665.0 9412.7 9581.2 9583.0 13443.3 14401.0 1751.3 1752.5 1761.7 1779.1 1822.2 76611.0 76723.0 76932.6 77128.0 78546.2 10429.7 10430.3 10490.6 10541.4 10715.5 14418.2 14436.0 14489.2 14500.3 14515.3 7011.5 7057.9 7189.1 7440.3 7672.8 6839.2 6851.8 6856.8 7041.0 7114.3 4375.1 4391.9 4395.4 4398.2 4542.2 1875.0 1952.9 1955.4 2002.3 2017.8 886.8 970.5 979.3 996.8 1011.7 18257.9 18752.3 18964.9 19097.4 19135.5 870.6 984.6 1016.6 1018.2 1058.4 10358.2 10513.6 10555.3 10878.7 10933.4 520815.0 524169.0 533488.0 533897.0 534563.0 55349.4 74577.0 91424.5 92102.0 99931.0 965.6 970.7 986.3 991.5 998.9 17323.8 17477.9 18106.6 18187.2 18217.8 29721.6 34400.8 36680.3 41180.2 42015.0 55921.7 56513.0 59478.7 59493.4 59732.7 8057.8 8149.7 8418.4 8486.5 8494.8 9545.8 13794.0 14101.4 14245.6 14253.9 11638.5 11762.4 11927.5 11982.7 12054.6 11879.8 11904.3 12138.2 12178.5 12260.1 12095.9 12202.2 12218.6 12415.5 12415.9 8113.6 8219.4 8287.9 8404.7 8423.6 8702.9 10739.4 11420.1 11599.5 12378.4 05:10:05 INFO - PROCESS | 22556 | 05:10:05 INFO - PROCESS | 22556 | [#3] mootools.html Cycles:180 Average:5792.30 Median:4611.27 stddev:3342.99 (72.5%) stddev-sans-first:3336.37 05:10:05 INFO - PROCESS | 22556 | Values: 1439.8 1475.2 1546.5 1680.9 1690.0 7833.9 8381.3 8453.6 8950.4 8966.7 8511.5 8710.3 8798.4 8806.4 8828.3 2332.7 2352.0 2364.6 2367.7 2368.5 2326.5 2355.1 2386.2 2386.2 2391.0 2306.2 2313.4 2339.8 2339.9 2342.8 2235.8 2258.7 2280.2 2298.3 2315.4 2352.8 2354.5 2377.7 2382.6 2389.6 8695.0 8752.2 8809.0 8829.8 8836.1 4940.6 4957.6 5052.2 5079.0 5080.9 3360.0 3430.6 3466.2 3518.7 3541.5 1098.9 1147.0 1155.7 1182.3 1185.1 12263.5 12435.8 12466.1 12482.7 12533.0 4463.3 4515.3 4600.6 4607.4 4615.1 10246.3 10322.4 10336.9 10339.2 10401.5 5097.1 5107.7 5122.1 5146.0 5154.2 4245.0 4603.6 4667.4 4737.2 4773.8 3812.7 3884.5 3893.9 3999.3 4036.3 1268.8 1272.7 1286.4 1286.6 1288.2 751.2 845.6 899.6 916.8 917.8 5581.0 5613.0 5627.1 5720.3 5866.4 905.5 929.5 934.9 951.9 972.2 3740.3 3898.1 3934.3 3939.2 3947.9 10677.8 11062.0 11096.0 11105.7 11112.6 10686.8 11202.6 11258.8 11260.7 11265.9 8333.0 8411.9 8423.4 8458.7 8487.6 5575.5 5655.4 5702.5 5737.4 5854.0 10245.9 10281.0 10411.9 10432.3 10455.1 10251.1 10356.9 10379.4 10533.7 10633.7 6833.0 7295.9 7308.3 7407.8 7524.0 8692.0 8722.5 8727.2 8813.0 8813.3 7282.7 7429.3 7638.3 7693.4 8007.0 7629.5 7678.3 7687.2 7760.1 7761.5 7243.5 7258.7 7285.0 7311.5 7320.1 4951.6 4966.5 5057.3 5136.8 5210.0 5130.3 5188.2 5188.2 5188.8 5208.9 05:10:05 INFO - PROCESS | 22556 | 05:10:05 INFO - PROCESS | 22556 | [#4] prototype.html Cycles:180 Average:4861.31 Median:5616.26 stddev:1456.81 (25.9%) stddev-sans-first:1420.15 05:10:05 INFO - PROCESS | 22556 | Values: 302.8 306.3 306.6 313.6 314.2 5572.8 5610.7 5611.6 5624.3 5728.4 5533.4 5553.7 5562.2 5590.6 5616.2 4123.4 4124.0 4212.5 4237.7 4265.3 4205.5 4232.9 4237.4 4244.0 4261.6 4231.8 4255.8 4260.9 4279.8 4299.5 4019.9 4236.2 4253.3 4265.3 4271.1 3723.5 3723.7 3744.9 3750.6 3754.3 5424.9 5454.5 5454.7 5455.7 5509.3 4764.7 4850.2 4850.9 4873.0 4906.8 5712.3 5756.3 5764.6 5769.8 5783.5 4044.8 4046.9 4059.9 4073.0 4079.6 5789.9 6004.0 6007.6 6020.5 6042.8 4123.9 4125.6 4144.4 4172.2 4173.3 4224.5 4225.1 4237.4 4249.1 4255.2 4727.3 4900.7 4906.4 4916.9 4919.8 5768.7 5785.3 5815.7 5888.2 5899.0 1402.4 1422.1 1426.2 1431.8 1433.5 897.9 911.6 913.7 930.6 963.7 5512.2 5631.8 5635.2 5636.3 5670.1 5773.7 5864.3 5901.9 5910.7 5916.9 5281.0 5524.6 5533.8 5606.2 5616.3 3108.5 3130.6 3143.8 3152.4 3160.7 5803.5 6125.3 6127.5 6153.5 6172.8 5882.0 5929.9 5938.3 5952.6 5964.9 6021.6 6103.1 6116.8 6140.9 6169.2 5622.0 5694.6 5783.8 5798.3 5863.1 5735.8 5780.0 5823.0 5827.2 5850.4 6038.2 6072.5 6131.2 6131.3 6313.4 4171.5 4204.0 4210.5 4238.4 4256.6 6048.7 6084.9 6094.2 6103.1 6109.5 5687.0 5868.9 5882.9 5915.5 5928.6 5839.1 5859.3 5872.9 5893.6 5911.8 5568.0 5571.5 5706.9 5790.7 5824.2 5865.1 5887.9 5900.2 5928.8 5935.9 5579.2 5748.5 5753.6 5759.2 5802.4 05:10:05 INFO - PROCESS | 22556 | 05:10:05 INFO - PROCESS | 22556 | [#5] yui.html Cycles:180 Average:20420.99 Median:4809.31 stddev:29782.66 (619.3%) stddev-sans-first:29829.59 05:10:05 INFO - PROCESS | 22556 | Values: 749.4 764.5 786.9 806.7 843.2 13672.7 13887.5 13890.7 13900.2 13962.8 14333.4 14333.9 14362.5 14363.7 14384.9 734.9 759.9 793.1 799.2 803.0 779.6 785.0 785.1 789.9 791.7 815.8 823.1 824.8 826.3 827.4 810.7 813.0 813.3 819.1 819.2 591.6 596.2 596.9 597.8 598.6 14190.8 14248.3 14294.9 14296.4 14297.7 14341.5 14444.1 14586.9 14678.2 14779.5 11623.9 11719.8 11786.1 11829.5 11896.2 3699.2 3771.5 3937.1 3965.2 3986.4 72691.6 73216.0 73341.0 74468.3 75571.6 11088.7 11400.3 11495.1 11497.3 11755.4 20255.9 20277.8 20295.2 20343.4 20387.1 8290.5 8398.4 8472.1 8494.0 8553.5 4793.4 4823.0 4852.9 4922.3 4990.5 3264.7 3357.8 3368.4 3368.5 3379.5 600.5 619.7 627.9 638.8 641.2 585.0 659.4 673.8 680.3 685.6 8477.6 8668.6 8708.4 8718.0 8730.9 615.7 633.0 636.3 655.2 694.5 4350.3 4627.2 4673.4 4705.7 4795.6 105047.5 109723.0 113009.4 113358.5 113424.0 101035.0 101348.5 102212.5 102642.0 103093.0 70879.6 85199.0 86201.6 86243.0 86791.0 8507.2 8772.4 8841.3 9037.4 9193.5 50655.2 50956.0 51182.0 51772.7 53028.9 74530.3 75884.6 79145.0 79888.0 81693.2 11399.4 11761.5 11807.9 11850.2 12454.8 13505.3 13656.0 13679.7 14359.7 14519.6 12621.9 12829.9 13294.3 13470.1 13495.8 12292.6 13125.1 13467.8 13526.5 13685.0 12713.9 13224.2 13273.1 13456.3 13482.9 9409.6 9570.8 9597.3 9643.6 9803.6 10019.7 10707.4 10898.3 10946.5 11004.8 05:10:05 INFO - PROCESS | 22556 | -------- Summary: end -------- 05:10:05 INFO - PROCESS | 22556 | 05:10:06 INFO - TEST-INFO | 22556: exit 0 05:10:06 INFO - TEST-OK | dromaeo_css | took 1111696ms 05:10:06 INFO - TEST-START | kraken 05:10:06 INFO - operating with platform_type : linux_ 05:10:06 INFO - Initialising browser for kraken test... 05:10:06 INFO - TEST-INFO | started process 22789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ6_C1u/profile http://localhost:38195/getInfo.html) 05:10:11 INFO - PROCESS | 22789 | __metrics Screen width/height:1600/1200 05:10:11 INFO - PROCESS | 22789 | colorDepth:24 05:10:11 INFO - PROCESS | 22789 | Browser inner width/height: 1024/697 05:10:11 INFO - PROCESS | 22789 | __metrics 05:10:12 ERROR - PROCESS | 22789 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 05:10:13 INFO - TEST-INFO | 22789: exit 0 05:10:13 INFO - Browser initialized. 05:10:13 INFO - Running cycle 1/1 for kraken test... 05:10:13 INFO - TEST-INFO | started process 22911 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ6_C1u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:10:25 INFO - PROCESS | 22911 | RSS: Main: 184868864 05:10:25 INFO - PROCESS | 22911 | 05:10:27 INFO - PROCESS | 22911 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38195/tests/kraken/driver.html?testName=audio-beat-detection) 05:10:28 INFO - PROCESS | 22911 | RSS: Main: 190078976 05:10:28 INFO - PROCESS | 22911 | 05:10:31 INFO - PROCESS | 22911 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38195/tests/kraken/driver.html?testName=audio-dft) 05:10:31 INFO - PROCESS | 22911 | RSS: Main: 189222912 05:10:31 INFO - PROCESS | 22911 | 05:10:34 INFO - PROCESS | 22911 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38195/tests/kraken/driver.html?testName=audio-fft) 05:10:35 INFO - PROCESS | 22911 | RSS: Main: 184074240 05:10:35 INFO - PROCESS | 22911 | 05:10:37 INFO - PROCESS | 22911 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38195/tests/kraken/driver.html?testName=audio-oscillator) 05:10:38 INFO - PROCESS | 22911 | RSS: Main: 184987648 05:10:38 INFO - PROCESS | 22911 | 05:10:40 INFO - PROCESS | 22911 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38195/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:10:41 INFO - PROCESS | 22911 | RSS: Main: 185425920 05:10:41 INFO - PROCESS | 22911 | 05:10:44 INFO - PROCESS | 22911 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38195/tests/kraken/driver.html?testName=imaging-darkroom) 05:10:44 INFO - PROCESS | 22911 | RSS: Main: 186064896 05:10:44 INFO - PROCESS | 22911 | 05:10:48 INFO - PROCESS | 22911 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38195/tests/kraken/driver.html?testName=imaging-desaturate) 05:10:49 INFO - PROCESS | 22911 | RSS: Main: 186060800 05:10:49 INFO - PROCESS | 22911 | 05:10:51 INFO - PROCESS | 22911 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38195/tests/kraken/driver.html?testName=json-parse-financial) 05:10:52 INFO - PROCESS | 22911 | RSS: Main: 185323520 05:10:52 INFO - PROCESS | 22911 | 05:10:54 INFO - PROCESS | 22911 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38195/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:10:54 INFO - PROCESS | 22911 | RSS: Main: 185507840 05:10:54 INFO - PROCESS | 22911 | 05:10:56 INFO - PROCESS | 22911 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38195/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:10:57 INFO - PROCESS | 22911 | RSS: Main: 185716736 05:10:57 INFO - PROCESS | 22911 | 05:10:59 INFO - PROCESS | 22911 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38195/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:10:59 INFO - PROCESS | 22911 | RSS: Main: 185982976 05:10:59 INFO - PROCESS | 22911 | 05:11:02 INFO - PROCESS | 22911 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38195/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:11:03 INFO - PROCESS | 22911 | RSS: Main: 186073088 05:11:03 INFO - PROCESS | 22911 | 05:11:05 INFO - PROCESS | 22911 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38195/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:11:06 INFO - PROCESS | 22911 | RSS: Main: 185946112 05:11:06 INFO - PROCESS | 22911 | 05:11:08 INFO - PROCESS | 22911 | Cycle 1(1): loaded http://localhost:38195/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38195/tests/kraken/driver.html?testName=ai-astar) 05:11:08 INFO - PROCESS | 22911 | RSS: Main: 186679296 05:11:08 INFO - PROCESS | 22911 | 05:11:08 INFO - PROCESS | 22911 | __start_tp_report 05:11:08 INFO - PROCESS | 22911 | _x_x_mozilla_page_load 05:11:08 INFO - PROCESS | 22911 | _x_x_mozilla_page_load_details 05:11:08 INFO - PROCESS | 22911 | |i|pagename|runs| 05:11:08 INFO - PROCESS | 22911 | |0;ai-astar;102;110;106;111;111;112;112;110;110;112 05:11:08 INFO - PROCESS | 22911 | |1;audio-beat-detection;163;128;163;191;133;153;156;128;184;139 05:11:08 INFO - PROCESS | 22911 | |2;audio-dft;162;164;164;164;164;175;163;164;163;164 05:11:08 INFO - PROCESS | 22911 | |3;audio-fft;75;75;76;162;76;76;76;73;159;76 05:11:08 INFO - PROCESS | 22911 | |4;audio-oscillator;84;84;153;86;86;86;148;86;85;150 05:11:08 INFO - PROCESS | 22911 | |5;imaging-gaussian-blur;117;117;118;119;118;117;118;117;119;119 05:11:08 INFO - PROCESS | 22911 | |6;imaging-darkroom;147;147;147;149;146;146;146;148;147;147 05:11:08 INFO - PROCESS | 22911 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;95 05:11:08 INFO - PROCESS | 22911 | |8;json-parse-financial;54;54;54;55;54;58;58;56;54;55 05:11:08 INFO - PROCESS | 22911 | |9;json-stringify-tinderbox;61;62;62;62;61;61;62;61;61;62 05:11:08 INFO - PROCESS | 22911 | |10;stanford-crypto-aes;80;79;79;80;85;83;81;79;147;82 05:11:08 INFO - PROCESS | 22911 | |11;stanford-crypto-ccm;122;119;129;119;129;121;129;124;134;124 05:11:08 INFO - PROCESS | 22911 | |12;stanford-crypto-pbkdf2;157;162;161;161;157;161;158;160;162;161 05:11:08 INFO - PROCESS | 22911 | |13;stanford-crypto-sha256-iterative;64;65;68;67;67;63;65;63;66;61 05:11:08 INFO - PROCESS | 22911 | __end_tp_report 05:11:08 INFO - PROCESS | 22911 | __start_cc_report 05:11:08 INFO - PROCESS | 22911 | _x_x_mozilla_cycle_collect,872 05:11:08 INFO - PROCESS | 22911 | __end_cc_report 05:11:08 INFO - PROCESS | 22911 | __startTimestamp1466770268331__endTimestamp 05:11:08 INFO - PROCESS | 22911 | 05:11:08 INFO - PROCESS | 22911 | ------- Summary: start ------- 05:11:08 INFO - PROCESS | 22911 | Number of tests: 14 05:11:08 INFO - PROCESS | 22911 | 05:11:08 INFO - PROCESS | 22911 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.20 (2.9%) stddev-sans-first:1.88 05:11:08 INFO - PROCESS | 22911 | Values: 102.0 110.0 106.0 111.0 111.0 112.0 112.0 110.0 110.0 112.0 05:11:08 INFO - PROCESS | 22911 | 05:11:08 INFO - PROCESS | 22911 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:159.50 stddev:22.25 (13.9%) stddev-sans-first:23.34 05:11:08 INFO - PROCESS | 22911 | Values: 163.0 128.0 163.0 191.0 133.0 153.0 156.0 128.0 184.0 139.0 05:11:08 INFO - PROCESS | 22911 | 05:11:08 INFO - PROCESS | 22911 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:3.68 (2.2%) stddev-sans-first:3.77 05:11:08 INFO - PROCESS | 22911 | Values: 162.0 164.0 164.0 164.0 164.0 175.0 163.0 164.0 163.0 164.0 05:11:08 INFO - PROCESS | 22911 | 05:11:08 INFO - PROCESS | 22911 | [#3] audio-fft Cycles:10 Average:92.40 Median:76.00 stddev:35.91 (47.3%) stddev-sans-first:37.53 05:11:08 INFO - PROCESS | 22911 | Values: 75.0 75.0 76.0 162.0 76.0 76.0 76.0 73.0 159.0 76.0 05:11:08 INFO - PROCESS | 22911 | 05:11:08 INFO - PROCESS | 22911 | [#4] audio-oscillator Cycles:10 Average:104.80 Median:85.50 stddev:31.45 (36.8%) stddev-sans-first:32.45 05:11:08 INFO - PROCESS | 22911 | Values: 84.0 84.0 153.0 86.0 86.0 86.0 148.0 86.0 85.0 150.0 05:11:08 INFO - PROCESS | 22911 | 05:11:08 INFO - PROCESS | 22911 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.87 05:11:08 INFO - PROCESS | 22911 | Values: 117.0 117.0 118.0 119.0 118.0 117.0 118.0 117.0 119.0 119.0 05:11:08 INFO - PROCESS | 22911 | 05:11:08 INFO - PROCESS | 22911 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 05:11:08 INFO - PROCESS | 22911 | Values: 147.0 147.0 147.0 149.0 146.0 146.0 146.0 148.0 147.0 147.0 05:11:08 INFO - PROCESS | 22911 | 05:11:08 INFO - PROCESS | 22911 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:11:08 INFO - PROCESS | 22911 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:11:08 INFO - PROCESS | 22911 | 05:11:08 INFO - PROCESS | 22911 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:1.62 (2.9%) stddev-sans-first:1.66 05:11:08 INFO - PROCESS | 22911 | Values: 54.0 54.0 54.0 55.0 54.0 58.0 58.0 56.0 54.0 55.0 05:11:08 INFO - PROCESS | 22911 | 05:11:08 INFO - PROCESS | 22911 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 05:11:08 INFO - PROCESS | 22911 | Values: 61.0 62.0 62.0 62.0 61.0 61.0 62.0 61.0 61.0 62.0 05:11:08 INFO - PROCESS | 22911 | 05:11:08 INFO - PROCESS | 22911 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:80.50 stddev:21.00 (26.1%) stddev-sans-first:22.10 05:11:08 INFO - PROCESS | 22911 | Values: 80.0 79.0 79.0 80.0 85.0 83.0 81.0 79.0 147.0 82.0 05:11:08 INFO - PROCESS | 22911 | 05:11:08 INFO - PROCESS | 22911 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:126.50 stddev:5.03 (4.0%) stddev-sans-first:5.22 05:11:08 INFO - PROCESS | 22911 | Values: 122.0 119.0 129.0 119.0 129.0 121.0 129.0 124.0 134.0 124.0 05:11:08 INFO - PROCESS | 22911 | 05:11:08 INFO - PROCESS | 22911 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.00 Median:161.00 stddev:1.94 (1.2%) stddev-sans-first:1.73 05:11:08 INFO - PROCESS | 22911 | Values: 157.0 162.0 161.0 161.0 157.0 161.0 158.0 160.0 162.0 161.0 05:11:08 INFO - PROCESS | 22911 | 05:11:08 INFO - PROCESS | 22911 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.50 stddev:2.18 (3.3%) stddev-sans-first:2.29 05:11:08 INFO - PROCESS | 22911 | Values: 64.0 65.0 68.0 67.0 67.0 63.0 65.0 63.0 66.0 61.0 05:11:08 INFO - PROCESS | 22911 | -------- Summary: end -------- 05:11:08 INFO - PROCESS | 22911 | 05:11:09 INFO - TEST-INFO | 22911: exit 0 05:11:09 INFO - TEST-OK | kraken | took 62684ms 05:11:09 INFO - SUITE-END | took 1174s 05:11:09 INFO - Completed test suite (00:19:34) 05:11:09 INFO - javascript benchmark 05:11:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7080.458995165935, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.585335979643, 3116.0184541869316, 3126.640436349819, 3146.2449012237043, 3156.8263745493987, 5315.548178404831, 5320.866978325539, 5371.355437347519, 5381.704006279653, 5383.703896285702, 5188.2995795567585, 5310.70791106489, 5374.247605335247, 5380.623356365056, 5411.83764487065, 4811.13399588074, 4883.072216278913, 4970.403551573798, 4976.900461990758, 5043.319151914499, 572.3277798040552, 4763.0, 4869.269609558577, 4882.170031094704, 4976.900461990776, 4921.458639549646, 4937.851864444073, 4946.208606622941, 4954.009198160383, 4963.751812409401, 4952.455229924742, 4961.4542400336295, 4965.602751779849, 4978.2034874419915, 4982.252662100677, 4748.907751217205, 4845.951540484621, 4853.150698627726, 4871.732054736988, 4872.537108974641, 5258.526732594085, 5323.813666521692, 5327.706976116312, 5344.091504444254, 5347.144456886879, 5563.109902415594, 5646.915296270559, 5743.856403589902, 5745.166950792153, 5784.219130417382, 5733.3406658234, 5748.770049198069, 5773.191753154561, 5773.538116950675, 5825.504832089277, 5390.730463476811, 5391.676499410009, 5391.892162156774, 5394.379646340682, 5400.648957817729, 5747.885042299131, 5874.765009399662, 5879.441453062038, 5889.558283128783, 5933.317668468181, 5683.8010669626365, 5704.3154821421695, 5714.485696287354, 5744.281964754406, 5757.971210144006, 5779.768809247583, 5783.306003279633, 5792.768289268466, 5799.768009279666, 5803.941960580424, 5587.608867379245, 5627.549796016309, 5790.305163380422, 5795.971020144872, 5815.447532484407, 5802.622829516068, 5808.477237048686, 5810.360860305363, 5831.737571809279, 5860.970695146497, 4431.667624928079, 4437.0, 4465.263231566755, 4466.196084704719, 4492.415985921809, 3932.4494570760116, 3971.62269584389, 3988.7008474363956, 4010.839566417311, 4041.81811818463, 5476.452354764491, 5486.533644640251, 5543.1408131739645, 5544.584156188302, 5550.306211723535, 5762.135679648086, 5856.238688970407, 5860.355360910296, 5864.384239654775, 5869.178315035899, 5390.380106287827, 5447.700376479332, 5593.916091258634, 5603.271574695264, 5611.466910643482, 5038.0, 5061.898762024813, 5082.059818933509, 5095.847124586268, 5123.436421993578, 6042.607230530001, 6061.605995610271, 6115.785947491817, 6126.6017708848785, 6132.141500189977, 5575.0, 5665.0, 5763.567732420169, 5782.913256301159, 5794.217780599565, 6102.03483898519, 6113.693598638453, 6114.019547345639, 6118.497354392036, 6118.862843289846, 5698.800541981177, 5698.829035128787, 5700.629459085146, 5707.971460142673, 5729.799457019151, 5510.228568000403, 5666.603337766482, 5712.514436272797, 5721.914171287517, 5747.453991870766, 5583.106702927512, 5635.239242702182, 5639.295088113986, 5640.520555752807, 5651.124075768263, 5578.49793518569, 5599.8880022400135, 5600.69196194197, 5614.04561224601, 5630.127330263816, 5354.678719276856, 5510.0632892409185, 5574.052411090205, 5585.720713964367, 5627.296587926509, 5679.062954612443, 5696.971515142398, 5723.456271654186, 5741.799037033851, 5753.367129615823, 5330.893382132258, 5571.303587051619, 5574.777008919597, 5584.46947539983, 5596.048671725735], "value": 5298.122594026263, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.3681305783225, 601.6360102138207, 614.1095411653102, 618.2642655240261, 619.408464916005, 39964.200715985666, 41086.38370424442, 41299.38050929239, 41545.37681934766, 45400.772996134976, 42649.14701705972, 43364.0, 43431.13137737251, 43983.56016439835, 44103.117937641226, 8799.956000220005, 8897.955510222473, 8922.509261990588, 8944.508052057134, 8964.686235981742, 8803.779905502382, 8809.735707928772, 8811.074837142103, 8827.73516794494, 8887.73336799897, 8877.20105190536, 8877.289816814671, 8883.911160888372, 8884.289256859469, 8899.599518021705, 8484.745457636282, 8516.318694504456, 8518.23335899772, 8521.786955326104, 8530.0, 8672.349573781992, 8742.519161446118, 8751.474911505331, 8781.07798681142, 8782.209601135864, 41265.1746965059, 41728.58271417277, 41828.0, 41863.7906810467, 41873.581264187276, 3166.493361062242, 3310.751693622964, 3336.2993771308056, 3342.197872510604, 3409.5226668266464, 28152.436951261065, 28461.57307640387, 28949.565756513668, 29006.0, 29153.70846291531, 4360.520342762294, 4367.58507941745, 4466.263066594008, 4548.204064288736, 4574.947762014755, 242054.0, 243432.0, 243602.0, 245608.0, 246753.9999999982, 33537.496937545955, 34357.82821085879, 34373.82813085918, 53852.46147538474, 54724.72637636866, 35913.46129808055, 36257.0, 36356.81821590875, 36425.817870910476, 36531.634683653356, 13717.45130194781, 13757.724845503235, 13787.0, 13917.443302267797, 13923.58229253124, 11488.597899073493, 11541.884581154249, 11578.536858525564, 11584.884151158549, 11592.362420066976, 7281.490295679358, 7285.70857165718, 7389.408847292311, 7461.328480436787, 7474.252574742591, 3137.325475022881, 3186.713195812342, 3201.791883527563, 3234.0, 3243.821589812536, 928.5171710710528, 962.2206013129388, 1097.3854641400842, 1118.3625333559955, 1140.5323817234894, 31589.684103159136, 31997.360052798813, 32054.519182211818, 32207.51688724671, 32614.184645383582, 973.4451362723321, 984.6159997600942, 1053.7892421515728, 1078.4715489410132, 1095.2169199022737, 15852.52442426729, 16292.185390730654, 16359.263833127538, 16423.83576164247, 16563.0, 601884.9811501916, 605553.0, 609674.0, 610645.0, 611316.0, 56026.71986640041, 57260.42739572634, 57749.42250577525, 57873.71063144657, 57933.131003034985, 1289.2715615677112, 1307.7706955461836, 1308.5812539987303, 1314.8750868667653, 1325.9801102983463, 29407.411851762416, 29925.0, 30972.690273097884, 31155.065348039596, 31370.0, 48945.510544894096, 49172.26241606307, 49594.0, 49694.75152624214, 49717.254241185685, 358150.0, 358554.0, 486266.0, 487565.0, 488176.0, 27472.313192170357, 27825.16524504268, 28034.579481308203, 28066.736996834785, 28129.0, 45109.548904510535, 46997.295040573736, 48311.37664675234, 48323.27515087206, 48355.0, 40179.0, 40210.79894600508, 40872.56946006876, 41588.01988746383, 41790.0, 40812.38781418222, 40914.18171636491, 41255.1748965013, 41490.37764433475, 41807.0, 40273.39589906095, 40761.184776303715, 41226.0, 41519.377209342485, 43650.0, 34197.65802341945, 37239.255214895005, 37610.247795044495, 37795.81102094472, 38146.42780358352, 27990.720092798812, 28266.2933426666, 28692.282692932844, 28722.856385717936, 28860.0], "value": 18224.05718087457, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.6087191065113, 387.755713900243, 391.9745216560922, 393.5886998086999, 412.64512519233455, 13601.38793754281, 15309.846901530982, 17602.735958960628, 19182.90408547957, 19351.0, 14365.569032929003, 16373.91813040933, 16745.330186792515, 16864.241109150087, 17487.300507979664, 5625.887482250352, 5784.0, 5815.505682017034, 5852.887951289263, 5875.588708790387, 5653.0, 5740.024195886688, 5751.338596061465, 5756.0, 5778.422157784209, 5315.415304316522, 5629.240052592909, 5633.859153521174, 5674.489295963363, 5677.432256774331, 5653.632513886605, 5725.0, 6342.175517182783, 6360.872782544369, 6361.872762544724, 4872.3422337984275, 5614.242077319551, 5747.56893233005, 5761.020626493506, 5777.62445441045, 12887.935560322232, 13052.15161014531, 13167.60497185086, 13194.340282985811, 14259.928700356535, 1970.2808474906556, 2041.8672786268844, 2131.8827464489445, 2289.8511596746157, 2665.0405853892585, 9412.670556530556, 9581.233501319877, 9582.952085239598, 13443.26062066586, 14401.0, 1751.3344928927054, 1752.4589345449021, 1761.7093179625347, 1779.0570997371415, 1822.1618055694396, 76611.0, 76723.0, 76932.61533692296, 77128.0, 78546.21453785447, 10429.68710938658, 10430.322029068086, 10490.580376784843, 10541.420221887869, 10715.517801698943, 14418.206998614967, 14436.0, 14489.20309382973, 14500.274986250855, 14515.274236288144, 7011.54424962386, 7057.858842823115, 7189.1013623297085, 7440.330370266702, 7672.846543069108, 6839.247682754893, 6851.828704282433, 6856.828579285558, 7040.9647951760935, 7114.324139206767, 4375.146846364928, 4391.890202744893, 4395.373711726682, 4398.164348773723, 4542.182407166676, 1874.9625007499774, 1952.8730632508841, 1955.3645065353817, 2002.3392280547384, 2017.7982201779705, 886.7916039730658, 970.45169479244, 979.3389462113046, 996.8155891160159, 1011.6863772230632, 18257.908710456628, 18752.34366797183, 18964.905175474036, 19097.427077187705, 19135.52161195981, 870.5516658920661, 984.5667906121283, 1016.5730393234859, 1018.1600179851652, 1058.4496062047692, 10358.223133264884, 10513.632022879163, 10555.313904596176, 10878.72803179911, 10933.398663073449, 520815.0, 524169.0, 533488.0, 533896.9577281642, 534563.0, 55349.446505534426, 74577.0, 91424.54287728519, 92102.0, 99931.0, 965.5896244096231, 970.6554173268529, 986.3292960786733, 991.5290237137447, 998.9211651416452, 17323.82676173222, 17477.861741393153, 18106.637867242844, 18187.18157682881, 18217.817821822144, 29721.554176686936, 34400.82799585986, 36680.266394671424, 41180.1763964725, 42015.0, 55921.72039139778, 56513.0, 59478.70260648842, 59493.405065948784, 59732.70133649478, 8057.798555036171, 8149.7147599833725, 8418.410711250153, 8486.533240671575, 8494.830103397773, 9545.761355966157, 13794.0, 14101.365438555085, 14245.572632821031, 14253.857461425254, 11638.476268567765, 11762.3530705812, 11927.522899083939, 11982.700432489257, 12054.638360849189, 11879.80223658626, 11904.285742855456, 12138.150329476852, 12178.451969661564, 12260.14179007461, 12095.879041209828, 12202.20685655465, 12218.633440996784, 12415.503379864704, 12415.93792031034, 8113.553754543321, 8219.383546234176, 8287.875681864656, 8404.705835295736, 8423.620937057725, 8702.91297087021, 10739.355638661393, 11420.086393088699, 11599.478023488795, 12378.44297006655], "value": 8837.664229640597, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.7984282200493, 1475.2107622422004, 1546.5128484527372, 1680.8739344549163, 1689.9915500422503, 7833.882491762628, 8381.32949364051, 8453.57732113395, 8950.373473856824, 8966.686165984192, 8511.489310641366, 8710.34672399571, 8798.42810217337, 8806.427582207152, 8828.29373650108, 2332.7200735911674, 2351.95296094078, 2364.598018336887, 2367.6685264062958, 2368.4670949036417, 2326.464913069995, 2355.0815182079004, 2386.200622791367, 2386.2483317754936, 2390.95218095638, 2306.1813056365, 2313.3869524575916, 2339.7543257957923, 2339.894704738291, 2342.812574994005, 2235.832312576555, 2258.6612008198904, 2280.1563421533974, 2298.276043046435, 2315.363275099353, 2352.776486233805, 2354.4937838364835, 2377.702787151606, 2382.583047966616, 2389.569877422063, 8694.956525217396, 8752.21230089295, 8809.0, 8829.779255518664, 8836.072212417668, 4940.604751619861, 4957.553820156168, 5052.216906379517, 5078.974605126988, 5080.923786143211, 3359.96640033599, 3430.6397828227928, 3466.2027733621157, 3518.66572675598, 3541.5218945442293, 1098.8516550265772, 1147.0, 1155.7341811383428, 1182.2788099259444, 1185.0993245133761, 12263.509459621604, 12435.813462798065, 12466.065045121652, 12482.687932801662, 12533.0, 4463.330500424897, 4515.277555591089, 4600.608948239437, 4607.44710634726, 4615.100055489147, 10246.333988290737, 10322.380657160595, 10336.896631033744, 10339.224558158168, 10401.53193106312, 5097.082525145435, 5107.719075450812, 5122.129238029544, 5146.022255771391, 5154.201098829687, 4244.957550424518, 4603.58567728906, 4667.439907211156, 4737.24204127338, 4773.832915847998, 3812.694984401241, 3884.4950156479476, 3893.902652433655, 3999.320115580358, 4036.2936486114813, 1268.7969924811987, 1272.6500212441467, 1286.4339690536135, 1286.5561381323428, 1288.1626942487271, 751.1812124784012, 845.6110189312861, 899.5771987166022, 916.8258030974093, 917.8393781088283, 5581.0, 5613.0, 5627.12202915921, 5720.313562372458, 5866.442687944638, 905.5336501701629, 929.5212965322864, 934.8734774596595, 951.9333646644668, 972.1882228339274, 3740.3080430120513, 3898.142408670088, 3934.252492026506, 3939.1727737174942, 3947.940780888289, 10677.83983240252, 11062.004419602274, 11096.0, 11105.666829995112, 11112.611058612909, 10686.786264274671, 11202.551897924155, 11258.83111753308, 11260.718482037852, 11265.887341126649, 8332.958335208285, 8411.873821892677, 8423.410361274775, 8458.661653533789, 8487.618057187441, 5575.526080283222, 5655.4344565543115, 5702.45826646468, 5737.426257374396, 5853.970730146322, 10245.897541024495, 10281.0, 10411.895881041395, 10432.321899076536, 10455.059044686015, 10251.12865406419, 10356.896431035895, 10379.377237365783, 10533.683989480327, 10633.680989570325, 6832.965835170792, 7295.927040729737, 7308.342249197598, 7407.8148046299275, 7524.0, 8692.0438751736, 8722.520261385685, 8727.170918762708, 8813.030566637794, 8813.294936404944, 7282.745103921337, 7429.33136017761, 7638.312551870358, 7693.384529237535, 8006.999125109362, 7629.46593738433, 7678.270564296383, 7687.192844751445, 7760.068791745027, 7761.495502792301, 7243.45674074457, 7258.673359698932, 7284.963575182091, 7311.524750891175, 7320.1215854097845, 4951.603871690329, 4966.478519755374, 5057.342545469065, 5136.768845402041, 5210.036143313499, 5130.333056702605, 5188.22176673502, 5188.247704082963, 5188.766505507186, 5208.869778255574], "value": 4616.28820248663, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.7683821876265, 306.26190879979254, 306.602949180811, 313.60172580822353, 314.19252521020974, 5572.804951826682, 5610.663360198391, 5611.607187496877, 5624.268845050143, 5728.42715728427, 5533.363663178736, 5553.694546799924, 5562.163296718672, 5590.552755779538, 5616.241807356006, 4123.443335149761, 4123.9793801030955, 4212.473440819897, 4237.724547904377, 4265.338872474771, 4205.474315710536, 4232.936505952398, 4237.38557909103, 4243.957560424403, 4261.573842615745, 4231.788410579474, 4255.829766809324, 4260.850870219543, 4279.764612946286, 4299.462567179103, 4019.919601607981, 4236.216299984513, 4253.29820579604, 4265.274903266452, 4271.103068355649, 3723.515942927429, 3723.7393382463238, 3744.925101497982, 3750.6497660842074, 3754.3054534910857, 5424.918626220609, 5454.53636440903, 5454.672719636835, 5455.699936503491, 5509.256250406224, 4764.690295130806, 4850.223964165716, 4850.889862909646, 4873.01280046853, 4906.828261010847, 5712.285964254468, 5756.33802112754, 5764.5676574257095, 5769.826905192851, 5783.537317014629, 4044.8382064717375, 4046.9477935736627, 4059.857904973341, 4072.9796351018053, 4079.5920407959266, 5789.913151302734, 6004.0, 6007.609505382136, 6020.4581587656885, 6042.818715438544, 4123.8556650517685, 4125.5874412558505, 4144.3990621359735, 4172.165566886635, 4173.33066773287, 4224.471941007374, 4225.070484493406, 4237.385579091015, 4249.128928569636, 4255.170241802881, 4727.338172655831, 4900.681455705368, 4906.386701662293, 4916.852494425173, 4919.827806026843, 5768.711564421846, 5785.27684039495, 5815.709214539341, 5888.234529511136, 5899.0, 1402.4039783092146, 1422.07565082695, 1426.2298358886085, 1431.8496557861274, 1433.519770876747, 897.9236764874928, 911.5761171055491, 913.6847787513298, 930.5719369090294, 963.7012526116927, 5512.200730893998, 5631.831045068655, 5635.239242702265, 5636.323641163087, 5670.121131224667, 5773.74018169175, 5864.266966629171, 5901.940980590139, 5910.704464776744, 5916.881662366814, 5281.0, 5524.613277070647, 5533.75490514631, 5606.159076138611, 5616.269884914935, 3108.4870996285813, 3130.577372054789, 3143.764217683683, 3152.3537674776617, 3160.668129846379, 5803.5357171426185, 6125.264968203844, 6127.5404344674325, 6153.538484613672, 6172.783952561639, 5881.9705901470215, 5929.851753706192, 5938.287405511366, 5952.5833191676165, 5964.940350596526, 6021.638701677914, 6103.084537319438, 6116.78591249313, 6140.89463896494, 6169.167162433104, 5622.0, 5694.601377903507, 5783.768649253982, 5798.318487638538, 5863.149843272787, 5735.827925162252, 5780.0, 5823.030254570284, 5827.155062515827, 5850.356460789395, 6038.215032045806, 6072.514198864169, 6131.202943617302, 6131.344536975081, 6313.43179113882, 4171.520275168395, 4203.97898010508, 4210.45264115663, 4238.36424536322, 4256.616904478488, 6048.699529600981, 6084.904717150778, 6094.2077529920825, 6103.115048318058, 6109.525642114951, 5686.9715651421475, 5868.911966320423, 5882.882342353215, 5915.497182739516, 5928.584999050025, 5839.080459770115, 5859.296884373903, 5872.911906321494, 5893.5874488785375, 5911.7635294587735, 5567.972160139173, 5571.498565129158, 5706.885862282814, 5790.681512516852, 5824.184614153937, 5865.120231965239, 5887.881302552501, 5900.229931020763, 5928.762849485972, 5935.940640593712, 5579.19101730255, 5748.476653686693, 5753.597248192754, 5759.222504961944, 5802.4197580241635], "value": 4379.3364868227045, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.4042236422044, 764.5298141642888, 786.893769341139, 806.681360862459, 843.2452954605626, 13672.658183545416, 13887.513937012207, 13890.722185556282, 13900.235487048209, 13962.790558141623, 14333.426662933496, 14333.928330358334, 14362.497312594036, 14363.71272574548, 14384.856151438482, 734.8750712378882, 759.9430042746789, 793.0562630469751, 799.168864381046, 803.0, 779.6335722210551, 784.9882251766228, 785.0540099180474, 789.8775689768095, 791.7110254757001, 815.7756616930362, 823.1480417767611, 824.789678631948, 826.2522417212432, 827.3546633625751, 810.7000409848364, 812.959352032399, 813.324940299553, 819.1030821250721, 819.2053707903324, 591.6006695480534, 596.1564386393248, 596.8836076964993, 597.7818096394784, 598.6408155106901, 14190.787138192936, 14248.287585620781, 14294.92852535741, 14296.428142874272, 14297.71404571913, 14341.524513897186, 14444.133351998913, 14586.854131458762, 14678.192699401528, 14779.482718104922, 11623.94188029063, 11719.824202636883, 11786.116041296851, 11829.467673954692, 11896.167268291223, 3699.2416554606243, 3771.4719939208535, 3937.1338305572726, 3965.167314863882, 3986.382110772806, 72691.63654181748, 73216.0, 73341.0, 74468.25531744667, 75571.62214188949, 11088.722781930517, 11400.315981041163, 11495.137864660184, 11497.310161390176, 11755.412229388496, 20255.898720506597, 20277.79722202759, 20295.18819247243, 20343.389698309074, 20387.082581283878, 8290.502569845828, 8398.370122240856, 8472.110428405053, 8494.0, 8553.486790792573, 4793.376861008047, 4822.9758851205515, 4852.902941941142, 4922.261660750916, 4990.500949905053, 3264.6735326467638, 3357.7649564530248, 3368.427367347557, 3368.494725791151, 3379.4761811919193, 600.5195843325322, 619.6591874469024, 627.9058141278845, 638.7700427845972, 641.2241188162376, 584.9502792262621, 659.4197106546304, 673.7574473189648, 680.2517231045908, 685.5671646259342, 8477.576121193915, 8668.566571671392, 8708.433951793113, 8718.0, 8730.86903696445, 615.6521565315672, 632.9841753956188, 636.2746469025315, 655.2333769489709, 694.5416025423197, 4350.282203436461, 4627.167109920247, 4673.395638629284, 4705.7411842349, 4795.640326975491, 105047.4747626257, 109723.0, 113009.43495282636, 113358.49811264189, 113424.0, 101035.0, 101348.49325753324, 102212.48893755632, 102642.0, 103093.0, 70879.64560177166, 85199.0, 86201.56899215464, 86243.0, 86791.0, 8507.191816777397, 8772.429792063751, 8841.336899732674, 9037.41256818331, 9193.54032298369, 50655.24017139672, 50956.0, 51182.0, 51772.74113629408, 53028.901676307716, 74530.2546974545, 75884.62057689676, 79145.0, 79888.0, 81693.18306816855, 11399.373034483184, 11761.529538818351, 11807.940960295487, 11850.170488065753, 12454.813177802522, 13505.257210853497, 13656.0, 13679.726405471636, 14359.712805744035, 14519.637009074857, 12621.87378126207, 12829.93585032069, 13294.268815215257, 13470.124441911245, 13495.797563036365, 12292.569760058355, 13125.081244312807, 13467.797983030066, 13526.458941642224, 13684.973626977817, 12713.87286127127, 13224.206547607175, 13273.137246079361, 13456.25990570528, 13482.944165477144, 9409.623615055321, 9570.808583828424, 9597.328187026842, 9643.614255429704, 9803.558839852367, 10019.749506262402, 10707.357558546511, 10898.346099234072, 10946.45267736594, 11004.779904402027], "value": 7303.365718223984, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 106.0, 111.0, 111.0, 112.0, 112.0, 110.0, 110.0, 112.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 128.0, 163.0, 191.0, 133.0, 153.0, 156.0, 128.0, 184.0, 139.0], "value": 153.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 164.0, 164.0, 175.0, 163.0, 164.0, 163.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 162.0, 76.0, 76.0, 76.0, 73.0, 159.0, 76.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 153.0, 86.0, 86.0, 86.0, 148.0, 86.0, 85.0, 150.0], "value": 104.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 119.0, 118.0, 117.0, 118.0, 117.0, 119.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 149.0, 146.0, 146.0, 146.0, 148.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 54.0, 58.0, 58.0, 56.0, 54.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 80.0, 85.0, 83.0, 81.0, 79.0, 147.0, 82.0], "value": 87.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 119.0, 129.0, 119.0, 129.0, 121.0, 129.0, 124.0, 134.0, 124.0], "value": 125.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 162.0, 161.0, 161.0, 157.0, 161.0, 158.0, 160.0, 162.0, 161.0], "value": 160.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 68.0, 67.0, 67.0, 63.0, 65.0, 63.0, 66.0, 61.0], "value": 64.9, "unit": "score"}]}]} 05:11:09 INFO - Return code: 0 05:11:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:11:09 ERROR - # TBPL SUCCESS # 05:11:09 INFO - Running post-action listener: _resource_record_post_action 05:11:09 INFO - ##### 05:11:09 INFO - ##### Finished run-tests step (success) 05:11:09 INFO - ##### 05:11:09 INFO - Running post-run listener: _resource_record_post_run 05:11:09 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553709568; Read time: 12; Write time: 738868 05:11:09 INFO - TinderboxPrint: CPU usage
13.5% 05:11:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:11:09 INFO - TinderboxPrint: I/O write bytes / time
553,709,568 / 738,868 05:11:09 INFO - TinderboxPrint: CPU idle
8,233.1 (86.5%) 05:11:09 INFO - TinderboxPrint: CPU user
1,223.0 (12.9%) 05:11:09 INFO - TinderboxPrint: Swap in / out
0 / 0 05:11:09 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 262836224; Read time: 0; Write time: 488924 05:11:09 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290873344; Read time: 12; Write time: 249944 05:11:10 INFO - Running post-run listener: _upload_blobber_files 05:11:10 INFO - Blob upload gear active. 05:11:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:11:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:11:10 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:11:10 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:11:10 INFO - (blobuploader) - INFO - Open directory for files ... 05:11:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:11:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:11:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:11:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:11 INFO - (blobuploader) - INFO - Done attempting. 05:11:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:11:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:11:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:11:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:12 INFO - (blobuploader) - INFO - Done attempting. 05:11:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:11:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:11:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:11:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:11:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:11:15 INFO - (blobuploader) - INFO - Done attempting. 05:11:15 INFO - (blobuploader) - INFO - Iteration through files over. 05:11:15 INFO - Return code: 0 05:11:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:11:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:11:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dcd1e3a9f9077f0f6a20f6cab97e61b1ab11abc6ad908cf8f3fa539517ccbc06bfc4fdb5b2cc32b338b93c8cd31930c3bdedfa14c36df6b4120cb3c7f3280fb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/66df04662a1d5c2e0b26cd472d04a387e86b514d93fd8796b4005b47702f051662721e4039e2283020acc15e944d2de06066f20ba4b5de210f6add1a0f41f9d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/06a7e077957b9826c896df926456362e69bc540a75b48412144a647e7aefb00deb2b071f5e0e67151f294e05ebc12d2380ce2e81e9dbe707882d2b407180eba5"} 05:11:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:11:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:11:16 INFO - Contents: 05:11:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/dcd1e3a9f9077f0f6a20f6cab97e61b1ab11abc6ad908cf8f3fa539517ccbc06bfc4fdb5b2cc32b338b93c8cd31930c3bdedfa14c36df6b4120cb3c7f3280fb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/66df04662a1d5c2e0b26cd472d04a387e86b514d93fd8796b4005b47702f051662721e4039e2283020acc15e944d2de06066f20ba4b5de210f6add1a0f41f9d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/06a7e077957b9826c896df926456362e69bc540a75b48412144a647e7aefb00deb2b071f5e0e67151f294e05ebc12d2380ce2e81e9dbe707882d2b407180eba5"} 05:11:16 INFO - Running post-run listener: copy_logs_to_upload_dir 05:11:16 INFO - Copying logs to upload dir... 05:11:16 INFO - mkdir: /builds/slave/test/build/upload/logs 05:11:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.593158 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-06-24 05:11:14.894757) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 05:11:14.899918) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671 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/Mozilla-Inbound/sha512/dcd1e3a9f9077f0f6a20f6cab97e61b1ab11abc6ad908cf8f3fa539517ccbc06bfc4fdb5b2cc32b338b93c8cd31930c3bdedfa14c36df6b4120cb3c7f3280fb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/66df04662a1d5c2e0b26cd472d04a387e86b514d93fd8796b4005b47702f051662721e4039e2283020acc15e944d2de06066f20ba4b5de210f6add1a0f41f9d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/06a7e077957b9826c896df926456362e69bc540a75b48412144a647e7aefb00deb2b071f5e0e67151f294e05ebc12d2380ce2e81e9dbe707882d2b407180eba5"} build_url:https://queue.taskcluster.net/v1/task/KZlk3obISy-GXGaqYLdgCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/KZlk3obISy-GXGaqYLdgCQ/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/Mozilla-Inbound/sha512/dcd1e3a9f9077f0f6a20f6cab97e61b1ab11abc6ad908cf8f3fa539517ccbc06bfc4fdb5b2cc32b338b93c8cd31930c3bdedfa14c36df6b4120cb3c7f3280fb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/66df04662a1d5c2e0b26cd472d04a387e86b514d93fd8796b4005b47702f051662721e4039e2283020acc15e944d2de06066f20ba4b5de210f6add1a0f41f9d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/06a7e077957b9826c896df926456362e69bc540a75b48412144a647e7aefb00deb2b071f5e0e67151f294e05ebc12d2380ce2e81e9dbe707882d2b407180eba5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 05:11:14.925223) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:11:14.925570) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1466769038.561962-2077481671 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 05:11:15.010604) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 05:11:15.010947) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 05:11:15.011272) ========= ========= Total master_lag: 0.18 =========