builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1466906846.87 results: success (0) buildid: 20160625163004 builduid: 049f11f2fee943048a24a0e745bb3559 revision: c2da34d96746288b5fee27bf6542a12c9f410988 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-25 19:07:26.868231) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-25 19:07:26.869055) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-25 19:07:26.869649) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-25 19:07:26.913876) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 19:07:26.914181) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-25 19:07:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.8M=0s 2016-06-25 19:07:27 (32.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.152942 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 19:07:27.085167) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 19:07:27.085730) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.103253 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 19:07:27.203198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 19:07:27.203682) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c2da34d96746288b5fee27bf6542a12c9f410988 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c2da34d96746288b5fee27bf6542a12c9f410988 --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=337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-25 19:07:27,300 truncating revision to first 12 chars 2016-06-25 19:07:27,301 Setting DEBUG logging. 2016-06-25 19:07:27,301 attempt 1/10 2016-06-25 19:07:27,301 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c2da34d96746?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-25 19:07:27,723 unpacking tar archive at: mozilla-central-c2da34d96746/testing/mozharness/ program finished with exit code 0 elapsedTime=0.749187 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 19:07:27.970888) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-25 19:07:27.971572) ========= script_repo_revision: c2da34d96746288b5fee27bf6542a12c9f410988 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-25 19:07:27.972455) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-25 19:07:27.973183) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-25 19:07:27.984561) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-25 19:07:27.985267) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:07:28 INFO - MultiFileLogger online at 20160625 19:07:28 in /builds/slave/test 19:07:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:07:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:07:28 INFO - {'append_to_log': False, 19:07:28 INFO - 'base_work_dir': '/builds/slave/test', 19:07:28 INFO - 'blob_upload_branch': 'Firefox', 19:07:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:07:28 INFO - 'branch': 'Firefox', 19:07:28 INFO - 'buildbot_json_path': 'buildprops.json', 19:07:28 INFO - 'config_files': ('talos/linux_config.py',), 19:07:28 INFO - 'default_actions': ('clobber', 19:07:28 INFO - 'read-buildbot-config', 19:07:28 INFO - 'download-and-extract', 19:07:28 INFO - 'populate-webroot', 19:07:28 INFO - 'create-virtualenv', 19:07:28 INFO - 'install', 19:07:28 INFO - 'run-tests'), 19:07:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:07:28 INFO - 'download_minidump_stackwalk': True, 19:07:28 INFO - 'download_symbols': 'ondemand', 19:07:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:07:28 INFO - 'tooltool.py': '/tools/tooltool.py', 19:07:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:07:28 INFO - '/tools/misc-python/virtualenv.py')}, 19:07:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:07:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:07:28 INFO - 'installer_path': 'installer.exe', 19:07:28 INFO - 'log_level': 'info', 19:07:28 INFO - 'log_name': 'talos', 19:07:28 INFO - 'log_to_console': True, 19:07:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:07:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:07:28 INFO - 'opt_config_files': (), 19:07:28 INFO - 'pip_index': False, 19:07:28 INFO - 'sps_profile': False, 19:07:28 INFO - 'sps_profile_interval': 0, 19:07:28 INFO - 'suite': 'dromaeojs-e10s', 19:07:28 INFO - 'system_bits': '32', 19:07:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:07:28 INFO - 'title': 'talos-linux64-ix-060', 19:07:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:07:28 INFO - 'use_talos_json': True, 19:07:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:07:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:07:28 INFO - 'work_dir': 'build'} 19:07:28 INFO - ##### 19:07:28 INFO - ##### Running clobber step. 19:07:28 INFO - ##### 19:07:28 INFO - Running pre-action listener: _resource_record_pre_action 19:07:28 INFO - Running main action method: clobber 19:07:28 INFO - rmtree: /builds/slave/test/build 19:07:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:07:29 INFO - Running post-action listener: _resource_record_post_action 19:07:29 INFO - ##### 19:07:29 INFO - ##### Finished clobber step (success) 19:07:29 INFO - ##### 19:07:29 INFO - ##### 19:07:29 INFO - ##### Running read-buildbot-config step. 19:07:29 INFO - ##### 19:07:29 INFO - Running pre-action listener: _resource_record_pre_action 19:07:29 INFO - Running main action method: read_buildbot_config 19:07:29 INFO - Using buildbot properties: 19:07:29 INFO - { 19:07:29 INFO - "project": "", 19:07:29 INFO - "product": "firefox", 19:07:29 INFO - "script_repo_revision": "production", 19:07:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:07:29 INFO - "repository": "", 19:07:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 19:07:29 INFO - "buildid": "20160625163004", 19:07:29 INFO - "pgo_build": "True", 19:07:29 INFO - "basedir": "/builds/slave/test", 19:07:29 INFO - "buildnumber": 262, 19:07:29 INFO - "slavename": "talos-linux64-ix-060", 19:07:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:07:29 INFO - "platform": "ubuntu64_hw", 19:07:29 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:07:29 INFO - "branch": "mozilla-central", 19:07:29 INFO - "repo_path": "mozilla-central", 19:07:29 INFO - "revision": "c2da34d96746288b5fee27bf6542a12c9f410988", 19:07:29 INFO - "stage_platform": "linux64-pgo", 19:07:29 INFO - "builduid": "049f11f2fee943048a24a0e745bb3559", 19:07:29 INFO - "slavebuilddir": "test" 19:07:29 INFO - } 19:07:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:07:29 INFO - Running post-action listener: _resource_record_post_action 19:07:29 INFO - ##### 19:07:29 INFO - ##### Finished read-buildbot-config step (success) 19:07:29 INFO - ##### 19:07:29 INFO - ##### 19:07:29 INFO - ##### Running download-and-extract step. 19:07:29 INFO - ##### 19:07:29 INFO - Running pre-action listener: _resource_record_pre_action 19:07:29 INFO - Running main action method: download_and_extract 19:07:29 INFO - mkdir: /builds/slave/test/build/tests 19:07:29 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')]} 19:07:29 INFO - https://queue.taskcluster.net/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:07:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:07:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:07:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/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 19:07:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/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 19:07:30 INFO - Downloaded 1361 bytes. 19:07:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:07:30 INFO - Using the following test package requirements: 19:07:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:07:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:07:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:07:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:30 INFO - u'jsshell-linux-x86_64.zip'], 19:07:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:07:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:07:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:07:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:07:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:07:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:07:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:07:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:07:30 INFO - https://queue.taskcluster.net/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:07:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:07:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:07:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/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 19:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/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 19:07:31 INFO - Downloaded 24279286 bytes. 19:07:31 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'] 19:07:31 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 19:07:33 INFO - Return code: 0 19:07:33 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:07: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')]} 19:07:33 INFO - https://queue.taskcluster.net/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:07:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:07:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:07:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/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 19:07:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/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 19:07:44 INFO - Downloaded 24279286 bytes. 19:07: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'] 19:07: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 19:07:45 INFO - Return code: 0 19:07: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')]} 19:07:45 INFO - https://queue.taskcluster.net/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:07:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:07:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:07:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/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 19:07:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/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 19:07:48 INFO - Downloaded 14405240 bytes. 19:07:48 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'] 19:07:48 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 19:07:48 INFO - Return code: 0 19:07: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')]} 19:07:48 INFO - https://queue.taskcluster.net/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:07:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:07:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:07:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/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 19:07:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/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 19:07:52 INFO - Downloaded 60128976 bytes. 19:07:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:07:52 INFO - mkdir: /builds/slave/test/properties 19:07:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:07:52 INFO - Writing to file /builds/slave/test/properties/build_url 19:07:52 INFO - Contents: 19:07:52 INFO - build_url:https://queue.taskcluster.net/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:07:53 INFO - Running post-action listener: _resource_record_post_action 19:07:53 INFO - Running post-action listener: set_extra_try_arguments 19:07:53 INFO - ##### 19:07:53 INFO - ##### Finished download-and-extract step (success) 19:07:53 INFO - ##### 19:07:53 INFO - ##### 19:07:53 INFO - ##### Running populate-webroot step. 19:07:53 INFO - ##### 19:07:53 INFO - Running pre-action listener: _resource_record_pre_action 19:07:53 INFO - Running main action method: populate_webroot 19:07:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:07:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:07:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:07:53 INFO - '--tppagecycles', 19:07:53 INFO - '7'], 19:07:53 INFO - 'tests': ['tsvgm']}}, 19:07:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:07:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:07:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:07:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:07:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:07:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:07:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:53 INFO - 'talos_options': ['--disable-e10s'], 19:07:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:07:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:07:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:53 INFO - 'talos_options': ['--disable-e10s'], 19:07:53 INFO - 'tests': ['damp', 'tps']}, 19:07:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:53 INFO - 'tests': ['damp', 'tps']}, 19:07:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:07:53 INFO - 'tests': ['dromaeo_dom']}, 19:07:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:07:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:07:53 INFO - 'tests': ['basic_compositor_video']}, 19:07:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:07:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:07:53 INFO - 'tests': ['a11yr', 19:07:53 INFO - 'ts_paint', 19:07:53 INFO - 'tpaint', 19:07:53 INFO - 'sessionrestore', 19:07:53 INFO - 'sessionrestore_no_auto_restore', 19:07:53 INFO - 'tabpaint']}, 19:07:53 INFO - 'other-e10s': {'tests': ['a11yr', 19:07:53 INFO - 'ts_paint', 19:07:53 INFO - 'tpaint', 19:07:53 INFO - 'sessionrestore', 19:07:53 INFO - 'sessionrestore_no_auto_restore', 19:07:53 INFO - 'tabpaint']}, 19:07:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:07:53 INFO - 'ts_paint', 19:07:53 INFO - 'tpaint', 19:07:53 INFO - 'sessionrestore', 19:07:53 INFO - 'sessionrestore_no_auto_restore', 19:07:53 INFO - 'tabpaint']}, 19:07:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:07:53 INFO - 'ts_paint', 19:07:53 INFO - 'tpaint', 19:07:53 INFO - 'sessionrestore', 19:07:53 INFO - 'sessionrestore_no_auto_restore', 19:07:53 INFO - 'tabpaint']}, 19:07:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:07:53 INFO - 'tests': ['a11yr', 19:07:53 INFO - 'ts_paint', 19:07:53 INFO - 'tpaint', 19:07:53 INFO - 'sessionrestore', 19:07:53 INFO - 'sessionrestore_no_auto_restore', 19:07:53 INFO - 'tabpaint']}, 19:07:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:07:53 INFO - 'tests': ['a11yr', 19:07:53 INFO - 'ts_paint', 19:07:53 INFO - 'tpaint', 19:07:53 INFO - 'sessionrestore', 19:07:53 INFO - 'sessionrestore_no_auto_restore', 19:07:53 INFO - 'tabpaint']}, 19:07:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:07:53 INFO - 'tests': ['tsvgx', 19:07:53 INFO - 'tsvgr_opacity', 19:07:53 INFO - 'tart', 19:07:53 INFO - 'tscrollx', 19:07:53 INFO - 'cart']}, 19:07:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:07:53 INFO - 'tsvgr_opacity', 19:07:53 INFO - 'tart', 19:07:53 INFO - 'tscrollx', 19:07:53 INFO - 'cart']}, 19:07:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:53 INFO - 'talos_options': ['--disable-e10s'], 19:07:53 INFO - 'tests': ['tp5o']}, 19:07:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:53 INFO - 'tests': ['tp5o']}, 19:07:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:53 INFO - 'talos_options': ['--disable-e10s', 19:07:53 INFO - '--xperf_path', 19:07:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:07:53 INFO - 'tests': ['tp5n']}, 19:07:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:07:53 INFO - 'talos_options': ['--xperf_path', 19:07:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:07:53 INFO - 'tests': ['tp5n']}}, 19:07:53 INFO - 'talos.zip': {'path': '', 19:07:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:07:53 INFO - Running post-action listener: _resource_record_post_action 19:07:53 INFO - ##### 19:07:53 INFO - ##### Finished populate-webroot step (success) 19:07:53 INFO - ##### 19:07:53 INFO - ##### 19:07:53 INFO - ##### Running create-virtualenv step. 19:07:53 INFO - ##### 19:07:53 INFO - Running pre-action listener: _resource_record_pre_action 19:07:53 INFO - Running main action method: create_virtualenv 19:07:53 INFO - Creating virtualenv /builds/slave/test/build/venv 19:07:53 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 19:07:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:07:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:07:53 INFO - Using real prefix '/usr' 19:07:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:07:54 INFO - Installing distribute.............................................................................................................................................................................................done. 19:07:56 INFO - Installing pip.................done. 19:07:56 INFO - Return code: 0 19:07:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:07:56 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')]} 19:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:56 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')]} 19:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:56 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 0x7f98af819f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd34480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc36f0>, '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 0xdc45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4aa0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', '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 19:07:56 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 19:07:56 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 19:07:56 INFO - Using env: {'DISPLAY': ':0', 19:07:56 INFO - 'HOME': '/home/cltbld', 19:07:56 INFO - 'LANG': 'en_US.UTF-8', 19:07:56 INFO - 'LANGUAGE': 'en_US:en', 19:07:56 INFO - 'LOGNAME': 'cltbld', 19:07:56 INFO - 'MAIL': '/var/mail/cltbld', 19:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:56 INFO - 'MOZ_NO_REMOTE': '1', 19:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:56 INFO - 'NO_EM_RESTART': '1', 19:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:56 INFO - 'PWD': '/builds/slave/test', 19:07:56 INFO - 'SHELL': '/bin/bash', 19:07:56 INFO - 'SHLVL': '1', 19:07:56 INFO - 'TERM': 'linux', 19:07:56 INFO - 'TMOUT': '86400', 19:07:56 INFO - 'USER': 'cltbld', 19:07:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', 19:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:56 INFO - '_': '/tools/buildbot/bin/python'} 19:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:56 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 19:07:56 INFO - Cleaning up... 19:07:56 INFO - Return code: 0 19:07:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:07:56 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')]} 19:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:56 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')]} 19:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:07:56 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 0x7f98af819f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd34480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc36f0>, '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 0xdc45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4aa0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', '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 19:07:56 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 19:07:56 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 19:07:56 INFO - Using env: {'DISPLAY': ':0', 19:07:56 INFO - 'HOME': '/home/cltbld', 19:07:56 INFO - 'LANG': 'en_US.UTF-8', 19:07:56 INFO - 'LANGUAGE': 'en_US:en', 19:07:56 INFO - 'LOGNAME': 'cltbld', 19:07:56 INFO - 'MAIL': '/var/mail/cltbld', 19:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:56 INFO - 'MOZ_NO_REMOTE': '1', 19:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:56 INFO - 'NO_EM_RESTART': '1', 19:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:56 INFO - 'PWD': '/builds/slave/test', 19:07:56 INFO - 'SHELL': '/bin/bash', 19:07:56 INFO - 'SHLVL': '1', 19:07:56 INFO - 'TERM': 'linux', 19:07:56 INFO - 'TMOUT': '86400', 19:07:56 INFO - 'USER': 'cltbld', 19:07:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', 19:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:56 INFO - '_': '/tools/buildbot/bin/python'} 19:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:07:56 INFO - Downloading/unpacking psutil>=3.1.1 19:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:07:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:07:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:07:58 INFO - Installing collected packages: psutil 19:07:58 INFO - Running setup.py install for psutil 19:07:58 INFO - building 'psutil._psutil_linux' extension 19:07:58 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 19:08:00 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 19:08:00 INFO - building 'psutil._psutil_posix' extension 19:08:00 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 19:08:00 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 19:08:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:08:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:08:00 INFO - Successfully installed psutil 19:08:00 INFO - Cleaning up... 19:08:00 INFO - Return code: 0 19:08:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:00 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 0x7f98af819f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd34480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc36f0>, '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 0xdc45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4aa0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', '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 19:08:00 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 19:08:00 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 19:08:00 INFO - Using env: {'DISPLAY': ':0', 19:08:00 INFO - 'HOME': '/home/cltbld', 19:08:00 INFO - 'LANG': 'en_US.UTF-8', 19:08:00 INFO - 'LANGUAGE': 'en_US:en', 19:08:00 INFO - 'LOGNAME': 'cltbld', 19:08:00 INFO - 'MAIL': '/var/mail/cltbld', 19:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:00 INFO - 'MOZ_NO_REMOTE': '1', 19:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:00 INFO - 'NO_EM_RESTART': '1', 19:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:00 INFO - 'PWD': '/builds/slave/test', 19:08:00 INFO - 'SHELL': '/bin/bash', 19:08:00 INFO - 'SHLVL': '1', 19:08:00 INFO - 'TERM': 'linux', 19:08:00 INFO - 'TMOUT': '86400', 19:08:00 INFO - 'USER': 'cltbld', 19:08:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', 19:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:00 INFO - '_': '/tools/buildbot/bin/python'} 19:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:08:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:08:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:08:02 INFO - Installing collected packages: mozsystemmonitor 19:08:02 INFO - Running setup.py install for mozsystemmonitor 19:08:02 INFO - Successfully installed mozsystemmonitor 19:08:02 INFO - Cleaning up... 19:08:02 INFO - Return code: 0 19:08:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08: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')]} 19:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98af819f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd34480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc36f0>, '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 0xdc45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4aa0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', '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 19:08:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:08:02 INFO - Using env: {'DISPLAY': ':0', 19:08:02 INFO - 'HOME': '/home/cltbld', 19:08:02 INFO - 'LANG': 'en_US.UTF-8', 19:08:02 INFO - 'LANGUAGE': 'en_US:en', 19:08:02 INFO - 'LOGNAME': 'cltbld', 19:08:02 INFO - 'MAIL': '/var/mail/cltbld', 19:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:02 INFO - 'MOZ_NO_REMOTE': '1', 19:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:02 INFO - 'NO_EM_RESTART': '1', 19:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:02 INFO - 'PWD': '/builds/slave/test', 19:08:02 INFO - 'SHELL': '/bin/bash', 19:08:02 INFO - 'SHLVL': '1', 19:08:02 INFO - 'TERM': 'linux', 19:08:02 INFO - 'TMOUT': '86400', 19:08:02 INFO - 'USER': 'cltbld', 19:08:02 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', 19:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:02 INFO - '_': '/tools/buildbot/bin/python'} 19:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:03 INFO - Downloading/unpacking jsonschema==2.5.1 19:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:08:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:05 INFO - Downloading functools32-3.2.3-2.tar.gz 19:08:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:08:05 INFO - warning: no files found matching '*.txt' 19:08:05 INFO - no previously-included directories found matching 'build' 19:08:05 INFO - no previously-included directories found matching 'dist' 19:08:05 INFO - no previously-included directories found matching '.git*' 19:08:05 INFO - Installing collected packages: jsonschema, functools32 19:08:05 INFO - Running setup.py install for functools32 19:08:05 INFO - warning: no files found matching '*.txt' 19:08:05 INFO - no previously-included directories found matching 'build' 19:08:05 INFO - no previously-included directories found matching 'dist' 19:08:05 INFO - no previously-included directories found matching '.git*' 19:08:05 INFO - Successfully installed jsonschema functools32 19:08:05 INFO - Cleaning up... 19:08:05 INFO - Return code: 0 19:08:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08: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')]} 19:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:05 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 0x7f98af819f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd34480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc36f0>, '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 0xdc45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4aa0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', '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 19:08:05 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 19:08:05 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 19:08:05 INFO - Using env: {'DISPLAY': ':0', 19:08:05 INFO - 'HOME': '/home/cltbld', 19:08:05 INFO - 'LANG': 'en_US.UTF-8', 19:08:05 INFO - 'LANGUAGE': 'en_US:en', 19:08:05 INFO - 'LOGNAME': 'cltbld', 19:08:05 INFO - 'MAIL': '/var/mail/cltbld', 19:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:05 INFO - 'MOZ_NO_REMOTE': '1', 19:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:05 INFO - 'NO_EM_RESTART': '1', 19:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:05 INFO - 'PWD': '/builds/slave/test', 19:08:05 INFO - 'SHELL': '/bin/bash', 19:08:05 INFO - 'SHLVL': '1', 19:08:05 INFO - 'TERM': 'linux', 19:08:05 INFO - 'TMOUT': '86400', 19:08:05 INFO - 'USER': 'cltbld', 19:08:05 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', 19:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:05 INFO - '_': '/tools/buildbot/bin/python'} 19:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:05 INFO - Downloading/unpacking blobuploader==1.2.4 19:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:07 INFO - Downloading blobuploader-1.2.4.tar.gz 19:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:08:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:08:07 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 19:08:07 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 19:08:07 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 19:08:07 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 19:08:07 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 19:08:07 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 19:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:08:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:08:08 INFO - Downloading docopt-0.6.1.tar.gz 19:08:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:08:08 INFO - Installing collected packages: blobuploader, requests, docopt 19:08:08 INFO - Running setup.py install for blobuploader 19:08:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:08:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:08:08 INFO - Running setup.py install for requests 19:08:08 INFO - Running setup.py install for docopt 19:08:08 INFO - Successfully installed blobuploader requests docopt 19:08:08 INFO - Cleaning up... 19:08:08 INFO - Return code: 0 19:08:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:08 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 0x7f98af819f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd34480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc36f0>, '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 0xdc45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4aa0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', '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 19:08:08 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 19:08:08 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 19:08:08 INFO - Using env: {'DISPLAY': ':0', 19:08:08 INFO - 'HOME': '/home/cltbld', 19:08:08 INFO - 'LANG': 'en_US.UTF-8', 19:08:08 INFO - 'LANGUAGE': 'en_US:en', 19:08:08 INFO - 'LOGNAME': 'cltbld', 19:08:08 INFO - 'MAIL': '/var/mail/cltbld', 19:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:08 INFO - 'MOZ_NO_REMOTE': '1', 19:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:08 INFO - 'NO_EM_RESTART': '1', 19:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:08 INFO - 'PWD': '/builds/slave/test', 19:08:08 INFO - 'SHELL': '/bin/bash', 19:08:08 INFO - 'SHLVL': '1', 19:08:08 INFO - 'TERM': 'linux', 19:08:08 INFO - 'TMOUT': '86400', 19:08:08 INFO - 'USER': 'cltbld', 19:08:08 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', 19:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:08 INFO - '_': '/tools/buildbot/bin/python'} 19:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:09 INFO - Running setup.py (path:/tmp/pip-Aej3yZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:09 INFO - Running setup.py (path:/tmp/pip-HZPPlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:09 INFO - Running setup.py (path:/tmp/pip-qW18YC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:09 INFO - Running setup.py (path:/tmp/pip-25T7Mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:09 INFO - Running setup.py (path:/tmp/pip-wr47QR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:09 INFO - Running setup.py (path:/tmp/pip-xCIykf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:09 INFO - Running setup.py (path:/tmp/pip-iWGPN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:09 INFO - Running setup.py (path:/tmp/pip-tVPZyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:09 INFO - Running setup.py (path:/tmp/pip-i_ck_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:09 INFO - Running setup.py (path:/tmp/pip-gS3nqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:09 INFO - Running setup.py (path:/tmp/pip-5jKi0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:09 INFO - Running setup.py (path:/tmp/pip-PHKOmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:10 INFO - Running setup.py (path:/tmp/pip-8bIdFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:10 INFO - Running setup.py (path:/tmp/pip-5wVMAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:10 INFO - Running setup.py (path:/tmp/pip-zxB4Za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:10 INFO - Running setup.py (path:/tmp/pip-fR99Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:10 INFO - Running setup.py (path:/tmp/pip-k1Cwzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:08:10 INFO - Running setup.py install for manifestparser 19:08:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:08:10 INFO - Running setup.py install for mozcrash 19:08:10 INFO - Running setup.py install for mozdebug 19:08:10 INFO - Running setup.py install for mozdevice 19:08:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:08:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:08:10 INFO - Running setup.py install for mozfile 19:08:10 INFO - Running setup.py install for mozhttpd 19:08:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:08:10 INFO - Running setup.py install for mozinfo 19:08:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:08:11 INFO - Running setup.py install for mozInstall 19:08:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:08:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:08:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:08:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:08:11 INFO - Running setup.py install for mozleak 19:08:11 INFO - Running setup.py install for mozlog 19:08:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:08:11 INFO - Running setup.py install for moznetwork 19:08:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:08:11 INFO - Running setup.py install for mozprocess 19:08:11 INFO - Running setup.py install for mozprofile 19:08:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:08:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:08:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:08:11 INFO - Running setup.py install for mozrunner 19:08:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:08:11 INFO - Running setup.py install for mozscreenshot 19:08:11 INFO - Running setup.py install for moztest 19:08:12 INFO - Running setup.py install for mozversion 19:08:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:08:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:08:12 INFO - Cleaning up... 19:08:12 INFO - Return code: 0 19:08:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08: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')]} 19:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08: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')]} 19:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:12 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 0x7f98af819f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd34480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc36f0>, '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 0xdc45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4aa0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', '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 19:08:12 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 19:08:12 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 19:08:12 INFO - Using env: {'DISPLAY': ':0', 19:08:12 INFO - 'HOME': '/home/cltbld', 19:08:12 INFO - 'LANG': 'en_US.UTF-8', 19:08:12 INFO - 'LANGUAGE': 'en_US:en', 19:08:12 INFO - 'LOGNAME': 'cltbld', 19:08:12 INFO - 'MAIL': '/var/mail/cltbld', 19:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:12 INFO - 'MOZ_NO_REMOTE': '1', 19:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:12 INFO - 'NO_EM_RESTART': '1', 19:08:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:12 INFO - 'PWD': '/builds/slave/test', 19:08:12 INFO - 'SHELL': '/bin/bash', 19:08:12 INFO - 'SHLVL': '1', 19:08:12 INFO - 'TERM': 'linux', 19:08:12 INFO - 'TMOUT': '86400', 19:08:12 INFO - 'USER': 'cltbld', 19:08:12 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', 19:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:12 INFO - '_': '/tools/buildbot/bin/python'} 19:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:08:12 INFO - Running setup.py (path:/tmp/pip-CLXOOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:08:12 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)) 19:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:08:12 INFO - Running setup.py (path:/tmp/pip-4VGbpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:08:12 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)) 19:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:08:12 INFO - Running setup.py (path:/tmp/pip-iHUThS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:08:12 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)) 19:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:08:12 INFO - Running setup.py (path:/tmp/pip-DoeBIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:08:12 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)) 19:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:08:12 INFO - Running setup.py (path:/tmp/pip-_gwoMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:08:12 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)) 19:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:08:12 INFO - Running setup.py (path:/tmp/pip-vWgT2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:08:12 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)) 19:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:08:12 INFO - Running setup.py (path:/tmp/pip-YaBka8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:08:12 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)) 19:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:08:12 INFO - Running setup.py (path:/tmp/pip-Ncb2fH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:08:12 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)) 19:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:08:12 INFO - Running setup.py (path:/tmp/pip-RWaRsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:08:13 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)) 19:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:08:13 INFO - Running setup.py (path:/tmp/pip-tnxzg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:08:13 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)) 19:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:08:13 INFO - Running setup.py (path:/tmp/pip-uVorkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:08:13 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)) 19:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:08:13 INFO - Running setup.py (path:/tmp/pip-N22OfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:08:13 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)) 19:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:08:13 INFO - Running setup.py (path:/tmp/pip-I1Y8Qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:08:13 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)) 19:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:08:13 INFO - Running setup.py (path:/tmp/pip-sSXbW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:08:13 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)) 19:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:13 INFO - Running setup.py (path:/tmp/pip-IwE78A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:08:13 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)) 19:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:08:13 INFO - Running setup.py (path:/tmp/pip-vsXW4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:08:13 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)) 19:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:08:13 INFO - Running setup.py (path:/tmp/pip-SF2YwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:08:13 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)) 19:08:13 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)) 19:08:13 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)) 19:08:13 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)) 19:08:13 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)) 19:08:13 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)) 19:08:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08: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 19:08:15 INFO - Downloading blessings-1.6.tar.gz 19:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:08:15 INFO - Installing collected packages: blessings 19:08:15 INFO - Running setup.py install for blessings 19:08:15 INFO - Successfully installed blessings 19:08:15 INFO - Cleaning up... 19:08:15 INFO - Return code: 0 19:08:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:08:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:15 INFO - Reading from file tmpfile_stdout 19:08:15 INFO - Current package versions: 19:08:15 INFO - argparse == 1.2.1 19:08:15 INFO - blessings == 1.6 19:08:15 INFO - blobuploader == 1.2.4 19:08:15 INFO - docopt == 0.6.1 19:08:15 INFO - functools32 == 3.2.3-2 19:08:15 INFO - jsonschema == 2.5.1 19:08:15 INFO - manifestparser == 1.1 19:08:15 INFO - mozInstall == 1.12 19:08:15 INFO - mozcrash == 0.17 19:08:15 INFO - mozdebug == 0.1 19:08:15 INFO - mozdevice == 0.48 19:08:15 INFO - mozfile == 1.2 19:08:15 INFO - mozhttpd == 0.7 19:08:15 INFO - mozinfo == 0.9 19:08:15 INFO - mozleak == 0.1 19:08:15 INFO - mozlog == 3.2 19:08:15 INFO - moznetwork == 0.27 19:08:15 INFO - mozprocess == 0.22 19:08:15 INFO - mozprofile == 0.28 19:08:15 INFO - mozrunner == 6.11 19:08:15 INFO - mozscreenshot == 0.1 19:08:15 INFO - mozsystemmonitor == 0.3 19:08:15 INFO - moztest == 0.7 19:08:15 INFO - mozversion == 1.4 19:08:15 INFO - psutil == 3.1.1 19:08:15 INFO - requests == 1.2.3 19:08:15 INFO - wsgiref == 0.1.2 19:08:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:15 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 0x7f98af819f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd34480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc36f0>, '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 0xdc45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4aa0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', '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 19:08:15 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 19:08:15 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 19:08:15 INFO - Using env: {'DISPLAY': ':0', 19:08:15 INFO - 'HOME': '/home/cltbld', 19:08:15 INFO - 'LANG': 'en_US.UTF-8', 19:08:15 INFO - 'LANGUAGE': 'en_US:en', 19:08:15 INFO - 'LOGNAME': 'cltbld', 19:08:15 INFO - 'MAIL': '/var/mail/cltbld', 19:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:15 INFO - 'MOZ_NO_REMOTE': '1', 19:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:15 INFO - 'NO_EM_RESTART': '1', 19:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:15 INFO - 'PWD': '/builds/slave/test', 19:08:15 INFO - 'SHELL': '/bin/bash', 19:08:15 INFO - 'SHLVL': '1', 19:08:15 INFO - 'TERM': 'linux', 19:08:15 INFO - 'TMOUT': '86400', 19:08:15 INFO - 'USER': 'cltbld', 19:08:15 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', 19:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:15 INFO - '_': '/tools/buildbot/bin/python'} 19:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:16 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)) 19:08:16 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)) 19:08:16 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)) 19:08:16 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)) 19:08:16 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)) 19:08:16 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)) 19:08:16 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)) 19:08:16 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)) 19:08:16 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)) 19:08:16 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)) 19:08:16 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)) 19:08:16 INFO - Cleaning up... 19:08:16 INFO - Return code: 0 19:08:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:16 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 0x7f98af819f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd34480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc36f0>, '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 0xdc45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4aa0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', '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 19:08:16 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 19:08:16 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 19:08:16 INFO - Using env: {'DISPLAY': ':0', 19:08:16 INFO - 'HOME': '/home/cltbld', 19:08:16 INFO - 'LANG': 'en_US.UTF-8', 19:08:16 INFO - 'LANGUAGE': 'en_US:en', 19:08:16 INFO - 'LOGNAME': 'cltbld', 19:08:16 INFO - 'MAIL': '/var/mail/cltbld', 19:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:16 INFO - 'MOZ_NO_REMOTE': '1', 19:08:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:16 INFO - 'NO_EM_RESTART': '1', 19:08:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:16 INFO - 'PWD': '/builds/slave/test', 19:08:16 INFO - 'SHELL': '/bin/bash', 19:08:16 INFO - 'SHLVL': '1', 19:08:16 INFO - 'TERM': 'linux', 19:08:16 INFO - 'TMOUT': '86400', 19:08:16 INFO - 'USER': 'cltbld', 19:08:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', 19:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:16 INFO - '_': '/tools/buildbot/bin/python'} 19:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:08:16 INFO - Cleaning up... 19:08:16 INFO - Return code: 0 19:08:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:08:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:08:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:08:16 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 0x7f98af819f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd34480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc36f0>, '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 0xdc45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4aa0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', '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 19:08:16 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 19:08:16 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 19:08:16 INFO - Using env: {'DISPLAY': ':0', 19:08:16 INFO - 'HOME': '/home/cltbld', 19:08:16 INFO - 'LANG': 'en_US.UTF-8', 19:08:16 INFO - 'LANGUAGE': 'en_US:en', 19:08:16 INFO - 'LOGNAME': 'cltbld', 19:08:16 INFO - 'MAIL': '/var/mail/cltbld', 19:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:16 INFO - 'MOZ_NO_REMOTE': '1', 19:08:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:16 INFO - 'NO_EM_RESTART': '1', 19:08:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:16 INFO - 'PWD': '/builds/slave/test', 19:08:16 INFO - 'SHELL': '/bin/bash', 19:08:16 INFO - 'SHLVL': '1', 19:08:16 INFO - 'TERM': 'linux', 19:08:16 INFO - 'TMOUT': '86400', 19:08:16 INFO - 'USER': 'cltbld', 19:08:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', 19:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:16 INFO - '_': '/tools/buildbot/bin/python'} 19:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:08:16 INFO - Downloading/unpacking flake8 19:08:16 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 19:08:16 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 19:08:16 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 19:08:16 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 19:08:16 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 19:08:16 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 19:08:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:08:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:08:18 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 19:08:18 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 19:08:18 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 19:08:18 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 19:08:18 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 19:08:18 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 19:08:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:08:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:08:18 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 19:08:18 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 19:08:18 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 19:08:18 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 19:08:18 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 19:08:18 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 19:08:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:08:18 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 19:08:18 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 19:08:18 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 19:08:18 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 19:08:18 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 19:08:18 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 19:08:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:08:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:08:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:08:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:08:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:08:19 INFO - no previously-included directories found matching 'docs/_build' 19:08:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:08:19 INFO - Running setup.py install for pep8 19:08:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:08:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:08:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:08:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:08:19 INFO - no previously-included directories found matching 'docs/_build' 19:08:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:08:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:08:19 INFO - Cleaning up... 19:08:19 INFO - Return code: 0 19:08:19 INFO - Running post-action listener: _resource_record_post_action 19:08:19 INFO - Running post-action listener: _start_resource_monitoring 19:08:19 INFO - Starting resource monitoring. 19:08:19 INFO - ##### 19:08:19 INFO - ##### Finished create-virtualenv step (success) 19:08:19 INFO - ##### 19:08:19 INFO - ##### 19:08:19 INFO - ##### Running install step. 19:08:19 INFO - ##### 19:08:19 INFO - Running pre-action listener: _resource_record_pre_action 19:08:19 INFO - Running main action method: install 19:08:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:08:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:08:19 INFO - Reading from file tmpfile_stdout 19:08:19 INFO - Detecting whether we're running mozinstall >=1.0... 19:08:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:08:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:08:19 INFO - Reading from file tmpfile_stdout 19:08:19 INFO - Output received: 19:08:19 INFO - Usage: mozinstall [options] installer 19:08:19 INFO - Options: 19:08:19 INFO - -h, --help show this help message and exit 19:08:19 INFO - -d DEST, --destination=DEST 19:08:19 INFO - Directory to install application into. [default: 19:08:19 INFO - "/builds/slave/test"] 19:08:19 INFO - --app=APP Application being installed. [default: firefox] 19:08:19 INFO - mkdir: /builds/slave/test/build/application 19:08:19 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'] 19:08:19 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 19:08:36 INFO - Reading from file tmpfile_stdout 19:08:36 INFO - Output received: 19:08:36 INFO - /builds/slave/test/build/application/firefox/firefox 19:08:36 INFO - Running post-action listener: _resource_record_post_action 19:08:36 INFO - ##### 19:08:36 INFO - ##### Finished install step (success) 19:08:36 INFO - ##### 19:08:36 INFO - ##### 19:08:36 INFO - ##### Running run-tests step. 19:08:36 INFO - ##### 19:08:36 INFO - Running pre-action listener: _resource_record_pre_action 19:08:36 INFO - Running main action method: run_tests 19:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:08:36 INFO - Python 2.7.3 19:08:36 INFO - Return code: 0 19:08:36 INFO - grabbing minidump binary from tooltool 19:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:08:36 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 0xdc36f0>, '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 0xdc45f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdc4aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:08:36 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 19:08:36 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 19:08:36 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 19:08:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:08:36 INFO - Return code: 0 19:08:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:08:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:08:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:08:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:08:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:08:37 INFO - Return code: 0 19:08:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 19:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 19:08:37 INFO - Using env: {'DISPLAY': ':0', 19:08:37 INFO - 'HOME': '/home/cltbld', 19:08:37 INFO - 'LANG': 'en_US.UTF-8', 19:08:37 INFO - 'LANGUAGE': 'en_US:en', 19:08:37 INFO - 'LOGNAME': 'cltbld', 19:08:37 INFO - 'MAIL': '/var/mail/cltbld', 19:08:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:08:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:08:37 INFO - 'MOZ_NO_REMOTE': '1', 19:08:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:08:37 INFO - 'NO_EM_RESTART': '1', 19:08:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:08:37 INFO - 'PWD': '/builds/slave/test', 19:08:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:08:37 INFO - 'SHELL': '/bin/bash', 19:08:37 INFO - 'SHLVL': '1', 19:08:37 INFO - 'TERM': 'linux', 19:08:37 INFO - 'TMOUT': '86400', 19:08:37 INFO - 'USER': 'cltbld', 19:08:37 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923', 19:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:08:37 INFO - '_': '/tools/buildbot/bin/python'} 19:08:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 19:08:38 INFO - mozversion application_buildid: 20160625163004 19:08:38 INFO - mozversion application_changeset: c2da34d96746288b5fee27bf6542a12c9f410988 19:08:38 INFO - mozversion application_display_name: Nightly 19:08:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:08:38 INFO - mozversion application_name: Firefox 19:08:38 INFO - mozversion application_remotingname: firefox 19:08:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:08:38 INFO - mozversion application_vendor: Mozilla 19:08:38 INFO - mozversion application_version: 50.0a1 19:08:38 INFO - mozversion platform_buildid: 20160625163004 19:08:38 INFO - mozversion platform_changeset: c2da34d96746288b5fee27bf6542a12c9f410988 19:08:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:08:38 INFO - mozversion platform_version: 50.0a1 19:08:38 INFO - using testdate: 1466906918 19:08:38 INFO - actual date: 1466906918 19:08:38 INFO - starting webserver on 'localhost:42260' 19:08:38 INFO - SUITE-START | Running 2 tests 19:08:38 INFO - TEST-START | dromaeo_css 19:08:38 INFO - operating with platform_type : linux_ 19:08:38 INFO - Initialising browser for dromaeo_css test... 19:08:38 INFO - TEST-INFO | started process 3325 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQB91m7/profile http://localhost:42260/getInfo.html) 19:08:44 INFO - PROCESS | 3325 | __metrics Screen width/height:1600/1200 19:08:44 INFO - PROCESS | 3325 | colorDepth:24 19:08:44 INFO - PROCESS | 3325 | Browser inner width/height: 1024/697 19:08:44 INFO - PROCESS | 3325 | __metrics 19:08:46 ERROR - PROCESS | 3325 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 19:08:47 INFO - TEST-INFO | 3325: exit 0 19:08:47 INFO - Browser initialized. 19:08:47 INFO - Running cycle 1/1 for dromaeo_css test... 19:08:47 INFO - TEST-INFO | started process 3450 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQB91m7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:08:59 INFO - PROCESS | 3450 | RSS: Main: 184918016 19:08:59 INFO - PROCESS | 3450 | 19:09:48 INFO - PROCESS | 3450 | 1466906988623 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] 19:11:56 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:42260/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42260/tests/dromaeo/cssquery-ext.html) 19:11:57 INFO - PROCESS | 3450 | RSS: Main: 188305408 19:11:57 INFO - PROCESS | 3450 | 19:15:00 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:42260/tests/dromaeo/cssquery-ext.html (next: http://localhost:42260/tests/dromaeo/cssquery-jquery.html) 19:15:00 INFO - PROCESS | 3450 | RSS: Main: 187490304 19:15:00 INFO - PROCESS | 3450 | 19:18:02 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:42260/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42260/tests/dromaeo/cssquery-mootools.html) 19:18:03 INFO - PROCESS | 3450 | RSS: Main: 189046784 19:18:03 INFO - PROCESS | 3450 | 19:21:04 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:42260/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42260/tests/dromaeo/cssquery-prototype.html) 19:21:05 INFO - PROCESS | 3450 | RSS: Main: 186515456 19:21:05 INFO - PROCESS | 3450 | 19:24:07 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:42260/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42260/tests/dromaeo/cssquery-yui.html) 19:24:08 INFO - PROCESS | 3450 | RSS: Main: 188510208 19:24:08 INFO - PROCESS | 3450 | 19:27:10 INFO - PROCESS | 3450 | Cycle 1(1): loaded http://localhost:42260/tests/dromaeo/cssquery-yui.html (next: http://localhost:42260/tests/dromaeo/cssquery-dojo.html) 19:27:11 INFO - PROCESS | 3450 | RSS: Main: 189603840 19:27:11 INFO - PROCESS | 3450 | 19:27:11 INFO - PROCESS | 3450 | __start_tp_report 19:27:11 INFO - PROCESS | 3450 | _x_x_mozilla_page_load 19:27:11 INFO - PROCESS | 3450 | _x_x_mozilla_page_load_details 19:27:11 INFO - PROCESS | 3450 | |i|pagename|runs| 19:27:11 INFO - PROCESS | 3450 | |0;dojo.html;3140;3179.4912813949745;3201.2797120647856;3215.726663233625;3224.290656055667;5441.211024401459;5510.972445137773;5517.69652669103;5536.224928510007;5601.523870471015;5344.812931547397;5417.539509141718;5471.753771080301;5511.22842802008;5572.331320241577;4925.1627223372025;4971.950280497203;5068.037072956145;5130.846074617749;5163.096458119833;783.3567385479577;5046.167382381903;5101.336826212587;5124.359455068116;5151.81968631098;4985.102681517325;5016.673916195454;5023.723695196781;5030.622703297267;5073.1122053640465;4935.876603084916;5012.473690262506;5017.247412888059;5043.924341134886;5061.772220250097;4909.950900491021;4962.0324036812835;4970.850874473772;4976.975115124437;5023.246513023076;5454.890902181974;5467.808626698046;5481.451854814487;5484.643498172646;5487.368952570466;5753.7123143843055;5840.4451577100535;5862.97068514659;5937.079752638348;6033.818985430444;6017.819465416044;6040.12418199363;6059.606125601866;6073.3622969588;6086.452219300284;5609.439056094398;5656.4060773618585;5667;5669.631473954221;5674.914876276859;5887.264091988502;6064.787732429344;6114.694265286718;6119.908201376983;6148.938510614837;5903.114532820111;5907.172995780594;5910.940890591039;5913.704314784243;5931.614445061057;5922.230110085661;5937.7921772737745;5938.940610593839;5969.074793407029;5990.161377407167;5712.914306285409;5870.853228669232;5904.143899134601;5925.170476133345;5967.16459695643;5733.827985160452;5796.971015144897;5824.242848429677;5838.824835254949;5968.671723055274;4433.312836510346;4437.711548749321;4463.129689710475;4471.128130014616;4506.977465112654;3924.2740093082302;3963.583823698528;3986.920261594752;3997.6801855851463;4025.255327764373;5652.491275785117;5739.253896993448;5743.3395159557185;5753.626014309057;5784.652920824764;6007.519398448114;6029.125776762345;6038.305594856648;6044.576879618472;6058.12157237207;5470.64440811346;5594.160875868571;5641.661500309994;5683.573731970118;5743.62666426681;4963.043814137493;4989.301497790312;5015.473375295542;5023.19628859388;5025.170846810309;6211.192544969215;6240.344763799826;6256.405641464054;6257.155284036688;6267.467265282411;5749.597528172988;5938.376470470538;5979.4618484336615;5998.400159983967;6031.849203769765;6155.6614386209185;6176.66028368444;6188.2883468399905;6216.222972128484;6217.222847144107;5685;5869;5925.081612350093;5925.674087925206;5940.79207227745;5889.440503152194;5926.644401335933;5941.197938278277;6021.42796434338;6035.336113027652;5792.160136780228;5837.854053648693;5879.382664820132;5883.94116058834;5885.264341957255;5586.441355864381;5674.716264186856;5715.085586306171;5738.512226460798;5754.309482862083;5534.640248383842;5573.7213139343685;5587.525060369914;5719.0277652798295;5770.855728606818;5715.057015592547;5719.942800572107;5755.913661295168;5771.740271687868;5790.363060063305;5513.862153446035;5551.8889622206525;5655.066913959316;5656.37779844225;5685.545156387397 19:27:11 INFO - PROCESS | 3450 | |1;ext.html;573.681606708277;617.4288782875841;617.9938200617993;622.2222222222222;642.1299139665751;39959.60040399595;42193.52322668707;42292;42326.78836605813;45305.54694453054;43745;44173.77913110438;44250.33624495635;44341.7782911085;44546.777266113706;8955.104489551042;8978.955105224464;9038.412503187305;9063.320250981169;9079.546022698873;8850.955745221265;8928.24109950655;8942.508162051085;8944.686935957243;8981.101889811;9026.413283136575;9039.096090390942;9070.138336857988;9087.95456022719;9090.13643703847;9042.502662353569;9044.09559044097;9058.320625953047;9059.59231834569;9114.772130696752;8877.689280875204;8975;8991.505467199302;8995.055519170524;8997.640094396216;41201.381979270336;41684.58315416868;41720.79139604313;41761.58238417607;42002.369964450554;3227.160938156073;3246.594175728034;3350.8994730158133;3625.528681271418;3845.61543845616;31744.682553174403;32221.838890805397;32405.189870253198;32671.509927351108;33492.832535837406;4301.526832048472;4353.73877567347;4418.094290670405;4475.910481790378;4483.237849565582;342927;343670;343969;344243;345243;33155.83422082874;58003.41996580065;58330.4166958325;58330.70834645884;58418.70790646019;34156.82921585376;35681;35728.28543429169;35760;36074.63925360713;14238.43046278158;14402.20787856678;14418.783718244234;14618.122912625277;14624.122552646875;12338.568150114703;12382.81425778614;12399.566015189424;12431.37843107841;12537.686557836127;8282.25459708617;8313.501189928624;8347.833043339098;8348.707795227137;8389.699596562543;3123.1723593247807;3137.105924811418;3194.440972829792;3205.9198520037185;3221.4201443739885;1013.9442330671736;1026.609888242463;1041.8124737547314;1072.973175670599;1115.5934060461211;31222;31428.52857207144;31444.21389465236;31767.52348714771;32175.35649287048;1101.8126918423886;1169.2107827216594;1174.9530018799323;1186.2882270637722;1222.786012447836;16615.584610384594;16683.916580417263;16884.493465196065;16914.577135571464;16990.915045424696;581789;583930;586955;587348;594890;53938.730306349;54953.45046549563;54954;55029.72485137549;55098.72450637721;1233.993830030844;1312.173330801589;1344.2808097667896;1352.8714772096635;1355.3155656393656;28988.7101128986;30055.549166762077;30385.544216836322;30541;30744.84627576848;49194;49562;49844.50155498399;49894.75052624714;49913.75043124761;448529;452048;455461;456803;459202;27338;27659.308517287227;27980.580291296053;28030.579541307303;28197.15408537747;47052.29421558748;47145.76427117842;47156.292655609504;47418;48270;40530;40682.9829254271;41112.58887411088;41251.793741031106;41617.79191104025;39260.411093834184;40071.799641001606;40538.59461405466;40956.38565421462;41012.79493602632;39344.60655393409;39817.2036559273;40567.3914891271;40602;40686.593134069466;35604.287914242086;36090.55637774565;36262;36623.26753464969;36936.63063369332;27370.726292736817;27550.5867411993;27641;27661.30846728848;27715.584266236427 19:27:11 INFO - PROCESS | 3450 | |2;jquery.html;378.6289436352373;389.47529296923165;389.7427697719506;391.8119302734687;411.444549857692;14074.507392241274;17593.120343982813;17643.735343969835;19160.71258931117;19305.806941930576;14498.275086245698;17841.197146128423;18185.09074546271;18590.628187436276;18866.151023203955;5567.526760225375;5887.116932460122;5926.88146237075;5935.9703201483935;5953.58324917256;5788.768449262025;5812.534997200235;5823.5341172706085;5878.617889837168;5898.557608179382;5659.971700141494;5765.740541675614;5775.913361299584;5804.535637149039;5860.912086318687;5700.543956483471;5741.913871291913;5760.6255593386295;5769.884602307972;5770.163326317703;5195.3246078009615;5201.45384734605;5214.113600687854;5215.400228973679;5219.739013049332;21496.462588435257;22110;23151.536969260687;23162.420939476648;23324.3002709919;2222.2555443926303;2351.2240960483;2370.8103351731993;2442.511497700449;2764.8802235094818;7251.673674684652;7252.2385149559595;13383.86616133836;14302.785458218135;14403.351849166813;1670.9081000544966;1821.9635607287912;1849.2972670385302;1853.6756067688236;1860.748798912143;53442.73278633621;68211;76160.23839761587;77496.61251693762;79363.60318198372;10616.30993985404;10802.621908233174;10921.836172457419;11231.66305010851;11304.434778261219;15157.469488568067;15197.62005949838;15204.239788010555;15268.923655381652;15277.618059548378;7356.117265928123;7759.456838021397;7826.726064587712;7865.174156713577;8238.711645092393;7768;7789;7850.214978502104;7963.4027447941635;7977.60111994398;4576.81692732287;4633.142868569325;4641.141388843075;4686.507916668769;4693;1928.623918335911;1980.5939782344585;1981.6631172700675;1983.3851506032888;1994.4515258304082;940.2149205413556;940.8965013848472;942.6323733743845;966.9323147379616;975.8536219567121;18319.267229310677;18912;18943;18969.43091707251;19298.53286297634;927.2280056647317;939.68050862707;955.254901177083;984.5126662302206;1013.4291847636134;10426.426546540013;10643.201759868041;10706.518206680717;10737.087347575387;10822.78354432907;353549;480696;485315;489377;491533;87777;88150;88841;89617;90012.5499372512;987;987.3532835992437;993.4635296939716;996.5366104761321;998.1066945084254;15163.924180379028;16567.17164141764;16789;17233.913830430767;17458;36499.63500364962;38818.2236355277;39102.80448597739;39694.404583930685;40569;58411.415885842296;60087;61916.69041654763;62694;64004;7524.2851929066655;7746.49647772893;8401.53791541471;8565.871511927202;8642.827143457222;13551.254680992246;13608.863911361155;13627.250501222528;13697.520586779416;13987.650308742363;11337.319760814378;11382.886171138183;11391.544338226378;11745.17783755129;11829.290242585472;11358.920902514248;11502.137339699724;11555.653330400102;11730.472128754398;12383.19509231897;12031.398430078636;12239.75520489603;12402.503899843905;12410.937945310216;12411.069169812119;7660.463767536219;7713.922860771545;7720.382369410321;7813.765587032398;7831.138574756887;11041;11080.944595277295;11664.825027624762;11711.648650540497;11822.34977076269 19:27:11 INFO - PROCESS | 3450 | |3;mootools.html;1404.6277736399857;1429.9428022879083;1542.4293011585708;1675.463851567499;1700.4983529858691;7529.585872776995;7993.400494962872;7993.600319984;8631.093735157812;8638.395312328132;8163.551004694739;8403.285720713731;8487.91512084879;8498.915010849905;8501.362397820158;2283.954320913585;2288.519410923708;2313.595120853852;2314.5255222679393;2324.8023917966993;2262.1177740681146;2286.8056215221727;2317.953640927189;2345.1440224318085;2358.681577986967;2276.886155692217;2289.8740569268684;2293.2546922250253;2313.4794671199015;2349.706286714161;2219.2676416782424;2268.9886550567226;2279.7948184663296;2285.6685780561725;2286.4512516995883;2217.4456385903522;2236.3514580771557;2240.843140980132;2254.9210777622707;2260.152442833937;8362.58187090643;8408.327333813342;8480.321574274105;8494.78763030923;8504.532250726208;4872.65891387603;4994.750262486861;5000.499950005007;5033.597312215051;5033.697978121288;3100.98449507751;3105.9223519412194;3203.9199020024453;3204.5513628092085;3205.4069997050387;1056.260617567698;1063.5320458998017;1079.1097344690584;1089.7330154112215;1095.2552264460164;11323.603673871376;11327.830082548768;11340.489677964511;11362.318260904372;11424.371659558721;4475.440569928759;4532.9320060199125;4616.838410655678;4631.536846315342;4643.698159619614;9680.177184939219;9713.36863103896;9762.365446246113;9778.559964801601;9796.167325777245;5151.845444636667;5155.123628983082;5163.870903227449;5164.302819119446;5179;4219.767912764766;4531.753767713905;4635.072985402933;4659.883502912454;4759.405074365704;3860.8069596520622;3900.278448486982;3970.7419017763755;3994.0414300568236;4008.07814202735;1227.6501197158766;1290.9349786426235;1293.6507143071506;1304.1523010043547;1306.73865226955;953.3517208298424;961.5240455974338;962.9311464274649;963.6145541783343;978.4569563891966;5590.664560126405;5732.312122545238;5839.532837373;5839.824805255849;5867.941320586825;978.2760757039739;985.1330828870691;985.9112679858847;1076.208986394999;1076.4671487613682;4016.859409920639;4057.229126465962;4058.5738497457933;4072.8778136655947;4092.4884389451317;9323.860142097874;9492.810143797224;9638.710838674851;9669.951650241705;9692;9622.422654640744;9622.759431014281;9647.662331818352;9658.855117173249;9659.565319560637;7275.527090739085;7561.470697051153;7901;8033.156518565584;8036.557989310527;5852.561057920588;5926.140709597171;5989.101634754822;6077.085717998816;6084.787032453843;9555.283353748635;9649.421034737938;9779.902200977898;9795.706128816148;9820.4107753535;9717.56270967794;9830.852537212091;10085.647002354883;10124.848127278245;10164.18686505063;6876.484263680344;7127.358537731629;7233.168185658506;7444.73943411978;7620.466567340454;7684;7932.4843885149585;7966.641501132347;7972.242636949481;7993.800154996172;7078.539894906815;7276.527025743309;7339.229380915141;7383.630818459163;7450.627468626439;6872.862542749217;7093.751718689821;7272;7302.233265507258;7357.337839594462;6835.453163746789;6874.175098988154;6884.449244060564;6885.827854303682;6951.617661028692;4531.886702832456;4771.95228047729;4873.926891096708;4885.560299573055;4970.975145124251;5043.44522102561;5049.394072711151;5049.570786483043;5063.797448102035;5202.167653175474 19:27:11 INFO - PROCESS | 3450 | |4;prototype.html;332.161292735842;333.889816360601;335.6123677152888;337.6353538178767;341.69418370558367;5616.32604087509;5672.659640421578;5675.744591493382;5727.367700205442;5769.596128271022;5607.467290607386;5620.775168993246;5624.437556244374;5633.126865335869;5661.971690141554;4175.290200665887;4211.515675697288;4328.264195086827;4344.435223420966;4377.518472967971;4303.956960430402;4304.504981927087;4339.956600433987;4343.283358245885;4371.803268852909;4302.65578753699;4306.806193721274;4322.308430651096;4335.981044454551;4338.89358213655;4234.703570750049;4241.787910604473;4313.805878735433;4320.589543993316;4345.565443455661;3769.2838360711653;3769.453429252743;3775.3954569308207;3782.3380908341205;3793.7534060285993;5381.730913454312;5395.678058875601;5410.675359478444;5420.91868621971;5474.2609747683955;4843.346148269974;4956.628252881048;4961.156603377434;4978.950210497885;4981.103401387749;5760.7695692172265;5817.650940943557;5817.680027598481;5850.912236316459;5863.856547973147;4159.708820382574;4175.642916052265;4193.91612167758;4210.85262015828;4218.8523401681105;5820.272465941757;6078.115784106897;6085.604435711664;6098.176746139303;6108.267007959029;4307.418498502725;4312.611864932172;4318.632916202158;4335.371371151228;4349.695521313478;4324.67564932625;4365.869023929287;4376.387305777193;4391.934120988188;4413.668974826836;4781.330613714083;4929;4929.309896614477;4932.53140951609;4940.2342636891335;5837.270341207349;5847.707614619252;5890.322612899486;5909.763609455574;5958.463738263577;1491.5599898030107;1500.4748338081583;1504.7667611520233;1509.690513444741;1511.1235483419591;957.5451660461225;978.0878382761683;993.2997236947934;998.7752755629925;1002.6390499420203;5655.737704917983;5668.404817494186;5682.232898558725;5732.828015159552;5738.856528586819;6006.849828754229;6032.276126864716;6045.63726176422;6051.273847138372;6055.485283750931;5367.302250707383;5593.440655934455;5665.405132461115;5695;5721.685307308138;3178.9986154361304;3187.2509960159346;3192.1859925718795;3231.9676803232137;3255.9674403255663;5893.263342082239;6195.411435913581;6209.96895015522;6228.377162283826;6276.497880169575;6140.293866205354;6164.445199932027;6168.290646575611;6173.783917562953;6190.288116866618;5915.911261331084;6230.563860529719;6233.158523599256;6248.843778905472;6277.654728989858;5958.255218097738;5967.671778052249;5968.791092311748;5974.671393073423;6044.184035155374;5923.348431672426;5946.137810017437;5946.732397042057;5994.490468310068;6057;5965.821025369246;6137.96931015342;6171.197744293213;6182;6239.75040998355;4170.186813571325;4184.309588917795;4186.35111557709;4198.097409057067;4202.180574788009;5812.796552120824;5940;6037.762258737036;6062.696865156637;6086.269647642312;5881.38245484218;5888.646681199141;5918.6091268551;5950.34546199909;5979.312379076462;5625.268715067015;5828.300603927556;5855.853603659943;5871.853203669943;5934.19888315072;5730.790757175995;5771.624844385269;5782.681952492653;5800.709964501673;5837.883242335045;5882.294124705063;5886.028805247086;5963.940360596339;5977.432143946318;6015.037593984942;5712.65724056558;5778.971105144616;5789.623674461147;5850.795222167204;5859.648421094748 19:27:11 INFO - PROCESS | 3450 | |5;yui.html;735.5476382025053;756.682193478739;756.8940348351232;762.8664983627865;783.7021931665967;14395.78406323906;15678.216089195552;15692.607684807885;15698.450554230605;15735.21323933803;14304.070235434716;14500.41998320066;14553.563393098197;14558.563243102697;14563.126212427262;758.6244808819628;782.2373186143493;784.1217836023661;787.4605894961969;790.2295262119445;765.0627980723625;770.6262462705612;774.3031271855347;780.4770803561628;781.570136424964;828.7430896422098;831.733845169546;832.367400775409;833.071125694852;835.9665613375457;826.0912995704737;826.1160558202725;828.5360198288947;828.5774255129897;828.9088200297963;599.6192417814719;601.0863487499021;601.2964831147568;601.6149664214906;601.8555546668812;14499.782503262459;14544.781828272584;14563.854361456355;14595.489157879423;14643.56069317922;12564.434600443003;12752.489900403973;13560.013736195317;14248;14399.424023039066;11153.932668516141;11280.492377843017;11422.657320280405;11514.769704605944;11654.941725291319;3751.681107105899;3758.3798673219158;3817.7709337439564;3832.6742226910746;3905.746126501797;50743.238851417256;56102.43897561013;65089.67455162741;69085;69696;10745.83881241782;10759.515821788038;10829.512671929782;10988;11020.669379918616;20743.688844667344;20768.68846967297;21060.894695526425;21121.68317475239;21218.045187966578;7692.384609231248;8433.662653493915;8548;8767.561621919007;8927.508987005776;4355.716878402894;4637.721736695809;4707.976460117678;4728.905421891543;4761.595264402496;3366.9326613468083;3482.355764183634;3492.7729697570085;3512.2448673535314;3521.683048525645;587.5857520448074;594.2186025376616;597.8775347516299;599.5173885022512;615.9753609855555;530.8036026670156;553.3442870198747;576.0696475192534;588.0591054313151;597.7788218359235;8188.222118898695;8289.83420331602;8304.958475207706;8452.408331416866;8721.171488708562;468.5618946285234;494.019371547478;524.2450870746113;559.1445089013815;590.6928397233414;3982.661473774762;4082.8775136745944;4171.561985991427;4208.957910420918;4349.108432771274;70035;70809.64595176991;86066;122960.38519807343;123230;96588.51705741567;99121.50439247758;99377;105759.4712026435;107024.92975070306;53778.46221537813;73798.6310068457;86525.56737216274;88790.11209887947;89263;9089.863652045093;9609.327347085637;9655.275854311096;9709.9029009709;9740.220782337254;50978;51314.74342628263;52689;53117.4688253128;54564.45435545753;69573.30426695668;79478.20521794708;79764.20235797568;80723;82685.58657206917;11047;11326.263792853439;11525.711857203636;11558.364289964133;11892.966299766358;13102.410391532594;13577.932110339385;13749.793753093512;14041.719165616834;14145;12010.219335743148;12774.808377874153;12822.166559173624;12902.612921612366;13058.281794501394;12477.188982716094;12645.24128552253;13000.739985200433;13052.608421747364;13154.736905262032;11766.705832353917;11913.344766037952;12321.260724356567;12330.75338493243;12563.623091307276;9996.20030397581;10010.203319811744;10148.644797432054;10202.28583999113;10398.272120951764;9975;10161.84757228657;10240.53917573696;10661.946690266499;10687.679369618923 19:27:11 INFO - PROCESS | 3450 | __end_tp_report 19:27:11 INFO - PROCESS | 3450 | __start_cc_report 19:27:11 INFO - PROCESS | 3450 | _x_x_mozilla_cycle_collect,359 19:27:11 INFO - PROCESS | 3450 | __end_cc_report 19:27:11 INFO - PROCESS | 3450 | __startTimestamp1466908031130__endTimestamp 19:27:11 INFO - PROCESS | 3450 | 19:27:11 INFO - PROCESS | 3450 | ------- Summary: start ------- 19:27:11 INFO - PROCESS | 3450 | Number of tests: 6 19:27:11 INFO - PROCESS | 3450 | 19:27:11 INFO - PROCESS | 3450 | [#0] dojo.html Cycles:165 Average:5478.56 Median:5715.09 stddev:744.93 (13.0%) stddev-sans-first:724.27 19:27:11 INFO - PROCESS | 3450 | Values: 3140.0 3179.5 3201.3 3215.7 3224.3 5441.2 5511.0 5517.7 5536.2 5601.5 5344.8 5417.5 5471.8 5511.2 5572.3 4925.2 4972.0 5068.0 5130.8 5163.1 783.4 5046.2 5101.3 5124.4 5151.8 4985.1 5016.7 5023.7 5030.6 5073.1 4935.9 5012.5 5017.2 5043.9 5061.8 4910.0 4962.0 4970.9 4977.0 5023.2 5454.9 5467.8 5481.5 5484.6 5487.4 5753.7 5840.4 5863.0 5937.1 6033.8 6017.8 6040.1 6059.6 6073.4 6086.5 5609.4 5656.4 5667.0 5669.6 5674.9 5887.3 6064.8 6114.7 6119.9 6148.9 5903.1 5907.2 5910.9 5913.7 5931.6 5922.2 5937.8 5938.9 5969.1 5990.2 5712.9 5870.9 5904.1 5925.2 5967.2 5733.8 5797.0 5824.2 5838.8 5968.7 4433.3 4437.7 4463.1 4471.1 4507.0 3924.3 3963.6 3986.9 3997.7 4025.3 5652.5 5739.3 5743.3 5753.6 5784.7 6007.5 6029.1 6038.3 6044.6 6058.1 5470.6 5594.2 5641.7 5683.6 5743.6 4963.0 4989.3 5015.5 5023.2 5025.2 6211.2 6240.3 6256.4 6257.2 6267.5 5749.6 5938.4 5979.5 5998.4 6031.8 6155.7 6176.7 6188.3 6216.2 6217.2 5685.0 5869.0 5925.1 5925.7 5940.8 5889.4 5926.6 5941.2 6021.4 6035.3 5792.2 5837.9 5879.4 5883.9 5885.3 5586.4 5674.7 5715.1 5738.5 5754.3 5534.6 5573.7 5587.5 5719.0 5770.9 5715.1 5719.9 5755.9 5771.7 5790.4 5513.9 5551.9 5655.1 5656.4 5685.5 19:27:11 INFO - PROCESS | 3450 | 19:27:11 INFO - PROCESS | 3450 | [#1] ext.html Cycles:180 Average:60394.37 Median:40684.79 stddev:125896.77 (309.4%) stddev-sans-first:126169.83 19:27:11 INFO - PROCESS | 3450 | Values: 573.7 617.4 618.0 622.2 642.1 39959.6 42193.5 42292.0 42326.8 45305.5 43745.0 44173.8 44250.3 44341.8 44546.8 8955.1 8979.0 9038.4 9063.3 9079.5 8851.0 8928.2 8942.5 8944.7 8981.1 9026.4 9039.1 9070.1 9088.0 9090.1 9042.5 9044.1 9058.3 9059.6 9114.8 8877.7 8975.0 8991.5 8995.1 8997.6 41201.4 41684.6 41720.8 41761.6 42002.4 3227.2 3246.6 3350.9 3625.5 3845.6 31744.7 32221.8 32405.2 32671.5 33492.8 4301.5 4353.7 4418.1 4475.9 4483.2 342927.0 343670.0 343969.0 344243.0 345243.0 33155.8 58003.4 58330.4 58330.7 58418.7 34156.8 35681.0 35728.3 35760.0 36074.6 14238.4 14402.2 14418.8 14618.1 14624.1 12338.6 12382.8 12399.6 12431.4 12537.7 8282.3 8313.5 8347.8 8348.7 8389.7 3123.2 3137.1 3194.4 3205.9 3221.4 1013.9 1026.6 1041.8 1073.0 1115.6 31222.0 31428.5 31444.2 31767.5 32175.4 1101.8 1169.2 1175.0 1186.3 1222.8 16615.6 16683.9 16884.5 16914.6 16990.9 581789.0 583930.0 586955.0 587348.0 594890.0 53938.7 54953.5 54954.0 55029.7 55098.7 1234.0 1312.2 1344.3 1352.9 1355.3 28988.7 30055.5 30385.5 30541.0 30744.8 49194.0 49562.0 49844.5 49894.8 49913.8 448529.0 452048.0 455461.0 456803.0 459202.0 27338.0 27659.3 27980.6 28030.6 28197.2 47052.3 47145.8 47156.3 47418.0 48270.0 40530.0 40683.0 41112.6 41251.8 41617.8 39260.4 40071.8 40538.6 40956.4 41012.8 39344.6 39817.2 40567.4 40602.0 40686.6 35604.3 36090.6 36262.0 36623.3 36936.6 27370.7 27550.6 27641.0 27661.3 27715.6 19:27:11 INFO - PROCESS | 3450 | 19:27:11 INFO - PROCESS | 3450 | [#2] jquery.html Cycles:180 Average:27685.43 Median:19747.31 stddev:76375.63 (386.8%) stddev-sans-first:76562.36 19:27:11 INFO - PROCESS | 3450 | Values: 378.6 389.5 389.7 391.8 411.4 14074.5 17593.1 17643.7 19160.7 19305.8 14498.3 17841.2 18185.1 18590.6 18866.2 5567.5 5887.1 5926.9 5936.0 5953.6 5788.8 5812.5 5823.5 5878.6 5898.6 5660.0 5765.7 5775.9 5804.5 5860.9 5700.5 5741.9 5760.6 5769.9 5770.2 5195.3 5201.5 5214.1 5215.4 5219.7 21496.5 22110.0 23151.5 23162.4 23324.3 2222.3 2351.2 2370.8 2442.5 2764.9 7251.7 7252.2 13383.9 14302.8 14403.4 1670.9 1822.0 1849.3 1853.7 1860.7 53442.7 68211.0 76160.2 77496.6 79363.6 10616.3 10802.6 10921.8 11231.7 11304.4 15157.5 15197.6 15204.2 15268.9 15277.6 7356.1 7759.5 7826.7 7865.2 8238.7 7768.0 7789.0 7850.2 7963.4 7977.6 4576.8 4633.1 4641.1 4686.5 4693.0 1928.6 1980.6 1981.7 1983.4 1994.5 940.2 940.9 942.6 966.9 975.9 18319.3 18912.0 18943.0 18969.4 19298.5 927.2 939.7 955.3 984.5 1013.4 10426.4 10643.2 10706.5 10737.1 10822.8 353549.0 480696.0 485315.0 489377.0 491533.0 87777.0 88150.0 88841.0 89617.0 90012.5 987.0 987.4 993.5 996.5 998.1 15163.9 16567.2 16789.0 17233.9 17458.0 36499.6 38818.2 39102.8 39694.4 40569.0 58411.4 60087.0 61916.7 62694.0 64004.0 7524.3 7746.5 8401.5 8565.9 8642.8 13551.3 13608.9 13627.3 13697.5 13987.7 11337.3 11382.9 11391.5 11745.2 11829.3 11358.9 11502.1 11555.7 11730.5 12383.2 12031.4 12239.8 12402.5 12410.9 12411.1 7660.5 7713.9 7720.4 7813.8 7831.1 11041.0 11080.9 11664.8 11711.6 11822.3 19:27:11 INFO - PROCESS | 3450 | 19:27:11 INFO - PROCESS | 3450 | [#3] mootools.html Cycles:180 Average:5521.52 Median:5159.50 stddev:3031.35 (58.8%) stddev-sans-first:3024.07 19:27:11 INFO - PROCESS | 3450 | Values: 1404.6 1429.9 1542.4 1675.5 1700.5 7529.6 7993.4 7993.6 8631.1 8638.4 8163.6 8403.3 8487.9 8498.9 8501.4 2284.0 2288.5 2313.6 2314.5 2324.8 2262.1 2286.8 2318.0 2345.1 2358.7 2276.9 2289.9 2293.3 2313.5 2349.7 2219.3 2269.0 2279.8 2285.7 2286.5 2217.4 2236.4 2240.8 2254.9 2260.2 8362.6 8408.3 8480.3 8494.8 8504.5 4872.7 4994.8 5000.5 5033.6 5033.7 3101.0 3105.9 3203.9 3204.6 3205.4 1056.3 1063.5 1079.1 1089.7 1095.3 11323.6 11327.8 11340.5 11362.3 11424.4 4475.4 4532.9 4616.8 4631.5 4643.7 9680.2 9713.4 9762.4 9778.6 9796.2 5151.8 5155.1 5163.9 5164.3 5179.0 4219.8 4531.8 4635.1 4659.9 4759.4 3860.8 3900.3 3970.7 3994.0 4008.1 1227.7 1290.9 1293.7 1304.2 1306.7 953.4 961.5 962.9 963.6 978.5 5590.7 5732.3 5839.5 5839.8 5867.9 978.3 985.1 985.9 1076.2 1076.5 4016.9 4057.2 4058.6 4072.9 4092.5 9323.9 9492.8 9638.7 9670.0 9692.0 9622.4 9622.8 9647.7 9658.9 9659.6 7275.5 7561.5 7901.0 8033.2 8036.6 5852.6 5926.1 5989.1 6077.1 6084.8 9555.3 9649.4 9779.9 9795.7 9820.4 9717.6 9830.9 10085.6 10124.8 10164.2 6876.5 7127.4 7233.2 7444.7 7620.5 7684.0 7932.5 7966.6 7972.2 7993.8 7078.5 7276.5 7339.2 7383.6 7450.6 6872.9 7093.8 7272.0 7302.2 7357.3 6835.5 6874.2 6884.4 6885.8 6951.6 4531.9 4772.0 4873.9 4885.6 4971.0 5043.4 5049.4 5049.6 5063.8 5202.2 19:27:11 INFO - PROCESS | 3450 | 19:27:11 INFO - PROCESS | 3450 | [#4] prototype.html Cycles:180 Average:4935.26 Median:5688.62 stddev:1460.40 (25.7%) stddev-sans-first:1423.04 19:27:11 INFO - PROCESS | 3450 | Values: 332.2 333.9 335.6 337.6 341.7 5616.3 5672.7 5675.7 5727.4 5769.6 5607.5 5620.8 5624.4 5633.1 5662.0 4175.3 4211.5 4328.3 4344.4 4377.5 4304.0 4304.5 4340.0 4343.3 4371.8 4302.7 4306.8 4322.3 4336.0 4338.9 4234.7 4241.8 4313.8 4320.6 4345.6 3769.3 3769.5 3775.4 3782.3 3793.8 5381.7 5395.7 5410.7 5420.9 5474.3 4843.3 4956.6 4961.2 4979.0 4981.1 5760.8 5817.7 5817.7 5850.9 5863.9 4159.7 4175.6 4193.9 4210.9 4218.9 5820.3 6078.1 6085.6 6098.2 6108.3 4307.4 4312.6 4318.6 4335.4 4349.7 4324.7 4365.9 4376.4 4391.9 4413.7 4781.3 4929.0 4929.3 4932.5 4940.2 5837.3 5847.7 5890.3 5909.8 5958.5 1491.6 1500.5 1504.8 1509.7 1511.1 957.5 978.1 993.3 998.8 1002.6 5655.7 5668.4 5682.2 5732.8 5738.9 6006.8 6032.3 6045.6 6051.3 6055.5 5367.3 5593.4 5665.4 5695.0 5721.7 3179.0 3187.3 3192.2 3232.0 3256.0 5893.3 6195.4 6210.0 6228.4 6276.5 6140.3 6164.4 6168.3 6173.8 6190.3 5915.9 6230.6 6233.2 6248.8 6277.7 5958.3 5967.7 5968.8 5974.7 6044.2 5923.3 5946.1 5946.7 5994.5 6057.0 5965.8 6138.0 6171.2 6182.0 6239.8 4170.2 4184.3 4186.4 4198.1 4202.2 5812.8 5940.0 6037.8 6062.7 6086.3 5881.4 5888.6 5918.6 5950.3 5979.3 5625.3 5828.3 5855.9 5871.9 5934.2 5730.8 5771.6 5782.7 5800.7 5837.9 5882.3 5886.0 5963.9 5977.4 6015.0 5712.7 5779.0 5789.6 5850.8 5859.6 19:27:11 INFO - PROCESS | 3450 | 19:27:11 INFO - PROCESS | 3450 | [#5] yui.html Cycles:180 Average:19479.03 Median:4718.44 stddev:28082.17 (595.2%) stddev-sans-first:28125.68 19:27:11 INFO - PROCESS | 3450 | Values: 735.5 756.7 756.9 762.9 783.7 14395.8 15678.2 15692.6 15698.5 15735.2 14304.1 14500.4 14553.6 14558.6 14563.1 758.6 782.2 784.1 787.5 790.2 765.1 770.6 774.3 780.5 781.6 828.7 831.7 832.4 833.1 836.0 826.1 826.1 828.5 828.6 828.9 599.6 601.1 601.3 601.6 601.9 14499.8 14544.8 14563.9 14595.5 14643.6 12564.4 12752.5 13560.0 14248.0 14399.4 11153.9 11280.5 11422.7 11514.8 11654.9 3751.7 3758.4 3817.8 3832.7 3905.7 50743.2 56102.4 65089.7 69085.0 69696.0 10745.8 10759.5 10829.5 10988.0 11020.7 20743.7 20768.7 21060.9 21121.7 21218.0 7692.4 8433.7 8548.0 8767.6 8927.5 4355.7 4637.7 4708.0 4728.9 4761.6 3366.9 3482.4 3492.8 3512.2 3521.7 587.6 594.2 597.9 599.5 616.0 530.8 553.3 576.1 588.1 597.8 8188.2 8289.8 8305.0 8452.4 8721.2 468.6 494.0 524.2 559.1 590.7 3982.7 4082.9 4171.6 4209.0 4349.1 70035.0 70809.6 86066.0 122960.4 123230.0 96588.5 99121.5 99377.0 105759.5 107024.9 53778.5 73798.6 86525.6 88790.1 89263.0 9089.9 9609.3 9655.3 9709.9 9740.2 50978.0 51314.7 52689.0 53117.5 54564.5 69573.3 79478.2 79764.2 80723.0 82685.6 11047.0 11326.3 11525.7 11558.4 11893.0 13102.4 13577.9 13749.8 14041.7 14145.0 12010.2 12774.8 12822.2 12902.6 13058.3 12477.2 12645.2 13000.7 13052.6 13154.7 11766.7 11913.3 12321.3 12330.8 12563.6 9996.2 10010.2 10148.6 10202.3 10398.3 9975.0 10161.8 10240.5 10661.9 10687.7 19:27:11 INFO - PROCESS | 3450 | -------- Summary: end -------- 19:27:11 INFO - PROCESS | 3450 | 19:27:11 INFO - TEST-INFO | 3450: exit 0 19:27:11 INFO - TEST-OK | dromaeo_css | took 1113700ms 19:27:11 INFO - TEST-START | kraken 19:27:11 INFO - operating with platform_type : linux_ 19:27:11 INFO - Initialising browser for kraken test... 19:27:11 INFO - TEST-INFO | started process 3690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD7zKE8/profile http://localhost:42260/getInfo.html) 19:27:16 INFO - PROCESS | 3690 | __metrics Screen width/height:1600/1200 19:27:16 INFO - PROCESS | 3690 | colorDepth:24 19:27:16 INFO - PROCESS | 3690 | Browser inner width/height: 1024/697 19:27:16 INFO - PROCESS | 3690 | __metrics 19:27:17 ERROR - PROCESS | 3690 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 19:27:17 INFO - TEST-INFO | 3690: exit 0 19:27:17 INFO - Browser initialized. 19:27:17 INFO - Running cycle 1/1 for kraken test... 19:27:17 INFO - TEST-INFO | started process 3809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD7zKE8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:27:29 INFO - PROCESS | 3809 | RSS: Main: 184868864 19:27:29 INFO - PROCESS | 3809 | 19:27:32 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:42260/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42260/tests/kraken/driver.html?testName=audio-beat-detection) 19:27:33 INFO - PROCESS | 3809 | RSS: Main: 190791680 19:27:33 INFO - PROCESS | 3809 | 19:27:36 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:42260/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42260/tests/kraken/driver.html?testName=audio-dft) 19:27:36 INFO - PROCESS | 3809 | RSS: Main: 189558784 19:27:36 INFO - PROCESS | 3809 | 19:27:39 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:42260/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42260/tests/kraken/driver.html?testName=audio-fft) 19:27:40 INFO - PROCESS | 3809 | RSS: Main: 184631296 19:27:40 INFO - PROCESS | 3809 | 19:27:42 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:42260/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42260/tests/kraken/driver.html?testName=audio-oscillator) 19:27:43 INFO - PROCESS | 3809 | RSS: Main: 185540608 19:27:43 INFO - PROCESS | 3809 | 19:27:45 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:42260/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42260/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:27:45 INFO - PROCESS | 3809 | RSS: Main: 186208256 19:27:45 INFO - PROCESS | 3809 | 19:27:49 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:42260/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42260/tests/kraken/driver.html?testName=imaging-darkroom) 19:27:49 INFO - PROCESS | 3809 | RSS: Main: 186253312 19:27:49 INFO - PROCESS | 3809 | 19:27:53 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:42260/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42260/tests/kraken/driver.html?testName=imaging-desaturate) 19:27:53 INFO - PROCESS | 3809 | RSS: Main: 183132160 19:27:53 INFO - PROCESS | 3809 | 19:27:56 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:42260/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42260/tests/kraken/driver.html?testName=json-parse-financial) 19:27:57 INFO - PROCESS | 3809 | RSS: Main: 184700928 19:27:57 INFO - PROCESS | 3809 | 19:27:58 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:42260/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42260/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:27:59 INFO - PROCESS | 3809 | RSS: Main: 184946688 19:27:59 INFO - PROCESS | 3809 | 19:28:01 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:42260/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42260/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:28:01 INFO - PROCESS | 3809 | RSS: Main: 185262080 19:28:01 INFO - PROCESS | 3809 | 19:28:04 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:42260/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42260/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:28:04 INFO - PROCESS | 3809 | RSS: Main: 185987072 19:28:04 INFO - PROCESS | 3809 | 19:28:07 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:42260/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42260/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:28:07 INFO - PROCESS | 3809 | RSS: Main: 185651200 19:28:07 INFO - PROCESS | 3809 | 19:28:10 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:42260/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42260/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:28:11 INFO - PROCESS | 3809 | RSS: Main: 185696256 19:28:11 INFO - PROCESS | 3809 | 19:28:12 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:42260/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42260/tests/kraken/driver.html?testName=ai-astar) 19:28:13 INFO - PROCESS | 3809 | RSS: Main: 186470400 19:28:13 INFO - PROCESS | 3809 | 19:28:13 INFO - PROCESS | 3809 | __start_tp_report 19:28:13 INFO - PROCESS | 3809 | _x_x_mozilla_page_load 19:28:13 INFO - PROCESS | 3809 | _x_x_mozilla_page_load_details 19:28:13 INFO - PROCESS | 3809 | |i|pagename|runs| 19:28:13 INFO - PROCESS | 3809 | |0;ai-astar;104;112;104;112;114;112;112;109;110;111 19:28:13 INFO - PROCESS | 3809 | |1;audio-beat-detection;153;125;161;187;124;158;160;132;182;133 19:28:13 INFO - PROCESS | 3809 | |2;audio-dft;163;161;164;163;165;171;165;164;161;162 19:28:13 INFO - PROCESS | 3809 | |3;audio-fft;76;75;75;170;76;74;75;74;166;76 19:28:13 INFO - PROCESS | 3809 | |4;audio-oscillator;84;87;144;86;85;84;142;85;86;144 19:28:13 INFO - PROCESS | 3809 | |5;imaging-gaussian-blur;118;118;118;118;118;118;119;117;117;119 19:28:13 INFO - PROCESS | 3809 | |6;imaging-darkroom;148;151;147;147;151;150;146;147;148;146 19:28:13 INFO - PROCESS | 3809 | |7;imaging-desaturate;96;95;95;95;96;95;96;95;95;95 19:28:13 INFO - PROCESS | 3809 | |8;json-parse-financial;56;60;58;56;56;58;58;56;57;56 19:28:13 INFO - PROCESS | 3809 | |9;json-stringify-tinderbox;62;60;61;61;61;60;61;61;61;61 19:28:13 INFO - PROCESS | 3809 | |10;stanford-crypto-aes;87;79;80;79;81;86;83;80;97;80 19:28:13 INFO - PROCESS | 3809 | |11;stanford-crypto-ccm;124;135;128;121;126;128;122;136;141;125 19:28:13 INFO - PROCESS | 3809 | |12;stanford-crypto-pbkdf2;156;158;162;165;157;166;159;160;164;164 19:28:13 INFO - PROCESS | 3809 | |13;stanford-crypto-sha256-iterative;64;64;63;63;64;61;63;64;62;62 19:28:13 INFO - PROCESS | 3809 | __end_tp_report 19:28:13 INFO - PROCESS | 3809 | __start_cc_report 19:28:13 INFO - PROCESS | 3809 | _x_x_mozilla_cycle_collect,880 19:28:13 INFO - PROCESS | 3809 | __end_cc_report 19:28:13 INFO - PROCESS | 3809 | __startTimestamp1466908093186__endTimestamp 19:28:13 INFO - PROCESS | 3809 | 19:28:13 INFO - PROCESS | 3809 | ------- Summary: start ------- 19:28:13 INFO - PROCESS | 3809 | Number of tests: 14 19:28:13 INFO - PROCESS | 3809 | 19:28:13 INFO - PROCESS | 3809 | [#0] ai-astar Cycles:10 Average:110.00 Median:112.00 stddev:3.43 (3.1%) stddev-sans-first:2.87 19:28:13 INFO - PROCESS | 3809 | Values: 104.0 112.0 104.0 112.0 114.0 112.0 112.0 109.0 110.0 111.0 19:28:13 INFO - PROCESS | 3809 | 19:28:13 INFO - PROCESS | 3809 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:159.00 stddev:22.55 (14.2%) stddev-sans-first:23.92 19:28:13 INFO - PROCESS | 3809 | Values: 153.0 125.0 161.0 187.0 124.0 158.0 160.0 132.0 182.0 133.0 19:28:13 INFO - PROCESS | 3809 | 19:28:13 INFO - PROCESS | 3809 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:2.88 (1.8%) stddev-sans-first:3.04 19:28:13 INFO - PROCESS | 3809 | Values: 163.0 161.0 164.0 163.0 165.0 171.0 165.0 164.0 161.0 162.0 19:28:13 INFO - PROCESS | 3809 | 19:28:13 INFO - PROCESS | 3809 | [#3] audio-fft Cycles:10 Average:93.70 Median:75.00 stddev:39.18 (52.2%) stddev-sans-first:41.03 19:28:13 INFO - PROCESS | 3809 | Values: 76.0 75.0 75.0 170.0 76.0 74.0 75.0 74.0 166.0 76.0 19:28:13 INFO - PROCESS | 3809 | 19:28:13 INFO - PROCESS | 3809 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:85.00 stddev:28.06 (33.0%) stddev-sans-first:28.93 19:28:13 INFO - PROCESS | 3809 | Values: 84.0 87.0 144.0 86.0 85.0 84.0 142.0 85.0 86.0 144.0 19:28:13 INFO - PROCESS | 3809 | 19:28:13 INFO - PROCESS | 3809 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 19:28:13 INFO - PROCESS | 3809 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 119.0 117.0 117.0 119.0 19:28:13 INFO - PROCESS | 3809 | 19:28:13 INFO - PROCESS | 3809 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.91 (1.3%) stddev-sans-first:2.03 19:28:13 INFO - PROCESS | 3809 | Values: 148.0 151.0 147.0 147.0 151.0 150.0 146.0 147.0 148.0 146.0 19:28:13 INFO - PROCESS | 3809 | 19:28:13 INFO - PROCESS | 3809 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 19:28:13 INFO - PROCESS | 3809 | Values: 96.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 19:28:13 INFO - PROCESS | 3809 | 19:28:13 INFO - PROCESS | 3809 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.50 stddev:1.37 (2.4%) stddev-sans-first:1.39 19:28:13 INFO - PROCESS | 3809 | Values: 56.0 60.0 58.0 56.0 56.0 58.0 58.0 56.0 57.0 56.0 19:28:13 INFO - PROCESS | 3809 | 19:28:13 INFO - PROCESS | 3809 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 19:28:13 INFO - PROCESS | 3809 | Values: 62.0 60.0 61.0 61.0 61.0 60.0 61.0 61.0 61.0 61.0 19:28:13 INFO - PROCESS | 3809 | 19:28:13 INFO - PROCESS | 3809 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:82.00 stddev:5.61 (6.8%) stddev-sans-first:5.78 19:28:13 INFO - PROCESS | 3809 | Values: 87.0 79.0 80.0 79.0 81.0 86.0 83.0 80.0 97.0 80.0 19:28:13 INFO - PROCESS | 3809 | 19:28:13 INFO - PROCESS | 3809 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:128.00 stddev:6.60 (5.2%) stddev-sans-first:6.79 19:28:13 INFO - PROCESS | 3809 | Values: 124.0 135.0 128.0 121.0 126.0 128.0 122.0 136.0 141.0 125.0 19:28:13 INFO - PROCESS | 3809 | 19:28:13 INFO - PROCESS | 3809 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:163.00 stddev:3.57 (2.2%) stddev-sans-first:3.28 19:28:13 INFO - PROCESS | 3809 | Values: 156.0 158.0 162.0 165.0 157.0 166.0 159.0 160.0 164.0 164.0 19:28:13 INFO - PROCESS | 3809 | 19:28:13 INFO - PROCESS | 3809 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.50 stddev:1.05 (1.7%) stddev-sans-first:1.05 19:28:13 INFO - PROCESS | 3809 | Values: 64.0 64.0 63.0 63.0 64.0 61.0 63.0 64.0 62.0 62.0 19:28:13 INFO - PROCESS | 3809 | -------- Summary: end -------- 19:28:13 INFO - PROCESS | 3809 | 19:28:14 INFO - TEST-INFO | 3809: exit 0 19:28:14 INFO - TEST-OK | kraken | took 62361ms 19:28:14 INFO - SUITE-END | took 1176s 19:28:14 INFO - Completed test suite (00:19:36) 19:28:14 INFO - javascript benchmark 19:28:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7126.973049205781, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3140.0, 3179.4912813949745, 3201.2797120647856, 3215.726663233625, 3224.290656055667, 5441.211024401459, 5510.972445137773, 5517.69652669103, 5536.224928510007, 5601.523870471015, 5344.812931547397, 5417.539509141718, 5471.753771080301, 5511.22842802008, 5572.331320241577, 4925.1627223372025, 4971.950280497203, 5068.037072956145, 5130.846074617749, 5163.096458119833, 783.3567385479577, 5046.167382381903, 5101.336826212587, 5124.359455068116, 5151.81968631098, 4985.102681517325, 5016.673916195454, 5023.723695196781, 5030.622703297267, 5073.1122053640465, 4935.876603084916, 5012.473690262506, 5017.247412888059, 5043.924341134886, 5061.772220250097, 4909.950900491021, 4962.0324036812835, 4970.850874473772, 4976.975115124437, 5023.246513023076, 5454.890902181974, 5467.808626698046, 5481.451854814487, 5484.643498172646, 5487.368952570466, 5753.7123143843055, 5840.4451577100535, 5862.97068514659, 5937.079752638348, 6033.818985430444, 6017.819465416044, 6040.12418199363, 6059.606125601866, 6073.3622969588, 6086.452219300284, 5609.439056094398, 5656.4060773618585, 5667.0, 5669.631473954221, 5674.914876276859, 5887.264091988502, 6064.787732429344, 6114.694265286718, 6119.908201376983, 6148.938510614837, 5903.114532820111, 5907.172995780594, 5910.940890591039, 5913.704314784243, 5931.614445061057, 5922.230110085661, 5937.7921772737745, 5938.940610593839, 5969.074793407029, 5990.161377407167, 5712.914306285409, 5870.853228669232, 5904.143899134601, 5925.170476133345, 5967.16459695643, 5733.827985160452, 5796.971015144897, 5824.242848429677, 5838.824835254949, 5968.671723055274, 4433.312836510346, 4437.711548749321, 4463.129689710475, 4471.128130014616, 4506.977465112654, 3924.2740093082302, 3963.583823698528, 3986.920261594752, 3997.6801855851463, 4025.255327764373, 5652.491275785117, 5739.253896993448, 5743.3395159557185, 5753.626014309057, 5784.652920824764, 6007.519398448114, 6029.125776762345, 6038.305594856648, 6044.576879618472, 6058.12157237207, 5470.64440811346, 5594.160875868571, 5641.661500309994, 5683.573731970118, 5743.62666426681, 4963.043814137493, 4989.301497790312, 5015.473375295542, 5023.19628859388, 5025.170846810309, 6211.192544969215, 6240.344763799826, 6256.405641464054, 6257.155284036688, 6267.467265282411, 5749.597528172988, 5938.376470470538, 5979.4618484336615, 5998.400159983967, 6031.849203769765, 6155.6614386209185, 6176.66028368444, 6188.2883468399905, 6216.222972128484, 6217.222847144107, 5685.0, 5869.0, 5925.081612350093, 5925.674087925206, 5940.79207227745, 5889.440503152194, 5926.644401335933, 5941.197938278277, 6021.42796434338, 6035.336113027652, 5792.160136780228, 5837.854053648693, 5879.382664820132, 5883.94116058834, 5885.264341957255, 5586.441355864381, 5674.716264186856, 5715.085586306171, 5738.512226460798, 5754.309482862083, 5534.640248383842, 5573.7213139343685, 5587.525060369914, 5719.0277652798295, 5770.855728606818, 5715.057015592547, 5719.942800572107, 5755.913661295168, 5771.740271687868, 5790.363060063305, 5513.862153446035, 5551.8889622206525, 5655.066913959316, 5656.37779844225, 5685.545156387397], "value": 5428.968935552738, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.681606708277, 617.4288782875841, 617.9938200617993, 622.2222222222222, 642.1299139665751, 39959.60040399595, 42193.52322668707, 42292.0, 42326.78836605813, 45305.54694453054, 43745.0, 44173.77913110438, 44250.33624495635, 44341.7782911085, 44546.777266113706, 8955.104489551042, 8978.955105224464, 9038.412503187305, 9063.320250981169, 9079.546022698873, 8850.955745221265, 8928.24109950655, 8942.508162051085, 8944.686935957243, 8981.101889811, 9026.413283136575, 9039.096090390942, 9070.138336857988, 9087.95456022719, 9090.13643703847, 9042.502662353569, 9044.09559044097, 9058.320625953047, 9059.59231834569, 9114.772130696752, 8877.689280875204, 8975.0, 8991.505467199302, 8995.055519170524, 8997.640094396216, 41201.381979270336, 41684.58315416868, 41720.79139604313, 41761.58238417607, 42002.369964450554, 3227.160938156073, 3246.594175728034, 3350.8994730158133, 3625.528681271418, 3845.61543845616, 31744.682553174403, 32221.838890805397, 32405.189870253198, 32671.509927351108, 33492.832535837406, 4301.526832048472, 4353.73877567347, 4418.094290670405, 4475.910481790378, 4483.237849565582, 342927.0, 343670.0, 343969.0, 344243.0, 345243.0, 33155.83422082874, 58003.41996580065, 58330.4166958325, 58330.70834645884, 58418.70790646019, 34156.82921585376, 35681.0, 35728.28543429169, 35760.0, 36074.63925360713, 14238.43046278158, 14402.20787856678, 14418.783718244234, 14618.122912625277, 14624.122552646875, 12338.568150114703, 12382.81425778614, 12399.566015189424, 12431.37843107841, 12537.686557836127, 8282.25459708617, 8313.501189928624, 8347.833043339098, 8348.707795227137, 8389.699596562543, 3123.1723593247807, 3137.105924811418, 3194.440972829792, 3205.9198520037185, 3221.4201443739885, 1013.9442330671736, 1026.609888242463, 1041.8124737547314, 1072.973175670599, 1115.5934060461211, 31222.0, 31428.52857207144, 31444.21389465236, 31767.52348714771, 32175.35649287048, 1101.8126918423886, 1169.2107827216594, 1174.9530018799323, 1186.2882270637722, 1222.786012447836, 16615.584610384594, 16683.916580417263, 16884.493465196065, 16914.577135571464, 16990.915045424696, 581789.0, 583930.0, 586955.0, 587348.0, 594890.0, 53938.730306349, 54953.45046549563, 54954.0, 55029.72485137549, 55098.72450637721, 1233.993830030844, 1312.173330801589, 1344.2808097667896, 1352.8714772096635, 1355.3155656393656, 28988.7101128986, 30055.549166762077, 30385.544216836322, 30541.0, 30744.84627576848, 49194.0, 49562.0, 49844.50155498399, 49894.75052624714, 49913.75043124761, 448529.0, 452048.0, 455461.0, 456803.0, 459202.0, 27338.0, 27659.308517287227, 27980.580291296053, 28030.579541307303, 28197.15408537747, 47052.29421558748, 47145.76427117842, 47156.292655609504, 47418.0, 48270.0, 40530.0, 40682.9829254271, 41112.58887411088, 41251.793741031106, 41617.79191104025, 39260.411093834184, 40071.799641001606, 40538.59461405466, 40956.38565421462, 41012.79493602632, 39344.60655393409, 39817.2036559273, 40567.3914891271, 40602.0, 40686.593134069466, 35604.287914242086, 36090.55637774565, 36262.0, 36623.26753464969, 36936.63063369332, 27370.726292736817, 27550.5867411993, 27641.0, 27661.30846728848, 27715.584266236427], "value": 18793.65720739282, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.6289436352373, 389.47529296923165, 389.7427697719506, 391.8119302734687, 411.444549857692, 14074.507392241274, 17593.120343982813, 17643.735343969835, 19160.71258931117, 19305.806941930576, 14498.275086245698, 17841.197146128423, 18185.09074546271, 18590.628187436276, 18866.151023203955, 5567.526760225375, 5887.116932460122, 5926.88146237075, 5935.9703201483935, 5953.58324917256, 5788.768449262025, 5812.534997200235, 5823.5341172706085, 5878.617889837168, 5898.557608179382, 5659.971700141494, 5765.740541675614, 5775.913361299584, 5804.535637149039, 5860.912086318687, 5700.543956483471, 5741.913871291913, 5760.6255593386295, 5769.884602307972, 5770.163326317703, 5195.3246078009615, 5201.45384734605, 5214.113600687854, 5215.400228973679, 5219.739013049332, 21496.462588435257, 22110.0, 23151.536969260687, 23162.420939476648, 23324.3002709919, 2222.2555443926303, 2351.2240960483, 2370.8103351731993, 2442.511497700449, 2764.8802235094818, 7251.673674684652, 7252.2385149559595, 13383.86616133836, 14302.785458218135, 14403.351849166813, 1670.9081000544966, 1821.9635607287912, 1849.2972670385302, 1853.6756067688236, 1860.748798912143, 53442.73278633621, 68211.0, 76160.23839761587, 77496.61251693762, 79363.60318198372, 10616.30993985404, 10802.621908233174, 10921.836172457419, 11231.66305010851, 11304.434778261219, 15157.469488568067, 15197.62005949838, 15204.239788010555, 15268.923655381652, 15277.618059548378, 7356.117265928123, 7759.456838021397, 7826.726064587712, 7865.174156713577, 8238.711645092393, 7768.0, 7789.0, 7850.214978502104, 7963.4027447941635, 7977.60111994398, 4576.81692732287, 4633.142868569325, 4641.141388843075, 4686.507916668769, 4693.0, 1928.623918335911, 1980.5939782344585, 1981.6631172700675, 1983.3851506032888, 1994.4515258304082, 940.2149205413556, 940.8965013848472, 942.6323733743845, 966.9323147379616, 975.8536219567121, 18319.267229310677, 18912.0, 18943.0, 18969.43091707251, 19298.53286297634, 927.2280056647317, 939.68050862707, 955.254901177083, 984.5126662302206, 1013.4291847636134, 10426.426546540013, 10643.201759868041, 10706.518206680717, 10737.087347575387, 10822.78354432907, 353549.0, 480696.0, 485315.0, 489377.0, 491533.0, 87777.0, 88150.0, 88841.0, 89617.0, 90012.5499372512, 987.0, 987.3532835992437, 993.4635296939716, 996.5366104761321, 998.1066945084254, 15163.924180379028, 16567.17164141764, 16789.0, 17233.913830430767, 17458.0, 36499.63500364962, 38818.2236355277, 39102.80448597739, 39694.404583930685, 40569.0, 58411.415885842296, 60087.0, 61916.69041654763, 62694.0, 64004.0, 7524.2851929066655, 7746.49647772893, 8401.53791541471, 8565.871511927202, 8642.827143457222, 13551.254680992246, 13608.863911361155, 13627.250501222528, 13697.520586779416, 13987.650308742363, 11337.319760814378, 11382.886171138183, 11391.544338226378, 11745.17783755129, 11829.290242585472, 11358.920902514248, 11502.137339699724, 11555.653330400102, 11730.472128754398, 12383.19509231897, 12031.398430078636, 12239.75520489603, 12402.503899843905, 12410.937945310216, 12411.069169812119, 7660.463767536219, 7713.922860771545, 7720.382369410321, 7813.765587032398, 7831.138574756887, 11041.0, 11080.944595277295, 11664.825027624762, 11711.648650540497, 11822.34977076269], "value": 9043.789420846393, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.6277736399857, 1429.9428022879083, 1542.4293011585708, 1675.463851567499, 1700.4983529858691, 7529.585872776995, 7993.400494962872, 7993.600319984, 8631.093735157812, 8638.395312328132, 8163.551004694739, 8403.285720713731, 8487.91512084879, 8498.915010849905, 8501.362397820158, 2283.954320913585, 2288.519410923708, 2313.595120853852, 2314.5255222679393, 2324.8023917966993, 2262.1177740681146, 2286.8056215221727, 2317.953640927189, 2345.1440224318085, 2358.681577986967, 2276.886155692217, 2289.8740569268684, 2293.2546922250253, 2313.4794671199015, 2349.706286714161, 2219.2676416782424, 2268.9886550567226, 2279.7948184663296, 2285.6685780561725, 2286.4512516995883, 2217.4456385903522, 2236.3514580771557, 2240.843140980132, 2254.9210777622707, 2260.152442833937, 8362.58187090643, 8408.327333813342, 8480.321574274105, 8494.78763030923, 8504.532250726208, 4872.65891387603, 4994.750262486861, 5000.499950005007, 5033.597312215051, 5033.697978121288, 3100.98449507751, 3105.9223519412194, 3203.9199020024453, 3204.5513628092085, 3205.4069997050387, 1056.260617567698, 1063.5320458998017, 1079.1097344690584, 1089.7330154112215, 1095.2552264460164, 11323.603673871376, 11327.830082548768, 11340.489677964511, 11362.318260904372, 11424.371659558721, 4475.440569928759, 4532.9320060199125, 4616.838410655678, 4631.536846315342, 4643.698159619614, 9680.177184939219, 9713.36863103896, 9762.365446246113, 9778.559964801601, 9796.167325777245, 5151.845444636667, 5155.123628983082, 5163.870903227449, 5164.302819119446, 5179.0, 4219.767912764766, 4531.753767713905, 4635.072985402933, 4659.883502912454, 4759.405074365704, 3860.8069596520622, 3900.278448486982, 3970.7419017763755, 3994.0414300568236, 4008.07814202735, 1227.6501197158766, 1290.9349786426235, 1293.6507143071506, 1304.1523010043547, 1306.73865226955, 953.3517208298424, 961.5240455974338, 962.9311464274649, 963.6145541783343, 978.4569563891966, 5590.664560126405, 5732.312122545238, 5839.532837373, 5839.824805255849, 5867.941320586825, 978.2760757039739, 985.1330828870691, 985.9112679858847, 1076.208986394999, 1076.4671487613682, 4016.859409920639, 4057.229126465962, 4058.5738497457933, 4072.8778136655947, 4092.4884389451317, 9323.860142097874, 9492.810143797224, 9638.710838674851, 9669.951650241705, 9692.0, 9622.422654640744, 9622.759431014281, 9647.662331818352, 9658.855117173249, 9659.565319560637, 7275.527090739085, 7561.470697051153, 7901.0, 8033.156518565584, 8036.557989310527, 5852.561057920588, 5926.140709597171, 5989.101634754822, 6077.085717998816, 6084.787032453843, 9555.283353748635, 9649.421034737938, 9779.902200977898, 9795.706128816148, 9820.4107753535, 9717.56270967794, 9830.852537212091, 10085.647002354883, 10124.848127278245, 10164.18686505063, 6876.484263680344, 7127.358537731629, 7233.168185658506, 7444.73943411978, 7620.466567340454, 7684.0, 7932.4843885149585, 7966.641501132347, 7972.242636949481, 7993.800154996172, 7078.539894906815, 7276.527025743309, 7339.229380915141, 7383.630818459163, 7450.627468626439, 6872.862542749217, 7093.751718689821, 7272.0, 7302.233265507258, 7357.337839594462, 6835.453163746789, 6874.175098988154, 6884.449244060564, 6885.827854303682, 6951.617661028692, 4531.886702832456, 4771.95228047729, 4873.926891096708, 4885.560299573055, 4970.975145124251, 5043.44522102561, 5049.394072711151, 5049.570786483043, 5063.797448102035, 5202.167653175474], "value": 4480.9813470990875, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.161292735842, 333.889816360601, 335.6123677152888, 337.6353538178767, 341.69418370558367, 5616.32604087509, 5672.659640421578, 5675.744591493382, 5727.367700205442, 5769.596128271022, 5607.467290607386, 5620.775168993246, 5624.437556244374, 5633.126865335869, 5661.971690141554, 4175.290200665887, 4211.515675697288, 4328.264195086827, 4344.435223420966, 4377.518472967971, 4303.956960430402, 4304.504981927087, 4339.956600433987, 4343.283358245885, 4371.803268852909, 4302.65578753699, 4306.806193721274, 4322.308430651096, 4335.981044454551, 4338.89358213655, 4234.703570750049, 4241.787910604473, 4313.805878735433, 4320.589543993316, 4345.565443455661, 3769.2838360711653, 3769.453429252743, 3775.3954569308207, 3782.3380908341205, 3793.7534060285993, 5381.730913454312, 5395.678058875601, 5410.675359478444, 5420.91868621971, 5474.2609747683955, 4843.346148269974, 4956.628252881048, 4961.156603377434, 4978.950210497885, 4981.103401387749, 5760.7695692172265, 5817.650940943557, 5817.680027598481, 5850.912236316459, 5863.856547973147, 4159.708820382574, 4175.642916052265, 4193.91612167758, 4210.85262015828, 4218.8523401681105, 5820.272465941757, 6078.115784106897, 6085.604435711664, 6098.176746139303, 6108.267007959029, 4307.418498502725, 4312.611864932172, 4318.632916202158, 4335.371371151228, 4349.695521313478, 4324.67564932625, 4365.869023929287, 4376.387305777193, 4391.934120988188, 4413.668974826836, 4781.330613714083, 4929.0, 4929.309896614477, 4932.53140951609, 4940.2342636891335, 5837.270341207349, 5847.707614619252, 5890.322612899486, 5909.763609455574, 5958.463738263577, 1491.5599898030107, 1500.4748338081583, 1504.7667611520233, 1509.690513444741, 1511.1235483419591, 957.5451660461225, 978.0878382761683, 993.2997236947934, 998.7752755629925, 1002.6390499420203, 5655.737704917983, 5668.404817494186, 5682.232898558725, 5732.828015159552, 5738.856528586819, 6006.849828754229, 6032.276126864716, 6045.63726176422, 6051.273847138372, 6055.485283750931, 5367.302250707383, 5593.440655934455, 5665.405132461115, 5695.0, 5721.685307308138, 3178.9986154361304, 3187.2509960159346, 3192.1859925718795, 3231.9676803232137, 3255.9674403255663, 5893.263342082239, 6195.411435913581, 6209.96895015522, 6228.377162283826, 6276.497880169575, 6140.293866205354, 6164.445199932027, 6168.290646575611, 6173.783917562953, 6190.288116866618, 5915.911261331084, 6230.563860529719, 6233.158523599256, 6248.843778905472, 6277.654728989858, 5958.255218097738, 5967.671778052249, 5968.791092311748, 5974.671393073423, 6044.184035155374, 5923.348431672426, 5946.137810017437, 5946.732397042057, 5994.490468310068, 6057.0, 5965.821025369246, 6137.96931015342, 6171.197744293213, 6182.0, 6239.75040998355, 4170.186813571325, 4184.309588917795, 4186.35111557709, 4198.097409057067, 4202.180574788009, 5812.796552120824, 5940.0, 6037.762258737036, 6062.696865156637, 6086.269647642312, 5881.38245484218, 5888.646681199141, 5918.6091268551, 5950.34546199909, 5979.312379076462, 5625.268715067015, 5828.300603927556, 5855.853603659943, 5871.853203669943, 5934.19888315072, 5730.790757175995, 5771.624844385269, 5782.681952492653, 5800.709964501673, 5837.883242335045, 5882.294124705063, 5886.028805247086, 5963.940360596339, 5977.432143946318, 6015.037593984942, 5712.65724056558, 5778.971105144616, 5789.623674461147, 5850.795222167204, 5859.648421094748], "value": 4464.895804044904, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.5476382025053, 756.682193478739, 756.8940348351232, 762.8664983627865, 783.7021931665967, 14395.78406323906, 15678.216089195552, 15692.607684807885, 15698.450554230605, 15735.21323933803, 14304.070235434716, 14500.41998320066, 14553.563393098197, 14558.563243102697, 14563.126212427262, 758.6244808819628, 782.2373186143493, 784.1217836023661, 787.4605894961969, 790.2295262119445, 765.0627980723625, 770.6262462705612, 774.3031271855347, 780.4770803561628, 781.570136424964, 828.7430896422098, 831.733845169546, 832.367400775409, 833.071125694852, 835.9665613375457, 826.0912995704737, 826.1160558202725, 828.5360198288947, 828.5774255129897, 828.9088200297963, 599.6192417814719, 601.0863487499021, 601.2964831147568, 601.6149664214906, 601.8555546668812, 14499.782503262459, 14544.781828272584, 14563.854361456355, 14595.489157879423, 14643.56069317922, 12564.434600443003, 12752.489900403973, 13560.013736195317, 14248.0, 14399.424023039066, 11153.932668516141, 11280.492377843017, 11422.657320280405, 11514.769704605944, 11654.941725291319, 3751.681107105899, 3758.3798673219158, 3817.7709337439564, 3832.6742226910746, 3905.746126501797, 50743.238851417256, 56102.43897561013, 65089.67455162741, 69085.0, 69696.0, 10745.83881241782, 10759.515821788038, 10829.512671929782, 10988.0, 11020.669379918616, 20743.688844667344, 20768.68846967297, 21060.894695526425, 21121.68317475239, 21218.045187966578, 7692.384609231248, 8433.662653493915, 8548.0, 8767.561621919007, 8927.508987005776, 4355.716878402894, 4637.721736695809, 4707.976460117678, 4728.905421891543, 4761.595264402496, 3366.9326613468083, 3482.355764183634, 3492.7729697570085, 3512.2448673535314, 3521.683048525645, 587.5857520448074, 594.2186025376616, 597.8775347516299, 599.5173885022512, 615.9753609855555, 530.8036026670156, 553.3442870198747, 576.0696475192534, 588.0591054313151, 597.7788218359235, 8188.222118898695, 8289.83420331602, 8304.958475207706, 8452.408331416866, 8721.171488708562, 468.5618946285234, 494.019371547478, 524.2450870746113, 559.1445089013815, 590.6928397233414, 3982.661473774762, 4082.8775136745944, 4171.561985991427, 4208.957910420918, 4349.108432771274, 70035.0, 70809.64595176991, 86066.0, 122960.38519807343, 123230.0, 96588.51705741567, 99121.50439247758, 99377.0, 105759.4712026435, 107024.92975070306, 53778.46221537813, 73798.6310068457, 86525.56737216274, 88790.11209887947, 89263.0, 9089.863652045093, 9609.327347085637, 9655.275854311096, 9709.9029009709, 9740.220782337254, 50978.0, 51314.74342628263, 52689.0, 53117.4688253128, 54564.45435545753, 69573.30426695668, 79478.20521794708, 79764.20235797568, 80723.0, 82685.58657206917, 11047.0, 11326.263792853439, 11525.711857203636, 11558.364289964133, 11892.966299766358, 13102.410391532594, 13577.932110339385, 13749.793753093512, 14041.719165616834, 14145.0, 12010.219335743148, 12774.808377874153, 12822.166559173624, 12902.612921612366, 13058.281794501394, 12477.188982716094, 12645.24128552253, 13000.739985200433, 13052.608421747364, 13154.736905262032, 11766.705832353917, 11913.344766037952, 12321.260724356567, 12330.75338493243, 12563.623091307276, 9996.20030397581, 10010.203319811744, 10148.644797432054, 10202.28583999113, 10398.272120951764, 9975.0, 10161.84757228657, 10240.53917573696, 10661.946690266499, 10687.679369618923], "value": 7097.840995018711, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 104.0, 112.0, 114.0, 112.0, 112.0, 109.0, 110.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 125.0, 161.0, 187.0, 124.0, 158.0, 160.0, 132.0, 182.0, 133.0], "value": 151.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 164.0, 163.0, 165.0, 171.0, 165.0, 164.0, 161.0, 162.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 170.0, 76.0, 74.0, 75.0, 74.0, 166.0, 76.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 144.0, 86.0, 85.0, 84.0, 142.0, 85.0, 86.0, 144.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 117.0, 117.0, 119.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 151.0, 147.0, 147.0, 151.0, 150.0, 146.0, 147.0, 148.0, 146.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 60.0, 58.0, 56.0, 56.0, 58.0, 58.0, 56.0, 57.0, 56.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 79.0, 80.0, 79.0, 81.0, 86.0, 83.0, 80.0, 97.0, 80.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 135.0, 128.0, 121.0, 126.0, 128.0, 122.0, 136.0, 141.0, 125.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 158.0, 162.0, 165.0, 157.0, 166.0, 159.0, 160.0, 164.0, 164.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 64.0, 61.0, 63.0, 64.0, 62.0, 62.0], "value": 63.0, "unit": "score"}]}]} 19:28:14 INFO - Return code: 0 19:28:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:28:14 ERROR - # TBPL SUCCESS # 19:28:14 INFO - Running post-action listener: _resource_record_post_action 19:28:14 INFO - ##### 19:28:14 INFO - ##### Finished run-tests step (success) 19:28:14 INFO - ##### 19:28:14 INFO - Running post-run listener: _resource_record_post_run 19:28:14 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 7790592; Write bytes: 367009792; Read time: 1436; Write time: 222448 19:28:14 INFO - TinderboxPrint: CPU usage
13.4% 19:28:14 INFO - TinderboxPrint: I/O read bytes / time
7,790,592 / 1,436 19:28:14 INFO - TinderboxPrint: I/O write bytes / time
367,009,792 / 222,448 19:28:14 INFO - TinderboxPrint: CPU idle
8,249.0 (86.6%) 19:28:14 INFO - TinderboxPrint: CPU user
1,217.9 (12.8%) 19:28:14 INFO - TinderboxPrint: Swap in / out
0 / 0 19:28:14 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 76742656; Read time: 0; Write time: 50468 19:28:14 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 6029312; Write bytes: 290267136; Read time: 1380; Write time: 171980 19:28:15 INFO - Running post-run listener: _upload_blobber_files 19:28:15 INFO - Blob upload gear active. 19:28:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:28:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:28:15 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:28:15 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:28:15 INFO - (blobuploader) - INFO - Open directory for files ... 19:28:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:28:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:28:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:16 INFO - (blobuploader) - INFO - Done attempting. 19:28:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:28:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:28:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:19 INFO - (blobuploader) - INFO - Done attempting. 19:28:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:28:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:28:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:28:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:28:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:28:20 INFO - (blobuploader) - INFO - Done attempting. 19:28:20 INFO - (blobuploader) - INFO - Iteration through files over. 19:28:20 INFO - Return code: 0 19:28:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:28:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:28:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16f21b664095121faa402ecc67eced0340ad7437880708649ede677a7d43f905ba2f1769f11bfd003f3b1a3fb8f1e3f525ca5b1bd4a81c2d575137b1b1db6a44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/142dad24dff6d8ca784139fec7a8a98a23b19b1e6bfdf70da76cd5936e38ab53294a4ae9b10e9a8e5fe38c38c4996578a1ecb6e87b37d937beb1a0276c9ef1d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d8592fff37b094ffd13d533c77b962d4a49006dbde49798319f0c23e6045e332061cba073a39cc0b613d0699994e99c5f6233571cb7bef0f1c876fff7c48fe9"} 19:28:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:28:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:28:20 INFO - Contents: 19:28:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16f21b664095121faa402ecc67eced0340ad7437880708649ede677a7d43f905ba2f1769f11bfd003f3b1a3fb8f1e3f525ca5b1bd4a81c2d575137b1b1db6a44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/142dad24dff6d8ca784139fec7a8a98a23b19b1e6bfdf70da76cd5936e38ab53294a4ae9b10e9a8e5fe38c38c4996578a1ecb6e87b37d937beb1a0276c9ef1d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d8592fff37b094ffd13d533c77b962d4a49006dbde49798319f0c23e6045e332061cba073a39cc0b613d0699994e99c5f6233571cb7bef0f1c876fff7c48fe9"} 19:28:20 INFO - Running post-run listener: copy_logs_to_upload_dir 19:28:20 INFO - Copying logs to upload dir... 19:28:20 INFO - mkdir: /builds/slave/test/build/upload/logs 19:28:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.368307 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-06-25 19:28:20.394029) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-25 19:28:20.399024) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923 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/Firefox/sha512/16f21b664095121faa402ecc67eced0340ad7437880708649ede677a7d43f905ba2f1769f11bfd003f3b1a3fb8f1e3f525ca5b1bd4a81c2d575137b1b1db6a44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/142dad24dff6d8ca784139fec7a8a98a23b19b1e6bfdf70da76cd5936e38ab53294a4ae9b10e9a8e5fe38c38c4996578a1ecb6e87b37d937beb1a0276c9ef1d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d8592fff37b094ffd13d533c77b962d4a49006dbde49798319f0c23e6045e332061cba073a39cc0b613d0699994e99c5f6233571cb7bef0f1c876fff7c48fe9"} build_url:https://queue.taskcluster.net/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011225 build_url: 'https://queue.taskcluster.net/v1/task/JuhXrBWiSqGi8RLBt5BoDQ/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/Firefox/sha512/16f21b664095121faa402ecc67eced0340ad7437880708649ede677a7d43f905ba2f1769f11bfd003f3b1a3fb8f1e3f525ca5b1bd4a81c2d575137b1b1db6a44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/142dad24dff6d8ca784139fec7a8a98a23b19b1e6bfdf70da76cd5936e38ab53294a4ae9b10e9a8e5fe38c38c4996578a1ecb6e87b37d937beb1a0276c9ef1d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d8592fff37b094ffd13d533c77b962d4a49006dbde49798319f0c23e6045e332061cba073a39cc0b613d0699994e99c5f6233571cb7bef0f1c876fff7c48fe9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-25 19:28:20.427616) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 19:28:20.427996) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466903812.724717-1210237923 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 19:28:20.509795) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-25 19:28:20.510172) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-25 19:28:20.510548) ========= ========= Total master_lag: 0.19 =========