builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1462285544.52 results: success (0) buildid: 20160503043038 builduid: 2bba10f2df964202895594984614dd83 revision: 21afe591e4954a256ab665496885ee63a33ed7d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-03 07:25:44.516593) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-03 07:25:44.517063) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-03 07:25:44.517338) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-03 07:25:44.529392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 07:25:44.529737) ========= 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=8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-03 07:25:45-- 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% 43.5M=0s 2016-05-03 07:25:45 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.069514 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 07:25:44.610513) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 07:25:44.610846) ========= 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=8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014435 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 07:25:44.660808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 07:25:44.661159) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 21afe591e4954a256ab665496885ee63a33ed7d6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 21afe591e4954a256ab665496885ee63a33ed7d6 --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=8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-03 07:25:45,344 truncating revision to first 12 chars 2016-05-03 07:25:45,344 Setting DEBUG logging. 2016-05-03 07:25:45,344 attempt 1/10 2016-05-03 07:25:45,344 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/21afe591e495?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-03 07:25:46,030 unpacking tar archive at: mozilla-inbound-21afe591e495/testing/mozharness/ program finished with exit code 0 elapsedTime=0.947177 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 07:25:45.623566) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-03 07:25:45.624116) ========= script_repo_revision: 21afe591e4954a256ab665496885ee63a33ed7d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-03 07:25:45.624764) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-03 07:25:45.625215) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-03 07:25:45.635821) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 28 secs) (at 2016-05-03 07:25:45.636389) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:25:46 INFO - MultiFileLogger online at 20160503 07:25:46 in /builds/slave/test 07:25:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:25:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:25:46 INFO - {'append_to_log': False, 07:25:46 INFO - 'base_work_dir': '/builds/slave/test', 07:25:46 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:25:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:25:46 INFO - 'branch': 'Mozilla-Inbound', 07:25:46 INFO - 'buildbot_json_path': 'buildprops.json', 07:25:46 INFO - 'config_files': ('talos/linux_config.py',), 07:25:46 INFO - 'default_actions': ('clobber', 07:25:46 INFO - 'read-buildbot-config', 07:25:46 INFO - 'download-and-extract', 07:25:46 INFO - 'populate-webroot', 07:25:46 INFO - 'create-virtualenv', 07:25:46 INFO - 'install', 07:25:46 INFO - 'run-tests'), 07:25:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:25:46 INFO - 'download_minidump_stackwalk': True, 07:25:46 INFO - 'download_symbols': 'ondemand', 07:25:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:25:46 INFO - 'tooltool.py': '/tools/tooltool.py', 07:25:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:25:46 INFO - '/tools/misc-python/virtualenv.py')}, 07:25:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:25:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:25:46 INFO - 'installer_path': 'installer.exe', 07:25:46 INFO - 'log_level': 'info', 07:25:46 INFO - 'log_name': 'talos', 07:25:46 INFO - 'log_to_console': True, 07:25:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:25:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:25:46 INFO - 'opt_config_files': (), 07:25:46 INFO - 'pip_index': False, 07:25:46 INFO - 'sps_profile': False, 07:25:46 INFO - 'sps_profile_interval': 0, 07:25:46 INFO - 'suite': 'dromaeojs-e10s', 07:25:46 INFO - 'system_bits': '32', 07:25:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:25:46 INFO - 'title': 'talos-linux64-ix-001', 07:25:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:25:46 INFO - 'use_talos_json': True, 07:25:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:25:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:25:46 INFO - 'work_dir': 'build'} 07:25:46 INFO - ##### 07:25:46 INFO - ##### Running clobber step. 07:25:46 INFO - ##### 07:25:46 INFO - Running pre-action listener: _resource_record_pre_action 07:25:46 INFO - Running main action method: clobber 07:25:46 INFO - rmtree: /builds/slave/test/build 07:25:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:25:46 INFO - Running post-action listener: _resource_record_post_action 07:25:46 INFO - ##### 07:25:46 INFO - ##### Running read-buildbot-config step. 07:25:46 INFO - ##### 07:25:46 INFO - Running pre-action listener: _resource_record_pre_action 07:25:46 INFO - Running main action method: read_buildbot_config 07:25:46 INFO - Using buildbot properties: 07:25:46 INFO - { 07:25:46 INFO - "project": "", 07:25:46 INFO - "product": "firefox", 07:25:46 INFO - "script_repo_revision": "production", 07:25:46 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:25:46 INFO - "repository": "", 07:25:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:25:46 INFO - "buildid": "20160503043038", 07:25:46 INFO - "pgo_build": "True", 07:25:46 INFO - "basedir": "/builds/slave/test", 07:25:46 INFO - "buildnumber": 987, 07:25:46 INFO - "slavename": "talos-linux64-ix-001", 07:25:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:25:46 INFO - "platform": "ubuntu64_hw", 07:25:46 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:25:46 INFO - "branch": "mozilla-inbound", 07:25:46 INFO - "repo_path": "integration/mozilla-inbound", 07:25:46 INFO - "revision": "21afe591e4954a256ab665496885ee63a33ed7d6", 07:25:46 INFO - "stage_platform": "linux64-pgo", 07:25:46 INFO - "builduid": "2bba10f2df964202895594984614dd83", 07:25:46 INFO - "slavebuilddir": "test" 07:25:46 INFO - } 07:25:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 07:25:46 INFO - Running post-action listener: _resource_record_post_action 07:25:46 INFO - ##### 07:25:46 INFO - ##### Running download-and-extract step. 07:25:46 INFO - ##### 07:25:46 INFO - Running pre-action listener: _resource_record_pre_action 07:25:46 INFO - Running main action method: download_and_extract 07:25:46 INFO - mkdir: /builds/slave/test/build/tests 07:25:46 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')]} 07:25:46 INFO - https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:25:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:25:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:25:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:25:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:26:16 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 07:26:16 INFO - retry: attempt #1 caught exception: timed out 07:26:16 INFO - retry: Failed, sleeping 30 seconds before retrying 07:26:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #2 07:27:17 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 07:27:17 INFO - retry: attempt #2 caught exception: timed out 07:27:17 INFO - retry: Failed, sleeping 60 seconds before retrying 07:28:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #3 07:28:47 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 07:28:47 INFO - retry: attempt #3 caught exception: timed out 07:28:47 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json! 07:28:47 INFO - Caught exception: timed out 07:28:47 INFO - Caught exception: timed out 07:28:47 INFO - Caught exception: timed out 07:28:47 INFO - trying https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:28:47 INFO - Downloading https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:28:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:28:47 INFO - Downloaded 1361 bytes. 07:28:47 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 07:28:47 INFO - Using the following test package requirements: 07:28:47 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:47 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:28:47 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:28:47 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:47 INFO - u'jsshell-linux-x86_64.zip'], 07:28:47 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:28:47 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:47 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:28:47 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:28:47 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:28:47 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:47 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:28:47 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:47 INFO - https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:28:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:28:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:28:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:28:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:29:17 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 07:29:17 INFO - retry: attempt #1 caught exception: timed out 07:29:17 INFO - retry: Failed, sleeping 30 seconds before retrying 07:29:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #2 07:30:18 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 07:30:18 INFO - retry: attempt #2 caught exception: timed out 07:30:18 INFO - retry: Failed, sleeping 60 seconds before retrying 07:31:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #3 07:31:48 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 07:31:48 INFO - retry: attempt #3 caught exception: timed out 07:31:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip! 07:31:48 INFO - Caught exception: timed out 07:31:48 INFO - Caught exception: timed out 07:31:48 INFO - Caught exception: timed out 07:31:48 INFO - trying https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:31:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:31:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:31:49 INFO - Downloaded 23880489 bytes. 07:31:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:31:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:31:50 INFO - Return code: 0 07:31:50 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:31:50 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')]} 07:31:50 INFO - https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:31:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:31:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:31:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:31:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:32:20 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 07:32:20 INFO - retry: attempt #1 caught exception: timed out 07:32:20 INFO - retry: Failed, sleeping 30 seconds before retrying 07:32:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #2 07:33:20 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 07:33:20 INFO - retry: attempt #2 caught exception: timed out 07:33:20 INFO - retry: Failed, sleeping 60 seconds before retrying 07:34:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #3 07:34:50 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 07:34:50 INFO - retry: attempt #3 caught exception: timed out 07:34:50 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip! 07:34:50 INFO - Caught exception: timed out 07:34:50 INFO - Caught exception: timed out 07:34:50 INFO - Caught exception: timed out 07:34:50 INFO - trying https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:34:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 07:34:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:34:51 INFO - Downloaded 23880489 bytes. 07:34:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:34:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:34:53 INFO - Return code: 0 07:34:53 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')]} 07:34:53 INFO - https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:34:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:34:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:34:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:34:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:35:23 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 07:35:23 INFO - retry: attempt #1 caught exception: timed out 07:35:23 INFO - retry: Failed, sleeping 30 seconds before retrying 07:35:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 07:36:23 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 07:36:23 INFO - retry: attempt #2 caught exception: timed out 07:36:23 INFO - retry: Failed, sleeping 60 seconds before retrying 07:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 07:37:53 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 07:37:53 INFO - retry: attempt #3 caught exception: timed out 07:37:53 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip! 07:37:53 INFO - Caught exception: timed out 07:37:53 INFO - Caught exception: timed out 07:37:53 INFO - Caught exception: timed out 07:37:53 INFO - trying https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 07:37:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:37:54 INFO - Downloaded 10840152 bytes. 07:37:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:37:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:37:55 INFO - Return code: 0 07:37:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:55 INFO - https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:37:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:37:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:37:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:37:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:38:25 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 07:38:25 INFO - retry: attempt #1 caught exception: timed out 07:38:25 INFO - retry: Failed, sleeping 30 seconds before retrying 07:38:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #2 07:39:25 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 07:39:25 INFO - retry: attempt #2 caught exception: timed out 07:39:25 INFO - retry: Failed, sleeping 60 seconds before retrying 07:40:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #3 07:40:55 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 07:40:55 INFO - retry: attempt #3 caught exception: timed out 07:40:55 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2! 07:40:55 INFO - Caught exception: timed out 07:40:55 INFO - Caught exception: timed out 07:40:55 INFO - Caught exception: timed out 07:40:55 INFO - trying https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:40:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:40:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:40:56 INFO - Downloaded 58608771 bytes. 07:40:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:40:56 INFO - mkdir: /builds/slave/test/properties 07:40:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:40:56 INFO - Writing to file /builds/slave/test/properties/build_url 07:40:56 INFO - Contents: 07:40:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 07:40:57 INFO - Running post-action listener: _resource_record_post_action 07:40:57 INFO - Running post-action listener: set_extra_try_arguments 07:40:57 INFO - ##### 07:40:57 INFO - ##### Running populate-webroot step. 07:40:57 INFO - ##### 07:40:57 INFO - Running pre-action listener: _resource_record_pre_action 07:40:57 INFO - Running main action method: populate_webroot 07:40:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:40:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:40:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:40:57 INFO - '--tppagecycles', 07:40:57 INFO - '7'], 07:40:57 INFO - 'tests': ['tsvgm']}}, 07:40:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:40:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:40:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:40:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:40:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:40:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:40:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:57 INFO - 'talos_options': ['--disable-e10s'], 07:40:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:40:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:40:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:57 INFO - 'talos_options': ['--disable-e10s'], 07:40:57 INFO - 'tests': ['damp', 'tps']}, 07:40:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:57 INFO - 'tests': ['damp', 'tps']}, 07:40:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:40:57 INFO - 'tests': ['dromaeo_dom']}, 07:40:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:40:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:40:57 INFO - 'tests': ['a11yr', 07:40:57 INFO - 'ts_paint', 07:40:57 INFO - 'tpaint', 07:40:57 INFO - 'sessionrestore', 07:40:57 INFO - 'sessionrestore_no_auto_restore', 07:40:57 INFO - 'tabpaint']}, 07:40:57 INFO - 'other-e10s': {'tests': ['a11yr', 07:40:57 INFO - 'ts_paint', 07:40:57 INFO - 'tpaint', 07:40:57 INFO - 'sessionrestore', 07:40:57 INFO - 'sessionrestore_no_auto_restore', 07:40:57 INFO - 'tabpaint']}, 07:40:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:40:57 INFO - 'ts_paint', 07:40:57 INFO - 'tpaint', 07:40:57 INFO - 'sessionrestore', 07:40:57 INFO - 'sessionrestore_no_auto_restore', 07:40:57 INFO - 'tabpaint']}, 07:40:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:40:57 INFO - 'ts_paint', 07:40:57 INFO - 'tpaint', 07:40:57 INFO - 'sessionrestore', 07:40:57 INFO - 'sessionrestore_no_auto_restore', 07:40:57 INFO - 'tabpaint']}, 07:40:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:40:57 INFO - 'tests': ['a11yr', 07:40:57 INFO - 'ts_paint', 07:40:57 INFO - 'tpaint', 07:40:57 INFO - 'sessionrestore', 07:40:57 INFO - 'sessionrestore_no_auto_restore', 07:40:57 INFO - 'tabpaint']}, 07:40:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:40:57 INFO - 'tests': ['a11yr', 07:40:57 INFO - 'ts_paint', 07:40:57 INFO - 'tpaint', 07:40:57 INFO - 'sessionrestore', 07:40:57 INFO - 'sessionrestore_no_auto_restore', 07:40:57 INFO - 'tabpaint']}, 07:40:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:40:57 INFO - 'tests': ['tsvgx', 07:40:57 INFO - 'tsvgr_opacity', 07:40:57 INFO - 'tart', 07:40:57 INFO - 'tscrollx', 07:40:57 INFO - 'cart']}, 07:40:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:40:57 INFO - 'tsvgr_opacity', 07:40:57 INFO - 'tart', 07:40:57 INFO - 'tscrollx', 07:40:57 INFO - 'cart']}, 07:40:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:57 INFO - 'talos_options': ['--disable-e10s'], 07:40:57 INFO - 'tests': ['tp5o']}, 07:40:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:57 INFO - 'tests': ['tp5o']}, 07:40:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:57 INFO - 'talos_options': ['--disable-e10s', 07:40:57 INFO - '--xperf_path', 07:40:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:40:57 INFO - 'tests': ['tp5n']}, 07:40:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:40:57 INFO - 'talos_options': ['--xperf_path', 07:40:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:40:57 INFO - 'tests': ['tp5n']}}, 07:40:57 INFO - 'talos.zip': {'path': '', 07:40:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:40:57 INFO - Running post-action listener: _resource_record_post_action 07:40:57 INFO - ##### 07:40:57 INFO - ##### Running create-virtualenv step. 07:40:57 INFO - ##### 07:40:57 INFO - Running pre-action listener: _resource_record_pre_action 07:40:57 INFO - Running main action method: create_virtualenv 07:40:57 INFO - Creating virtualenv /builds/slave/test/build/venv 07:40:57 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 07:40:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:40:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:40:57 INFO - Using real prefix '/usr' 07:40:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:40:58 INFO - Installing distribute.............................................................................................................................................................................................done. 07:41:00 INFO - Installing pip.................done. 07:41:00 INFO - Return code: 0 07:41:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf91c49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0f410>, '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 0x1a10310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a107a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063', '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 07:41:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:41:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:41:00 INFO - Using env: {'DISPLAY': ':0', 07:41:00 INFO - 'HOME': '/home/cltbld', 07:41:00 INFO - 'LANG': 'en_US.UTF-8', 07:41:00 INFO - 'LANGUAGE': 'en_US:en', 07:41:00 INFO - 'LOGNAME': 'cltbld', 07:41:00 INFO - 'MAIL': '/var/mail/cltbld', 07:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:00 INFO - 'MOZ_NO_REMOTE': '1', 07:41:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:00 INFO - 'NO_EM_RESTART': '1', 07:41:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:00 INFO - 'PWD': '/builds/slave/test', 07:41:00 INFO - 'SHELL': '/bin/bash', 07:41:00 INFO - 'SHLVL': '1', 07:41:00 INFO - 'TERM': 'linux', 07:41:00 INFO - 'TMOUT': '86400', 07:41:00 INFO - 'USER': 'cltbld', 07:41:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063', 07:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:00 INFO - '_': '/tools/buildbot/bin/python'} 07:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:00 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 07:41:00 INFO - Cleaning up... 07:41:00 INFO - Return code: 0 07:41:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf91c49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0f410>, '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 0x1a10310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a107a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063', '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 07:41:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:41:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:41:00 INFO - Using env: {'DISPLAY': ':0', 07:41:00 INFO - 'HOME': '/home/cltbld', 07:41:00 INFO - 'LANG': 'en_US.UTF-8', 07:41:00 INFO - 'LANGUAGE': 'en_US:en', 07:41:00 INFO - 'LOGNAME': 'cltbld', 07:41:00 INFO - 'MAIL': '/var/mail/cltbld', 07:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:00 INFO - 'MOZ_NO_REMOTE': '1', 07:41:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:00 INFO - 'NO_EM_RESTART': '1', 07:41:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:00 INFO - 'PWD': '/builds/slave/test', 07:41:00 INFO - 'SHELL': '/bin/bash', 07:41:00 INFO - 'SHLVL': '1', 07:41:00 INFO - 'TERM': 'linux', 07:41:00 INFO - 'TMOUT': '86400', 07:41:00 INFO - 'USER': 'cltbld', 07:41:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063', 07:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:00 INFO - '_': '/tools/buildbot/bin/python'} 07:41:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:00 INFO - Downloading/unpacking psutil>=0.7.1 07:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:41:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:02 INFO - Installing collected packages: psutil 07:41:02 INFO - Running setup.py install for psutil 07:41:02 INFO - building 'psutil._psutil_linux' extension 07:41:02 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 07:41:02 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 07:41:02 INFO - building 'psutil._psutil_posix' extension 07:41:02 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 07:41:02 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 07:41:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:02 INFO - Successfully installed psutil 07:41:02 INFO - Cleaning up... 07:41:02 INFO - Return code: 0 07:41:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf91c49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0f410>, '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 0x1a10310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a107a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063', '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 07:41:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:41:02 INFO - Using env: {'DISPLAY': ':0', 07:41:02 INFO - 'HOME': '/home/cltbld', 07:41:02 INFO - 'LANG': 'en_US.UTF-8', 07:41:02 INFO - 'LANGUAGE': 'en_US:en', 07:41:02 INFO - 'LOGNAME': 'cltbld', 07:41:02 INFO - 'MAIL': '/var/mail/cltbld', 07:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:02 INFO - 'MOZ_NO_REMOTE': '1', 07:41:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:03 INFO - 'NO_EM_RESTART': '1', 07:41:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:03 INFO - 'PWD': '/builds/slave/test', 07:41:03 INFO - 'SHELL': '/bin/bash', 07:41:03 INFO - 'SHLVL': '1', 07:41:03 INFO - 'TERM': 'linux', 07:41:03 INFO - 'TMOUT': '86400', 07:41:03 INFO - 'USER': 'cltbld', 07:41:03 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063', 07:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:03 INFO - '_': '/tools/buildbot/bin/python'} 07:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:41:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:41:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:41:05 INFO - Installing collected packages: mozsystemmonitor 07:41:05 INFO - Running setup.py install for mozsystemmonitor 07:41:05 INFO - Successfully installed mozsystemmonitor 07:41:05 INFO - Cleaning up... 07:41:05 INFO - Return code: 0 07:41:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf91c49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0f410>, '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 0x1a10310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a107a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063', '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 07:41:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:41:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:41:05 INFO - Using env: {'DISPLAY': ':0', 07:41:05 INFO - 'HOME': '/home/cltbld', 07:41:05 INFO - 'LANG': 'en_US.UTF-8', 07:41:05 INFO - 'LANGUAGE': 'en_US:en', 07:41:05 INFO - 'LOGNAME': 'cltbld', 07:41:05 INFO - 'MAIL': '/var/mail/cltbld', 07:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:05 INFO - 'MOZ_NO_REMOTE': '1', 07:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:05 INFO - 'NO_EM_RESTART': '1', 07:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:05 INFO - 'PWD': '/builds/slave/test', 07:41:05 INFO - 'SHELL': '/bin/bash', 07:41:05 INFO - 'SHLVL': '1', 07:41:05 INFO - 'TERM': 'linux', 07:41:05 INFO - 'TMOUT': '86400', 07:41:05 INFO - 'USER': 'cltbld', 07:41:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063', 07:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:05 INFO - '_': '/tools/buildbot/bin/python'} 07:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:05 INFO - Downloading/unpacking blobuploader==1.2.4 07:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:07 INFO - Downloading blobuploader-1.2.4.tar.gz 07:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:41:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:41:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:08 INFO - Downloading docopt-0.6.1.tar.gz 07:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:41:08 INFO - Installing collected packages: blobuploader, requests, docopt 07:41:08 INFO - Running setup.py install for blobuploader 07:41:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:41:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:41:08 INFO - Running setup.py install for requests 07:41:08 INFO - Running setup.py install for docopt 07:41:08 INFO - Successfully installed blobuploader requests docopt 07:41:08 INFO - Cleaning up... 07:41:08 INFO - Return code: 0 07:41:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf91c49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0f410>, '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 0x1a10310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a107a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063', '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 07:41:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:41:08 INFO - Using env: {'DISPLAY': ':0', 07:41:08 INFO - 'HOME': '/home/cltbld', 07:41:08 INFO - 'LANG': 'en_US.UTF-8', 07:41:08 INFO - 'LANGUAGE': 'en_US:en', 07:41:08 INFO - 'LOGNAME': 'cltbld', 07:41:08 INFO - 'MAIL': '/var/mail/cltbld', 07:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:08 INFO - 'MOZ_NO_REMOTE': '1', 07:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:08 INFO - 'NO_EM_RESTART': '1', 07:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:08 INFO - 'PWD': '/builds/slave/test', 07:41:08 INFO - 'SHELL': '/bin/bash', 07:41:08 INFO - 'SHLVL': '1', 07:41:08 INFO - 'TERM': 'linux', 07:41:08 INFO - 'TMOUT': '86400', 07:41:08 INFO - 'USER': 'cltbld', 07:41:08 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063', 07:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:08 INFO - '_': '/tools/buildbot/bin/python'} 07:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:41:09 INFO - Running setup.py (path:/tmp/pip-DFzAxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:41:09 INFO - Running setup.py (path:/tmp/pip-liGGLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:41:09 INFO - Running setup.py (path:/tmp/pip-Ab4jtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:41:09 INFO - Running setup.py (path:/tmp/pip-cg4ZrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:41:09 INFO - Running setup.py (path:/tmp/pip-UUZo8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:41:09 INFO - Running setup.py (path:/tmp/pip-JIgHXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:41:09 INFO - Running setup.py (path:/tmp/pip-pdI27G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:41:09 INFO - Running setup.py (path:/tmp/pip-Xc4GR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:41:09 INFO - Running setup.py (path:/tmp/pip-eo81Dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:41:09 INFO - Running setup.py (path:/tmp/pip-0tt1qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:41:09 INFO - Running setup.py (path:/tmp/pip-idRBq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:41:09 INFO - Running setup.py (path:/tmp/pip-aC5ZXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:41:09 INFO - Running setup.py (path:/tmp/pip-2UI6HT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:41:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:41:09 INFO - Running setup.py (path:/tmp/pip-HnjIvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:10 INFO - Running setup.py (path:/tmp/pip-cIYx5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:41:10 INFO - Running setup.py (path:/tmp/pip-b3dVIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:41:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:41:10 INFO - Running setup.py (path:/tmp/pip-Ph_2yH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:41:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:41:10 INFO - Running setup.py install for manifestparser 07:41:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:41:10 INFO - Running setup.py install for mozcrash 07:41:10 INFO - Running setup.py install for mozdebug 07:41:10 INFO - Running setup.py install for mozdevice 07:41:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:41:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:41:10 INFO - Running setup.py install for mozfile 07:41:10 INFO - Running setup.py install for mozhttpd 07:41:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:41:10 INFO - Running setup.py install for mozinfo 07:41:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:41:10 INFO - Running setup.py install for mozInstall 07:41:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:41:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:41:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:41:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:41:11 INFO - Running setup.py install for mozleak 07:41:11 INFO - Running setup.py install for mozlog 07:41:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:41:11 INFO - Running setup.py install for moznetwork 07:41:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:41:11 INFO - Running setup.py install for mozprocess 07:41:11 INFO - Running setup.py install for mozprofile 07:41:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:41:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:41:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:41:11 INFO - Running setup.py install for mozrunner 07:41:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:41:11 INFO - Running setup.py install for mozscreenshot 07:41:11 INFO - Running setup.py install for moztest 07:41:11 INFO - Running setup.py install for mozversion 07:41:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:41:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:41:12 INFO - Cleaning up... 07:41:12 INFO - Return code: 0 07:41:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:41: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')]} 07:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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')]} 07:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf91c49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0f410>, '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 0x1a10310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a107a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063', '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 07:41:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:41:12 INFO - Using env: {'DISPLAY': ':0', 07:41:12 INFO - 'HOME': '/home/cltbld', 07:41:12 INFO - 'LANG': 'en_US.UTF-8', 07:41:12 INFO - 'LANGUAGE': 'en_US:en', 07:41:12 INFO - 'LOGNAME': 'cltbld', 07:41:12 INFO - 'MAIL': '/var/mail/cltbld', 07:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:12 INFO - 'MOZ_NO_REMOTE': '1', 07:41:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:12 INFO - 'NO_EM_RESTART': '1', 07:41:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:12 INFO - 'PWD': '/builds/slave/test', 07:41:12 INFO - 'SHELL': '/bin/bash', 07:41:12 INFO - 'SHLVL': '1', 07:41:12 INFO - 'TERM': 'linux', 07:41:12 INFO - 'TMOUT': '86400', 07:41:12 INFO - 'USER': 'cltbld', 07:41:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063', 07:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:12 INFO - '_': '/tools/buildbot/bin/python'} 07:41:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:41:12 INFO - Running setup.py (path:/tmp/pip-T55OqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:41:12 INFO - Running setup.py (path:/tmp/pip-W_8uMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:41:12 INFO - Running setup.py (path:/tmp/pip-Ya1XVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:41:12 INFO - Running setup.py (path:/tmp/pip-Kq1b14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:41:12 INFO - Running setup.py (path:/tmp/pip-YvyYYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:41:12 INFO - Running setup.py (path:/tmp/pip-OEKCp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:41:12 INFO - Running setup.py (path:/tmp/pip-9KMuMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:41:12 INFO - Running setup.py (path:/tmp/pip-pr8q2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:41:12 INFO - Running setup.py (path:/tmp/pip-G240bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:41:12 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)) 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:41:12 INFO - Running setup.py (path:/tmp/pip-SSwfeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 07:41:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:41:12 INFO - Running setup.py (path:/tmp/pip-3TR1Qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:41:13 INFO - Running setup.py (path:/tmp/pip-WWopJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:41:13 INFO - Running setup.py (path:/tmp/pip-Tu0j7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:41:13 INFO - Running setup.py (path:/tmp/pip-L_ep1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:13 INFO - Running setup.py (path:/tmp/pip-rcu1yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:41:13 INFO - Running setup.py (path:/tmp/pip-wPpvr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:41:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:41:13 INFO - Running setup.py (path:/tmp/pip-v0CRbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:41:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:15 INFO - Downloading blessings-1.6.tar.gz 07:41:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:41:15 INFO - Installing collected packages: blessings 07:41:15 INFO - Running setup.py install for blessings 07:41:15 INFO - Successfully installed blessings 07:41:15 INFO - Cleaning up... 07:41:15 INFO - Return code: 0 07:41:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:41:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:41:15 INFO - Reading from file tmpfile_stdout 07:41:15 INFO - Current package versions: 07:41:15 INFO - argparse == 1.2.1 07:41:15 INFO - blessings == 1.6 07:41:15 INFO - blobuploader == 1.2.4 07:41:15 INFO - docopt == 0.6.1 07:41:15 INFO - manifestparser == 1.1 07:41:15 INFO - mozInstall == 1.12 07:41:15 INFO - mozcrash == 0.17 07:41:15 INFO - mozdebug == 0.1 07:41:15 INFO - mozdevice == 0.48 07:41:15 INFO - mozfile == 1.2 07:41:15 INFO - mozhttpd == 0.7 07:41:15 INFO - mozinfo == 0.9 07:41:15 INFO - mozleak == 0.1 07:41:15 INFO - mozlog == 3.1 07:41:15 INFO - moznetwork == 0.27 07:41:15 INFO - mozprocess == 0.22 07:41:15 INFO - mozprofile == 0.28 07:41:15 INFO - mozrunner == 6.11 07:41:15 INFO - mozscreenshot == 0.1 07:41:15 INFO - mozsystemmonitor == 0.0 07:41:15 INFO - moztest == 0.7 07:41:15 INFO - mozversion == 1.4 07:41:15 INFO - psutil == 3.1.1 07:41:15 INFO - requests == 1.2.3 07:41:15 INFO - wsgiref == 0.1.2 07:41:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf91c49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0f410>, '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 0x1a10310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a107a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063', '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 07:41:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:41:15 INFO - Using env: {'DISPLAY': ':0', 07:41:15 INFO - 'HOME': '/home/cltbld', 07:41:15 INFO - 'LANG': 'en_US.UTF-8', 07:41:15 INFO - 'LANGUAGE': 'en_US:en', 07:41:15 INFO - 'LOGNAME': 'cltbld', 07:41:15 INFO - 'MAIL': '/var/mail/cltbld', 07:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:15 INFO - 'MOZ_NO_REMOTE': '1', 07:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:15 INFO - 'NO_EM_RESTART': '1', 07:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:15 INFO - 'PWD': '/builds/slave/test', 07:41:15 INFO - 'SHELL': '/bin/bash', 07:41:15 INFO - 'SHLVL': '1', 07:41:15 INFO - 'TERM': 'linux', 07:41:15 INFO - 'TMOUT': '86400', 07:41:15 INFO - 'USER': 'cltbld', 07:41:15 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063', 07:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:15 INFO - '_': '/tools/buildbot/bin/python'} 07:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:41:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:41:16 INFO - Cleaning up... 07:41:16 INFO - Return code: 0 07:41:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf91c49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0f410>, '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 0x1a10310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a107a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063', '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 07:41:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:41:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:41:16 INFO - Using env: {'DISPLAY': ':0', 07:41:16 INFO - 'HOME': '/home/cltbld', 07:41:16 INFO - 'LANG': 'en_US.UTF-8', 07:41:16 INFO - 'LANGUAGE': 'en_US:en', 07:41:16 INFO - 'LOGNAME': 'cltbld', 07:41:16 INFO - 'MAIL': '/var/mail/cltbld', 07:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:16 INFO - 'MOZ_NO_REMOTE': '1', 07:41:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:16 INFO - 'NO_EM_RESTART': '1', 07:41:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:16 INFO - 'PWD': '/builds/slave/test', 07:41:16 INFO - 'SHELL': '/bin/bash', 07:41:16 INFO - 'SHLVL': '1', 07:41:16 INFO - 'TERM': 'linux', 07:41:16 INFO - 'TMOUT': '86400', 07:41:16 INFO - 'USER': 'cltbld', 07:41:16 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063', 07:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:16 INFO - '_': '/tools/buildbot/bin/python'} 07:41:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:16 INFO - Downloading/unpacking jsonschema 07:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:41:18 INFO - Downloading/unpacking functools32 (from jsonschema) 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41:18 INFO - Downloading functools32-3.2.3-2.tar.gz 07:41:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:41:18 INFO - warning: no files found matching '*.txt' 07:41:18 INFO - no previously-included directories found matching 'build' 07:41:18 INFO - no previously-included directories found matching 'dist' 07:41:18 INFO - no previously-included directories found matching '.git*' 07:41:18 INFO - Installing collected packages: jsonschema, functools32 07:41:18 INFO - Running setup.py install for functools32 07:41:18 INFO - warning: no files found matching '*.txt' 07:41:18 INFO - no previously-included directories found matching 'build' 07:41:18 INFO - no previously-included directories found matching 'dist' 07:41:18 INFO - no previously-included directories found matching '.git*' 07:41:18 INFO - Successfully installed jsonschema functools32 07:41:18 INFO - Cleaning up... 07:41:18 INFO - Return code: 0 07:41:18 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:41: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')]} 07:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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')]} 07:41:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf91c49f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19805a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0f410>, '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 0x1a10310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a107a0>, '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': '8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063', '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 07:41: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', 'flake8'] in /builds/slave/test/build 07:41: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 flake8 07:41:18 INFO - Using env: {'DISPLAY': ':0', 07:41:18 INFO - 'HOME': '/home/cltbld', 07:41:18 INFO - 'LANG': 'en_US.UTF-8', 07:41:18 INFO - 'LANGUAGE': 'en_US:en', 07:41:18 INFO - 'LOGNAME': 'cltbld', 07:41:18 INFO - 'MAIL': '/var/mail/cltbld', 07:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:18 INFO - 'MOZ_NO_REMOTE': '1', 07:41:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:18 INFO - 'NO_EM_RESTART': '1', 07:41:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:18 INFO - 'PWD': '/builds/slave/test', 07:41:18 INFO - 'SHELL': '/bin/bash', 07:41:18 INFO - 'SHLVL': '1', 07:41:18 INFO - 'TERM': 'linux', 07:41:18 INFO - 'TMOUT': '86400', 07:41:18 INFO - 'USER': 'cltbld', 07:41:18 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063', 07:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:18 INFO - '_': '/tools/buildbot/bin/python'} 07:41:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:18 INFO - Downloading/unpacking flake8 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:41:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:41:20 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 07:41:20 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 07:41:20 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 07:41:20 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 07:41:20 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 07:41:20 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 07:41:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:41:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:41:20 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 07:41:20 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 07:41:20 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 07:41:20 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 07:41:20 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 07:41:20 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 07:41:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41: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 07:41:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:41:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:41:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:41:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:41:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:41:21 INFO - no previously-included directories found matching 'docs/_build' 07:41:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:41:21 INFO - Running setup.py install for pep8 07:41:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:41:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:41:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:41:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:41:21 INFO - no previously-included directories found matching 'docs/_build' 07:41:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:41:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:41:21 INFO - Cleaning up... 07:41:21 INFO - Return code: 0 07:41:21 INFO - Running post-action listener: _resource_record_post_action 07:41:21 INFO - Running post-action listener: _start_resource_monitoring 07:41:21 INFO - Starting resource monitoring. 07:41:21 INFO - ##### 07:41:21 INFO - ##### Running install step. 07:41:21 INFO - ##### 07:41:21 INFO - Running pre-action listener: _resource_record_pre_action 07:41:21 INFO - Running main action method: install 07:41:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:41:21 INFO - Reading from file tmpfile_stdout 07:41:21 INFO - Detecting whether we're running mozinstall >=1.0... 07:41:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:41:21 INFO - Reading from file tmpfile_stdout 07:41:21 INFO - Output received: 07:41:21 INFO - Usage: mozinstall [options] installer 07:41:21 INFO - Options: 07:41:21 INFO - -h, --help show this help message and exit 07:41:21 INFO - -d DEST, --destination=DEST 07:41:21 INFO - Directory to install application into. [default: 07:41:21 INFO - "/builds/slave/test"] 07:41:21 INFO - --app=APP Application being installed. [default: firefox] 07:41:21 INFO - mkdir: /builds/slave/test/build/application 07:41:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:41:38 INFO - Reading from file tmpfile_stdout 07:41:38 INFO - Output received: 07:41:38 INFO - /builds/slave/test/build/application/firefox/firefox 07:41:38 INFO - Running post-action listener: _resource_record_post_action 07:41:38 INFO - ##### 07:41:38 INFO - ##### Running run-tests step. 07:41:38 INFO - ##### 07:41:38 INFO - Running pre-action listener: _resource_record_pre_action 07:41:38 INFO - Running main action method: run_tests 07:41:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:41:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:41:38 INFO - Python 2.7.3 07:41:38 INFO - Return code: 0 07:41:38 INFO - grabbing minidump binary from tooltool 07:41:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:38 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a0f410>, '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 0x1a10310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a107a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:41:38 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 07:41:38 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 07:41:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:41:38 INFO - Return code: 0 07:41:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:41:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:41:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:41:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:41:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:41:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:41:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:41:39 INFO - Return code: 0 07:41:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 07:41:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 07:41:39 INFO - Using env: {'DISPLAY': ':0', 07:41:39 INFO - 'HOME': '/home/cltbld', 07:41:39 INFO - 'LANG': 'en_US.UTF-8', 07:41:39 INFO - 'LANGUAGE': 'en_US:en', 07:41:39 INFO - 'LOGNAME': 'cltbld', 07:41:39 INFO - 'MAIL': '/var/mail/cltbld', 07:41:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:41:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:39 INFO - 'MOZ_NO_REMOTE': '1', 07:41:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:41:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:39 INFO - 'NO_EM_RESTART': '1', 07:41:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:39 INFO - 'PWD': '/builds/slave/test', 07:41:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:41:39 INFO - 'SHELL': '/bin/bash', 07:41:39 INFO - 'SHLVL': '1', 07:41:39 INFO - 'TERM': 'linux', 07:41:39 INFO - 'TMOUT': '86400', 07:41:39 INFO - 'USER': 'cltbld', 07:41:39 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063', 07:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:39 INFO - '_': '/tools/buildbot/bin/python'} 07:41:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 07:41:39 INFO - mozversion application_buildid: 20160503043038 07:41:39 INFO - mozversion application_changeset: 21afe591e4954a256ab665496885ee63a33ed7d6 07:41:39 INFO - mozversion application_display_name: Nightly 07:41:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:41:39 INFO - mozversion application_name: Firefox 07:41:39 INFO - mozversion application_remotingname: firefox 07:41:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:41:39 INFO - mozversion application_vendor: Mozilla 07:41:39 INFO - mozversion application_version: 49.0a1 07:41:39 INFO - mozversion platform_buildid: 20160503043038 07:41:39 INFO - mozversion platform_changeset: 21afe591e4954a256ab665496885ee63a33ed7d6 07:41:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:41:39 INFO - mozversion platform_version: 49.0a1 07:41:39 INFO - using testdate: 1462286499 07:41:39 INFO - actual date: 1462286499 07:41:39 INFO - starting webserver on 'localhost:49892' 07:41:39 INFO - SUITE-START | Running 2 tests 07:41:39 INFO - TEST-START | dromaeo_css 07:41:39 INFO - operating with platform_type : linux_ 07:41:39 INFO - Initialising browser for dromaeo_css test... 07:41:39 INFO - TEST-INFO | started process 6303 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHCU9Ma/profile http://localhost:49892/getInfo.html) 07:41:43 INFO - PROCESS | 6303 | 07:41:43 INFO - PROCESS | 6303 | (process:6371): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:41:44 INFO - PROCESS | 6303 | __metrics Screen width/height:1600/1200 07:41:44 INFO - PROCESS | 6303 | colorDepth:24 07:41:44 INFO - PROCESS | 6303 | Browser inner width/height: 1024/697 07:41:44 INFO - PROCESS | 6303 | __metrics 07:41:45 ERROR - PROCESS | 6303 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 07:41:46 INFO - TEST-INFO | 6303: exit 0 07:41:46 INFO - Browser initialized. 07:41:46 INFO - Running cycle 1/1 for dromaeo_css test... 07:41:46 INFO - TEST-INFO | started process 6422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHCU9Ma/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:41:48 INFO - PROCESS | 6422 | 07:41:48 INFO - PROCESS | 6422 | (process:6485): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:41:58 INFO - PROCESS | 6422 | RSS: Main: 164855808 07:41:58 INFO - PROCESS | 6422 | 07:42:47 INFO - PROCESS | 6422 | 1462286567659 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] 07:44:55 INFO - PROCESS | 6422 | Cycle 1(1): loaded http://localhost:49892/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49892/tests/dromaeo/cssquery-ext.html) 07:44:56 INFO - PROCESS | 6422 | RSS: Main: 171323392 07:44:56 INFO - PROCESS | 6422 | 07:47:57 INFO - PROCESS | 6422 | Cycle 1(1): loaded http://localhost:49892/tests/dromaeo/cssquery-ext.html (next: http://localhost:49892/tests/dromaeo/cssquery-jquery.html) 07:47:58 INFO - PROCESS | 6422 | RSS: Main: 167329792 07:47:58 INFO - PROCESS | 6422 | 07:51:00 INFO - PROCESS | 6422 | Cycle 1(1): loaded http://localhost:49892/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49892/tests/dromaeo/cssquery-mootools.html) 07:51:00 INFO - PROCESS | 6422 | RSS: Main: 168189952 07:51:00 INFO - PROCESS | 6422 | 07:54:02 INFO - PROCESS | 6422 | Cycle 1(1): loaded http://localhost:49892/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49892/tests/dromaeo/cssquery-prototype.html) 07:54:03 INFO - PROCESS | 6422 | RSS: Main: 166088704 07:54:03 INFO - PROCESS | 6422 | 07:57:05 INFO - PROCESS | 6422 | Cycle 1(1): loaded http://localhost:49892/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49892/tests/dromaeo/cssquery-yui.html) 07:57:06 INFO - PROCESS | 6422 | RSS: Main: 167526400 07:57:06 INFO - PROCESS | 6422 | 08:00:08 INFO - PROCESS | 6422 | Cycle 1(1): loaded http://localhost:49892/tests/dromaeo/cssquery-yui.html (next: http://localhost:49892/tests/dromaeo/cssquery-dojo.html) 08:00:08 INFO - PROCESS | 6422 | RSS: Main: 169480192 08:00:08 INFO - PROCESS | 6422 | 08:00:08 INFO - PROCESS | 6422 | __start_tp_report 08:00:08 INFO - PROCESS | 6422 | _x_x_mozilla_page_load 08:00:08 INFO - PROCESS | 6422 | _x_x_mozilla_page_load_details 08:00:08 INFO - PROCESS | 6422 | |i|pagename|runs| 08:00:08 INFO - PROCESS | 6422 | |0;dojo.html;3127.0618814355694;3178.4755515339975;3184.283536204353;3217.903462896111;3221.806691598504;5337.519623233903;5374.032674118662;5380.21986811913;5395.082835917893;5398.514133727964;5245.082110630643;5336.17289320155;5361.919571206435;5400.216968539559;5445.401005889359;4898.412190537131;4915.5084491550915;4967.329410529586;4988.775505102261;5031.421386540558;875.7217570059554;4886.60907127429;4942.9258561121615;4955.4548999610015;4986.4764199758865;4919.7540122993705;4923.286123512106;4942.579880710144;4942.728149951751;4994.900101997976;4815.66290359675;4945.134601444733;5004;5017.874553136165;5061.8734531637;4858.854234372974;4863.659543831933;4899.681520701179;4903.828366007208;4932.975335123338;5198.896022079575;5212.4266330703595;5229.032628963654;5229.816956406507;5284.022455845642;5651.2935883014625;5656.490915817555;5674.886502269931;5746.626469279525;5790.305163380379;5622.212890195376;5649.406812284692;5662.462066103755;5695.34503532095;5735.82792516221;5306.867328316785;5308.867278318073;5311.282976798121;5317.441668624816;5379.919301210485;5745.195672605839;5758.568107391879;5787.565932555075;5813.7383817728305;5814.360420353758;5592.552595792326;5625;5629.521490673339;5636.859078522988;5659.066254068115;5688.914666280009;5697.4587414195585;5707.828765137053;5716.399778023331;5723.742431590588;5602.943970560243;5654.858628534237;5670.319561652628;5750.913736293875;5775.740091695884;5548.528375088082;5669.744861481243;5689.2319536862;5736.340320863071;5785.942140578541;4297.247981603207;4302.09655972243;4320.027993701455;4321.308590625485;4332.870013899588;3804.429335599627;3864.381698928158;3878.204967981557;3936.4488971544006;3957.92084158321;5430.5927055471;5430.945690543123;5436.048691478975;5444.537214336747;5481.588880833874;5653.858653533613;5665.546756259571;5671.177679236487;5699.800506982236;5715.371309155989;5462.126059830408;5542.584306177053;5551.417101204396;5588.944110558924;5605.159226116115;4879.121758083508;4914.238293064581;4919.631027672939;4923.876903077452;4925.261210818334;5770.365259821417;5892.764289428461;5919.408059194132;5931.139984702194;5961.165436838846;5778.94221057784;5789.305283365855;5789.8552536186935;5799.507041901317;5831.854203644858;5904.527637789052;5930.199423078002;5954.493868021266;5956.434138756811;5961.552883533839;5502.174673798802;5641.548676105819;5665.0935850265405;5676.318841739017;5752.395998420106;5734.283214598176;5759.2512973313205;5761.308642962871;5780.682062486436;5827.59206855516;5550.888982220414;5594.13290939905;5601.075822489243;5602.85992850182;5605.878824235087;5429;5488.506034456918;5518.2826232591115;5592.608517403743;5662.348829884616;5353.4646535346155;5415.620906536505;5421.945780542144;5516.393196748435;5524.281843360337;5570.693611851387;5595.356533998643;5599.9720001401365;5642.689652069175;5648.2092507049865;5483.040467918018;5492.231087647812;5506.531944784738;5508.614396992172;5576.693281869536 08:00:08 INFO - PROCESS | 6422 | |1;ext.html;603.3242768099726;643.4562794438699;646.8997305417662;656.3534918105665;665.7936039827654;36665.450018249714;38187.23625527495;38223;38297.61702382976;38354.61645383545;40527;40833.795831020805;41476.17047659045;41480.792596036976;41555.376669349906;8413.579321033954;8648.74593183991;8682.088380720028;8684.782880428009;8718.17177368149;8551.657933682645;8679.392442529026;8695.521746303952;8708.129187081304;8831;8818.470891746516;8850.822983540358;8872;8888.155625215593;8945.373823832335;8817.470951742884;8832.558372081434;8885.333599979962;8891.288696904265;8908.10918908104;8647.351448641377;8709.95645021777;8766.035736069027;8797.692080777206;8828.735137945872;41272.38091428631;41847.58152418467;41919;42036.789816050725;42046.57953420488;3721.6464435878547;3771.340015497277;3817.408301713239;3984.342583473723;4319;31216.687833121832;31302.530462043087;31613.683863161303;31625.8418707905;32873.83563082193;4130.958690413087;4180.24755544002;4202.936955945664;4280.6789490788005;4315;208816;214238.78641820385;215238;217288;243486;56443.073477285114;57700.71149644225;57776;57780;57864.42135578675;55976.44023559794;56488.43511564914;57198.42801572014;57352;58534;15836.445724399591;16015.759763603555;16073;16122.435714750161;16168.514944551682;12334.259944403186;12389.566365177356;12408.75182496345;12429.627111186679;12506.937465312616;19099.09009099079;19150.521236969187;19162.13770380336;19212.327568535035;19277.325293614656;7283.308085731847;7378.413641067196;7384.741534046282;7435.256474352522;7538.585377804164;1049.8320268756963;1074.231924174219;1078.6817888722846;1141.7374003978964;1152.1071169843437;31828.204294892348;31871.681283187336;32062;32211.35577288441;32673.836630817168;1153.0487347937985;1172.7595842852195;1191.880811918801;1211.3216598704753;1241.2552468518998;16740.58148546296;16759.1620418981;17072.658546829243;17143.74284385735;17195.914020429816;482936;491444;491795;492398;492419;57331.426685733444;58933.705331473924;59086.704566476896;59109.113363299584;59117;1377.7037936843426;1380.758367285721;1404.95082672106;1405.6977749783846;1406.0438901546843;30523.2369190772;31033.844830775703;31275.530867036556;31613.683863161074;31664.366712666077;50906.236406453194;51273.7436312831;51380;51422.485775143265;52000.73999629977;396026;398004;399252;399424;399734;27776.44447111087;28107.297317566405;28183.859080704464;28252.85873570619;28444.146675599764;47983.5201647993;48883;49090;49387;49387.506124939726;40369.59630403658;41868;42232.1553568933;42372.57627423686;42436.8014868485;40299;40601.390979135926;40868;41610.79194604129;41771;36816;37467.6253237475;37777.433338499395;37938.43092353562;39933.60066399299;31316;34970.532414345034;35060.64939350574;35079.82460087683;35844;27259.86370068137;27780.16659500218;27795.888164473196;27808.721912780613;28188.718112819428 08:00:08 INFO - PROCESS | 6422 | |2;jquery.html;359.9928001439971;365.74998517229795;380.45784756721685;383.77740910272047;386.3200766650695;17820.821791782077;18814;19180.808191918077;19717.704234436496;19932.302369417073;18375;18643.813561864376;19032.9048354758;19163.50874386328;19174.712379314322;5429.294191755066;5503.229547863302;5718.285214348207;5746.942530574704;5769.336526299488;5481.5340696040885;5499.120140777476;5500.697461639608;5508.366537848158;5526.281583394153;5343.17180836969;5431.103867861818;5438.293021907147;5481.725913704318;5483.424240454755;5552.3892371839065;5591.608587398884;5603.551715862721;5612.298462692163;5618.269624948772;4793.2810078488155;4903.84759581498;4917.754112294407;4932.630052746023;4960.553550180501;22183.66724499134;22205.11179552816;22650.546989060127;22827;23048.884755576113;2321.025169428844;2371.27676058802;2419.9637005444933;2450.9387265318333;2506.348349429143;13713.45146194151;14150.787738183935;14573.927130364385;14596.927015364961;14830.110193388431;1890.1399863062275;1951.658459769549;1975.9506012349661;1994.6110508450859;2033.786452422504;80965;81488;82174;82283.5885820567;82383;10012.849807252896;10138.391696498235;10456.268061235793;10470.947645261725;10619.734506637242;14512.709745805025;14597.489087881873;14650.487232947009;14694.412223511154;14695.559133226021;7872.842543149105;7990.4406691532195;8016.71941482057;8139.331437055508;8199.139090395423;7686.500377475446;7824.37405007598;7861.606919653995;7869.527828330204;7947.443678942419;6474.773382931575;6515.446187074152;6528.771492997722;6531.346865313526;6640.369164929324;1836.9540761481069;1854.4343975087727;1878.286251224526;1885.3401309541825;1888.2163901980525;955.8852937647388;1033.5194134727237;1101.2071308657753;1132.9576789353814;1136.2500749505452;18841.246350146113;19112.522186945436;19163.61672766537;19273.710894336597;19559.11983960725;1061.920355973305;1066.3974854207347;1083.6911480228255;1092.3282181458346;1101.8402331661864;10671.19966002553;10872.891271087346;10948.945255273673;10963.725906852233;10975.615853445252;380516;382644;390494;493494;498436;91515.5424222888;99801;102075;104019.4799026;104812.47593762135;1009.5002973528151;1034.8654674892216;1066.7333166708322;1068.4444089073638;1080.7568297133082;16368.67262654764;17112.401065962633;17299.30802767875;17468.388606398716;17615.383461578782;39126.217475649755;39842.402363963985;40291.395629065;40682;41203;56096.439035609124;57707.71146144242;57739;58227.70886145542;58474.7076264633;8217.260446559838;8443.12933602578;8623.956880215559;8768.693095741619;8847.867281990646;12720.936395317964;12779.680507987374;12883.549075782303;13318.467261309439;13414.798778018143;11014.614488492864;11147.944260278971;11342.20604557673;11379.317240965569;11472;11297;11334.716632084264;11359.148063895076;11488.080953523531;11540.538378465104;11483.48324325424;11489.368084755419;11503.367314797766;11670.416479176178;11687.357195353998;8720.302375809793;8772.342074344322;8797.516136612549;8807.735767926972;8854.114588541095;11011.669649910515;11528.654140375802;11739.11956603241;11808.055355571361;11889.405529723652 08:00:08 INFO - PROCESS | 6422 | |3;mootools.html;1479.4304192885738;1486.4648726458477;1610.4202487104646;1754.964570903167;1780.8753387262898;7110.1112360954885;7426.591537465437;7483.887741683872;7832.334251588614;7847.450678452504;7525.5860927648955;7662.080550333968;7676.731314403997;7678.692852285916;7695.307422331989;2107.6838474228834;2150.5591353772516;2157.385145233609;2157.46063484129;2158.7949144831296;2110.3668899330214;2129.1057755742627;2149.344449942767;2151.354593621915;2152.569486102778;2139.5613899150712;2143.399848042543;2151.107290474451;2153.5692861427697;2160.168335190947;2075.9065842037144;2092.0794850265834;2092.079485026591;2093.7382827146607;2100.2754049852774;2086.2385229391316;2105.105330234644;2106.136484041536;2120.5652841167525;2131.9040643171093;7759.961200193963;7799.298063174285;7824.217578242187;7829.64766585505;7869.685212591547;4554.27131658933;4744.098621261984;4757.524247575249;4766.261229509431;4780.235162374003;3049.603551538308;3186.374948776118;3210.325831575372;3217.983910080458;3237.902862914116;973.4256788494822;1004.8794144702609;1023.4575674892244;1024.7028361775076;1067.6796960911772;9944.453055081967;9997;10011.49942502872;10026;10034.9498252509;4098.364753463218;4120.320147175682;4121.979390103031;4222.641075508616;4234.428352172479;8561.315094792402;8585.570721463902;8643.913560864437;8646.610902509403;8656.826863462695;4507.932381014288;4519.932201016922;4522.819087236474;4523.570260825217;4524.751138687404;3894.766314021168;4156.147989662112;4277;4321.351797230441;4346.434963454731;3508.754387192872;3584.2831433713363;3617.5478065241846;3636.581793093828;3654.5066416033496;1132.3545579019878;1133.6032388663903;1135.778523187987;1137.3630766770634;1146.5585749486509;891.6789955615973;970.5438443931482;1010.2776514791959;1012.6101450941441;1049.2864851900629;5566.777328906798;5589.524890384363;5606.495415412633;5643.5203007743985;5651.406602306781;1024.7079582319004;1028.3878947473333;1050.6217761605815;1067.5356220044305;1102.167863263231;3919.5884432134785;3950.6839452843706;4007.519097708294;4018.7789671568344;4022.054817117975;8803.603837827313;9132.726018219464;9171.495567743705;9194.310426718022;9213.631454741735;8945;8999.730008099768;9034.593443295067;9061.728148155566;9124;7222.169450513154;7406;7413.7775866723005;7416.666250018762;7422.703091876265;5467.343918729778;5531.446855314597;5589.5248903842;5656.0667489865355;5679.6876171810945;8543.273821725223;8684.131586841266;8772.692955746774;8790.077041910507;8816.647334106563;8570.957145214234;8783.165599268059;9209.401388909699;9229.169374756304;9270.675526356816;6279.529035322278;6792.286809884891;6850.725970961105;6858.451323893977;7038.225795162426;7674.731384401519;7691.730789422343;7722.575258360844;7733.110692270461;7761.068671759425;6720.395164435225;6852.965735171292;6919.896201557081;6953.374196322356;6977.2673869243;6873.243943166148;7013.053237813034;7015.859682806214;7019.5788252705;7022.754203602849;6125.448709616156;6165.784197553064;6435.259945106185;6460.4508616766225;6483.546151769519;4671.509491503343;4756.429228492603;4806.351142595845;4914.0908931847725;5060.51925067118;4647.209974304444;4668.5564871337165;4669.41632295963;4683.648726345606;4762.452317983476 08:00:08 INFO - PROCESS | 6422 | |4;prototype.html;312.6982461924243;319.0567019247443;323.4614367078815;323.4646659778068;326.86925229908036;5438.585967648411;5442.319710036246;5448.42791506892;5486.204500347447;5541.556675465963;5402.621816472849;5423.48142520094;5423.728813559326;5438.129899216126;5454.181872719094;3999.680025597945;4097.44684467596;4219.346001369792;4227.640650544708;4251.064765751546;4238.427812245338;4243.151369726052;4260.424842646234;4261.893452663678;4272.530021697611;4180.641291580248;4181.560936101711;4223.303154979425;4231.87304380869;4237.7669228192435;4075.4090656854737;4218.198542276958;4219.620234178923;4229.815651617552;4237.343211802176;3678.411454167347;3713.350163721338;3727.105494681257;3730.4404339349044;3731.9813400933094;5259.001579399804;5275.947240527584;5286.577073834084;5292.285541451894;5293.39126000511;4769.666123371366;4826.455534229048;4852.4662287148385;4872.123017856784;4883.780229889628;5616.269884914976;5623.297087864017;5639.407862174454;5713.3429655589725;5726.284214473191;4072.6741860651373;4073.9388909166387;4080.204360149772;4107;4118.64330570587;5686.545076393879;5879.323877754027;5889.5288376930175;5901.527877769811;5904.545840683206;4116;4160.729552579072;4166.791660416967;4185.539590645027;4189.2459357315365;4210.705250632487;4219.767912764827;4221.831126754957;4227.3447615619625;4247.787610619456;4477.843275485342;4758.738269395217;4799.712017278975;4816.229403295456;4833.03339332135;5728.341240757283;5737.512311453574;5763.538916886639;5818.592698511064;5823.941760582425;1480.8297045839865;1497.4758834408087;1507.8265999410207;1510.3731951240331;1516.8558986896228;914.7530166854912;970.146271281268;982.3516479123743;985.2462865907586;1015.664830605913;5918.171455996164;5936.970315148396;5943.821685349447;5985.229305537484;5987.161797348288;6245.28179259391;6265.498760099181;6274.341194174637;6312.337204593543;6317.305096439388;5814;5893.6463812171405;5904.704764761745;5917.970410148007;5926.288845338587;3328.517364982064;3334.3331333732867;3349.69852713257;3385.2721664841683;3403.149212696826;6293.748250070037;6305.873882522324;6370.617762934239;6385.616862988236;6464.903026454607;6298.212723409574;6356.14192084072;6360.173177486897;6375.968120159369;6413.422791948747;6259.812205633838;6452.741890324334;6470.48236141117;6527.15147030883;6536.607803531803;6217.409346112112;6250.874982500415;6275.435210831047;6293.181886354744;6312.400321969406;6210.254769427517;6211;6215.875682486235;6227.532935029982;6268;5817.243758311392;6161.137440758387;6166.290876549254;6174.233717432273;6185.103160041679;4072.226277007359;4077.9601201693376;4121.381792731115;4130.504339479162;4132.772697501546;5772.711364431678;5935.614185078129;5964.970175149097;5984.281886173687;6016.398360163948;5814.825555233349;5826.592138550431;5837.532997360286;5850.531957443309;5853.122031695109;5774.249347584787;5782.855428614318;5789.91315130265;5791.218185544897;5799.652020878761;5291.735413229246;5483.2049352844415;5571.331440227199;5650.434956504481;5664.688442135722;5816.651000939957;5818.272715910512;5826.679532625746;5827.329857066322;5833.241678581757;5565.30433695788;5688.687122208318;5692.1746346778655;5692.601517893708;5729.255196824386 08:00:08 INFO - PROCESS | 6422 | |5;yui.html;713.9250378710235;775.9456838021338;776.9067711874576;779.8401327727817;802.029544251456;13398.665033374158;13595.864041359584;13854.653633659163;13869.583912482616;13870.237136957463;13260.933695331534;13345.666358341023;13348.065635405526;13357.866421335784;13367;661.4774328280653;764.552736649061;811.6388207247777;828.0146625515647;830.8546004449228;803.1125606205147;806.7216810200472;808.1393316118345;812.8374325134997;813.0162503370899;869.5782545465444;874.9343799215053;876.9780755481132;878.4860856398982;880.8194320164351;843.797488602734;853.9658413663477;854.974350769478;857.7126662567985;859.2867919626694;636.598942666122;639.1307821362942;639.6481934935766;640.5996252342286;641.1856941684035;12524.937375313066;12561.120721549496;12630;12646.936765316206;12659.30373829439;13106.934465327708;13439.26084065376;13524.86475135246;13570.728585428236;13600.183988960694;11253.156013298954;11353.375564343958;11360.715982100432;11379.772404551863;11402.258853174517;3813.122981714221;3860.1121741999495;3860.4209368594657;3866.709996750255;3894.201688653819;48276.758616206695;49970.7501462494;49986.999999999636;50015;51787.223191652156;10319.896801032044;10938.781224375627;10958.123350131971;11035.44822758859;11159.051480624237;17227.913860430617;17316;17351.82648173502;17356.3057477702;17366.21852016662;8083.797905052421;8168.714095006765;8248.13394593571;8294.917050829536;8350.749477515685;4695.976520117378;4704.623630109583;4709.929351059737;4768.094062128254;4792.209285467929;3254;3327.101682545699;3329.6337402885665;3330.7335413167375;3331.06730115568;595.6694034810722;606.9969650151721;621.8445388652837;622.8411755002445;624.2664868779257;737.2001378504276;749.1272667342485;750.6509473094928;751.0574229342141;759.8708219602681;7888.605569721606;8232.382571307176;8261.463004904663;8362.916370836336;8499.447535910145;733.2740586819117;758.9279018493235;764.8432071425344;775.3603277296253;821.4906757810196;4227.175700738327;4273.273543497613;4303.526612072669;4333.9133217335475;4370.481762181411;55459;55687;56012;56262.718686406304;57016;50560.74719626379;52355.73822130941;52423.21365179525;53339.19991200135;55040.72479637576;49636.50363496391;49927;50417;50863.49136508587;51383.74308128435;8470.618822152896;8508.489490630334;8527.658893644184;8695.86956195645;8724.825503489768;32587.185320366232;32720.836395817867;32893.67106328906;33506.66493335035;33632.327353453285;39545.406818898315;41229;42444.78777606092;42857;43360.783196083816;10135;10234.6417875374;10512.632057877938;10812.837807432737;10949.83575246356;12236.388180591113;12246.326452045223;12272.202306850026;12614.306213158365;12618.621441356774;11222.438878056228;11263.26788758728;11317.547298108313;11329.433528323716;11385.146114041645;11913.16607837443;11957.641270761891;12036.879631203927;12213.45039473208;12581;10563.894361056291;11697.356645384585;12676.302803345905;13055.281959491938;13077;10820.350778952974;10868.782624347627;10985.890141098487;11065.170112241452;11203.327800331681;10815.56737730482;10820.729481762704;11221;11235.831462527905;11287.379194144401 08:00:08 INFO - PROCESS | 6422 | __end_tp_report 08:00:08 INFO - PROCESS | 6422 | __start_cc_report 08:00:08 INFO - PROCESS | 6422 | _x_x_mozilla_cycle_collect,335 08:00:08 INFO - PROCESS | 6422 | __end_cc_report 08:00:08 INFO - PROCESS | 6422 | __startTimestamp1462287608729__endTimestamp 08:00:08 INFO - PROCESS | 6422 | 08:00:08 INFO - PROCESS | 6422 | ------- Summary: start ------- 08:00:08 INFO - PROCESS | 6422 | Number of tests: 6 08:00:08 INFO - PROCESS | 6422 | 08:00:08 INFO - PROCESS | 6422 | [#0] dojo.html Cycles:165 Average:5296.69 Median:5524.28 stddev:680.86 (12.3%) stddev-sans-first:661.33 08:00:08 INFO - PROCESS | 6422 | Values: 3127.1 3178.5 3184.3 3217.9 3221.8 5337.5 5374.0 5380.2 5395.1 5398.5 5245.1 5336.2 5361.9 5400.2 5445.4 4898.4 4915.5 4967.3 4988.8 5031.4 875.7 4886.6 4942.9 4955.5 4986.5 4919.8 4923.3 4942.6 4942.7 4994.9 4815.7 4945.1 5004.0 5017.9 5061.9 4858.9 4863.7 4899.7 4903.8 4933.0 5198.9 5212.4 5229.0 5229.8 5284.0 5651.3 5656.5 5674.9 5746.6 5790.3 5622.2 5649.4 5662.5 5695.3 5735.8 5306.9 5308.9 5311.3 5317.4 5379.9 5745.2 5758.6 5787.6 5813.7 5814.4 5592.6 5625.0 5629.5 5636.9 5659.1 5688.9 5697.5 5707.8 5716.4 5723.7 5602.9 5654.9 5670.3 5750.9 5775.7 5548.5 5669.7 5689.2 5736.3 5785.9 4297.2 4302.1 4320.0 4321.3 4332.9 3804.4 3864.4 3878.2 3936.4 3957.9 5430.6 5430.9 5436.0 5444.5 5481.6 5653.9 5665.5 5671.2 5699.8 5715.4 5462.1 5542.6 5551.4 5588.9 5605.2 4879.1 4914.2 4919.6 4923.9 4925.3 5770.4 5892.8 5919.4 5931.1 5961.2 5778.9 5789.3 5789.9 5799.5 5831.9 5904.5 5930.2 5954.5 5956.4 5961.6 5502.2 5641.5 5665.1 5676.3 5752.4 5734.3 5759.3 5761.3 5780.7 5827.6 5550.9 5594.1 5601.1 5602.9 5605.9 5429.0 5488.5 5518.3 5592.6 5662.3 5353.5 5415.6 5421.9 5516.4 5524.3 5570.7 5595.4 5600.0 5642.7 5648.2 5483.0 5492.2 5506.5 5508.6 5576.7 08:00:08 INFO - PROCESS | 6422 | 08:00:08 INFO - PROCESS | 6422 | [#1] ext.html Cycles:180 Average:53826.79 Median:40448.30 stddev:102401.17 (253.2%) stddev-sans-first:102610.46 08:00:08 INFO - PROCESS | 6422 | Values: 603.3 643.5 646.9 656.4 665.8 36665.5 38187.2 38223.0 38297.6 38354.6 40527.0 40833.8 41476.2 41480.8 41555.4 8413.6 8648.7 8682.1 8684.8 8718.2 8551.7 8679.4 8695.5 8708.1 8831.0 8818.5 8850.8 8872.0 8888.2 8945.4 8817.5 8832.6 8885.3 8891.3 8908.1 8647.4 8710.0 8766.0 8797.7 8828.7 41272.4 41847.6 41919.0 42036.8 42046.6 3721.6 3771.3 3817.4 3984.3 4319.0 31216.7 31302.5 31613.7 31625.8 32873.8 4131.0 4180.2 4202.9 4280.7 4315.0 208816.0 214238.8 215238.0 217288.0 243486.0 56443.1 57700.7 57776.0 57780.0 57864.4 55976.4 56488.4 57198.4 57352.0 58534.0 15836.4 16015.8 16073.0 16122.4 16168.5 12334.3 12389.6 12408.8 12429.6 12506.9 19099.1 19150.5 19162.1 19212.3 19277.3 7283.3 7378.4 7384.7 7435.3 7538.6 1049.8 1074.2 1078.7 1141.7 1152.1 31828.2 31871.7 32062.0 32211.4 32673.8 1153.0 1172.8 1191.9 1211.3 1241.3 16740.6 16759.2 17072.7 17143.7 17195.9 482936.0 491444.0 491795.0 492398.0 492419.0 57331.4 58933.7 59086.7 59109.1 59117.0 1377.7 1380.8 1405.0 1405.7 1406.0 30523.2 31033.8 31275.5 31613.7 31664.4 50906.2 51273.7 51380.0 51422.5 52000.7 396026.0 398004.0 399252.0 399424.0 399734.0 27776.4 28107.3 28183.9 28252.9 28444.1 47983.5 48883.0 49090.0 49387.0 49387.5 40369.6 41868.0 42232.2 42372.6 42436.8 40299.0 40601.4 40868.0 41610.8 41771.0 36816.0 37467.6 37777.4 37938.4 39933.6 31316.0 34970.5 35060.6 35079.8 35844.0 27259.9 27780.2 27795.9 27808.7 28188.7 08:00:08 INFO - PROCESS | 6422 | 08:00:08 INFO - PROCESS | 6422 | [#2] jquery.html Cycles:180 Average:27555.48 Median:2014.20 stddev:71939.45 (3571.6%) stddev-sans-first:72112.28 08:00:08 INFO - PROCESS | 6422 | Values: 360.0 365.7 380.5 383.8 386.3 17820.8 18814.0 19180.8 19717.7 19932.3 18375.0 18643.8 19032.9 19163.5 19174.7 5429.3 5503.2 5718.3 5746.9 5769.3 5481.5 5499.1 5500.7 5508.4 5526.3 5343.2 5431.1 5438.3 5481.7 5483.4 5552.4 5591.6 5603.6 5612.3 5618.3 4793.3 4903.8 4917.8 4932.6 4960.6 22183.7 22205.1 22650.5 22827.0 23048.9 2321.0 2371.3 2420.0 2450.9 2506.3 13713.5 14150.8 14573.9 14596.9 14830.1 1890.1 1951.7 1976.0 1994.6 2033.8 80965.0 81488.0 82174.0 82283.6 82383.0 10012.8 10138.4 10456.3 10470.9 10619.7 14512.7 14597.5 14650.5 14694.4 14695.6 7872.8 7990.4 8016.7 8139.3 8199.1 7686.5 7824.4 7861.6 7869.5 7947.4 6474.8 6515.4 6528.8 6531.3 6640.4 1837.0 1854.4 1878.3 1885.3 1888.2 955.9 1033.5 1101.2 1133.0 1136.3 18841.2 19112.5 19163.6 19273.7 19559.1 1061.9 1066.4 1083.7 1092.3 1101.8 10671.2 10872.9 10948.9 10963.7 10975.6 380516.0 382644.0 390494.0 493494.0 498436.0 91515.5 99801.0 102075.0 104019.5 104812.5 1009.5 1034.9 1066.7 1068.4 1080.8 16368.7 17112.4 17299.3 17468.4 17615.4 39126.2 39842.4 40291.4 40682.0 41203.0 56096.4 57707.7 57739.0 58227.7 58474.7 8217.3 8443.1 8624.0 8768.7 8847.9 12720.9 12779.7 12883.5 13318.5 13414.8 11014.6 11147.9 11342.2 11379.3 11472.0 11297.0 11334.7 11359.1 11488.1 11540.5 11483.5 11489.4 11503.4 11670.4 11687.4 8720.3 8772.3 8797.5 8807.7 8854.1 11011.7 11528.7 11739.1 11808.1 11889.4 08:00:08 INFO - PROCESS | 6422 | 08:00:08 INFO - PROCESS | 6422 | [#3] mootools.html Cycles:180 Average:5141.77 Median:4773.25 stddev:2754.36 (57.7%) stddev-sans-first:2748.34 08:00:08 INFO - PROCESS | 6422 | Values: 1479.4 1486.5 1610.4 1755.0 1780.9 7110.1 7426.6 7483.9 7832.3 7847.5 7525.6 7662.1 7676.7 7678.7 7695.3 2107.7 2150.6 2157.4 2157.5 2158.8 2110.4 2129.1 2149.3 2151.4 2152.6 2139.6 2143.4 2151.1 2153.6 2160.2 2075.9 2092.1 2092.1 2093.7 2100.3 2086.2 2105.1 2106.1 2120.6 2131.9 7760.0 7799.3 7824.2 7829.6 7869.7 4554.3 4744.1 4757.5 4766.3 4780.2 3049.6 3186.4 3210.3 3218.0 3237.9 973.4 1004.9 1023.5 1024.7 1067.7 9944.5 9997.0 10011.5 10026.0 10034.9 4098.4 4120.3 4122.0 4222.6 4234.4 8561.3 8585.6 8643.9 8646.6 8656.8 4507.9 4519.9 4522.8 4523.6 4524.8 3894.8 4156.1 4277.0 4321.4 4346.4 3508.8 3584.3 3617.5 3636.6 3654.5 1132.4 1133.6 1135.8 1137.4 1146.6 891.7 970.5 1010.3 1012.6 1049.3 5566.8 5589.5 5606.5 5643.5 5651.4 1024.7 1028.4 1050.6 1067.5 1102.2 3919.6 3950.7 4007.5 4018.8 4022.1 8803.6 9132.7 9171.5 9194.3 9213.6 8945.0 8999.7 9034.6 9061.7 9124.0 7222.2 7406.0 7413.8 7416.7 7422.7 5467.3 5531.4 5589.5 5656.1 5679.7 8543.3 8684.1 8772.7 8790.1 8816.6 8571.0 8783.2 9209.4 9229.2 9270.7 6279.5 6792.3 6850.7 6858.5 7038.2 7674.7 7691.7 7722.6 7733.1 7761.1 6720.4 6853.0 6919.9 6953.4 6977.3 6873.2 7013.1 7015.9 7019.6 7022.8 6125.4 6165.8 6435.3 6460.5 6483.5 4671.5 4756.4 4806.4 4914.1 5060.5 4647.2 4668.6 4669.4 4683.6 4762.5 08:00:08 INFO - PROCESS | 6422 | 08:00:08 INFO - PROCESS | 6422 | [#4] prototype.html Cycles:180 Average:4911.69 Median:5619.78 stddev:1489.39 (26.5%) stddev-sans-first:1453.02 08:00:08 INFO - PROCESS | 6422 | Values: 312.7 319.1 323.5 323.5 326.9 5438.6 5442.3 5448.4 5486.2 5541.6 5402.6 5423.5 5423.7 5438.1 5454.2 3999.7 4097.4 4219.3 4227.6 4251.1 4238.4 4243.2 4260.4 4261.9 4272.5 4180.6 4181.6 4223.3 4231.9 4237.8 4075.4 4218.2 4219.6 4229.8 4237.3 3678.4 3713.4 3727.1 3730.4 3732.0 5259.0 5275.9 5286.6 5292.3 5293.4 4769.7 4826.5 4852.5 4872.1 4883.8 5616.3 5623.3 5639.4 5713.3 5726.3 4072.7 4073.9 4080.2 4107.0 4118.6 5686.5 5879.3 5889.5 5901.5 5904.5 4116.0 4160.7 4166.8 4185.5 4189.2 4210.7 4219.8 4221.8 4227.3 4247.8 4477.8 4758.7 4799.7 4816.2 4833.0 5728.3 5737.5 5763.5 5818.6 5823.9 1480.8 1497.5 1507.8 1510.4 1516.9 914.8 970.1 982.4 985.2 1015.7 5918.2 5937.0 5943.8 5985.2 5987.2 6245.3 6265.5 6274.3 6312.3 6317.3 5814.0 5893.6 5904.7 5918.0 5926.3 3328.5 3334.3 3349.7 3385.3 3403.1 6293.7 6305.9 6370.6 6385.6 6464.9 6298.2 6356.1 6360.2 6376.0 6413.4 6259.8 6452.7 6470.5 6527.2 6536.6 6217.4 6250.9 6275.4 6293.2 6312.4 6210.3 6211.0 6215.9 6227.5 6268.0 5817.2 6161.1 6166.3 6174.2 6185.1 4072.2 4078.0 4121.4 4130.5 4132.8 5772.7 5935.6 5965.0 5984.3 6016.4 5814.8 5826.6 5837.5 5850.5 5853.1 5774.2 5782.9 5789.9 5791.2 5799.7 5291.7 5483.2 5571.3 5650.4 5664.7 5816.7 5818.3 5826.7 5827.3 5833.2 5565.3 5688.7 5692.2 5692.6 5729.3 08:00:08 INFO - PROCESS | 6422 | 08:00:08 INFO - PROCESS | 6422 | [#5] yui.html Cycles:180 Average:14046.84 Median:23580.26 stddev:16024.15 (68.0%) stddev-sans-first:16037.82 08:00:08 INFO - PROCESS | 6422 | Values: 713.9 775.9 776.9 779.8 802.0 13398.7 13595.9 13854.7 13869.6 13870.2 13260.9 13345.7 13348.1 13357.9 13367.0 661.5 764.6 811.6 828.0 830.9 803.1 806.7 808.1 812.8 813.0 869.6 874.9 877.0 878.5 880.8 843.8 854.0 855.0 857.7 859.3 636.6 639.1 639.6 640.6 641.2 12524.9 12561.1 12630.0 12646.9 12659.3 13106.9 13439.3 13524.9 13570.7 13600.2 11253.2 11353.4 11360.7 11379.8 11402.3 3813.1 3860.1 3860.4 3866.7 3894.2 48276.8 49970.8 49987.0 50015.0 51787.2 10319.9 10938.8 10958.1 11035.4 11159.1 17227.9 17316.0 17351.8 17356.3 17366.2 8083.8 8168.7 8248.1 8294.9 8350.7 4696.0 4704.6 4709.9 4768.1 4792.2 3254.0 3327.1 3329.6 3330.7 3331.1 595.7 607.0 621.8 622.8 624.3 737.2 749.1 750.7 751.1 759.9 7888.6 8232.4 8261.5 8362.9 8499.4 733.3 758.9 764.8 775.4 821.5 4227.2 4273.3 4303.5 4333.9 4370.5 55459.0 55687.0 56012.0 56262.7 57016.0 50560.7 52355.7 52423.2 53339.2 55040.7 49636.5 49927.0 50417.0 50863.5 51383.7 8470.6 8508.5 8527.7 8695.9 8724.8 32587.2 32720.8 32893.7 33506.7 33632.3 39545.4 41229.0 42444.8 42857.0 43360.8 10135.0 10234.6 10512.6 10812.8 10949.8 12236.4 12246.3 12272.2 12614.3 12618.6 11222.4 11263.3 11317.5 11329.4 11385.1 11913.2 11957.6 12036.9 12213.5 12581.0 10563.9 11697.4 12676.3 13055.3 13077.0 10820.4 10868.8 10985.9 11065.2 11203.3 10815.6 10820.7 11221.0 11235.8 11287.4 08:00:08 INFO - PROCESS | 6422 | -------- Summary: end -------- 08:00:08 INFO - PROCESS | 6422 | 08:00:09 INFO - TEST-INFO | 6422: exit 0 08:00:09 INFO - TEST-OK | dromaeo_css | took 1109634ms 08:00:09 INFO - TEST-START | kraken 08:00:09 INFO - operating with platform_type : linux_ 08:00:09 INFO - Initialising browser for kraken test... 08:00:09 INFO - TEST-INFO | started process 6661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpputwKP/profile http://localhost:49892/getInfo.html) 08:00:13 INFO - PROCESS | 6661 | 08:00:13 INFO - PROCESS | 6661 | (process:6728): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:00:14 INFO - PROCESS | 6661 | __metrics Screen width/height:1600/1200 08:00:14 INFO - PROCESS | 6661 | colorDepth:24 08:00:14 INFO - PROCESS | 6661 | Browser inner width/height: 1024/697 08:00:14 INFO - PROCESS | 6661 | __metrics 08:00:14 ERROR - PROCESS | 6661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:00:15 INFO - TEST-INFO | 6661: exit 0 08:00:15 INFO - Browser initialized. 08:00:15 INFO - Running cycle 1/1 for kraken test... 08:00:15 INFO - TEST-INFO | started process 6779 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpputwKP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:00:17 INFO - PROCESS | 6779 | 08:00:17 INFO - PROCESS | 6779 | (process:6840): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 08:00:27 INFO - PROCESS | 6779 | RSS: Main: 164970496 08:00:27 INFO - PROCESS | 6779 | 08:00:29 INFO - PROCESS | 6779 | Cycle 1(1): loaded http://localhost:49892/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49892/tests/kraken/driver.html?testName=audio-beat-detection) 08:00:30 INFO - PROCESS | 6779 | RSS: Main: 169340928 08:00:30 INFO - PROCESS | 6779 | 08:00:33 INFO - PROCESS | 6779 | Cycle 1(1): loaded http://localhost:49892/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49892/tests/kraken/driver.html?testName=audio-dft) 08:00:34 INFO - PROCESS | 6779 | RSS: Main: 171724800 08:00:34 INFO - PROCESS | 6779 | 08:00:36 INFO - PROCESS | 6779 | Cycle 1(1): loaded http://localhost:49892/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49892/tests/kraken/driver.html?testName=audio-fft) 08:00:37 INFO - PROCESS | 6779 | RSS: Main: 163545088 08:00:37 INFO - PROCESS | 6779 | 08:00:39 INFO - PROCESS | 6779 | Cycle 1(1): loaded http://localhost:49892/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49892/tests/kraken/driver.html?testName=audio-oscillator) 08:00:40 INFO - PROCESS | 6779 | RSS: Main: 164077568 08:00:40 INFO - PROCESS | 6779 | 08:00:42 INFO - PROCESS | 6779 | Cycle 1(1): loaded http://localhost:49892/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49892/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:00:43 INFO - PROCESS | 6779 | RSS: Main: 165322752 08:00:43 INFO - PROCESS | 6779 | 08:00:46 INFO - PROCESS | 6779 | Cycle 1(1): loaded http://localhost:49892/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49892/tests/kraken/driver.html?testName=imaging-darkroom) 08:00:46 INFO - PROCESS | 6779 | RSS: Main: 165703680 08:00:46 INFO - PROCESS | 6779 | 08:00:50 INFO - PROCESS | 6779 | Cycle 1(1): loaded http://localhost:49892/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49892/tests/kraken/driver.html?testName=imaging-desaturate) 08:00:50 INFO - PROCESS | 6779 | RSS: Main: 166383616 08:00:50 INFO - PROCESS | 6779 | 08:00:53 INFO - PROCESS | 6779 | Cycle 1(1): loaded http://localhost:49892/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49892/tests/kraken/driver.html?testName=json-parse-financial) 08:00:54 INFO - PROCESS | 6779 | RSS: Main: 167985152 08:00:54 INFO - PROCESS | 6779 | 08:00:55 INFO - PROCESS | 6779 | Cycle 1(1): loaded http://localhost:49892/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49892/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:00:56 INFO - PROCESS | 6779 | RSS: Main: 168120320 08:00:56 INFO - PROCESS | 6779 | 08:00:58 INFO - PROCESS | 6779 | Cycle 1(1): loaded http://localhost:49892/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49892/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:00:58 INFO - PROCESS | 6779 | RSS: Main: 168374272 08:00:58 INFO - PROCESS | 6779 | 08:01:00 INFO - PROCESS | 6779 | Cycle 1(1): loaded http://localhost:49892/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49892/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:01:01 INFO - PROCESS | 6779 | RSS: Main: 168497152 08:01:01 INFO - PROCESS | 6779 | 08:01:04 INFO - PROCESS | 6779 | Cycle 1(1): loaded http://localhost:49892/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49892/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:01:04 INFO - PROCESS | 6779 | RSS: Main: 168808448 08:01:04 INFO - PROCESS | 6779 | 08:01:07 INFO - PROCESS | 6779 | Cycle 1(1): loaded http://localhost:49892/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49892/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:01:08 INFO - PROCESS | 6779 | RSS: Main: 169234432 08:01:08 INFO - PROCESS | 6779 | 08:01:10 INFO - PROCESS | 6779 | Cycle 1(1): loaded http://localhost:49892/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49892/tests/kraken/driver.html?testName=ai-astar) 08:01:10 INFO - PROCESS | 6779 | RSS: Main: 170147840 08:01:10 INFO - PROCESS | 6779 | 08:01:10 INFO - PROCESS | 6779 | __start_tp_report 08:01:10 INFO - PROCESS | 6779 | _x_x_mozilla_page_load 08:01:10 INFO - PROCESS | 6779 | _x_x_mozilla_page_load_details 08:01:10 INFO - PROCESS | 6779 | |i|pagename|runs| 08:01:10 INFO - PROCESS | 6779 | |0;ai-astar;112;108;112;112;114;126;111;112;113;112 08:01:10 INFO - PROCESS | 6779 | |1;audio-beat-detection;160;132;155;176;138;159;162;130;180;131 08:01:10 INFO - PROCESS | 6779 | |2;audio-dft;163;162;162;164;161;170;170;161;166;163 08:01:10 INFO - PROCESS | 6779 | |3;audio-fft;76;77;76;156;76;76;76;73;175;77 08:01:10 INFO - PROCESS | 6779 | |4;audio-oscillator;93;93;145;92;93;93;152;93;92;139 08:01:10 INFO - PROCESS | 6779 | |5;imaging-gaussian-blur;118;118;117;117;118;117;118;118;118;118 08:01:10 INFO - PROCESS | 6779 | |6;imaging-darkroom;147;149;148;149;147;147;149;148;149;146 08:01:10 INFO - PROCESS | 6779 | |7;imaging-desaturate;95;97;95;96;95;95;97;96;96;95 08:01:10 INFO - PROCESS | 6779 | |8;json-parse-financial;59;59;59;59;58;59;59;84;58;55 08:01:10 INFO - PROCESS | 6779 | |9;json-stringify-tinderbox;63;64;62;62;63;63;62;63;63;63 08:01:10 INFO - PROCESS | 6779 | |10;stanford-crypto-aes;78;76;76;76;78;78;78;83;79;78 08:01:10 INFO - PROCESS | 6779 | |11;stanford-crypto-ccm;127;129;137;124;125;129;130;130;160;128 08:01:10 INFO - PROCESS | 6779 | |12;stanford-crypto-pbkdf2;175;167;168;170;170;167;168;171;171;167 08:01:10 INFO - PROCESS | 6779 | |13;stanford-crypto-sha256-iterative;68;72;70;72;69;68;71;68;69;69 08:01:10 INFO - PROCESS | 6779 | __end_tp_report 08:01:10 INFO - PROCESS | 6779 | __start_cc_report 08:01:10 INFO - PROCESS | 6779 | _x_x_mozilla_cycle_collect,833 08:01:10 INFO - PROCESS | 6779 | __end_cc_report 08:01:10 INFO - PROCESS | 6779 | __startTimestamp1462287670291__endTimestamp 08:01:10 INFO - PROCESS | 6779 | 08:01:10 INFO - PROCESS | 6779 | ------- Summary: start ------- 08:01:10 INFO - PROCESS | 6779 | Number of tests: 14 08:01:10 INFO - PROCESS | 6779 | 08:01:10 INFO - PROCESS | 6779 | [#0] ai-astar Cycles:10 Average:113.20 Median:112.00 stddev:4.76 (4.2%) stddev-sans-first:5.02 08:01:10 INFO - PROCESS | 6779 | Values: 112.0 108.0 112.0 112.0 114.0 126.0 111.0 112.0 113.0 112.0 08:01:10 INFO - PROCESS | 6779 | 08:01:10 INFO - PROCESS | 6779 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:159.50 stddev:18.57 (11.6%) stddev-sans-first:19.48 08:01:10 INFO - PROCESS | 6779 | Values: 160.0 132.0 155.0 176.0 138.0 159.0 162.0 130.0 180.0 131.0 08:01:10 INFO - PROCESS | 6779 | 08:01:10 INFO - PROCESS | 6779 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:3.39 (2.1%) stddev-sans-first:3.57 08:01:10 INFO - PROCESS | 6779 | Values: 163.0 162.0 162.0 164.0 161.0 170.0 170.0 161.0 166.0 163.0 08:01:10 INFO - PROCESS | 6779 | 08:01:10 INFO - PROCESS | 6779 | [#3] audio-fft Cycles:10 Average:93.80 Median:76.00 stddev:38.07 (50.1%) stddev-sans-first:39.83 08:01:10 INFO - PROCESS | 6779 | Values: 76.0 77.0 76.0 156.0 76.0 76.0 76.0 73.0 175.0 77.0 08:01:10 INFO - PROCESS | 6779 | 08:01:10 INFO - PROCESS | 6779 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:93.00 stddev:25.60 (27.5%) stddev-sans-first:26.54 08:01:10 INFO - PROCESS | 6779 | Values: 93.0 93.0 145.0 92.0 93.0 93.0 152.0 93.0 92.0 139.0 08:01:10 INFO - PROCESS | 6779 | 08:01:10 INFO - PROCESS | 6779 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:01:10 INFO - PROCESS | 6779 | Values: 118.0 118.0 117.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 08:01:10 INFO - PROCESS | 6779 | 08:01:10 INFO - PROCESS | 6779 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.50 stddev:1.10 (0.7%) stddev-sans-first:1.12 08:01:10 INFO - PROCESS | 6779 | Values: 147.0 149.0 148.0 149.0 147.0 147.0 149.0 148.0 149.0 146.0 08:01:10 INFO - PROCESS | 6779 | 08:01:10 INFO - PROCESS | 6779 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 08:01:10 INFO - PROCESS | 6779 | Values: 95.0 97.0 95.0 96.0 95.0 95.0 97.0 96.0 96.0 95.0 08:01:10 INFO - PROCESS | 6779 | 08:01:10 INFO - PROCESS | 6779 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:59.00 stddev:8.21 (13.9%) stddev-sans-first:8.68 08:01:10 INFO - PROCESS | 6779 | Values: 59.0 59.0 59.0 59.0 58.0 59.0 59.0 84.0 58.0 55.0 08:01:10 INFO - PROCESS | 6779 | 08:01:10 INFO - PROCESS | 6779 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 08:01:10 INFO - PROCESS | 6779 | Values: 63.0 64.0 62.0 62.0 63.0 63.0 62.0 63.0 63.0 63.0 08:01:10 INFO - PROCESS | 6779 | 08:01:10 INFO - PROCESS | 6779 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:78.00 stddev:2.05 (2.6%) stddev-sans-first:2.18 08:01:10 INFO - PROCESS | 6779 | Values: 78.0 76.0 76.0 76.0 78.0 78.0 78.0 83.0 79.0 78.0 08:01:10 INFO - PROCESS | 6779 | 08:01:10 INFO - PROCESS | 6779 | [#11] stanford-crypto-ccm Cycles:10 Average:131.90 Median:129.50 stddev:10.48 (8.1%) stddev-sans-first:10.97 08:01:10 INFO - PROCESS | 6779 | Values: 127.0 129.0 137.0 124.0 125.0 129.0 130.0 130.0 160.0 128.0 08:01:10 INFO - PROCESS | 6779 | 08:01:10 INFO - PROCESS | 6779 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:170.00 stddev:2.55 (1.5%) stddev-sans-first:1.72 08:01:10 INFO - PROCESS | 6779 | Values: 175.0 167.0 168.0 170.0 170.0 167.0 168.0 171.0 171.0 167.0 08:01:10 INFO - PROCESS | 6779 | 08:01:10 INFO - PROCESS | 6779 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.50 stddev:1.58 (2.3%) stddev-sans-first:1.56 08:01:10 INFO - PROCESS | 6779 | Values: 68.0 72.0 70.0 72.0 69.0 68.0 71.0 68.0 69.0 69.0 08:01:10 INFO - PROCESS | 6779 | -------- Summary: end -------- 08:01:10 INFO - PROCESS | 6779 | 08:01:11 INFO - TEST-INFO | 6779: exit 0 08:01:11 INFO - TEST-OK | kraken | took 61831ms 08:01:11 INFO - SUITE-END | took 1171s 08:01:11 INFO - Completed test suite (00:19:31) 08:01:11 INFO - javascript benchmark 08:01:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3127.0618814355694, 3178.4755515339975, 3184.283536204353, 3217.903462896111, 3221.806691598504, 5337.519623233903, 5374.032674118662, 5380.21986811913, 5395.082835917893, 5398.514133727964, 5245.082110630643, 5336.17289320155, 5361.919571206435, 5400.216968539559, 5445.401005889359, 4898.412190537131, 4915.5084491550915, 4967.329410529586, 4988.775505102261, 5031.421386540558, 875.7217570059554, 4886.60907127429, 4942.9258561121615, 4955.4548999610015, 4986.4764199758865, 4919.7540122993705, 4923.286123512106, 4942.579880710144, 4942.728149951751, 4994.900101997976, 4815.66290359675, 4945.134601444733, 5004.0, 5017.874553136165, 5061.8734531637, 4858.854234372974, 4863.659543831933, 4899.681520701179, 4903.828366007208, 4932.975335123338, 5198.896022079575, 5212.4266330703595, 5229.032628963654, 5229.816956406507, 5284.022455845642, 5651.2935883014625, 5656.490915817555, 5674.886502269931, 5746.626469279525, 5790.305163380379, 5622.212890195376, 5649.406812284692, 5662.462066103755, 5695.34503532095, 5735.82792516221, 5306.867328316785, 5308.867278318073, 5311.282976798121, 5317.441668624816, 5379.919301210485, 5745.195672605839, 5758.568107391879, 5787.565932555075, 5813.7383817728305, 5814.360420353758, 5592.552595792326, 5625.0, 5629.521490673339, 5636.859078522988, 5659.066254068115, 5688.914666280009, 5697.4587414195585, 5707.828765137053, 5716.399778023331, 5723.742431590588, 5602.943970560243, 5654.858628534237, 5670.319561652628, 5750.913736293875, 5775.740091695884, 5548.528375088082, 5669.744861481243, 5689.2319536862, 5736.340320863071, 5785.942140578541, 4297.247981603207, 4302.09655972243, 4320.027993701455, 4321.308590625485, 4332.870013899588, 3804.429335599627, 3864.381698928158, 3878.204967981557, 3936.4488971544006, 3957.92084158321, 5430.5927055471, 5430.945690543123, 5436.048691478975, 5444.537214336747, 5481.588880833874, 5653.858653533613, 5665.546756259571, 5671.177679236487, 5699.800506982236, 5715.371309155989, 5462.126059830408, 5542.584306177053, 5551.417101204396, 5588.944110558924, 5605.159226116115, 4879.121758083508, 4914.238293064581, 4919.631027672939, 4923.876903077452, 4925.261210818334, 5770.365259821417, 5892.764289428461, 5919.408059194132, 5931.139984702194, 5961.165436838846, 5778.94221057784, 5789.305283365855, 5789.8552536186935, 5799.507041901317, 5831.854203644858, 5904.527637789052, 5930.199423078002, 5954.493868021266, 5956.434138756811, 5961.552883533839, 5502.174673798802, 5641.548676105819, 5665.0935850265405, 5676.318841739017, 5752.395998420106, 5734.283214598176, 5759.2512973313205, 5761.308642962871, 5780.682062486436, 5827.59206855516, 5550.888982220414, 5594.13290939905, 5601.075822489243, 5602.85992850182, 5605.878824235087, 5429.0, 5488.506034456918, 5518.2826232591115, 5592.608517403743, 5662.348829884616, 5353.4646535346155, 5415.620906536505, 5421.945780542144, 5516.393196748435, 5524.281843360337, 5570.693611851387, 5595.356533998643, 5599.9720001401365, 5642.689652069175, 5648.2092507049865, 5483.040467918018, 5492.231087647812, 5506.531944784738, 5508.614396992172, 5576.693281869536], "value": 5254.290968523108, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.3242768099726, 643.4562794438699, 646.8997305417662, 656.3534918105665, 665.7936039827654, 36665.450018249714, 38187.23625527495, 38223.0, 38297.61702382976, 38354.61645383545, 40527.0, 40833.795831020805, 41476.17047659045, 41480.792596036976, 41555.376669349906, 8413.579321033954, 8648.74593183991, 8682.088380720028, 8684.782880428009, 8718.17177368149, 8551.657933682645, 8679.392442529026, 8695.521746303952, 8708.129187081304, 8831.0, 8818.470891746516, 8850.822983540358, 8872.0, 8888.155625215593, 8945.373823832335, 8817.470951742884, 8832.558372081434, 8885.333599979962, 8891.288696904265, 8908.10918908104, 8647.351448641377, 8709.95645021777, 8766.035736069027, 8797.692080777206, 8828.735137945872, 41272.38091428631, 41847.58152418467, 41919.0, 42036.789816050725, 42046.57953420488, 3721.6464435878547, 3771.340015497277, 3817.408301713239, 3984.342583473723, 4319.0, 31216.687833121832, 31302.530462043087, 31613.683863161303, 31625.8418707905, 32873.83563082193, 4130.958690413087, 4180.24755544002, 4202.936955945664, 4280.6789490788005, 4315.0, 208816.0, 214238.78641820385, 215238.0, 217288.0, 243486.0, 56443.073477285114, 57700.71149644225, 57776.0, 57780.0, 57864.42135578675, 55976.44023559794, 56488.43511564914, 57198.42801572014, 57352.0, 58534.0, 15836.445724399591, 16015.759763603555, 16073.0, 16122.435714750161, 16168.514944551682, 12334.259944403186, 12389.566365177356, 12408.75182496345, 12429.627111186679, 12506.937465312616, 19099.09009099079, 19150.521236969187, 19162.13770380336, 19212.327568535035, 19277.325293614656, 7283.308085731847, 7378.413641067196, 7384.741534046282, 7435.256474352522, 7538.585377804164, 1049.8320268756963, 1074.231924174219, 1078.6817888722846, 1141.7374003978964, 1152.1071169843437, 31828.204294892348, 31871.681283187336, 32062.0, 32211.35577288441, 32673.836630817168, 1153.0487347937985, 1172.7595842852195, 1191.880811918801, 1211.3216598704753, 1241.2552468518998, 16740.58148546296, 16759.1620418981, 17072.658546829243, 17143.74284385735, 17195.914020429816, 482936.0, 491444.0, 491795.0, 492398.0, 492419.0, 57331.426685733444, 58933.705331473924, 59086.704566476896, 59109.113363299584, 59117.0, 1377.7037936843426, 1380.758367285721, 1404.95082672106, 1405.6977749783846, 1406.0438901546843, 30523.2369190772, 31033.844830775703, 31275.530867036556, 31613.683863161074, 31664.366712666077, 50906.236406453194, 51273.7436312831, 51380.0, 51422.485775143265, 52000.73999629977, 396026.0, 398004.0, 399252.0, 399424.0, 399734.0, 27776.44447111087, 28107.297317566405, 28183.859080704464, 28252.85873570619, 28444.146675599764, 47983.5201647993, 48883.0, 49090.0, 49387.0, 49387.506124939726, 40369.59630403658, 41868.0, 42232.1553568933, 42372.57627423686, 42436.8014868485, 40299.0, 40601.390979135926, 40868.0, 41610.79194604129, 41771.0, 36816.0, 37467.6253237475, 37777.433338499395, 37938.43092353562, 39933.60066399299, 31316.0, 34970.532414345034, 35060.64939350574, 35079.82460087683, 35844.0, 27259.86370068137, 27780.16659500218, 27795.888164473196, 27808.721912780613, 28188.718112819428], "value": 19658.825333656256, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.9928001439971, 365.74998517229795, 380.45784756721685, 383.77740910272047, 386.3200766650695, 17820.821791782077, 18814.0, 19180.808191918077, 19717.704234436496, 19932.302369417073, 18375.0, 18643.813561864376, 19032.9048354758, 19163.50874386328, 19174.712379314322, 5429.294191755066, 5503.229547863302, 5718.285214348207, 5746.942530574704, 5769.336526299488, 5481.5340696040885, 5499.120140777476, 5500.697461639608, 5508.366537848158, 5526.281583394153, 5343.17180836969, 5431.103867861818, 5438.293021907147, 5481.725913704318, 5483.424240454755, 5552.3892371839065, 5591.608587398884, 5603.551715862721, 5612.298462692163, 5618.269624948772, 4793.2810078488155, 4903.84759581498, 4917.754112294407, 4932.630052746023, 4960.553550180501, 22183.66724499134, 22205.11179552816, 22650.546989060127, 22827.0, 23048.884755576113, 2321.025169428844, 2371.27676058802, 2419.9637005444933, 2450.9387265318333, 2506.348349429143, 13713.45146194151, 14150.787738183935, 14573.927130364385, 14596.927015364961, 14830.110193388431, 1890.1399863062275, 1951.658459769549, 1975.9506012349661, 1994.6110508450859, 2033.786452422504, 80965.0, 81488.0, 82174.0, 82283.5885820567, 82383.0, 10012.849807252896, 10138.391696498235, 10456.268061235793, 10470.947645261725, 10619.734506637242, 14512.709745805025, 14597.489087881873, 14650.487232947009, 14694.412223511154, 14695.559133226021, 7872.842543149105, 7990.4406691532195, 8016.71941482057, 8139.331437055508, 8199.139090395423, 7686.500377475446, 7824.37405007598, 7861.606919653995, 7869.527828330204, 7947.443678942419, 6474.773382931575, 6515.446187074152, 6528.771492997722, 6531.346865313526, 6640.369164929324, 1836.9540761481069, 1854.4343975087727, 1878.286251224526, 1885.3401309541825, 1888.2163901980525, 955.8852937647388, 1033.5194134727237, 1101.2071308657753, 1132.9576789353814, 1136.2500749505452, 18841.246350146113, 19112.522186945436, 19163.61672766537, 19273.710894336597, 19559.11983960725, 1061.920355973305, 1066.3974854207347, 1083.6911480228255, 1092.3282181458346, 1101.8402331661864, 10671.19966002553, 10872.891271087346, 10948.945255273673, 10963.725906852233, 10975.615853445252, 380516.0, 382644.0, 390494.0, 493494.0, 498436.0, 91515.5424222888, 99801.0, 102075.0, 104019.4799026, 104812.47593762135, 1009.5002973528151, 1034.8654674892216, 1066.7333166708322, 1068.4444089073638, 1080.7568297133082, 16368.67262654764, 17112.401065962633, 17299.30802767875, 17468.388606398716, 17615.383461578782, 39126.217475649755, 39842.402363963985, 40291.395629065, 40682.0, 41203.0, 56096.439035609124, 57707.71146144242, 57739.0, 58227.70886145542, 58474.7076264633, 8217.260446559838, 8443.12933602578, 8623.956880215559, 8768.693095741619, 8847.867281990646, 12720.936395317964, 12779.680507987374, 12883.549075782303, 13318.467261309439, 13414.798778018143, 11014.614488492864, 11147.944260278971, 11342.20604557673, 11379.317240965569, 11472.0, 11297.0, 11334.716632084264, 11359.148063895076, 11488.080953523531, 11540.538378465104, 11483.48324325424, 11489.368084755419, 11503.367314797766, 11670.416479176178, 11687.357195353998, 8720.302375809793, 8772.342074344322, 8797.516136612549, 8807.735767926972, 8854.114588541095, 11011.669649910515, 11528.654140375802, 11739.11956603241, 11808.055355571361, 11889.405529723652], "value": 9282.412298571358, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1479.4304192885738, 1486.4648726458477, 1610.4202487104646, 1754.964570903167, 1780.8753387262898, 7110.1112360954885, 7426.591537465437, 7483.887741683872, 7832.334251588614, 7847.450678452504, 7525.5860927648955, 7662.080550333968, 7676.731314403997, 7678.692852285916, 7695.307422331989, 2107.6838474228834, 2150.5591353772516, 2157.385145233609, 2157.46063484129, 2158.7949144831296, 2110.3668899330214, 2129.1057755742627, 2149.344449942767, 2151.354593621915, 2152.569486102778, 2139.5613899150712, 2143.399848042543, 2151.107290474451, 2153.5692861427697, 2160.168335190947, 2075.9065842037144, 2092.0794850265834, 2092.079485026591, 2093.7382827146607, 2100.2754049852774, 2086.2385229391316, 2105.105330234644, 2106.136484041536, 2120.5652841167525, 2131.9040643171093, 7759.961200193963, 7799.298063174285, 7824.217578242187, 7829.64766585505, 7869.685212591547, 4554.27131658933, 4744.098621261984, 4757.524247575249, 4766.261229509431, 4780.235162374003, 3049.603551538308, 3186.374948776118, 3210.325831575372, 3217.983910080458, 3237.902862914116, 973.4256788494822, 1004.8794144702609, 1023.4575674892244, 1024.7028361775076, 1067.6796960911772, 9944.453055081967, 9997.0, 10011.49942502872, 10026.0, 10034.9498252509, 4098.364753463218, 4120.320147175682, 4121.979390103031, 4222.641075508616, 4234.428352172479, 8561.315094792402, 8585.570721463902, 8643.913560864437, 8646.610902509403, 8656.826863462695, 4507.932381014288, 4519.932201016922, 4522.819087236474, 4523.570260825217, 4524.751138687404, 3894.766314021168, 4156.147989662112, 4277.0, 4321.351797230441, 4346.434963454731, 3508.754387192872, 3584.2831433713363, 3617.5478065241846, 3636.581793093828, 3654.5066416033496, 1132.3545579019878, 1133.6032388663903, 1135.778523187987, 1137.3630766770634, 1146.5585749486509, 891.6789955615973, 970.5438443931482, 1010.2776514791959, 1012.6101450941441, 1049.2864851900629, 5566.777328906798, 5589.524890384363, 5606.495415412633, 5643.5203007743985, 5651.406602306781, 1024.7079582319004, 1028.3878947473333, 1050.6217761605815, 1067.5356220044305, 1102.167863263231, 3919.5884432134785, 3950.6839452843706, 4007.519097708294, 4018.7789671568344, 4022.054817117975, 8803.603837827313, 9132.726018219464, 9171.495567743705, 9194.310426718022, 9213.631454741735, 8945.0, 8999.730008099768, 9034.593443295067, 9061.728148155566, 9124.0, 7222.169450513154, 7406.0, 7413.7775866723005, 7416.666250018762, 7422.703091876265, 5467.343918729778, 5531.446855314597, 5589.5248903842, 5656.0667489865355, 5679.6876171810945, 8543.273821725223, 8684.131586841266, 8772.692955746774, 8790.077041910507, 8816.647334106563, 8570.957145214234, 8783.165599268059, 9209.401388909699, 9229.169374756304, 9270.675526356816, 6279.529035322278, 6792.286809884891, 6850.725970961105, 6858.451323893977, 7038.225795162426, 7674.731384401519, 7691.730789422343, 7722.575258360844, 7733.110692270461, 7761.068671759425, 6720.395164435225, 6852.965735171292, 6919.896201557081, 6953.374196322356, 6977.2673869243, 6873.243943166148, 7013.053237813034, 7015.859682806214, 7019.5788252705, 7022.754203602849, 6125.448709616156, 6165.784197553064, 6435.259945106185, 6460.4508616766225, 6483.546151769519, 4671.509491503343, 4756.429228492603, 4806.351142595845, 4914.0908931847725, 5060.51925067118, 4647.209974304444, 4668.5564871337165, 4669.41632295963, 4683.648726345606, 4762.452317983476], "value": 4212.42299881287, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.6982461924243, 319.0567019247443, 323.4614367078815, 323.4646659778068, 326.86925229908036, 5438.585967648411, 5442.319710036246, 5448.42791506892, 5486.204500347447, 5541.556675465963, 5402.621816472849, 5423.48142520094, 5423.728813559326, 5438.129899216126, 5454.181872719094, 3999.680025597945, 4097.44684467596, 4219.346001369792, 4227.640650544708, 4251.064765751546, 4238.427812245338, 4243.151369726052, 4260.424842646234, 4261.893452663678, 4272.530021697611, 4180.641291580248, 4181.560936101711, 4223.303154979425, 4231.87304380869, 4237.7669228192435, 4075.4090656854737, 4218.198542276958, 4219.620234178923, 4229.815651617552, 4237.343211802176, 3678.411454167347, 3713.350163721338, 3727.105494681257, 3730.4404339349044, 3731.9813400933094, 5259.001579399804, 5275.947240527584, 5286.577073834084, 5292.285541451894, 5293.39126000511, 4769.666123371366, 4826.455534229048, 4852.4662287148385, 4872.123017856784, 4883.780229889628, 5616.269884914976, 5623.297087864017, 5639.407862174454, 5713.3429655589725, 5726.284214473191, 4072.6741860651373, 4073.9388909166387, 4080.204360149772, 4107.0, 4118.64330570587, 5686.545076393879, 5879.323877754027, 5889.5288376930175, 5901.527877769811, 5904.545840683206, 4116.0, 4160.729552579072, 4166.791660416967, 4185.539590645027, 4189.2459357315365, 4210.705250632487, 4219.767912764827, 4221.831126754957, 4227.3447615619625, 4247.787610619456, 4477.843275485342, 4758.738269395217, 4799.712017278975, 4816.229403295456, 4833.03339332135, 5728.341240757283, 5737.512311453574, 5763.538916886639, 5818.592698511064, 5823.941760582425, 1480.8297045839865, 1497.4758834408087, 1507.8265999410207, 1510.3731951240331, 1516.8558986896228, 914.7530166854912, 970.146271281268, 982.3516479123743, 985.2462865907586, 1015.664830605913, 5918.171455996164, 5936.970315148396, 5943.821685349447, 5985.229305537484, 5987.161797348288, 6245.28179259391, 6265.498760099181, 6274.341194174637, 6312.337204593543, 6317.305096439388, 5814.0, 5893.6463812171405, 5904.704764761745, 5917.970410148007, 5926.288845338587, 3328.517364982064, 3334.3331333732867, 3349.69852713257, 3385.2721664841683, 3403.149212696826, 6293.748250070037, 6305.873882522324, 6370.617762934239, 6385.616862988236, 6464.903026454607, 6298.212723409574, 6356.14192084072, 6360.173177486897, 6375.968120159369, 6413.422791948747, 6259.812205633838, 6452.741890324334, 6470.48236141117, 6527.15147030883, 6536.607803531803, 6217.409346112112, 6250.874982500415, 6275.435210831047, 6293.181886354744, 6312.400321969406, 6210.254769427517, 6211.0, 6215.875682486235, 6227.532935029982, 6268.0, 5817.243758311392, 6161.137440758387, 6166.290876549254, 6174.233717432273, 6185.103160041679, 4072.226277007359, 4077.9601201693376, 4121.381792731115, 4130.504339479162, 4132.772697501546, 5772.711364431678, 5935.614185078129, 5964.970175149097, 5984.281886173687, 6016.398360163948, 5814.825555233349, 5826.592138550431, 5837.532997360286, 5850.531957443309, 5853.122031695109, 5774.249347584787, 5782.855428614318, 5789.91315130265, 5791.218185544897, 5799.652020878761, 5291.735413229246, 5483.2049352844415, 5571.331440227199, 5650.434956504481, 5664.688442135722, 5816.651000939957, 5818.272715910512, 5826.679532625746, 5827.329857066322, 5833.241678581757, 5565.30433695788, 5688.687122208318, 5692.1746346778655, 5692.601517893708, 5729.255196824386], "value": 4431.092446905723, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.9250378710235, 775.9456838021338, 776.9067711874576, 779.8401327727817, 802.029544251456, 13398.665033374158, 13595.864041359584, 13854.653633659163, 13869.583912482616, 13870.237136957463, 13260.933695331534, 13345.666358341023, 13348.065635405526, 13357.866421335784, 13367.0, 661.4774328280653, 764.552736649061, 811.6388207247777, 828.0146625515647, 830.8546004449228, 803.1125606205147, 806.7216810200472, 808.1393316118345, 812.8374325134997, 813.0162503370899, 869.5782545465444, 874.9343799215053, 876.9780755481132, 878.4860856398982, 880.8194320164351, 843.797488602734, 853.9658413663477, 854.974350769478, 857.7126662567985, 859.2867919626694, 636.598942666122, 639.1307821362942, 639.6481934935766, 640.5996252342286, 641.1856941684035, 12524.937375313066, 12561.120721549496, 12630.0, 12646.936765316206, 12659.30373829439, 13106.934465327708, 13439.26084065376, 13524.86475135246, 13570.728585428236, 13600.183988960694, 11253.156013298954, 11353.375564343958, 11360.715982100432, 11379.772404551863, 11402.258853174517, 3813.122981714221, 3860.1121741999495, 3860.4209368594657, 3866.709996750255, 3894.201688653819, 48276.758616206695, 49970.7501462494, 49986.999999999636, 50015.0, 51787.223191652156, 10319.896801032044, 10938.781224375627, 10958.123350131971, 11035.44822758859, 11159.051480624237, 17227.913860430617, 17316.0, 17351.82648173502, 17356.3057477702, 17366.21852016662, 8083.797905052421, 8168.714095006765, 8248.13394593571, 8294.917050829536, 8350.749477515685, 4695.976520117378, 4704.623630109583, 4709.929351059737, 4768.094062128254, 4792.209285467929, 3254.0, 3327.101682545699, 3329.6337402885665, 3330.7335413167375, 3331.06730115568, 595.6694034810722, 606.9969650151721, 621.8445388652837, 622.8411755002445, 624.2664868779257, 737.2001378504276, 749.1272667342485, 750.6509473094928, 751.0574229342141, 759.8708219602681, 7888.605569721606, 8232.382571307176, 8261.463004904663, 8362.916370836336, 8499.447535910145, 733.2740586819117, 758.9279018493235, 764.8432071425344, 775.3603277296253, 821.4906757810196, 4227.175700738327, 4273.273543497613, 4303.526612072669, 4333.9133217335475, 4370.481762181411, 55459.0, 55687.0, 56012.0, 56262.718686406304, 57016.0, 50560.74719626379, 52355.73822130941, 52423.21365179525, 53339.19991200135, 55040.72479637576, 49636.50363496391, 49927.0, 50417.0, 50863.49136508587, 51383.74308128435, 8470.618822152896, 8508.489490630334, 8527.658893644184, 8695.86956195645, 8724.825503489768, 32587.185320366232, 32720.836395817867, 32893.67106328906, 33506.66493335035, 33632.327353453285, 39545.406818898315, 41229.0, 42444.78777606092, 42857.0, 43360.783196083816, 10135.0, 10234.6417875374, 10512.632057877938, 10812.837807432737, 10949.83575246356, 12236.388180591113, 12246.326452045223, 12272.202306850026, 12614.306213158365, 12618.621441356774, 11222.438878056228, 11263.26788758728, 11317.547298108313, 11329.433528323716, 11385.146114041645, 11913.16607837443, 11957.641270761891, 12036.879631203927, 12213.45039473208, 12581.0, 10563.894361056291, 11697.356645384585, 12676.302803345905, 13055.281959491938, 13077.0, 10820.350778952974, 10868.782624347627, 10985.890141098487, 11065.170112241452, 11203.327800331681, 10815.56737730482, 10820.729481762704, 11221.0, 11235.831462527905, 11287.379194144401], "value": 6540.779269848323, "unit": "score"}], "name": "dromaeo_css", "value": 6994.2617525661, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 112.0, 112.0, 114.0, 126.0, 111.0, 112.0, 113.0, 112.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 132.0, 155.0, 176.0, 138.0, 159.0, 162.0, 130.0, 180.0, 131.0], "value": 152.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 164.0, 161.0, 170.0, 170.0, 161.0, 166.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 156.0, 76.0, 76.0, 76.0, 73.0, 175.0, 77.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 145.0, 92.0, 93.0, 93.0, 152.0, 93.0, 92.0, 139.0], "value": 108.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 149.0, 147.0, 147.0, 149.0, 148.0, 149.0, 146.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 96.0, 95.0, 95.0, 97.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 58.0, 59.0, 59.0, 84.0, 58.0, 55.0], "value": 60.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 62.0, 63.0, 63.0, 62.0, 63.0, 63.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 76.0, 78.0, 78.0, 78.0, 83.0, 79.0, 78.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 129.0, 137.0, 124.0, 125.0, 129.0, 130.0, 130.0, 160.0, 128.0], "value": 131.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 167.0, 168.0, 170.0, 170.0, 167.0, 168.0, 171.0, 171.0, 167.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 70.0, 72.0, 69.0, 68.0, 71.0, 68.0, 69.0, 69.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1565.9, "alertThreshold": 2.0}]} 08:01:11 INFO - Return code: 0 08:01:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:01:11 ERROR - # TBPL SUCCESS # 08:01:11 INFO - Running post-action listener: _resource_record_post_action 08:01:11 INFO - Running post-run listener: _resource_record_post_run 08:01:12 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 360345600; Read time: 8; Write time: 249028 08:01:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 72708096; Read time: 0; Write time: 56000 08:01:12 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287637504; Read time: 8; Write time: 193028 08:01:12 INFO - Running post-run listener: _upload_blobber_files 08:01:12 INFO - Blob upload gear active. 08:01:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:01:12 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:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:01:13 INFO - (blobuploader) - INFO - Open directory for files ... 08:01:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:01:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:01:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:13 INFO - (blobuploader) - INFO - Done attempting. 08:01:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:01:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:01:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:14 INFO - (blobuploader) - INFO - Done attempting. 08:01:14 INFO - (blobuploader) - INFO - Iteration through files over. 08:01:14 INFO - Return code: 0 08:01:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:01:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:01:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/381dbd3967989cc4b6394da3a9424618dfb66c22d11df905967c003ac4b01a30c8576ef09d177043ccae0990f4cb726d06655a23d1c8bf7c2acec505a774fddd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/069deb5a1894d6ff68bd249cb6c75ad0694ba022586e3ffbaef3632eb35002bc4607951972f32a6dac29732cc4119d0bddc7167ea3f8ec2760fd71679fa80c66"} 08:01:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:01:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:01:14 INFO - Contents: 08:01:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/381dbd3967989cc4b6394da3a9424618dfb66c22d11df905967c003ac4b01a30c8576ef09d177043ccae0990f4cb726d06655a23d1c8bf7c2acec505a774fddd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/069deb5a1894d6ff68bd249cb6c75ad0694ba022586e3ffbaef3632eb35002bc4607951972f32a6dac29732cc4119d0bddc7167ea3f8ec2760fd71679fa80c66"} 08:01:14 INFO - Running post-run listener: copy_logs_to_upload_dir 08:01:14 INFO - Copying logs to upload dir... 08:01:14 INFO - mkdir: /builds/slave/test/build/upload/logs 08:01:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2128.430690 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 28 secs) (at 2016-05-03 08:01:14.081323) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-03 08:01:14.085149) ========= 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=8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/381dbd3967989cc4b6394da3a9424618dfb66c22d11df905967c003ac4b01a30c8576ef09d177043ccae0990f4cb726d06655a23d1c8bf7c2acec505a774fddd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/069deb5a1894d6ff68bd249cb6c75ad0694ba022586e3ffbaef3632eb35002bc4607951972f32a6dac29732cc4119d0bddc7167ea3f8ec2760fd71679fa80c66"} build_url:https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011311 build_url: 'https://queue.taskcluster.net/v1/task/Xjr8bidtSZmGPI4two1c3Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/381dbd3967989cc4b6394da3a9424618dfb66c22d11df905967c003ac4b01a30c8576ef09d177043ccae0990f4cb726d06655a23d1c8bf7c2acec505a774fddd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/069deb5a1894d6ff68bd249cb6c75ad0694ba022586e3ffbaef3632eb35002bc4607951972f32a6dac29732cc4119d0bddc7167ea3f8ec2760fd71679fa80c66"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-03 08:01:14.110958) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 08:01:14.111386) ========= 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=8887e36bb8e381bfd44124ac000001a8-1462285543.582349-1902532063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 08:01:14.193746) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-03 08:01:14.194061) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-03 08:01:14.194645) ========= ========= Total master_lag: 0.17 =========