builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1473692794.06 results: success (0) buildid: 20160907212216 builduid: ac9f4432c3ca46b399057a7f993163a3 revision: 7d3d4f307002cc8475800df191196b94999ffd0a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-12 08:06:34.058365) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-12 08:06:34.058762) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-12 08:06:34.059066) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-12 08:06:34.107323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 08:06:34.107583) ========= 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=0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-12 08:06:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.5M=0s 2016-09-12 08:06:35 (37.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120581 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 08:06:34.248241) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 08:06:34.248522) ========= 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=0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019251 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 08:06:34.301123) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-12 08:06:34.301425) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7d3d4f307002cc8475800df191196b94999ffd0a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7d3d4f307002cc8475800df191196b94999ffd0a --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=0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-12 08:06:35,250 truncating revision to first 12 chars 2016-09-12 08:06:35,250 Setting DEBUG logging. 2016-09-12 08:06:35,250 attempt 1/10 2016-09-12 08:06:35,250 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7d3d4f307002?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-12 08:06:36,383 unpacking tar archive at: mozilla-aurora-7d3d4f307002/testing/mozharness/ program finished with exit code 0 elapsedTime=1.467459 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-12 08:06:35.781730) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-12 08:06:35.782026) ========= script_repo_revision: 7d3d4f307002cc8475800df191196b94999ffd0a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-12 08:06:35.782409) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-12 08:06:35.782679) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-12 08:06:35.791585) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 59 secs) (at 2016-09-12 08:06:35.791860) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:06:36 INFO - MultiFileLogger online at 20160912 08:06:36 in /builds/slave/test 08:06:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:06:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:06:36 INFO - {'append_to_log': False, 08:06:36 INFO - 'base_work_dir': '/builds/slave/test', 08:06:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:06:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:06:36 INFO - 'branch': 'Mozilla-Aurora', 08:06:36 INFO - 'buildbot_json_path': 'buildprops.json', 08:06:36 INFO - 'config_files': ('talos/linux_config.py',), 08:06:36 INFO - 'default_actions': ('clobber', 08:06:36 INFO - 'read-buildbot-config', 08:06:36 INFO - 'download-and-extract', 08:06:36 INFO - 'populate-webroot', 08:06:36 INFO - 'create-virtualenv', 08:06:36 INFO - 'install', 08:06:36 INFO - 'run-tests'), 08:06:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:06:36 INFO - 'download_minidump_stackwalk': True, 08:06:36 INFO - 'download_symbols': 'ondemand', 08:06:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:06:36 INFO - 'tooltool.py': '/tools/tooltool.py', 08:06:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:06:36 INFO - '/tools/misc-python/virtualenv.py')}, 08:06:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:06:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:06:36 INFO - 'installer_path': 'installer.exe', 08:06:36 INFO - 'log_level': 'info', 08:06:36 INFO - 'log_name': 'talos', 08:06:36 INFO - 'log_to_console': True, 08:06:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:06:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:06:36 INFO - 'opt_config_files': (), 08:06:36 INFO - 'pip_index': False, 08:06:36 INFO - 'sps_profile': False, 08:06:36 INFO - 'sps_profile_interval': 0, 08:06:36 INFO - 'suite': 'dromaeojs-e10s', 08:06:36 INFO - 'system_bits': '32', 08:06:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:06:36 INFO - 'title': 'talos-linux64-ix-058', 08:06:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:06:36 INFO - 'use_talos_json': True, 08:06:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:06:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:06:36 INFO - 'work_dir': 'build'} 08:06:36 INFO - [mozharness: 2016-09-12 15:06:36.837187Z] Running clobber step. 08:06:36 INFO - Running pre-action listener: _resource_record_pre_action 08:06:36 INFO - Running main action method: clobber 08:06:36 INFO - rmtree: /builds/slave/test/build 08:06:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:06:37 INFO - Running post-action listener: _resource_record_post_action 08:06:37 INFO - [mozharness: 2016-09-12 15:06:37.294870Z] Finished clobber step (success) 08:06:37 INFO - [mozharness: 2016-09-12 15:06:37.294973Z] Running read-buildbot-config step. 08:06:37 INFO - Running pre-action listener: _resource_record_pre_action 08:06:37 INFO - Running main action method: read_buildbot_config 08:06:37 INFO - Using buildbot properties: 08:06:37 INFO - { 08:06:37 INFO - "project": "", 08:06:37 INFO - "product": "firefox", 08:06:37 INFO - "script_repo_revision": "production", 08:06:37 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 08:06:37 INFO - "repository": "", 08:06:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 08:06:37 INFO - "buildid": "20160907212216", 08:06:37 INFO - "pgo_build": "True", 08:06:37 INFO - "basedir": "/builds/slave/test", 08:06:37 INFO - "buildnumber": 499, 08:06:37 INFO - "slavename": "talos-linux64-ix-058", 08:06:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:06:37 INFO - "platform": "ubuntu64_hw", 08:06:37 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:06:37 INFO - "branch": "mozilla-aurora", 08:06:37 INFO - "repo_path": "releases/mozilla-aurora", 08:06:37 INFO - "revision": "7d3d4f307002cc8475800df191196b94999ffd0a", 08:06:37 INFO - "stage_platform": "linux64-pgo", 08:06:37 INFO - "builduid": "ac9f4432c3ca46b399057a7f993163a3", 08:06:37 INFO - "slavebuilddir": "test" 08:06:37 INFO - } 08:06:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 08:06:37 INFO - Running post-action listener: _resource_record_post_action 08:06:37 INFO - [mozharness: 2016-09-12 15:06:37.297744Z] Finished read-buildbot-config step (success) 08:06:37 INFO - [mozharness: 2016-09-12 15:06:37.297857Z] Running download-and-extract step. 08:06:37 INFO - Running pre-action listener: _resource_record_pre_action 08:06:37 INFO - Running main action method: download_and_extract 08:06:37 INFO - mkdir: /builds/slave/test/build/tests 08:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:06:37 INFO - https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:06:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:06:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:06:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:06:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:06:37 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:06:37 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:06:37 INFO - retry: Failed, sleeping 30 seconds before retrying 08:07:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 08:07:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:07:07 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:07:07 INFO - retry: Failed, sleeping 60 seconds before retrying 08:08:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 08:08:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:08:07 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:08:07 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 08:08:07 INFO - Caught exception: HTTP Error 404: Not Found 08:08:07 INFO - Caught exception: HTTP Error 404: Not Found 08:08:07 INFO - Caught exception: HTTP Error 404: Not Found 08:08:07 INFO - trying https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:08:07 INFO - Downloading https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:08:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:08:07 INFO - Downloaded 1361 bytes. 08:08:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 08:08:07 INFO - Using the following test package requirements: 08:08:07 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 08:08:07 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:08:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:08:07 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:08:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:08:07 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:08:07 INFO - u'jsshell-linux-x86_64.zip'], 08:08:07 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:08:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:08:07 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 08:08:07 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:08:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:08:07 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:08:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:08:07 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:08:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:08:07 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 08:08:07 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:08:07 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:07 INFO - https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:08:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:08:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:08:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:08:07 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:08:07 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:08:07 INFO - retry: Failed, sleeping 30 seconds before retrying 08:08:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 08:08:38 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:08:38 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:08:38 INFO - retry: Failed, sleeping 60 seconds before retrying 08:09:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 08:09:38 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:09:38 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:09:38 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 08:09:38 INFO - Caught exception: HTTP Error 404: Not Found 08:09:38 INFO - Caught exception: HTTP Error 404: Not Found 08:09:38 INFO - Caught exception: HTTP Error 404: Not Found 08:09:38 INFO - trying https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:09:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:09:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:09:39 INFO - Downloaded 21769429 bytes. 08:09:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:09:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:09:40 INFO - Return code: 0 08:09:40 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:09:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:40 INFO - https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:09:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:09:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:09:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:09:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:09:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:09:40 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:09:40 INFO - retry: Failed, sleeping 30 seconds before retrying 08:10:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 08:10:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:10:10 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:10:10 INFO - retry: Failed, sleeping 60 seconds before retrying 08:11:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 08:11:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:11:10 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:11:10 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 08:11:10 INFO - Caught exception: HTTP Error 404: Not Found 08:11:10 INFO - Caught exception: HTTP Error 404: Not Found 08:11:10 INFO - Caught exception: HTTP Error 404: Not Found 08:11:10 INFO - trying https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:11:10 INFO - Downloading https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 08:11:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:11:11 INFO - Downloaded 21769429 bytes. 08:11:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:11:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:11:12 INFO - Return code: 0 08:11: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')]} 08:11:12 INFO - https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:11:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 08:11:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 08:11:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 08:11:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:11:12 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 08:11:12 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:11:12 INFO - retry: Failed, sleeping 30 seconds before retrying 08:11:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 08:11:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 08:11:42 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:11:42 INFO - retry: Failed, sleeping 60 seconds before retrying 08:12:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 08:12:42 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 08:12:42 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:12:42 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 08:12:42 INFO - Caught exception: HTTP Error 404: Not Found 08:12:42 INFO - Caught exception: HTTP Error 404: Not Found 08:12:42 INFO - Caught exception: HTTP Error 404: Not Found 08:12:42 INFO - trying https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 08:12:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 08:12:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:12:43 INFO - Downloaded 14413740 bytes. 08:12:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:12:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:12:43 INFO - Return code: 0 08:12:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:43 INFO - https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:12:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:12:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:12:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:12:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:12:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:12:43 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 08:12:43 INFO - retry: Failed, sleeping 30 seconds before retrying 08:13:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 08:13:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:13:13 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 08:13:13 INFO - retry: Failed, sleeping 60 seconds before retrying 08:14:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 08:14:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:14:13 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 08:14:13 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 08:14:13 INFO - Caught exception: HTTP Error 404: Not Found 08:14:13 INFO - Caught exception: HTTP Error 404: Not Found 08:14:13 INFO - Caught exception: HTTP Error 404: Not Found 08:14:13 INFO - trying https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:14:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:14:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:14:15 INFO - Downloaded 63918604 bytes. 08:14:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:14:15 INFO - mkdir: /builds/slave/test/properties 08:14:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:15 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:15 INFO - Contents: 08:14:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 08:14:15 INFO - Running post-action listener: _resource_record_post_action 08:14:15 INFO - Running post-action listener: set_extra_try_arguments 08:14:15 INFO - [mozharness: 2016-09-12 15:14:15.845641Z] Finished download-and-extract step (success) 08:14:15 INFO - [mozharness: 2016-09-12 15:14:15.845874Z] Running populate-webroot step. 08:14:15 INFO - Running pre-action listener: _resource_record_pre_action 08:14:15 INFO - Running main action method: populate_webroot 08:14:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:15 INFO - '--tppagecycles', 08:14:15 INFO - '7'], 08:14:15 INFO - 'tests': ['tsvgm']}}, 08:14:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:14:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:14:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:14:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:14:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:15 INFO - 'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:15 INFO - 'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['damp', 'tps']}, 08:14:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:15 INFO - 'tests': ['damp', 'tps']}, 08:14:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['dromaeo_dom']}, 08:14:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['basic_compositor_video']}, 08:14:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:14:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['a11yr', 08:14:15 INFO - 'ts_paint', 08:14:15 INFO - 'tpaint', 08:14:15 INFO - 'sessionrestore', 08:14:15 INFO - 'sessionrestore_no_auto_restore', 08:14:15 INFO - 'tabpaint']}, 08:14:15 INFO - 'other-e10s': {'tests': ['a11yr', 08:14:15 INFO - 'ts_paint', 08:14:15 INFO - 'tpaint', 08:14:15 INFO - 'sessionrestore', 08:14:15 INFO - 'sessionrestore_no_auto_restore', 08:14:15 INFO - 'tabpaint']}, 08:14:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:14:15 INFO - 'ts_paint', 08:14:15 INFO - 'tpaint', 08:14:15 INFO - 'sessionrestore', 08:14:15 INFO - 'sessionrestore_no_auto_restore', 08:14:15 INFO - 'tabpaint']}, 08:14:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:14:15 INFO - 'ts_paint', 08:14:15 INFO - 'tpaint', 08:14:15 INFO - 'sessionrestore', 08:14:15 INFO - 'sessionrestore_no_auto_restore', 08:14:15 INFO - 'tabpaint']}, 08:14:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['a11yr', 08:14:15 INFO - 'ts_paint', 08:14:15 INFO - 'tpaint', 08:14:15 INFO - 'sessionrestore', 08:14:15 INFO - 'sessionrestore_no_auto_restore', 08:14:15 INFO - 'tabpaint']}, 08:14:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['a11yr', 08:14:15 INFO - 'ts_paint', 08:14:15 INFO - 'tpaint', 08:14:15 INFO - 'sessionrestore', 08:14:15 INFO - 'sessionrestore_no_auto_restore', 08:14:15 INFO - 'tabpaint']}, 08:14:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['tsvgx', 08:14:15 INFO - 'tsvgr_opacity', 08:14:15 INFO - 'tart', 08:14:15 INFO - 'tscrollx', 08:14:15 INFO - 'cart']}, 08:14:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:14:15 INFO - 'tsvgr_opacity', 08:14:15 INFO - 'tart', 08:14:15 INFO - 'tscrollx', 08:14:15 INFO - 'cart']}, 08:14:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:15 INFO - 'talos_options': ['--disable-e10s'], 08:14:15 INFO - 'tests': ['tp5o']}, 08:14:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:15 INFO - 'tests': ['tp5o']}, 08:14:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:15 INFO - 'talos_options': ['--disable-e10s', 08:14:15 INFO - '--xperf_path', 08:14:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:15 INFO - 'tests': ['tp5n']}, 08:14:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:15 INFO - 'talos_options': ['--xperf_path', 08:14:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:15 INFO - 'tests': ['tp5n']}}, 08:14:15 INFO - 'talos.zip': {'path': '', 08:14:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:15 INFO - Running post-action listener: _resource_record_post_action 08:14:15 INFO - [mozharness: 2016-09-12 15:14:15.866315Z] Finished populate-webroot step (success) 08:14:15 INFO - [mozharness: 2016-09-12 15:14:15.866405Z] Running create-virtualenv step. 08:14:15 INFO - Running pre-action listener: _resource_record_pre_action 08:14:15 INFO - Running main action method: create_virtualenv 08:14:15 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:15 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 08:14:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:15 INFO - Using real prefix '/usr' 08:14:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:16 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:18 INFO - Installing pip.................done. 08:14:18 INFO - Return code: 0 08:14:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14:18 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')]} 08:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:18 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')]} 08:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:18 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 0x1483030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741570>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, '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': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', '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 08:14:18 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 08:14:18 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 08:14:18 INFO - Using env: {'DISPLAY': ':0', 08:14:18 INFO - 'HOME': '/home/cltbld', 08:14:18 INFO - 'LANG': 'en_US.UTF-8', 08:14:18 INFO - 'LANGUAGE': 'en_US:en', 08:14:18 INFO - 'LOGNAME': 'cltbld', 08:14:18 INFO - 'MAIL': '/var/mail/cltbld', 08:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:18 INFO - 'MOZ_NO_REMOTE': '1', 08:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:18 INFO - 'NO_EM_RESTART': '1', 08:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:18 INFO - 'PWD': '/builds/slave/test', 08:14:18 INFO - 'SHELL': '/bin/bash', 08:14:18 INFO - 'SHLVL': '1', 08:14:18 INFO - 'TERM': 'linux', 08:14:18 INFO - 'TMOUT': '86400', 08:14:18 INFO - 'USER': 'cltbld', 08:14:18 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', 08:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:18 INFO - '_': '/tools/buildbot/bin/python'} 08:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:18 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 08:14:18 INFO - Cleaning up... 08:14:18 INFO - Return code: 0 08:14:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:14:18 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')]} 08:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:18 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')]} 08:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:18 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 0x1483030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741570>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, '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': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', '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 08:14:18 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 08:14:18 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 08:14:18 INFO - Using env: {'DISPLAY': ':0', 08:14:18 INFO - 'HOME': '/home/cltbld', 08:14:18 INFO - 'LANG': 'en_US.UTF-8', 08:14:18 INFO - 'LANGUAGE': 'en_US:en', 08:14:18 INFO - 'LOGNAME': 'cltbld', 08:14:18 INFO - 'MAIL': '/var/mail/cltbld', 08:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:18 INFO - 'MOZ_NO_REMOTE': '1', 08:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:18 INFO - 'NO_EM_RESTART': '1', 08:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:18 INFO - 'PWD': '/builds/slave/test', 08:14:18 INFO - 'SHELL': '/bin/bash', 08:14:18 INFO - 'SHLVL': '1', 08:14:18 INFO - 'TERM': 'linux', 08:14:18 INFO - 'TMOUT': '86400', 08:14:18 INFO - 'USER': 'cltbld', 08:14:18 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', 08:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:18 INFO - '_': '/tools/buildbot/bin/python'} 08:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:18 INFO - Downloading/unpacking psutil>=3.1.1 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:20 INFO - Installing collected packages: psutil 08:14:20 INFO - Running setup.py install for psutil 08:14:20 INFO - building 'psutil._psutil_linux' extension 08:14:20 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 08:14:21 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 08:14:21 INFO - building 'psutil._psutil_posix' extension 08:14:21 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 08:14:21 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 08:14:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:21 INFO - Successfully installed psutil 08:14:21 INFO - Cleaning up... 08:14:21 INFO - Return code: 0 08:14:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:21 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 0x1483030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741570>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, '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': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', '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 08:14:21 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 08:14:21 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 08:14:21 INFO - Using env: {'DISPLAY': ':0', 08:14:21 INFO - 'HOME': '/home/cltbld', 08:14:21 INFO - 'LANG': 'en_US.UTF-8', 08:14:21 INFO - 'LANGUAGE': 'en_US:en', 08:14:21 INFO - 'LOGNAME': 'cltbld', 08:14:21 INFO - 'MAIL': '/var/mail/cltbld', 08:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:21 INFO - 'MOZ_NO_REMOTE': '1', 08:14:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:21 INFO - 'NO_EM_RESTART': '1', 08:14:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:21 INFO - 'PWD': '/builds/slave/test', 08:14:21 INFO - 'SHELL': '/bin/bash', 08:14:21 INFO - 'SHLVL': '1', 08:14:21 INFO - 'TERM': 'linux', 08:14:21 INFO - 'TMOUT': '86400', 08:14:21 INFO - 'USER': 'cltbld', 08:14:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', 08:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:21 INFO - '_': '/tools/buildbot/bin/python'} 08:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:14:21 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 08:14:21 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 08:14:21 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 08:14:21 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 08:14:21 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 08:14:21 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 08:14:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:14:23 INFO - Installing collected packages: mozsystemmonitor 08:14:23 INFO - Running setup.py install for mozsystemmonitor 08:14:23 INFO - Successfully installed mozsystemmonitor 08:14:23 INFO - Cleaning up... 08:14:23 INFO - Return code: 0 08:14:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:14:23 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')]} 08:14:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:23 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')]} 08:14:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:23 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 0x1483030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741570>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, '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': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', '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 08:14:23 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 08:14:23 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 08:14:23 INFO - Using env: {'DISPLAY': ':0', 08:14:23 INFO - 'HOME': '/home/cltbld', 08:14:23 INFO - 'LANG': 'en_US.UTF-8', 08:14:23 INFO - 'LANGUAGE': 'en_US:en', 08:14:23 INFO - 'LOGNAME': 'cltbld', 08:14:23 INFO - 'MAIL': '/var/mail/cltbld', 08:14:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:23 INFO - 'MOZ_NO_REMOTE': '1', 08:14:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:23 INFO - 'NO_EM_RESTART': '1', 08:14:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:23 INFO - 'PWD': '/builds/slave/test', 08:14:23 INFO - 'SHELL': '/bin/bash', 08:14:23 INFO - 'SHLVL': '1', 08:14:23 INFO - 'TERM': 'linux', 08:14:23 INFO - 'TMOUT': '86400', 08:14:23 INFO - 'USER': 'cltbld', 08:14:23 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', 08:14:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:23 INFO - '_': '/tools/buildbot/bin/python'} 08:14:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:23 INFO - Downloading/unpacking jsonschema==2.5.1 08:14:23 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 08:14:23 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 08:14:23 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 08:14:23 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 08:14:23 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 08:14:23 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 08:14:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:14:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:14:25 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 08:14:25 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 08:14:25 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 08:14:25 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 08:14:25 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 08:14:25 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 08:14:26 INFO - Downloading functools32-3.2.3-2.tar.gz 08:14:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:14:26 INFO - warning: no files found matching '*.txt' 08:14:26 INFO - no previously-included directories found matching 'build' 08:14:26 INFO - no previously-included directories found matching 'dist' 08:14:26 INFO - no previously-included directories found matching '.git*' 08:14:26 INFO - Installing collected packages: jsonschema, functools32 08:14:26 INFO - Running setup.py install for functools32 08:14:26 INFO - warning: no files found matching '*.txt' 08:14:26 INFO - no previously-included directories found matching 'build' 08:14:26 INFO - no previously-included directories found matching 'dist' 08:14:26 INFO - no previously-included directories found matching '.git*' 08:14:26 INFO - Successfully installed jsonschema functools32 08:14:26 INFO - Cleaning up... 08:14:26 INFO - Return code: 0 08:14:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:26 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1483030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741570>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, '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': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', '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 08:14:26 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:14:26 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 functools32==3.2.3-2 08:14:26 INFO - Using env: {'DISPLAY': ':0', 08:14:26 INFO - 'HOME': '/home/cltbld', 08:14:26 INFO - 'LANG': 'en_US.UTF-8', 08:14:26 INFO - 'LANGUAGE': 'en_US:en', 08:14:26 INFO - 'LOGNAME': 'cltbld', 08:14:26 INFO - 'MAIL': '/var/mail/cltbld', 08:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:26 INFO - 'MOZ_NO_REMOTE': '1', 08:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:26 INFO - 'NO_EM_RESTART': '1', 08:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:26 INFO - 'PWD': '/builds/slave/test', 08:14:26 INFO - 'SHELL': '/bin/bash', 08:14:26 INFO - 'SHLVL': '1', 08:14:26 INFO - 'TERM': 'linux', 08:14:26 INFO - 'TMOUT': '86400', 08:14:26 INFO - 'USER': 'cltbld', 08:14:26 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', 08:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:26 INFO - '_': '/tools/buildbot/bin/python'} 08:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:14:26 INFO - Cleaning up... 08:14:26 INFO - Return code: 0 08:14:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:26 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 0x1483030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741570>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, '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': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', '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 08:14:26 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 08:14:26 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 08:14:26 INFO - Using env: {'DISPLAY': ':0', 08:14:26 INFO - 'HOME': '/home/cltbld', 08:14:26 INFO - 'LANG': 'en_US.UTF-8', 08:14:26 INFO - 'LANGUAGE': 'en_US:en', 08:14:26 INFO - 'LOGNAME': 'cltbld', 08:14:26 INFO - 'MAIL': '/var/mail/cltbld', 08:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:26 INFO - 'MOZ_NO_REMOTE': '1', 08:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:26 INFO - 'NO_EM_RESTART': '1', 08:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:26 INFO - 'PWD': '/builds/slave/test', 08:14:26 INFO - 'SHELL': '/bin/bash', 08:14:26 INFO - 'SHLVL': '1', 08:14:26 INFO - 'TERM': 'linux', 08:14:26 INFO - 'TMOUT': '86400', 08:14:26 INFO - 'USER': 'cltbld', 08:14:26 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', 08:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:26 INFO - '_': '/tools/buildbot/bin/python'} 08:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:26 INFO - Downloading/unpacking blobuploader==1.2.4 08:14:26 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 08:14:26 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 08:14:26 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 08:14:26 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 08:14:26 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 08:14:26 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 08:14:28 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:14:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:14:29 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 08:14:29 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 08:14:29 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 08:14:29 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 08:14:29 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 08:14:29 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 08:14:29 INFO - Downloading docopt-0.6.1.tar.gz 08:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:14:29 INFO - Installing collected packages: blobuploader, requests, docopt 08:14:29 INFO - Running setup.py install for blobuploader 08:14:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:14:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:14:29 INFO - Running setup.py install for requests 08:14:30 INFO - Running setup.py install for docopt 08:14:30 INFO - Successfully installed blobuploader requests docopt 08:14:30 INFO - Cleaning up... 08:14:30 INFO - Return code: 0 08:14:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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')]} 08:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:30 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 0x1483030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741570>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, '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': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', '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 08:14:30 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 08:14:30 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 08:14:30 INFO - Using env: {'DISPLAY': ':0', 08:14:30 INFO - 'HOME': '/home/cltbld', 08:14:30 INFO - 'LANG': 'en_US.UTF-8', 08:14:30 INFO - 'LANGUAGE': 'en_US:en', 08:14:30 INFO - 'LOGNAME': 'cltbld', 08:14:30 INFO - 'MAIL': '/var/mail/cltbld', 08:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:30 INFO - 'MOZ_NO_REMOTE': '1', 08:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:30 INFO - 'NO_EM_RESTART': '1', 08:14:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:30 INFO - 'PWD': '/builds/slave/test', 08:14:30 INFO - 'SHELL': '/bin/bash', 08:14:30 INFO - 'SHLVL': '1', 08:14:30 INFO - 'TERM': 'linux', 08:14:30 INFO - 'TMOUT': '86400', 08:14:30 INFO - 'USER': 'cltbld', 08:14:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', 08:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:30 INFO - '_': '/tools/buildbot/bin/python'} 08:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:30 INFO - Running setup.py (path:/tmp/pip-jHRVnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:30 INFO - Running setup.py (path:/tmp/pip-dGuRLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:30 INFO - Running setup.py (path:/tmp/pip-sdjVR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:30 INFO - Running setup.py (path:/tmp/pip-Kw1Td8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:30 INFO - Running setup.py (path:/tmp/pip-vqzgp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:30 INFO - Running setup.py (path:/tmp/pip-BYBG4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:30 INFO - Running setup.py (path:/tmp/pip-yPEP_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:30 INFO - Running setup.py (path:/tmp/pip-D9Tmgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:30 INFO - Running setup.py (path:/tmp/pip-gGBTJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:31 INFO - Running setup.py (path:/tmp/pip-j3U_ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:31 INFO - Running setup.py (path:/tmp/pip-lkqrLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:31 INFO - Running setup.py (path:/tmp/pip-uOgekT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:31 INFO - Running setup.py (path:/tmp/pip-DhygYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:31 INFO - Running setup.py (path:/tmp/pip-JsFjYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:31 INFO - Running setup.py (path:/tmp/pip-5MK0_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:31 INFO - Running setup.py (path:/tmp/pip-HlBxCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:31 INFO - Running setup.py (path:/tmp/pip-X7Wanu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:31 INFO - Running setup.py install for manifestparser 08:14:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:31 INFO - Running setup.py install for mozcrash 08:14:31 INFO - Running setup.py install for mozdebug 08:14:31 INFO - Running setup.py install for mozdevice 08:14:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:14:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:14:32 INFO - Running setup.py install for mozfile 08:14:32 INFO - Running setup.py install for mozhttpd 08:14:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:14:32 INFO - Running setup.py install for mozinfo 08:14:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:14:32 INFO - Running setup.py install for mozInstall 08:14:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:14:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:14:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:14:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:14:32 INFO - Running setup.py install for mozleak 08:14:32 INFO - Running setup.py install for mozlog 08:14:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:14:32 INFO - Running setup.py install for moznetwork 08:14:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:14:32 INFO - Running setup.py install for mozprocess 08:14:32 INFO - Running setup.py install for mozprofile 08:14:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:14:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:14:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:14:32 INFO - Running setup.py install for mozrunner 08:14:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Running setup.py install for mozscreenshot 08:14:33 INFO - Running setup.py install for moztest 08:14:33 INFO - Running setup.py install for mozversion 08:14:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:14:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:14:33 INFO - Cleaning up... 08:14:33 INFO - Return code: 0 08:14:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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')]} 08:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:33 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 0x1483030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741570>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, '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': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', '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 08:14:33 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 08:14:33 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 08:14:33 INFO - Using env: {'DISPLAY': ':0', 08:14:33 INFO - 'HOME': '/home/cltbld', 08:14:33 INFO - 'LANG': 'en_US.UTF-8', 08:14:33 INFO - 'LANGUAGE': 'en_US:en', 08:14:33 INFO - 'LOGNAME': 'cltbld', 08:14:33 INFO - 'MAIL': '/var/mail/cltbld', 08:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:33 INFO - 'MOZ_NO_REMOTE': '1', 08:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:33 INFO - 'NO_EM_RESTART': '1', 08:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:33 INFO - 'PWD': '/builds/slave/test', 08:14:33 INFO - 'SHELL': '/bin/bash', 08:14:33 INFO - 'SHLVL': '1', 08:14:33 INFO - 'TERM': 'linux', 08:14:33 INFO - 'TMOUT': '86400', 08:14:33 INFO - 'USER': 'cltbld', 08:14:33 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', 08:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:33 INFO - '_': '/tools/buildbot/bin/python'} 08:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:33 INFO - Running setup.py (path:/tmp/pip-BMVAPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:33 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)) 08:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:33 INFO - Running setup.py (path:/tmp/pip-F3cvKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:33 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)) 08:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:33 INFO - Running setup.py (path:/tmp/pip-6s1c_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:33 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)) 08:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:33 INFO - Running setup.py (path:/tmp/pip-Fpo9IM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:33 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)) 08:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:33 INFO - Running setup.py (path:/tmp/pip-bkxiEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:34 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)) 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:34 INFO - Running setup.py (path:/tmp/pip-ozWZEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:34 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)) 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:34 INFO - Running setup.py (path:/tmp/pip-UAL8KW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:34 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)) 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:34 INFO - Running setup.py (path:/tmp/pip-jrTdpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:34 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)) 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:34 INFO - Running setup.py (path:/tmp/pip-vv3PXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:34 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)) 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:34 INFO - Running setup.py (path:/tmp/pip-kxcvQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:34 INFO - Running setup.py (path:/tmp/pip-rO4uON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:34 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)) 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:34 INFO - Running setup.py (path:/tmp/pip-KAyeuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:34 INFO - Running setup.py (path:/tmp/pip-qNzmBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:34 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)) 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:34 INFO - Running setup.py (path:/tmp/pip-7smWlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:34 INFO - Running setup.py (path:/tmp/pip-tkgugm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:34 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)) 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:34 INFO - Running setup.py (path:/tmp/pip-wPX_2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:34 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)) 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:34 INFO - Running setup.py (path:/tmp/pip-VZkseL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:34 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)) 08:14:34 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)) 08:14:34 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)) 08:14:34 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)) 08:14:34 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)) 08:14:34 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)) 08:14:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14:34 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 08:14:34 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 08:14:34 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 08:14:34 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 08:14:34 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 08:14:34 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 08:14:36 INFO - Downloading blessings-1.6.tar.gz 08:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:14:36 INFO - Installing collected packages: blessings 08:14:36 INFO - Running setup.py install for blessings 08:14:36 INFO - Successfully installed blessings 08:14:36 INFO - Cleaning up... 08:14:37 INFO - Return code: 0 08:14:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:37 INFO - Reading from file tmpfile_stdout 08:14:37 INFO - Current package versions: 08:14:37 INFO - argparse == 1.2.1 08:14:37 INFO - blessings == 1.6 08:14:37 INFO - blobuploader == 1.2.4 08:14:37 INFO - docopt == 0.6.1 08:14:37 INFO - functools32 == 3.2.3-2 08:14:37 INFO - jsonschema == 2.5.1 08:14:37 INFO - manifestparser == 1.1 08:14:37 INFO - mozInstall == 1.12 08:14:37 INFO - mozcrash == 0.17 08:14:37 INFO - mozdebug == 0.1 08:14:37 INFO - mozdevice == 0.48 08:14:37 INFO - mozfile == 1.2 08:14:37 INFO - mozhttpd == 0.7 08:14:37 INFO - mozinfo == 0.9 08:14:37 INFO - mozleak == 0.1 08:14:37 INFO - mozlog == 3.3 08:14:37 INFO - moznetwork == 0.27 08:14:37 INFO - mozprocess == 0.23 08:14:37 INFO - mozprofile == 0.28 08:14:37 INFO - mozrunner == 6.12 08:14:37 INFO - mozscreenshot == 0.1 08:14:37 INFO - mozsystemmonitor == 0.3 08:14:37 INFO - moztest == 0.7 08:14:37 INFO - mozversion == 1.4 08:14:37 INFO - psutil == 3.1.1 08:14:37 INFO - requests == 1.2.3 08:14:37 INFO - wsgiref == 0.1.2 08:14:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:37 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 0x1483030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741570>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, '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': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', '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 08:14:37 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 08:14:37 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 08:14:37 INFO - Using env: {'DISPLAY': ':0', 08:14:37 INFO - 'HOME': '/home/cltbld', 08:14:37 INFO - 'LANG': 'en_US.UTF-8', 08:14:37 INFO - 'LANGUAGE': 'en_US:en', 08:14:37 INFO - 'LOGNAME': 'cltbld', 08:14:37 INFO - 'MAIL': '/var/mail/cltbld', 08:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:37 INFO - 'MOZ_NO_REMOTE': '1', 08:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:37 INFO - 'NO_EM_RESTART': '1', 08:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:37 INFO - 'PWD': '/builds/slave/test', 08:14:37 INFO - 'SHELL': '/bin/bash', 08:14:37 INFO - 'SHLVL': '1', 08:14:37 INFO - 'TERM': 'linux', 08:14:37 INFO - 'TMOUT': '86400', 08:14:37 INFO - 'USER': 'cltbld', 08:14:37 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', 08:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:37 INFO - '_': '/tools/buildbot/bin/python'} 08:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:37 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)) 08:14:37 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)) 08:14:37 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)) 08:14:37 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)) 08:14:37 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)) 08:14:37 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)) 08:14:37 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)) 08:14:37 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)) 08:14:37 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)) 08:14:37 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)) 08:14:37 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)) 08:14:37 INFO - Cleaning up... 08:14:37 INFO - Return code: 0 08:14:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1483030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16b2400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1741570>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, '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': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', '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 08:14:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:14:37 INFO - Using env: {'DISPLAY': ':0', 08:14:37 INFO - 'HOME': '/home/cltbld', 08:14:37 INFO - 'LANG': 'en_US.UTF-8', 08:14:37 INFO - 'LANGUAGE': 'en_US:en', 08:14:37 INFO - 'LOGNAME': 'cltbld', 08:14:37 INFO - 'MAIL': '/var/mail/cltbld', 08:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:37 INFO - 'MOZ_NO_REMOTE': '1', 08:14:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:37 INFO - 'NO_EM_RESTART': '1', 08:14:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:37 INFO - 'PWD': '/builds/slave/test', 08:14:37 INFO - 'SHELL': '/bin/bash', 08:14:37 INFO - 'SHLVL': '1', 08:14:37 INFO - 'TERM': 'linux', 08:14:37 INFO - 'TMOUT': '86400', 08:14:37 INFO - 'USER': 'cltbld', 08:14:37 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', 08:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:37 INFO - '_': '/tools/buildbot/bin/python'} 08:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:14:37 INFO - Cleaning up... 08:14:37 INFO - Return code: 0 08:14:37 INFO - Running post-action listener: _resource_record_post_action 08:14:37 INFO - Running post-action listener: _start_resource_monitoring 08:14:37 INFO - Starting resource monitoring. 08:14:37 INFO - [mozharness: 2016-09-12 15:14:37.709576Z] Finished create-virtualenv step (success) 08:14:37 INFO - [mozharness: 2016-09-12 15:14:37.710058Z] Running install step. 08:14:37 INFO - Running pre-action listener: _resource_record_pre_action 08:14:37 INFO - Running main action method: install 08:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:37 INFO - Reading from file tmpfile_stdout 08:14:37 INFO - Detecting whether we're running mozinstall >=1.0... 08:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:14:38 INFO - Reading from file tmpfile_stdout 08:14:38 INFO - Output received: 08:14:38 INFO - Usage: mozinstall [options] installer 08:14:38 INFO - Options: 08:14:38 INFO - -h, --help show this help message and exit 08:14:38 INFO - -d DEST, --destination=DEST 08:14:38 INFO - Directory to install application into. [default: 08:14:38 INFO - "/builds/slave/test"] 08:14:38 INFO - --app=APP Application being installed. [default: firefox] 08:14:38 INFO - mkdir: /builds/slave/test/build/application 08:14:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:14:54 INFO - Reading from file tmpfile_stdout 08:14:54 INFO - Output received: 08:14:54 INFO - /builds/slave/test/build/application/firefox/firefox 08:14:54 INFO - Running post-action listener: _resource_record_post_action 08:14:54 INFO - [mozharness: 2016-09-12 15:14:54.059253Z] Finished install step (success) 08:14:54 INFO - [mozharness: 2016-09-12 15:14:54.059528Z] Running run-tests step. 08:14:54 INFO - Running pre-action listener: _resource_record_pre_action 08:14:54 INFO - Running main action method: run_tests 08:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:14:54 INFO - Python 2.7.3 08:14:54 INFO - Return code: 0 08:14:54 INFO - grabbing minidump binary from tooltool 08:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:54 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 0x1741570>, '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 0x1742470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1742900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:14:54 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 08:14:54 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 08:14:54 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 08:14:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:14:54 INFO - Return code: 0 08:14:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:14:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:14:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:14:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:14:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 08:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 08:14:54 INFO - Using env: {'DISPLAY': ':0', 08:14:54 INFO - 'HOME': '/home/cltbld', 08:14:54 INFO - 'LANG': 'en_US.UTF-8', 08:14:54 INFO - 'LANGUAGE': 'en_US:en', 08:14:54 INFO - 'LOGNAME': 'cltbld', 08:14:54 INFO - 'MAIL': '/var/mail/cltbld', 08:14:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:14:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:54 INFO - 'MOZ_NO_REMOTE': '1', 08:14:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:54 INFO - 'NO_EM_RESTART': '1', 08:14:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:54 INFO - 'PWD': '/builds/slave/test', 08:14:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:14:54 INFO - 'SHELL': '/bin/bash', 08:14:54 INFO - 'SHLVL': '1', 08:14:54 INFO - 'TERM': 'linux', 08:14:54 INFO - 'TMOUT': '86400', 08:14:54 INFO - 'USER': 'cltbld', 08:14:54 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685', 08:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:54 INFO - '_': '/tools/buildbot/bin/python'} 08:14:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 08:14:54 INFO - mozversion application_buildid: 20160907212216 08:14:54 INFO - mozversion application_changeset: 7d3d4f307002cc8475800df191196b94999ffd0a 08:14:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:14:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:14:54 INFO - mozversion application_name: Firefox 08:14:54 INFO - mozversion application_remotingname: firefox-dev 08:14:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:14:54 INFO - mozversion application_vendor: Mozilla 08:14:54 INFO - mozversion application_version: 50.0a2 08:14:54 INFO - mozversion platform_buildid: 20160907212216 08:14:54 INFO - mozversion platform_changeset: 7d3d4f307002cc8475800df191196b94999ffd0a 08:14:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:14:54 INFO - mozversion platform_version: 50.0a2 08:14:54 INFO - using testdate: 1473693294 08:14:54 INFO - actual date: 1473693294 08:14:54 INFO - starting webserver on 'localhost:59279' 08:14:54 INFO - SUITE-START | Running 2 tests 08:14:54 INFO - TEST-START | dromaeo_css 08:14:54 INFO - operating with platform_type : linux_ 08:14:54 INFO - Initialising browser for dromaeo_css test... 08:14:54 INFO - TEST-INFO | started process 10344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAsWZT0/profile http://localhost:59279/getInfo.html) 08:14:58 INFO - PROCESS | 10344 | __metrics Screen width/height:1600/1200 08:14:58 INFO - PROCESS | 10344 | colorDepth:24 08:14:58 INFO - PROCESS | 10344 | Browser inner width/height: 1024/697 08:14:58 INFO - PROCESS | 10344 | __metrics 08:14:59 ERROR - PROCESS | 10344 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 08:15:00 INFO - TEST-INFO | 10344: exit 0 08:15:00 INFO - Browser initialized. 08:15:00 INFO - Running cycle 1/1 for dromaeo_css test... 08:15:00 INFO - TEST-INFO | started process 10471 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAsWZT0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:11 INFO - PROCESS | 10471 | RSS: Main: 153063424 08:15:11 INFO - PROCESS | 10471 | 08:16:01 INFO - PROCESS | 10471 | 1473693361583 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] 08:18:10 INFO - PROCESS | 10471 | Cycle 1(1): loaded http://localhost:59279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59279/tests/dromaeo/cssquery-ext.html) 08:18:11 INFO - PROCESS | 10471 | RSS: Main: 157814784 08:18:11 INFO - PROCESS | 10471 | 08:21:13 INFO - PROCESS | 10471 | Cycle 1(1): loaded http://localhost:59279/tests/dromaeo/cssquery-ext.html (next: http://localhost:59279/tests/dromaeo/cssquery-jquery.html) 08:21:14 INFO - PROCESS | 10471 | RSS: Main: 153468928 08:21:14 INFO - PROCESS | 10471 | 08:24:16 INFO - PROCESS | 10471 | Cycle 1(1): loaded http://localhost:59279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59279/tests/dromaeo/cssquery-mootools.html) 08:24:16 INFO - PROCESS | 10471 | RSS: Main: 154861568 08:24:16 INFO - PROCESS | 10471 | 08:27:18 INFO - PROCESS | 10471 | Cycle 1(1): loaded http://localhost:59279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59279/tests/dromaeo/cssquery-prototype.html) 08:27:19 INFO - PROCESS | 10471 | RSS: Main: 152637440 08:27:19 INFO - PROCESS | 10471 | 08:30:21 INFO - PROCESS | 10471 | Cycle 1(1): loaded http://localhost:59279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59279/tests/dromaeo/cssquery-yui.html) 08:30:22 INFO - PROCESS | 10471 | RSS: Main: 155099136 08:30:22 INFO - PROCESS | 10471 | 08:33:24 INFO - PROCESS | 10471 | Cycle 1(1): loaded http://localhost:59279/tests/dromaeo/cssquery-yui.html (next: http://localhost:59279/tests/dromaeo/cssquery-dojo.html) 08:33:24 INFO - PROCESS | 10471 | RSS: Main: 156155904 08:33:24 INFO - PROCESS | 10471 | 08:33:24 INFO - PROCESS | 10471 | __start_tp_report 08:33:24 INFO - PROCESS | 10471 | _x_x_mozilla_page_load 08:33:24 INFO - PROCESS | 10471 | _x_x_mozilla_page_load_details 08:33:24 INFO - PROCESS | 10471 | |i|pagename|runs| 08:33:24 INFO - PROCESS | 10471 | |0;dojo.html;3272.6727327267276;3302.009397180846;3303.834808259588;3304.2895777407853;3311.8178500182494;5692.800751973682;5697.857553561163;5705.600607957439;5724.169995350677;5724.398938111501;5763.884722305552;5775.364709881909;5796.942030579704;5819.214406055181;5839.970800146004;5171;5259.815906443275;5295.4704529547125;5333.38666053403;5335.653182543142;5239.947600524003;5254.369475662926;5260.473952604728;5313.548348390392;5337.572994160477;5286.973565132169;5302.257683924254;5324.600654950875;5350.598705097113;5441.483059109398;5398.082326004589;5426.941746359481;5437.510624043815;5444.646098003617;5445.264889239941;5096.031753966735;5194.662346947436;5201.973990130063;5331.306930099101;5336;5647.29408823897;5714.0571805652435;5773.913391299134;5814.3313518945015;5872.911906321408;6253.968730156365;6268.731020062736;6299.118123462719;6311.08489269058;6320.5891617044745;6061.151438798572;6271.216097987752;6274.372562743734;6316.242050953915;6328.208973878265;5783.190353350535;5791.189233507313;5883;5888.411158884121;5895.793647222369;6348.619082855043;6371.044343348442;6388.073729309317;6419.646919419477;6443.420092191632;5881.2942446906645;6138.416850399205;6151.569390142647;6151.692415379213;6155.84610384744;6117.143599896018;6142.907856382158;6222.12890195373;6305.96847015762;6306.716197771111;6237.251529816451;6257.217847769029;6265.8746825063245;6294.653794041372;6296.590721603081;6053.878922421615;6212.534059945432;6250.4374606285655;6270.2475702915945;6274.874502509924;4727.4327080749845;4744.122337367598;4750.168720473903;4755.286706993978;4834.661573689878;4206.978965105216;4251.362295655615;4252.085801552681;4267.573242675708;4297.333913243452;5827.504662103769;6036.758529658852;6039.094135879654;6047.771729674662;6067.059605761114;6143.416375444325;6187.257529096537;6202.81391558254;6288.779892703734;6320.5891617044745;6020.8795824084145;6058.969705151534;6070.150178974947;6075;6075.3924607539775;5178.482151784791;5335.226392173191;5347.839564813062;5353;5359.758810853521;6392.616443013434;6451.29035806061;6476.255230648441;6536.215654121535;6547.934520654828;6267.122602835698;6272.372762723691;6275.278342990615;6281.309056003744;6298.905516417166;6175.980963141032;6483.675816209265;6508.8047358579315;6556.147700798866;6560;6105.481034111973;6137.79561000716;6140.87237156979;6229;6232.189815323979;6278.717457714322;6282.874342513032;6285.717142728679;6289.245290565162;6297.055441683784;5833.533317334518;6110.847228819315;6111.358307377839;6116.8776624468155;6121.785737499166;5954.880902382015;5968.582199246011;5988.221531200916;5989.281286245504;6079.848003799941;6001.819945401645;6021.698915054318;6023.789167379121;6033.42682445167;6038.275406951018;5947.553933454921;5970.0746384310505;6013.278406591237;6042.577019608585;6063.423974722395;5895;5908.202392677105;5944.494717949023;6003.519718422603;6048.032314829607 08:33:24 INFO - PROCESS | 10471 | |1;ext.html;579.7999690106915;638.1002786071639;643.7972038807777;659.3604203922193;709.078198342155;40926.18147637049;46597.068058638804;46839.53160468399;46884.296735549;47158.292625610644;46994;47260.52739472604;47307;47424.52575474244;47561;9123.635054597824;9240.122188392126;9251.213646840026;9254.44473331599;9262.6294948202;9059.184673379394;9124.726258212264;9139.862902056475;9205.493697846616;9209.217216536568;9203.815923681523;9222.170004699576;9257;9259.72220833376;9274.953625231865;9116.088391160898;9207.263418926503;9207.585658645377;9212.078792120768;9220.53897305132;9171.358004939657;9180.31147663928;9210.631574737003;9220.538973051387;9244.260459163252;43976.78011609954;44566.55433445657;44618.55381446209;44847;44866.55133448656;3193.6007999000126;3768.340540405418;3938.330483817758;4287.892802679927;4441.267190913528;32811;33580.32839343224;33604.83197583997;34378.82810585931;35327;4669.7665116744365;4920.360353154067;4921.975390123026;4929.704217746947;4990.700557966534;368019;406507;411804;561923;564388;60557.39442605517;60633.393666063654;60786.696066519384;60791;60865.39134608686;68402.65798670975;68803;68946.65526672435;69066.65466672635;69079.65460172767;17770;18335.816641833677;18434.723479147822;18879.716804247946;18891.43325700231;13735.587932362045;13877.028607997545;13877.722445551033;13913.026088173932;13947.302634868216;20774;20936.685949710765;21005;21052.157913683586;21083.578328433345;7579.355754760797;7634.96182519095;7718.884216736754;7746.728864489716;7810.65680295909;1039.8284283093205;1074.414444127952;1084.2410312781085;1092.983605245922;1112.7440688641495;34161;34252.486212706826;34325.14187145291;34519.654803451645;34673.826630866686;1160.1414952934936;1172.7654469106212;1179.8112302031634;1216.3127832774453;1252.6492582077033;17461.912690436722;18048.729269060976;18203.54491137732;18406.631867362845;18426.815731842777;161302;161322;161788;163301;164229;64090;64252.357476425575;64408.35591644117;64466;64472.35527644664;1438.7266419380494;1442.0986883198002;1456.9417223311161;1470.8602682745122;1474.9336279867432;32030.67969320277;34298;34620.65379346275;34914.77798277048;35746.8212658935;62750.686246568475;63613;63766.36233637604;63790;63807.680961594895;559696;563980;564457;566344;567901;48605.5139448601;48919;48982.755086224344;49439.25841112314;49716;54119;54214.457855422515;54503;54646;55360.169597455264;44997.55002450065;45766.313505296785;45995.31007034964;47063.294050588585;47083.529164707914;44947.32579011252;46537.53462465332;46943.29585056295;47407;47870;44263;44283.77858110689;44782.10435791201;44995.32507012463;45006;39401.40897886591;40636.182508449725;40731.38902916518;40948.38577421282;41013.179736404505;30394.54408183923;30509.54235686511;30963.84518077395;31251.37497250088;31612 08:33:24 INFO - PROCESS | 10471 | |2;jquery.html;402.9798510074497;408.8957315884449;415.23596582288593;417.5135966598912;426.0392814203972;19321.516962075955;20845;21333.466663333405;21926;22483.775162248374;18285.634287314246;18315.633687326244;18484.260629574834;18622.90688546559;18672.439826805185;5737.512311453521;5985.311689155759;6004.489618382421;6005.87988240235;6012.969935150318;5815.418458154172;5916.053431450969;6003;6005.729742161613;6093.634381937076;6119.479844213247;6138.47822935051;6142.385761423867;6144.41628045335;6156.56904016719;5951.107333899907;6027.5479339049525;6082.878342433127;6091.725872335755;6132.356102609228;5886.381929897342;5905.4094590541035;5924.052151655757;5942.286925568917;5942.762289508414;24670.259892203263;24702.629460558106;24968;25070.122545710812;25176.622350664755;2490.8007359411204;2536.4039450729065;2684.0337478507918;2784.09516907004;2792.5950737143203;10461.947690261575;10543.472826358728;10779.514921828537;10799.892001079967;10893.346399216072;1992.471994921347;2009.4072248686673;2014.5064459207588;2041.1937284772432;2078.937631871031;67720.66139669319;73036.63481682558;76724.61637691775;85134.57432712859;89052;10773.569057237779;11315.773684526263;11393.430328483542;11650.708732281591;11915.285082895054;16096.67806643884;16150.838491615168;16225.2698628562;16227;16263.26815293291;8166.510009399455;8198.467099638505;8605.225529702357;8664.48013119215;8757.080506546848;7785.493942893694;7872.960635196788;7917.524948502993;7947.125816160218;8409.74770756866;4818.951810481921;4858.246971719389;4911;4948.628852836052;5035.773390197377;1974.2103158736334;1997.470670272379;2010.597880423921;2014.174188582674;2053.250563544296;942.3074040580168;1038.771470276538;1055.9155267578576;1080.475969154959;1103.4813637590319;20735.792642073688;20822.479438014172;20968.790312096684;20977.68533471999;21020.369388918356;1030.6650338639822;1046.0219694585587;1063.7606538528769;1064.510325250378;1105.745678493951;11263;11336.659900203007;11557.364344961108;11572.42137893102;11576.826347604792;527187;573465;581824;596954;597317;94926;98787.50606247067;101801;102565.48717256515;103515;992.5781542844262;1040.0587468341164;1042.312074031151;1058.8782290036745;1060.4644654449453;17972.820271797114;18209.635807283514;18448.26206951707;18472.50966213689;18510.907445462686;45308.54691453043;45690.77154614338;45706.31440528328;45740;46058.76970615125;61201.38798612135;62331.68834155981;62386;62584;63532;8697.26073283778;8870.689525866565;8888.200061994452;8952.328575357005;9022;9636.566354513923;13700.45198192061;14203.076800007966;14604.561863144123;14706.41174353014;12129.696757580778;12140.878591214328;12337.383130843242;12434.378281085728;12700.428480718574;12310.630681079581;12331.445084971378;12539.49842006346;12611.747765044463;12866.163699359511;12284.508619655471;12397.814032789334;12559.748805024032;12589.24464532131;12597.43311550964;8998.55007249648;9005.864912026194;9111.271098312252;9268.073192680678;9269.212116969864;12035.819462707892;12356.691082723004;12479.126461147633;12535.24788512692;12624.621261362174 08:33:24 INFO - PROCESS | 10471 | |3;mootools.html;1554.8678362339201;1572.8898977071606;1719.6560687862432;1792.7579776730138;1847.9907600461995;8436.409451338393;9105.772355691102;9236.815263694722;9925;9937.304388692786;9332.953335233331;9694.515274236295;9701.466419346933;9716.417014979106;9746.317757756942;2395.544846479172;2428.3564855313357;2429.2469334506272;2431.4529230923076;2432.586460301744;2397.4845408237225;2419.177479656916;2438.9024439022505;2452.938676533092;2454.840435371704;2399.796017338528;2421.794147497465;2437.1591800828687;2446.4984678141027;2471.270975062361;2375.95248095038;2376.5246950609862;2388.7133543974833;2400.243923164198;2427.5144971005693;2369.609014512603;2384.475415408607;2399.664047033417;2402.531506356261;2408.542376948374;9572.282078844115;9744.415335079917;9779.902200977971;9782.41305521671;9818.214542836557;5436.293281873332;5590.91613625796;5603.803866864681;5607.831765047055;5610.719464026783;3537;3625.492431059654;3661.743677942545;3685.060309621056;3707.1473561080834;1258.4211262819115;1261.4575732435048;1267.9556215532411;1271.262667652759;1273.2487832179058;13476.797848032287;13540.390682419216;13576.796348054788;13687.520936767265;13706.794398084037;4560.293154561048;4584.312353147055;4707.646926480459;4742.5020372861045;4799.3041009053495;10450.738731531772;10463.68608941733;10533.36799792015;10538.473076346152;10563.894361056291;5583.916241256385;5608.4111168326735;5644.350899646511;5649.802256920988;5654.293213348332;4491.910161796745;5073.9746301269;5104.3619547556555;5184.455632158569;5259.47405259471;4138.8551400700835;4184.853530126492;4262.0836520147695;4272.4873015237745;4277.850275240352;1204.0728638948135;1240.5347994502063;1241.6838151559375;1245.9377031148588;1252.3174869695856;885.9911400886037;1015.1422048369117;1021.0759262867117;1026.7895081508273;1027.3989716016065;5904.143899134601;6067.484263837535;6110.908336374958;6164.815055548341;6394.968025159845;455.2738382280258;459.40277639069075;461.74603967817563;466.1190350238053;466.2027932235847;4191.874243772691;4281;4559.908801824011;4625.3755742974945;4762.666613337103;12308.384580770926;12385.318807465675;12468.688282793002;12484.937575312248;12574.748505029847;11293.661190164308;11877.227980181433;12026.75946481083;12073.27560346382;12128.151029427856;8820.162084601952;8863.335249856158;9009.459432433943;9030.999999999869;9046.86429703555;6503.447206987459;6535.640539770358;6597.472202223715;6725.226598940989;6755.088063111417;10716.892831071902;10902.182336324966;10952;11034.779304413707;11261.7747645045;11420.657380278604;11452.198346115692;11544.538218471167;11556.24884382546;11630.70923226926;8515.276201522693;8687.087855775053;8703.390762646553;8716.38985271025;8761.211490965843;9256.95371523138;9303.627854885728;9401.153896149106;9403.388779729295;9429.811403772022;8439.915600843913;8471.025832029149;8587.699430519902;8684.652613895627;8686.174813392718;7782.571958542108;8150.4294699370475;8153.470024448629;8199.59002049907;8243.546604936786;7189.1013623297085;7301.963490182515;7322.560646361236;7327.8534429312185;7336.7065317386705;5700.458456446631;5724.141378793214;5812.5349972001295;5912.113183022581;5920.348761636303;5569.220309156641;5644;5725.2843394575675;5780.479756821906;5811.1573821794755 08:33:24 INFO - PROCESS | 10471 | |4;prototype.html;327.81806097615816;329.89443378118995;330.85111699735097;332.8053088942967;341.5338063543263;5812.767489300428;5852.67810270435;5871.266091738533;5896.911546326804;5907.40925907409;5713.285839270091;5746.109353050273;5753.424657534244;5754.65472071676;5806.419358064202;4271.615554600093;4335.934960975588;4431.911361772763;4479.552044795527;4486.641068714495;4457.710248833831;4465.955340446587;4509.571590698878;4514.119746649389;4522.547745225467;4485.798139083749;4497.2129877271345;4501.977490112545;4538.682292239545;4544.272916333387;4370.519242883281;4402.3836662867225;4424.314231294123;4439.933400998988;4456.19788438081;3927.8232479538487;3935.8425662973445;3936.4292177634084;3946.6842652587725;3950.249452603996;5586.798838249796;5607.869009776259;5620.971895140498;5642.746076426571;5650.858728531778;5049.267856160836;5079.79680812767;5103.56619687327;5124.8981468983975;5218.634695571312;5917.491039784871;5945.305587907425;5985;6023.909641355383;6024.849378765566;4318.114786468766;4393.428854248928;4405.977970110161;4425.314076318144;4426.247537918562;6202.317745048041;6206.751729930797;6215.844603884894;6251.812445626684;6344.524160687967;4379.934300985487;4441.733495990251;4446.244138496463;4456.131054444352;4456.9108617828115;4319.352097185448;4428.778561071934;4433.246348120827;4442.489553551808;4478.373027776114;5041.546260836469;5073.416557095981;5096.133657278272;5134.306868572769;5162.070827251131;5998.580099393088;6009.549283803733;6027.246594175728;6052.848678783065;6078.240219972504;1440.3950340856866;1513.8713209377106;1534.7084054029922;1545.7835902973593;1557.0346385241223;928.3965422475445;953.1136043479491;964.4791812421214;1001.62439085343;1031.9587216511406;5823.883522329615;5831.241938548046;5863.413658634187;5875;5891.263592050994;6139;6153.261608606996;6194.907076393858;6201.844953876189;6242.157308763259;5712.685802280831;5761.8559536011935;5821.7380217890295;5829.76680932758;5838.32859221195;3280.671932806748;3281.425750493654;3283.5567198428384;3291.835408229579;3299.5710557627353;6174.598651087665;6315.96842015787;6322.336154703782;6383.170187875547;6401.743930242831;6171.259448866164;6186.350433204539;6225.202626397893;6275.529335299871;6282;6063.575549711478;6357.904631430532;6364.7135878885565;6387.265464471552;6414.390632889868;6100.847478813065;6186.597871138361;6212.347703491249;6224.9377506224355;6257.28041275241;6090.9390906090375;6117.908231376622;6119.265688117454;6123.785667501795;6176.258848938156;6304.873902521832;6379.266384365672;6462.709178086903;6485.54601177913;6506.41442270198;4439.955600443955;4448.888777780581;4493.348464472699;4526.275795872644;4530.592246697681;5977.22296101504;6227.906581401192;6303.9684801575695;6326.1021693492685;6391.201099862517;6107.389261074035;6137.943788830613;6145.108959200801;6168.9691551541955;6176.938230617816;6095.847603809941;6113.969430152999;6156.230471191101;6192.164057852132;6211.2857021443115;5731.3122425307565;5966.373530779206;6059.3637668045985;6096.420840020191;6124.510039196943;6152.907706384318;6168.444839964424;6180.134781130555;6180.845478863064;6199.690015499297;5898.439648233411;6012.759489620366;6033.43578978941;6069.2110025696375;6070.757169713162 08:33:24 INFO - PROCESS | 10471 | |5;yui.html;800.2957397490208;822.5434883639581;875.4965894610599;886.4238245140662;909.3245300175935;14679.339429725662;15413.383464661414;15558.844411555881;15658.451954181606;15928.12395318257;14647.633809154777;14736.263186840668;14745.705085898302;14810.333534990925;14840.109593424402;835.761807884753;846.0693237438799;851.4465597361733;853.5220276645099;857.2199298638241;848.5248260973843;859.6948083430386;865.9826803463927;869.8129902071054;871.8692196170593;916.2715641065336;918.5361392496814;918.9523942705288;919.7194855569048;922.7462447826834;905.7735566108473;908.6410867707252;910.635745701718;912.5847739278612;914.049388635818;668.2582333609689;671.8286836856619;674.8515326628134;675.7060678604822;675.8715843989626;14519.564413067625;14528.564143075724;14553.345099470444;14572.781408278885;14598.854011459856;16111.677766444722;16264.994384869971;16303.184840757915;16394.590135246595;16459.177041147894;13079.542216022488;13290.933545332211;13313.26777027263;13377.130486518443;13442.32788360578;3950.881473555798;3958.8614398495915;3971.344728119857;4070.531888832763;4071.124708187724;71783.28216717819;76546.61726691331;93088.53455732745;93261.5336923311;93592;12511.061670374576;12625.368731563569;12755.553555625509;12769.61691149267;12894.871051289554;22561.4359641007;22632;22842.657360139612;22879.19922802727;22910.65634015458;9283.39657922233;9345.626174952926;9349.756058546036;9454.243660507143;9768.853467197998;4893.314935908976;5208.739563021833;5272.420033796279;5323.760430780624;5355.410904800468;4001.199760048002;4124.9587504125175;4131.132462182915;4140.482439695038;4161.188568229227;694.3577191098213;695.5861262548876;697.5744795674634;711.0756017177648;713.4470785141453;706.1314583062862;766.7393086350668;779.3492433817712;780.3990926986189;800.0918956983866;10413.53139108742;11254.831177532344;11282.661520154408;11308.321500709984;11691.356975366436;787.3111027850631;795.769226924197;821.34292565947;835.6114406800867;845.9746207613781;5151.793928242903;5172.9096625112725;5213.817516386908;5232.319798426181;5250.107481728115;83281.58359208287;85125;102027.48986255021;145037;151434;96362;98316.50841745888;120203;126759;127089.36455317664;57771;58687;59953.400465995655;88469;95605;10080.495975201356;11250.66248012561;11415.143864210384;11471.541138354707;11666;41631;54310.72844635751;54339;54686;55575.444245557024;82410.17589824265;87508.5624571873;87571.1242887563;88159;89514.55242723745;11674.474648640662;11847.644570662895;11864.584739534075;12327.93836030814;12600.936995315331;14073.718525629634;14287.142771433748;15870.20648967524;16861.66276674435;18162.636747265246;15220;15240.618984525476;15673.373065077269;16094.195290235208;16296;14618.561443156723;15239.68328457462;15292.311845966735;15675.372985080468;15843.762343565086;14390.712185756436;14834.07157069574;15043.548693539211;15097.849021509644;15411.845881541489;12540.184887982252;12677.429515671633;13084.28036458004;13239.20564766117;13420.993425492932;9451.385659932082;9933.205343572641;10389.9480502597;10431.58273669075;10463.476826158814 08:33:24 INFO - PROCESS | 10471 | __end_tp_report 08:33:24 INFO - PROCESS | 10471 | __start_cc_report 08:33:24 INFO - PROCESS | 10471 | _x_x_mozilla_cycle_collect,351 08:33:24 INFO - PROCESS | 10471 | __end_cc_report 08:33:24 INFO - PROCESS | 10471 | __startTimestamp1473694404759__endTimestamp 08:33:24 INFO - PROCESS | 10471 | 08:33:24 INFO - PROCESS | 10471 | ------- Summary: start ------- 08:33:24 INFO - PROCESS | 10471 | Number of tests: 6 08:33:24 INFO - PROCESS | 10471 | 08:33:24 INFO - PROCESS | 10471 | [#0] dojo.html Cycles:165 Average:5789.68 Median:6023.79 stddev:670.99 (11.1%) stddev-sans-first:643.34 08:33:24 INFO - PROCESS | 10471 | Values: 3272.7 3302.0 3303.8 3304.3 3311.8 5692.8 5697.9 5705.6 5724.2 5724.4 5763.9 5775.4 5796.9 5819.2 5840.0 5171.0 5259.8 5295.5 5333.4 5335.7 5239.9 5254.4 5260.5 5313.5 5337.6 5287.0 5302.3 5324.6 5350.6 5441.5 5398.1 5426.9 5437.5 5444.6 5445.3 5096.0 5194.7 5202.0 5331.3 5336.0 5647.3 5714.1 5773.9 5814.3 5872.9 6254.0 6268.7 6299.1 6311.1 6320.6 6061.2 6271.2 6274.4 6316.2 6328.2 5783.2 5791.2 5883.0 5888.4 5895.8 6348.6 6371.0 6388.1 6419.6 6443.4 5881.3 6138.4 6151.6 6151.7 6155.8 6117.1 6142.9 6222.1 6306.0 6306.7 6237.3 6257.2 6265.9 6294.7 6296.6 6053.9 6212.5 6250.4 6270.2 6274.9 4727.4 4744.1 4750.2 4755.3 4834.7 4207.0 4251.4 4252.1 4267.6 4297.3 5827.5 6036.8 6039.1 6047.8 6067.1 6143.4 6187.3 6202.8 6288.8 6320.6 6020.9 6059.0 6070.2 6075.0 6075.4 5178.5 5335.2 5347.8 5353.0 5359.8 6392.6 6451.3 6476.3 6536.2 6547.9 6267.1 6272.4 6275.3 6281.3 6298.9 6176.0 6483.7 6508.8 6556.1 6560.0 6105.5 6137.8 6140.9 6229.0 6232.2 6278.7 6282.9 6285.7 6289.2 6297.1 5833.5 6110.8 6111.4 6116.9 6121.8 5954.9 5968.6 5988.2 5989.3 6079.8 6001.8 6021.7 6023.8 6033.4 6038.3 5947.6 5970.1 6013.3 6042.6 6063.4 5895.0 5908.2 5944.5 6003.5 6048.0 08:33:24 INFO - PROCESS | 10471 | 08:33:24 INFO - PROCESS | 10471 | [#1] ext.html Cycles:180 Average:59393.80 Median:25754.65 stddev:115973.64 (450.3%) stddev-sans-first:116214.91 08:33:24 INFO - PROCESS | 10471 | Values: 579.8 638.1 643.8 659.4 709.1 40926.2 46597.1 46839.5 46884.3 47158.3 46994.0 47260.5 47307.0 47424.5 47561.0 9123.6 9240.1 9251.2 9254.4 9262.6 9059.2 9124.7 9139.9 9205.5 9209.2 9203.8 9222.2 9257.0 9259.7 9275.0 9116.1 9207.3 9207.6 9212.1 9220.5 9171.4 9180.3 9210.6 9220.5 9244.3 43976.8 44566.6 44618.6 44847.0 44866.6 3193.6 3768.3 3938.3 4287.9 4441.3 32811.0 33580.3 33604.8 34378.8 35327.0 4669.8 4920.4 4922.0 4929.7 4990.7 368019.0 406507.0 411804.0 561923.0 564388.0 60557.4 60633.4 60786.7 60791.0 60865.4 68402.7 68803.0 68946.7 69066.7 69079.7 17770.0 18335.8 18434.7 18879.7 18891.4 13735.6 13877.0 13877.7 13913.0 13947.3 20774.0 20936.7 21005.0 21052.2 21083.6 7579.4 7635.0 7718.9 7746.7 7810.7 1039.8 1074.4 1084.2 1093.0 1112.7 34161.0 34252.5 34325.1 34519.7 34673.8 1160.1 1172.8 1179.8 1216.3 1252.6 17461.9 18048.7 18203.5 18406.6 18426.8 161302.0 161322.0 161788.0 163301.0 164229.0 64090.0 64252.4 64408.4 64466.0 64472.4 1438.7 1442.1 1456.9 1470.9 1474.9 32030.7 34298.0 34620.7 34914.8 35746.8 62750.7 63613.0 63766.4 63790.0 63807.7 559696.0 563980.0 564457.0 566344.0 567901.0 48605.5 48919.0 48982.8 49439.3 49716.0 54119.0 54214.5 54503.0 54646.0 55360.2 44997.6 45766.3 45995.3 47063.3 47083.5 44947.3 46537.5 46943.3 47407.0 47870.0 44263.0 44283.8 44782.1 44995.3 45006.0 39401.4 40636.2 40731.4 40948.4 41013.2 30394.5 30509.5 30963.8 31251.4 31612.0 08:33:24 INFO - PROCESS | 10471 | 08:33:24 INFO - PROCESS | 10471 | [#2] jquery.html Cycles:180 Average:32180.54 Median:24686.44 stddev:94663.45 (383.5%) stddev-sans-first:94898.93 08:33:24 INFO - PROCESS | 10471 | Values: 403.0 408.9 415.2 417.5 426.0 19321.5 20845.0 21333.5 21926.0 22483.8 18285.6 18315.6 18484.3 18622.9 18672.4 5737.5 5985.3 6004.5 6005.9 6013.0 5815.4 5916.1 6003.0 6005.7 6093.6 6119.5 6138.5 6142.4 6144.4 6156.6 5951.1 6027.5 6082.9 6091.7 6132.4 5886.4 5905.4 5924.1 5942.3 5942.8 24670.3 24702.6 24968.0 25070.1 25176.6 2490.8 2536.4 2684.0 2784.1 2792.6 10461.9 10543.5 10779.5 10799.9 10893.3 1992.5 2009.4 2014.5 2041.2 2078.9 67720.7 73036.6 76724.6 85134.6 89052.0 10773.6 11315.8 11393.4 11650.7 11915.3 16096.7 16150.8 16225.3 16227.0 16263.3 8166.5 8198.5 8605.2 8664.5 8757.1 7785.5 7873.0 7917.5 7947.1 8409.7 4819.0 4858.2 4911.0 4948.6 5035.8 1974.2 1997.5 2010.6 2014.2 2053.3 942.3 1038.8 1055.9 1080.5 1103.5 20735.8 20822.5 20968.8 20977.7 21020.4 1030.7 1046.0 1063.8 1064.5 1105.7 11263.0 11336.7 11557.4 11572.4 11576.8 527187.0 573465.0 581824.0 596954.0 597317.0 94926.0 98787.5 101801.0 102565.5 103515.0 992.6 1040.1 1042.3 1058.9 1060.5 17972.8 18209.6 18448.3 18472.5 18510.9 45308.5 45690.8 45706.3 45740.0 46058.8 61201.4 62331.7 62386.0 62584.0 63532.0 8697.3 8870.7 8888.2 8952.3 9022.0 9636.6 13700.5 14203.1 14604.6 14706.4 12129.7 12140.9 12337.4 12434.4 12700.4 12310.6 12331.4 12539.5 12611.7 12866.2 12284.5 12397.8 12559.7 12589.2 12597.4 8998.6 9005.9 9111.3 9268.1 9269.2 12035.8 12356.7 12479.1 12535.2 12624.6 08:33:24 INFO - PROCESS | 10471 | 08:33:24 INFO - PROCESS | 10471 | [#3] mootools.html Cycles:180 Average:6273.89 Median:2521.86 stddev:3676.02 (145.8%) stddev-sans-first:3669.23 08:33:24 INFO - PROCESS | 10471 | Values: 1554.9 1572.9 1719.7 1792.8 1848.0 8436.4 9105.8 9236.8 9925.0 9937.3 9333.0 9694.5 9701.5 9716.4 9746.3 2395.5 2428.4 2429.2 2431.5 2432.6 2397.5 2419.2 2438.9 2452.9 2454.8 2399.8 2421.8 2437.2 2446.5 2471.3 2376.0 2376.5 2388.7 2400.2 2427.5 2369.6 2384.5 2399.7 2402.5 2408.5 9572.3 9744.4 9779.9 9782.4 9818.2 5436.3 5590.9 5603.8 5607.8 5610.7 3537.0 3625.5 3661.7 3685.1 3707.1 1258.4 1261.5 1268.0 1271.3 1273.2 13476.8 13540.4 13576.8 13687.5 13706.8 4560.3 4584.3 4707.6 4742.5 4799.3 10450.7 10463.7 10533.4 10538.5 10563.9 5583.9 5608.4 5644.4 5649.8 5654.3 4491.9 5074.0 5104.4 5184.5 5259.5 4138.9 4184.9 4262.1 4272.5 4277.9 1204.1 1240.5 1241.7 1245.9 1252.3 886.0 1015.1 1021.1 1026.8 1027.4 5904.1 6067.5 6110.9 6164.8 6395.0 455.3 459.4 461.7 466.1 466.2 4191.9 4281.0 4559.9 4625.4 4762.7 12308.4 12385.3 12468.7 12484.9 12574.7 11293.7 11877.2 12026.8 12073.3 12128.2 8820.2 8863.3 9009.5 9031.0 9046.9 6503.4 6535.6 6597.5 6725.2 6755.1 10716.9 10902.2 10952.0 11034.8 11261.8 11420.7 11452.2 11544.5 11556.2 11630.7 8515.3 8687.1 8703.4 8716.4 8761.2 9257.0 9303.6 9401.2 9403.4 9429.8 8439.9 8471.0 8587.7 8684.7 8686.2 7782.6 8150.4 8153.5 8199.6 8243.5 7189.1 7302.0 7322.6 7327.9 7336.7 5700.5 5724.1 5812.5 5912.1 5920.3 5569.2 5644.0 5725.3 5780.5 5811.2 08:33:24 INFO - PROCESS | 10471 | 08:33:24 INFO - PROCESS | 10471 | [#4] prototype.html Cycles:180 Average:5097.89 Median:5845.50 stddev:1511.71 (25.9%) stddev-sans-first:1472.95 08:33:24 INFO - PROCESS | 10471 | Values: 327.8 329.9 330.9 332.8 341.5 5812.8 5852.7 5871.3 5896.9 5907.4 5713.3 5746.1 5753.4 5754.7 5806.4 4271.6 4335.9 4431.9 4479.6 4486.6 4457.7 4466.0 4509.6 4514.1 4522.5 4485.8 4497.2 4502.0 4538.7 4544.3 4370.5 4402.4 4424.3 4439.9 4456.2 3927.8 3935.8 3936.4 3946.7 3950.2 5586.8 5607.9 5621.0 5642.7 5650.9 5049.3 5079.8 5103.6 5124.9 5218.6 5917.5 5945.3 5985.0 6023.9 6024.8 4318.1 4393.4 4406.0 4425.3 4426.2 6202.3 6206.8 6215.8 6251.8 6344.5 4379.9 4441.7 4446.2 4456.1 4456.9 4319.4 4428.8 4433.2 4442.5 4478.4 5041.5 5073.4 5096.1 5134.3 5162.1 5998.6 6009.5 6027.2 6052.8 6078.2 1440.4 1513.9 1534.7 1545.8 1557.0 928.4 953.1 964.5 1001.6 1032.0 5823.9 5831.2 5863.4 5875.0 5891.3 6139.0 6153.3 6194.9 6201.8 6242.2 5712.7 5761.9 5821.7 5829.8 5838.3 3280.7 3281.4 3283.6 3291.8 3299.6 6174.6 6316.0 6322.3 6383.2 6401.7 6171.3 6186.4 6225.2 6275.5 6282.0 6063.6 6357.9 6364.7 6387.3 6414.4 6100.8 6186.6 6212.3 6224.9 6257.3 6090.9 6117.9 6119.3 6123.8 6176.3 6304.9 6379.3 6462.7 6485.5 6506.4 4440.0 4448.9 4493.3 4526.3 4530.6 5977.2 6227.9 6304.0 6326.1 6391.2 6107.4 6137.9 6145.1 6169.0 6176.9 6095.8 6114.0 6156.2 6192.2 6211.3 5731.3 5966.4 6059.4 6096.4 6124.5 6152.9 6168.4 6180.1 6180.8 6199.7 5898.4 6012.8 6033.4 6069.2 6070.8 08:33:24 INFO - PROCESS | 10471 | 08:33:24 INFO - PROCESS | 10471 | [#5] yui.html Cycles:180 Average:21905.42 Median:4128.05 stddev:31878.66 (772.2%) stddev-sans-first:31928.70 08:33:24 INFO - PROCESS | 10471 | Values: 800.3 822.5 875.5 886.4 909.3 14679.3 15413.4 15558.8 15658.5 15928.1 14647.6 14736.3 14745.7 14810.3 14840.1 835.8 846.1 851.4 853.5 857.2 848.5 859.7 866.0 869.8 871.9 916.3 918.5 919.0 919.7 922.7 905.8 908.6 910.6 912.6 914.0 668.3 671.8 674.9 675.7 675.9 14519.6 14528.6 14553.3 14572.8 14598.9 16111.7 16265.0 16303.2 16394.6 16459.2 13079.5 13290.9 13313.3 13377.1 13442.3 3950.9 3958.9 3971.3 4070.5 4071.1 71783.3 76546.6 93088.5 93261.5 93592.0 12511.1 12625.4 12755.6 12769.6 12894.9 22561.4 22632.0 22842.7 22879.2 22910.7 9283.4 9345.6 9349.8 9454.2 9768.9 4893.3 5208.7 5272.4 5323.8 5355.4 4001.2 4125.0 4131.1 4140.5 4161.2 694.4 695.6 697.6 711.1 713.4 706.1 766.7 779.3 780.4 800.1 10413.5 11254.8 11282.7 11308.3 11691.4 787.3 795.8 821.3 835.6 846.0 5151.8 5172.9 5213.8 5232.3 5250.1 83281.6 85125.0 102027.5 145037.0 151434.0 96362.0 98316.5 120203.0 126759.0 127089.4 57771.0 58687.0 59953.4 88469.0 95605.0 10080.5 11250.7 11415.1 11471.5 11666.0 41631.0 54310.7 54339.0 54686.0 55575.4 82410.2 87508.6 87571.1 88159.0 89514.6 11674.5 11847.6 11864.6 12327.9 12600.9 14073.7 14287.1 15870.2 16861.7 18162.6 15220.0 15240.6 15673.4 16094.2 16296.0 14618.6 15239.7 15292.3 15675.4 15843.8 14390.7 14834.1 15043.5 15097.8 15411.8 12540.2 12677.4 13084.3 13239.2 13421.0 9451.4 9933.2 10389.9 10431.6 10463.5 08:33:24 INFO - PROCESS | 10471 | -------- Summary: end -------- 08:33:24 INFO - PROCESS | 10471 | 08:33:25 INFO - TEST-INFO | 10471: exit 0 08:33:25 INFO - TEST-OK | dromaeo_css | took 1111147ms 08:33:25 INFO - TEST-START | kraken 08:33:25 INFO - operating with platform_type : linux_ 08:33:25 INFO - Initialising browser for kraken test... 08:33:25 INFO - TEST-INFO | started process 10730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp44InQg/profile http://localhost:59279/getInfo.html) 08:33:29 INFO - PROCESS | 10730 | __metrics Screen width/height:1600/1200 08:33:29 INFO - PROCESS | 10730 | colorDepth:24 08:33:29 INFO - PROCESS | 10730 | Browser inner width/height: 1024/697 08:33:29 INFO - PROCESS | 10730 | __metrics 08:33:30 ERROR - PROCESS | 10730 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 08:33:31 INFO - TEST-INFO | 10730: exit 0 08:33:31 INFO - Browser initialized. 08:33:31 INFO - Running cycle 1/1 for kraken test... 08:33:31 INFO - TEST-INFO | started process 10854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp44InQg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:43 INFO - PROCESS | 10854 | RSS: Main: 152666112 08:33:43 INFO - PROCESS | 10854 | 08:33:45 INFO - PROCESS | 10854 | Cycle 1(1): loaded http://localhost:59279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59279/tests/kraken/driver.html?testName=audio-beat-detection) 08:33:46 INFO - PROCESS | 10854 | RSS: Main: 158138368 08:33:46 INFO - PROCESS | 10854 | 08:33:49 INFO - PROCESS | 10854 | Cycle 1(1): loaded http://localhost:59279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59279/tests/kraken/driver.html?testName=audio-dft) 08:33:49 INFO - PROCESS | 10854 | RSS: Main: 156188672 08:33:49 INFO - PROCESS | 10854 | 08:33:52 INFO - PROCESS | 10854 | Cycle 1(1): loaded http://localhost:59279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59279/tests/kraken/driver.html?testName=audio-fft) 08:33:53 INFO - PROCESS | 10854 | RSS: Main: 157184000 08:33:53 INFO - PROCESS | 10854 | 08:33:55 INFO - PROCESS | 10854 | Cycle 1(1): loaded http://localhost:59279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59279/tests/kraken/driver.html?testName=audio-oscillator) 08:33:55 INFO - PROCESS | 10854 | RSS: Main: 156737536 08:33:55 INFO - PROCESS | 10854 | 08:33:58 INFO - PROCESS | 10854 | Cycle 1(1): loaded http://localhost:59279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:33:58 INFO - PROCESS | 10854 | RSS: Main: 157171712 08:33:58 INFO - PROCESS | 10854 | 08:34:01 INFO - PROCESS | 10854 | Cycle 1(1): loaded http://localhost:59279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59279/tests/kraken/driver.html?testName=imaging-darkroom) 08:34:02 INFO - PROCESS | 10854 | RSS: Main: 156352512 08:34:02 INFO - PROCESS | 10854 | 08:34:05 INFO - PROCESS | 10854 | Cycle 1(1): loaded http://localhost:59279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59279/tests/kraken/driver.html?testName=imaging-desaturate) 08:34:06 INFO - PROCESS | 10854 | RSS: Main: 154963968 08:34:06 INFO - PROCESS | 10854 | 08:34:09 INFO - PROCESS | 10854 | Cycle 1(1): loaded http://localhost:59279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59279/tests/kraken/driver.html?testName=json-parse-financial) 08:34:10 INFO - PROCESS | 10854 | RSS: Main: 156577792 08:34:10 INFO - PROCESS | 10854 | 08:34:11 INFO - PROCESS | 10854 | Cycle 1(1): loaded http://localhost:59279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:34:12 INFO - PROCESS | 10854 | RSS: Main: 156815360 08:34:12 INFO - PROCESS | 10854 | 08:34:13 INFO - PROCESS | 10854 | Cycle 1(1): loaded http://localhost:59279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59279/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:34:14 INFO - PROCESS | 10854 | RSS: Main: 157089792 08:34:14 INFO - PROCESS | 10854 | 08:34:16 INFO - PROCESS | 10854 | Cycle 1(1): loaded http://localhost:59279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:34:17 INFO - PROCESS | 10854 | RSS: Main: 157872128 08:34:17 INFO - PROCESS | 10854 | 08:34:19 INFO - PROCESS | 10854 | Cycle 1(1): loaded http://localhost:59279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:20 INFO - PROCESS | 10854 | RSS: Main: 157687808 08:34:20 INFO - PROCESS | 10854 | 08:34:23 INFO - PROCESS | 10854 | Cycle 1(1): loaded http://localhost:59279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:34:23 INFO - PROCESS | 10854 | RSS: Main: 157667328 08:34:23 INFO - PROCESS | 10854 | 08:34:25 INFO - PROCESS | 10854 | Cycle 1(1): loaded http://localhost:59279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59279/tests/kraken/driver.html?testName=ai-astar) 08:34:25 INFO - PROCESS | 10854 | RSS: Main: 158244864 08:34:25 INFO - PROCESS | 10854 | 08:34:25 INFO - PROCESS | 10854 | __start_tp_report 08:34:25 INFO - PROCESS | 10854 | _x_x_mozilla_page_load 08:34:25 INFO - PROCESS | 10854 | _x_x_mozilla_page_load_details 08:34:25 INFO - PROCESS | 10854 | |i|pagename|runs| 08:34:25 INFO - PROCESS | 10854 | |0;ai-astar;100;111;105;111;110;111;110;111;109;111 08:34:25 INFO - PROCESS | 10854 | |1;audio-beat-detection;141;118;151;168;118;146;148;117;188;116 08:34:25 INFO - PROCESS | 10854 | |2;audio-dft;163;173;164;162;164;164;162;162;163;164 08:34:25 INFO - PROCESS | 10854 | |3;audio-fft;75;75;76;178;76;76;75;75;173;77 08:34:25 INFO - PROCESS | 10854 | |4;audio-oscillator;84;86;149;83;83;84;140;83;84;139 08:34:25 INFO - PROCESS | 10854 | |5;imaging-gaussian-blur;117;118;117;117;117;117;118;117;117;119 08:34:25 INFO - PROCESS | 10854 | |6;imaging-darkroom;148;147;146;147;147;148;147;148;148;147 08:34:25 INFO - PROCESS | 10854 | |7;imaging-desaturate;97;96;95;96;96;95;95;97;95;95 08:34:25 INFO - PROCESS | 10854 | |8;json-parse-financial;56;52;52;51;51;53;52;51;52;52 08:34:25 INFO - PROCESS | 10854 | |9;json-stringify-tinderbox;62;62;66;62;61;61;61;61;61;61 08:34:25 INFO - PROCESS | 10854 | |10;stanford-crypto-aes;81;73;73;74;72;71;76;73;73;72 08:34:25 INFO - PROCESS | 10854 | |11;stanford-crypto-ccm;133;130;119;118;127;119;128;120;152;130 08:34:25 INFO - PROCESS | 10854 | |12;stanford-crypto-pbkdf2;156;154;159;154;152;151;160;155;153;156 08:34:25 INFO - PROCESS | 10854 | |13;stanford-crypto-sha256-iterative;63;63;62;61;61;61;62;61;60;61 08:34:25 INFO - PROCESS | 10854 | __end_tp_report 08:34:25 INFO - PROCESS | 10854 | __start_cc_report 08:34:25 INFO - PROCESS | 10854 | _x_x_mozilla_cycle_collect,891 08:34:25 INFO - PROCESS | 10854 | __end_cc_report 08:34:25 INFO - PROCESS | 10854 | __startTimestamp1473694465652__endTimestamp 08:34:25 INFO - PROCESS | 10854 | 08:34:25 INFO - PROCESS | 10854 | ------- Summary: start ------- 08:34:25 INFO - PROCESS | 10854 | Number of tests: 14 08:34:25 INFO - PROCESS | 10854 | 08:34:25 INFO - PROCESS | 10854 | [#0] ai-astar Cycles:10 Average:108.90 Median:111.00 stddev:3.63 (3.3%) stddev-sans-first:1.96 08:34:25 INFO - PROCESS | 10854 | Values: 100.0 111.0 105.0 111.0 110.0 111.0 110.0 111.0 109.0 111.0 08:34:25 INFO - PROCESS | 10854 | 08:34:25 INFO - PROCESS | 10854 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:147.00 stddev:24.43 (16.6%) stddev-sans-first:25.91 08:34:25 INFO - PROCESS | 10854 | Values: 141.0 118.0 151.0 168.0 118.0 146.0 148.0 117.0 188.0 116.0 08:34:25 INFO - PROCESS | 10854 | 08:34:25 INFO - PROCESS | 10854 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:3.25 (2.0%) stddev-sans-first:3.42 08:34:25 INFO - PROCESS | 10854 | Values: 163.0 173.0 164.0 162.0 164.0 164.0 162.0 162.0 163.0 164.0 08:34:25 INFO - PROCESS | 10854 | 08:34:25 INFO - PROCESS | 10854 | [#3] audio-fft Cycles:10 Average:95.60 Median:75.50 stddev:42.13 (55.8%) stddev-sans-first:44.02 08:34:25 INFO - PROCESS | 10854 | Values: 75.0 75.0 76.0 178.0 76.0 76.0 75.0 75.0 173.0 77.0 08:34:25 INFO - PROCESS | 10854 | 08:34:25 INFO - PROCESS | 10854 | [#4] audio-oscillator Cycles:10 Average:101.50 Median:83.50 stddev:28.54 (34.2%) stddev-sans-first:29.56 08:34:25 INFO - PROCESS | 10854 | Values: 84.0 86.0 149.0 83.0 83.0 84.0 140.0 83.0 84.0 139.0 08:34:25 INFO - PROCESS | 10854 | 08:34:25 INFO - PROCESS | 10854 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 08:34:25 INFO - PROCESS | 10854 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 119.0 08:34:25 INFO - PROCESS | 10854 | 08:34:25 INFO - PROCESS | 10854 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 08:34:25 INFO - PROCESS | 10854 | Values: 148.0 147.0 146.0 147.0 147.0 148.0 147.0 148.0 148.0 147.0 08:34:25 INFO - PROCESS | 10854 | 08:34:25 INFO - PROCESS | 10854 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.73 08:34:25 INFO - PROCESS | 10854 | Values: 97.0 96.0 95.0 96.0 96.0 95.0 95.0 97.0 95.0 95.0 08:34:25 INFO - PROCESS | 10854 | 08:34:25 INFO - PROCESS | 10854 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.00 stddev:1.48 (2.8%) stddev-sans-first:0.67 08:34:25 INFO - PROCESS | 10854 | Values: 56.0 52.0 52.0 51.0 51.0 53.0 52.0 51.0 52.0 52.0 08:34:25 INFO - PROCESS | 10854 | 08:34:25 INFO - PROCESS | 10854 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:61.50 stddev:1.55 (2.5%) stddev-sans-first:1.64 08:34:25 INFO - PROCESS | 10854 | Values: 62.0 62.0 66.0 62.0 61.0 61.0 61.0 61.0 61.0 61.0 08:34:25 INFO - PROCESS | 10854 | 08:34:25 INFO - PROCESS | 10854 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:73.00 stddev:2.86 (3.9%) stddev-sans-first:1.41 08:34:25 INFO - PROCESS | 10854 | Values: 81.0 73.0 73.0 74.0 72.0 71.0 76.0 73.0 73.0 72.0 08:34:25 INFO - PROCESS | 10854 | 08:34:25 INFO - PROCESS | 10854 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:129.00 stddev:10.19 (7.9%) stddev-sans-first:10.62 08:34:25 INFO - PROCESS | 10854 | Values: 133.0 130.0 119.0 118.0 127.0 119.0 128.0 120.0 152.0 130.0 08:34:25 INFO - PROCESS | 10854 | 08:34:25 INFO - PROCESS | 10854 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.00 Median:155.50 stddev:2.87 (1.8%) stddev-sans-first:3.02 08:34:25 INFO - PROCESS | 10854 | Values: 156.0 154.0 159.0 154.0 152.0 151.0 160.0 155.0 153.0 156.0 08:34:25 INFO - PROCESS | 10854 | 08:34:25 INFO - PROCESS | 10854 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.50 stddev:0.97 (1.6%) stddev-sans-first:0.87 08:34:25 INFO - PROCESS | 10854 | Values: 63.0 63.0 62.0 61.0 61.0 61.0 62.0 61.0 60.0 61.0 08:34:25 INFO - PROCESS | 10854 | -------- Summary: end -------- 08:34:25 INFO - PROCESS | 10854 | 08:34:26 INFO - TEST-INFO | 10854: exit 0 08:34:26 INFO - TEST-OK | kraken | took 61194ms 08:34:26 INFO - SUITE-END | took 1172s 08:34:26 INFO - Completed test suite (00:19:32) 08:34:26 INFO - javascript benchmark 08:34:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7769.726368452345, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3272.6727327267276, 3302.009397180846, 3303.834808259588, 3304.2895777407853, 3311.8178500182494, 5692.800751973682, 5697.857553561163, 5705.600607957439, 5724.169995350677, 5724.398938111501, 5763.884722305552, 5775.364709881909, 5796.942030579704, 5819.214406055181, 5839.970800146004, 5171.0, 5259.815906443275, 5295.4704529547125, 5333.38666053403, 5335.653182543142, 5239.947600524003, 5254.369475662926, 5260.473952604728, 5313.548348390392, 5337.572994160477, 5286.973565132169, 5302.257683924254, 5324.600654950875, 5350.598705097113, 5441.483059109398, 5398.082326004589, 5426.941746359481, 5437.510624043815, 5444.646098003617, 5445.264889239941, 5096.031753966735, 5194.662346947436, 5201.973990130063, 5331.306930099101, 5336.0, 5647.29408823897, 5714.0571805652435, 5773.913391299134, 5814.3313518945015, 5872.911906321408, 6253.968730156365, 6268.731020062736, 6299.118123462719, 6311.08489269058, 6320.5891617044745, 6061.151438798572, 6271.216097987752, 6274.372562743734, 6316.242050953915, 6328.208973878265, 5783.190353350535, 5791.189233507313, 5883.0, 5888.411158884121, 5895.793647222369, 6348.619082855043, 6371.044343348442, 6388.073729309317, 6419.646919419477, 6443.420092191632, 5881.2942446906645, 6138.416850399205, 6151.569390142647, 6151.692415379213, 6155.84610384744, 6117.143599896018, 6142.907856382158, 6222.12890195373, 6305.96847015762, 6306.716197771111, 6237.251529816451, 6257.217847769029, 6265.8746825063245, 6294.653794041372, 6296.590721603081, 6053.878922421615, 6212.534059945432, 6250.4374606285655, 6270.2475702915945, 6274.874502509924, 4727.4327080749845, 4744.122337367598, 4750.168720473903, 4755.286706993978, 4834.661573689878, 4206.978965105216, 4251.362295655615, 4252.085801552681, 4267.573242675708, 4297.333913243452, 5827.504662103769, 6036.758529658852, 6039.094135879654, 6047.771729674662, 6067.059605761114, 6143.416375444325, 6187.257529096537, 6202.81391558254, 6288.779892703734, 6320.5891617044745, 6020.8795824084145, 6058.969705151534, 6070.150178974947, 6075.0, 6075.3924607539775, 5178.482151784791, 5335.226392173191, 5347.839564813062, 5353.0, 5359.758810853521, 6392.616443013434, 6451.29035806061, 6476.255230648441, 6536.215654121535, 6547.934520654828, 6267.122602835698, 6272.372762723691, 6275.278342990615, 6281.309056003744, 6298.905516417166, 6175.980963141032, 6483.675816209265, 6508.8047358579315, 6556.147700798866, 6560.0, 6105.481034111973, 6137.79561000716, 6140.87237156979, 6229.0, 6232.189815323979, 6278.717457714322, 6282.874342513032, 6285.717142728679, 6289.245290565162, 6297.055441683784, 5833.533317334518, 6110.847228819315, 6111.358307377839, 6116.8776624468155, 6121.785737499166, 5954.880902382015, 5968.582199246011, 5988.221531200916, 5989.281286245504, 6079.848003799941, 6001.819945401645, 6021.698915054318, 6023.789167379121, 6033.42682445167, 6038.275406951018, 5947.553933454921, 5970.0746384310505, 6013.278406591237, 6042.577019608585, 6063.423974722395, 5895.0, 5908.202392677105, 5944.494717949023, 6003.519718422603, 6048.032314829607], "value": 5743.152547276078, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.7999690106915, 638.1002786071639, 643.7972038807777, 659.3604203922193, 709.078198342155, 40926.18147637049, 46597.068058638804, 46839.53160468399, 46884.296735549, 47158.292625610644, 46994.0, 47260.52739472604, 47307.0, 47424.52575474244, 47561.0, 9123.635054597824, 9240.122188392126, 9251.213646840026, 9254.44473331599, 9262.6294948202, 9059.184673379394, 9124.726258212264, 9139.862902056475, 9205.493697846616, 9209.217216536568, 9203.815923681523, 9222.170004699576, 9257.0, 9259.72220833376, 9274.953625231865, 9116.088391160898, 9207.263418926503, 9207.585658645377, 9212.078792120768, 9220.53897305132, 9171.358004939657, 9180.31147663928, 9210.631574737003, 9220.538973051387, 9244.260459163252, 43976.78011609954, 44566.55433445657, 44618.55381446209, 44847.0, 44866.55133448656, 3193.6007999000126, 3768.340540405418, 3938.330483817758, 4287.892802679927, 4441.267190913528, 32811.0, 33580.32839343224, 33604.83197583997, 34378.82810585931, 35327.0, 4669.7665116744365, 4920.360353154067, 4921.975390123026, 4929.704217746947, 4990.700557966534, 368019.0, 406507.0, 411804.0, 561923.0, 564388.0, 60557.39442605517, 60633.393666063654, 60786.696066519384, 60791.0, 60865.39134608686, 68402.65798670975, 68803.0, 68946.65526672435, 69066.65466672635, 69079.65460172767, 17770.0, 18335.816641833677, 18434.723479147822, 18879.716804247946, 18891.43325700231, 13735.587932362045, 13877.028607997545, 13877.722445551033, 13913.026088173932, 13947.302634868216, 20774.0, 20936.685949710765, 21005.0, 21052.157913683586, 21083.578328433345, 7579.355754760797, 7634.96182519095, 7718.884216736754, 7746.728864489716, 7810.65680295909, 1039.8284283093205, 1074.414444127952, 1084.2410312781085, 1092.983605245922, 1112.7440688641495, 34161.0, 34252.486212706826, 34325.14187145291, 34519.654803451645, 34673.826630866686, 1160.1414952934936, 1172.7654469106212, 1179.8112302031634, 1216.3127832774453, 1252.6492582077033, 17461.912690436722, 18048.729269060976, 18203.54491137732, 18406.631867362845, 18426.815731842777, 161302.0, 161322.0, 161788.0, 163301.0, 164229.0, 64090.0, 64252.357476425575, 64408.35591644117, 64466.0, 64472.35527644664, 1438.7266419380494, 1442.0986883198002, 1456.9417223311161, 1470.8602682745122, 1474.9336279867432, 32030.67969320277, 34298.0, 34620.65379346275, 34914.77798277048, 35746.8212658935, 62750.686246568475, 63613.0, 63766.36233637604, 63790.0, 63807.680961594895, 559696.0, 563980.0, 564457.0, 566344.0, 567901.0, 48605.5139448601, 48919.0, 48982.755086224344, 49439.25841112314, 49716.0, 54119.0, 54214.457855422515, 54503.0, 54646.0, 55360.169597455264, 44997.55002450065, 45766.313505296785, 45995.31007034964, 47063.294050588585, 47083.529164707914, 44947.32579011252, 46537.53462465332, 46943.29585056295, 47407.0, 47870.0, 44263.0, 44283.77858110689, 44782.10435791201, 44995.32507012463, 45006.0, 39401.40897886591, 40636.182508449725, 40731.38902916518, 40948.38577421282, 41013.179736404505, 30394.54408183923, 30509.54235686511, 30963.84518077395, 31251.37497250088, 31612.0], "value": 21574.100799346765, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.9798510074497, 408.8957315884449, 415.23596582288593, 417.5135966598912, 426.0392814203972, 19321.516962075955, 20845.0, 21333.466663333405, 21926.0, 22483.775162248374, 18285.634287314246, 18315.633687326244, 18484.260629574834, 18622.90688546559, 18672.439826805185, 5737.512311453521, 5985.311689155759, 6004.489618382421, 6005.87988240235, 6012.969935150318, 5815.418458154172, 5916.053431450969, 6003.0, 6005.729742161613, 6093.634381937076, 6119.479844213247, 6138.47822935051, 6142.385761423867, 6144.41628045335, 6156.56904016719, 5951.107333899907, 6027.5479339049525, 6082.878342433127, 6091.725872335755, 6132.356102609228, 5886.381929897342, 5905.4094590541035, 5924.052151655757, 5942.286925568917, 5942.762289508414, 24670.259892203263, 24702.629460558106, 24968.0, 25070.122545710812, 25176.622350664755, 2490.8007359411204, 2536.4039450729065, 2684.0337478507918, 2784.09516907004, 2792.5950737143203, 10461.947690261575, 10543.472826358728, 10779.514921828537, 10799.892001079967, 10893.346399216072, 1992.471994921347, 2009.4072248686673, 2014.5064459207588, 2041.1937284772432, 2078.937631871031, 67720.66139669319, 73036.63481682558, 76724.61637691775, 85134.57432712859, 89052.0, 10773.569057237779, 11315.773684526263, 11393.430328483542, 11650.708732281591, 11915.285082895054, 16096.67806643884, 16150.838491615168, 16225.2698628562, 16227.0, 16263.26815293291, 8166.510009399455, 8198.467099638505, 8605.225529702357, 8664.48013119215, 8757.080506546848, 7785.493942893694, 7872.960635196788, 7917.524948502993, 7947.125816160218, 8409.74770756866, 4818.951810481921, 4858.246971719389, 4911.0, 4948.628852836052, 5035.773390197377, 1974.2103158736334, 1997.470670272379, 2010.597880423921, 2014.174188582674, 2053.250563544296, 942.3074040580168, 1038.771470276538, 1055.9155267578576, 1080.475969154959, 1103.4813637590319, 20735.792642073688, 20822.479438014172, 20968.790312096684, 20977.68533471999, 21020.369388918356, 1030.6650338639822, 1046.0219694585587, 1063.7606538528769, 1064.510325250378, 1105.745678493951, 11263.0, 11336.659900203007, 11557.364344961108, 11572.42137893102, 11576.826347604792, 527187.0, 573465.0, 581824.0, 596954.0, 597317.0, 94926.0, 98787.50606247067, 101801.0, 102565.48717256515, 103515.0, 992.5781542844262, 1040.0587468341164, 1042.312074031151, 1058.8782290036745, 1060.4644654449453, 17972.820271797114, 18209.635807283514, 18448.26206951707, 18472.50966213689, 18510.907445462686, 45308.54691453043, 45690.77154614338, 45706.31440528328, 45740.0, 46058.76970615125, 61201.38798612135, 62331.68834155981, 62386.0, 62584.0, 63532.0, 8697.26073283778, 8870.689525866565, 8888.200061994452, 8952.328575357005, 9022.0, 9636.566354513923, 13700.45198192061, 14203.076800007966, 14604.561863144123, 14706.41174353014, 12129.696757580778, 12140.878591214328, 12337.383130843242, 12434.378281085728, 12700.428480718574, 12310.630681079581, 12331.445084971378, 12539.49842006346, 12611.747765044463, 12866.163699359511, 12284.508619655471, 12397.814032789334, 12559.748805024032, 12589.24464532131, 12597.43311550964, 8998.55007249648, 9005.864912026194, 9111.271098312252, 9268.073192680678, 9269.212116969864, 12035.819462707892, 12356.691082723004, 12479.126461147633, 12535.24788512692, 12624.621261362174], "value": 9737.173166658691, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1554.8678362339201, 1572.8898977071606, 1719.6560687862432, 1792.7579776730138, 1847.9907600461995, 8436.409451338393, 9105.772355691102, 9236.815263694722, 9925.0, 9937.304388692786, 9332.953335233331, 9694.515274236295, 9701.466419346933, 9716.417014979106, 9746.317757756942, 2395.544846479172, 2428.3564855313357, 2429.2469334506272, 2431.4529230923076, 2432.586460301744, 2397.4845408237225, 2419.177479656916, 2438.9024439022505, 2452.938676533092, 2454.840435371704, 2399.796017338528, 2421.794147497465, 2437.1591800828687, 2446.4984678141027, 2471.270975062361, 2375.95248095038, 2376.5246950609862, 2388.7133543974833, 2400.243923164198, 2427.5144971005693, 2369.609014512603, 2384.475415408607, 2399.664047033417, 2402.531506356261, 2408.542376948374, 9572.282078844115, 9744.415335079917, 9779.902200977971, 9782.41305521671, 9818.214542836557, 5436.293281873332, 5590.91613625796, 5603.803866864681, 5607.831765047055, 5610.719464026783, 3537.0, 3625.492431059654, 3661.743677942545, 3685.060309621056, 3707.1473561080834, 1258.4211262819115, 1261.4575732435048, 1267.9556215532411, 1271.262667652759, 1273.2487832179058, 13476.797848032287, 13540.390682419216, 13576.796348054788, 13687.520936767265, 13706.794398084037, 4560.293154561048, 4584.312353147055, 4707.646926480459, 4742.5020372861045, 4799.3041009053495, 10450.738731531772, 10463.68608941733, 10533.36799792015, 10538.473076346152, 10563.894361056291, 5583.916241256385, 5608.4111168326735, 5644.350899646511, 5649.802256920988, 5654.293213348332, 4491.910161796745, 5073.9746301269, 5104.3619547556555, 5184.455632158569, 5259.47405259471, 4138.8551400700835, 4184.853530126492, 4262.0836520147695, 4272.4873015237745, 4277.850275240352, 1204.0728638948135, 1240.5347994502063, 1241.6838151559375, 1245.9377031148588, 1252.3174869695856, 885.9911400886037, 1015.1422048369117, 1021.0759262867117, 1026.7895081508273, 1027.3989716016065, 5904.143899134601, 6067.484263837535, 6110.908336374958, 6164.815055548341, 6394.968025159845, 455.2738382280258, 459.40277639069075, 461.74603967817563, 466.1190350238053, 466.2027932235847, 4191.874243772691, 4281.0, 4559.908801824011, 4625.3755742974945, 4762.666613337103, 12308.384580770926, 12385.318807465675, 12468.688282793002, 12484.937575312248, 12574.748505029847, 11293.661190164308, 11877.227980181433, 12026.75946481083, 12073.27560346382, 12128.151029427856, 8820.162084601952, 8863.335249856158, 9009.459432433943, 9030.999999999869, 9046.86429703555, 6503.447206987459, 6535.640539770358, 6597.472202223715, 6725.226598940989, 6755.088063111417, 10716.892831071902, 10902.182336324966, 10952.0, 11034.779304413707, 11261.7747645045, 11420.657380278604, 11452.198346115692, 11544.538218471167, 11556.24884382546, 11630.70923226926, 8515.276201522693, 8687.087855775053, 8703.390762646553, 8716.38985271025, 8761.211490965843, 9256.95371523138, 9303.627854885728, 9401.153896149106, 9403.388779729295, 9429.811403772022, 8439.915600843913, 8471.025832029149, 8587.699430519902, 8684.652613895627, 8686.174813392718, 7782.571958542108, 8150.4294699370475, 8153.470024448629, 8199.59002049907, 8243.546604936786, 7189.1013623297085, 7301.963490182515, 7322.560646361236, 7327.8534429312185, 7336.7065317386705, 5700.458456446631, 5724.141378793214, 5812.5349972001295, 5912.113183022581, 5920.348761636303, 5569.220309156641, 5644.0, 5725.2843394575675, 5780.479756821906, 5811.1573821794755], "value": 4877.55503241498, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.81806097615816, 329.89443378118995, 330.85111699735097, 332.8053088942967, 341.5338063543263, 5812.767489300428, 5852.67810270435, 5871.266091738533, 5896.911546326804, 5907.40925907409, 5713.285839270091, 5746.109353050273, 5753.424657534244, 5754.65472071676, 5806.419358064202, 4271.615554600093, 4335.934960975588, 4431.911361772763, 4479.552044795527, 4486.641068714495, 4457.710248833831, 4465.955340446587, 4509.571590698878, 4514.119746649389, 4522.547745225467, 4485.798139083749, 4497.2129877271345, 4501.977490112545, 4538.682292239545, 4544.272916333387, 4370.519242883281, 4402.3836662867225, 4424.314231294123, 4439.933400998988, 4456.19788438081, 3927.8232479538487, 3935.8425662973445, 3936.4292177634084, 3946.6842652587725, 3950.249452603996, 5586.798838249796, 5607.869009776259, 5620.971895140498, 5642.746076426571, 5650.858728531778, 5049.267856160836, 5079.79680812767, 5103.56619687327, 5124.8981468983975, 5218.634695571312, 5917.491039784871, 5945.305587907425, 5985.0, 6023.909641355383, 6024.849378765566, 4318.114786468766, 4393.428854248928, 4405.977970110161, 4425.314076318144, 4426.247537918562, 6202.317745048041, 6206.751729930797, 6215.844603884894, 6251.812445626684, 6344.524160687967, 4379.934300985487, 4441.733495990251, 4446.244138496463, 4456.131054444352, 4456.9108617828115, 4319.352097185448, 4428.778561071934, 4433.246348120827, 4442.489553551808, 4478.373027776114, 5041.546260836469, 5073.416557095981, 5096.133657278272, 5134.306868572769, 5162.070827251131, 5998.580099393088, 6009.549283803733, 6027.246594175728, 6052.848678783065, 6078.240219972504, 1440.3950340856866, 1513.8713209377106, 1534.7084054029922, 1545.7835902973593, 1557.0346385241223, 928.3965422475445, 953.1136043479491, 964.4791812421214, 1001.62439085343, 1031.9587216511406, 5823.883522329615, 5831.241938548046, 5863.413658634187, 5875.0, 5891.263592050994, 6139.0, 6153.261608606996, 6194.907076393858, 6201.844953876189, 6242.157308763259, 5712.685802280831, 5761.8559536011935, 5821.7380217890295, 5829.76680932758, 5838.32859221195, 3280.671932806748, 3281.425750493654, 3283.5567198428384, 3291.835408229579, 3299.5710557627353, 6174.598651087665, 6315.96842015787, 6322.336154703782, 6383.170187875547, 6401.743930242831, 6171.259448866164, 6186.350433204539, 6225.202626397893, 6275.529335299871, 6282.0, 6063.575549711478, 6357.904631430532, 6364.7135878885565, 6387.265464471552, 6414.390632889868, 6100.847478813065, 6186.597871138361, 6212.347703491249, 6224.9377506224355, 6257.28041275241, 6090.9390906090375, 6117.908231376622, 6119.265688117454, 6123.785667501795, 6176.258848938156, 6304.873902521832, 6379.266384365672, 6462.709178086903, 6485.54601177913, 6506.41442270198, 4439.955600443955, 4448.888777780581, 4493.348464472699, 4526.275795872644, 4530.592246697681, 5977.22296101504, 6227.906581401192, 6303.9684801575695, 6326.1021693492685, 6391.201099862517, 6107.389261074035, 6137.943788830613, 6145.108959200801, 6168.9691551541955, 6176.938230617816, 6095.847603809941, 6113.969430152999, 6156.230471191101, 6192.164057852132, 6211.2857021443115, 5731.3122425307565, 5966.373530779206, 6059.3637668045985, 6096.420840020191, 6124.510039196943, 6152.907706384318, 6168.444839964424, 6180.134781130555, 6180.845478863064, 6199.690015499297, 5898.439648233411, 6012.759489620366, 6033.43578978941, 6069.2110025696375, 6070.757169713162], "value": 4601.266182432267, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.2957397490208, 822.5434883639581, 875.4965894610599, 886.4238245140662, 909.3245300175935, 14679.339429725662, 15413.383464661414, 15558.844411555881, 15658.451954181606, 15928.12395318257, 14647.633809154777, 14736.263186840668, 14745.705085898302, 14810.333534990925, 14840.109593424402, 835.761807884753, 846.0693237438799, 851.4465597361733, 853.5220276645099, 857.2199298638241, 848.5248260973843, 859.6948083430386, 865.9826803463927, 869.8129902071054, 871.8692196170593, 916.2715641065336, 918.5361392496814, 918.9523942705288, 919.7194855569048, 922.7462447826834, 905.7735566108473, 908.6410867707252, 910.635745701718, 912.5847739278612, 914.049388635818, 668.2582333609689, 671.8286836856619, 674.8515326628134, 675.7060678604822, 675.8715843989626, 14519.564413067625, 14528.564143075724, 14553.345099470444, 14572.781408278885, 14598.854011459856, 16111.677766444722, 16264.994384869971, 16303.184840757915, 16394.590135246595, 16459.177041147894, 13079.542216022488, 13290.933545332211, 13313.26777027263, 13377.130486518443, 13442.32788360578, 3950.881473555798, 3958.8614398495915, 3971.344728119857, 4070.531888832763, 4071.124708187724, 71783.28216717819, 76546.61726691331, 93088.53455732745, 93261.5336923311, 93592.0, 12511.061670374576, 12625.368731563569, 12755.553555625509, 12769.61691149267, 12894.871051289554, 22561.4359641007, 22632.0, 22842.657360139612, 22879.19922802727, 22910.65634015458, 9283.39657922233, 9345.626174952926, 9349.756058546036, 9454.243660507143, 9768.853467197998, 4893.314935908976, 5208.739563021833, 5272.420033796279, 5323.760430780624, 5355.410904800468, 4001.199760048002, 4124.9587504125175, 4131.132462182915, 4140.482439695038, 4161.188568229227, 694.3577191098213, 695.5861262548876, 697.5744795674634, 711.0756017177648, 713.4470785141453, 706.1314583062862, 766.7393086350668, 779.3492433817712, 780.3990926986189, 800.0918956983866, 10413.53139108742, 11254.831177532344, 11282.661520154408, 11308.321500709984, 11691.356975366436, 787.3111027850631, 795.769226924197, 821.34292565947, 835.6114406800867, 845.9746207613781, 5151.793928242903, 5172.9096625112725, 5213.817516386908, 5232.319798426181, 5250.107481728115, 83281.58359208287, 85125.0, 102027.48986255021, 145037.0, 151434.0, 96362.0, 98316.50841745888, 120203.0, 126759.0, 127089.36455317664, 57771.0, 58687.0, 59953.400465995655, 88469.0, 95605.0, 10080.495975201356, 11250.66248012561, 11415.143864210384, 11471.541138354707, 11666.0, 41631.0, 54310.72844635751, 54339.0, 54686.0, 55575.444245557024, 82410.17589824265, 87508.5624571873, 87571.1242887563, 88159.0, 89514.55242723745, 11674.474648640662, 11847.644570662895, 11864.584739534075, 12327.93836030814, 12600.936995315331, 14073.718525629634, 14287.142771433748, 15870.20648967524, 16861.66276674435, 18162.636747265246, 15220.0, 15240.618984525476, 15673.373065077269, 16094.195290235208, 16296.0, 14618.561443156723, 15239.68328457462, 15292.311845966735, 15675.372985080468, 15843.762343565086, 14390.712185756436, 14834.07157069574, 15043.548693539211, 15097.849021509644, 15411.845881541489, 12540.184887982252, 12677.429515671633, 13084.28036458004, 13239.20564766117, 13420.993425492932, 9451.385659932082, 9933.205343572641, 10389.9480502597, 10431.58273669075, 10463.476826158814], "value": 8124.506928406476, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1503.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 105.0, 111.0, 110.0, 111.0, 110.0, 111.0, 109.0, 111.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 118.0, 151.0, 168.0, 118.0, 146.0, 148.0, 117.0, 188.0, 116.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 173.0, 164.0, 162.0, 164.0, 164.0, 162.0, 162.0, 163.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 178.0, 76.0, 76.0, 75.0, 75.0, 173.0, 77.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 149.0, 83.0, 83.0, 84.0, 140.0, 83.0, 84.0, 139.0], "value": 101.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 119.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 147.0, 147.0, 148.0, 147.0, 148.0, 148.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 97.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 52.0, 51.0, 51.0, 53.0, 52.0, 51.0, 52.0, 52.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 66.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 73.0, 73.0, 74.0, 72.0, 71.0, 76.0, 73.0, 73.0, 72.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 119.0, 118.0, 127.0, 119.0, 128.0, 120.0, 152.0, 130.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 154.0, 159.0, 154.0, 152.0, 151.0, 160.0, 155.0, 153.0, 156.0], "value": 155.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 61.0, 61.0, 61.0, 62.0, 61.0, 60.0, 61.0], "value": 61.5, "unit": "score"}]}]} 08:34:26 INFO - Return code: 0 08:34:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:34:26 ERROR - # TBPL SUCCESS # 08:34:26 INFO - Running post-action listener: _resource_record_post_action 08:34:26 INFO - [mozharness: 2016-09-12 15:34:26.953243Z] Finished run-tests step (success) 08:34:26 INFO - Running post-run listener: _resource_record_post_run 08:34:27 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 327606272; Read time: 16; Write time: 227908 08:34:27 INFO - TinderboxPrint: CPU usage
13.2% 08:34:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:34:27 INFO - TinderboxPrint: I/O write bytes / time
327,606,272 / 227,908 08:34:27 INFO - TinderboxPrint: CPU idle
8,231.7 (86.8%) 08:34:27 INFO - TinderboxPrint: CPU user
1,198.9 (12.6%) 08:34:27 INFO - TinderboxPrint: Swap in / out
0 / 0 08:34:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 78516224; Read time: 0; Write time: 80628 08:34:27 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 248180736; Read time: 0; Write time: 147256 08:34:27 INFO - Running post-run listener: _upload_blobber_files 08:34:27 INFO - Blob upload gear active. 08:34:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:34:27 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 08:34:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:34:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:34:28 INFO - (blobuploader) - INFO - Open directory for files ... 08:34:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:34:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:34:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:32 INFO - (blobuploader) - INFO - Done attempting. 08:34:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:34:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:34:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:35 INFO - (blobuploader) - INFO - Done attempting. 08:34:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:34:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:34:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:35 INFO - (blobuploader) - INFO - Done attempting. 08:34:35 INFO - (blobuploader) - INFO - Iteration through files over. 08:34:35 INFO - Return code: 0 08:34:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:34:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:34:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36344dfdb9c7b4879f309df79cb4e51564c6739995ec7c57ac25b9224752de62d21d5c90cc97506e05b01cdfa44ca329adadb8130e38450ecee0ce3e048ffd07", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85fddc080ddcf3e90c555c766ebddfbf0106a8188a54ea9000578595246df193cacc2e9e9b3d279d65dd4cc93c77cd6aaa6414598521c4cd36576f3a8a4a868a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/769187578693da7b53538613e3bceed8f2e6ca2ab9796c55061f5739e9197cbf63aec5621604778144ec61a64e28ceeb3dfdfe0a70c7b5d5e84aa53cd476b024"} 08:34:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:34:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:34:35 INFO - Contents: 08:34:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36344dfdb9c7b4879f309df79cb4e51564c6739995ec7c57ac25b9224752de62d21d5c90cc97506e05b01cdfa44ca329adadb8130e38450ecee0ce3e048ffd07", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85fddc080ddcf3e90c555c766ebddfbf0106a8188a54ea9000578595246df193cacc2e9e9b3d279d65dd4cc93c77cd6aaa6414598521c4cd36576f3a8a4a868a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/769187578693da7b53538613e3bceed8f2e6ca2ab9796c55061f5739e9197cbf63aec5621604778144ec61a64e28ceeb3dfdfe0a70c7b5d5e84aa53cd476b024"} 08:34:35 INFO - Running post-run listener: copy_logs_to_upload_dir 08:34:35 INFO - Copying logs to upload dir... 08:34:35 INFO - mkdir: /builds/slave/test/build/upload/logs 08:34:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1679.327776 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 59 secs) (at 2016-09-12 08:34:35.128079) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-12 08:34:35.131429) ========= 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=0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36344dfdb9c7b4879f309df79cb4e51564c6739995ec7c57ac25b9224752de62d21d5c90cc97506e05b01cdfa44ca329adadb8130e38450ecee0ce3e048ffd07", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85fddc080ddcf3e90c555c766ebddfbf0106a8188a54ea9000578595246df193cacc2e9e9b3d279d65dd4cc93c77cd6aaa6414598521c4cd36576f3a8a4a868a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/769187578693da7b53538613e3bceed8f2e6ca2ab9796c55061f5739e9197cbf63aec5621604778144ec61a64e28ceeb3dfdfe0a70c7b5d5e84aa53cd476b024"} build_url:https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/Cime8-S0TOSnUvh7hU5NvA/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36344dfdb9c7b4879f309df79cb4e51564c6739995ec7c57ac25b9224752de62d21d5c90cc97506e05b01cdfa44ca329adadb8130e38450ecee0ce3e048ffd07", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/85fddc080ddcf3e90c555c766ebddfbf0106a8188a54ea9000578595246df193cacc2e9e9b3d279d65dd4cc93c77cd6aaa6414598521c4cd36576f3a8a4a868a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/769187578693da7b53538613e3bceed8f2e6ca2ab9796c55061f5739e9197cbf63aec5621604778144ec61a64e28ceeb3dfdfe0a70c7b5d5e84aa53cd476b024"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-12 08:34:35.156974) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 08:34:35.157306) ========= 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=0e2a256762fed810e2f0f810000001b3-1473692741.189263-241823685 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-12 08:34:35.243273) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-12 08:34:35.243623) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-12 08:34:35.243968) ========= ========= Total master_lag: 0.17 =========