builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1462337972.99 results: success (0) buildid: 20160503193626 builduid: 7222e98b2353437b84779ecb0b0cf852 revision: 54e84fa84d6defa32626421af67e634203256122 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-03 21:59:32.988889) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-03 21:59:32.989304) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-03 21:59:32.989606) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-03 21:59:33.036320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 21:59:33.036579) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-03 21:59:33-- 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% 222M=0s 2016-05-03 21:59:33 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095454 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 21:59:33.150448) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 21:59:33.150764) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022177 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 21:59:33.202625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 21:59:33.202936) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 54e84fa84d6defa32626421af67e634203256122 --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 54e84fa84d6defa32626421af67e634203256122 --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=78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-03 21:59:33,392 truncating revision to first 12 chars 2016-05-03 21:59:33,392 Setting DEBUG logging. 2016-05-03 21:59:33,392 attempt 1/10 2016-05-03 21:59:33,392 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/54e84fa84d6d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-03 21:59:33,743 unpacking tar archive at: mozilla-inbound-54e84fa84d6d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628474 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 21:59:33.843987) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-03 21:59:33.844264) ========= script_repo_revision: 54e84fa84d6defa32626421af67e634203256122 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-03 21:59:33.844638) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-03 21:59:33.844910) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-03 21:59:33.859146) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 35 secs) (at 2016-05-03 21:59:33.859417) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:59:34 INFO - MultiFileLogger online at 20160503 21:59:34 in /builds/slave/test 21:59:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 21:59:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:59:34 INFO - {'append_to_log': False, 21:59:34 INFO - 'base_work_dir': '/builds/slave/test', 21:59:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:59:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:59:34 INFO - 'branch': 'Mozilla-Inbound', 21:59:34 INFO - 'buildbot_json_path': 'buildprops.json', 21:59:34 INFO - 'config_files': ('talos/linux_config.py',), 21:59:34 INFO - 'default_actions': ('clobber', 21:59:34 INFO - 'read-buildbot-config', 21:59:34 INFO - 'download-and-extract', 21:59:34 INFO - 'populate-webroot', 21:59:34 INFO - 'create-virtualenv', 21:59:34 INFO - 'install', 21:59:34 INFO - 'run-tests'), 21:59:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:59:34 INFO - 'download_minidump_stackwalk': True, 21:59:34 INFO - 'download_symbols': 'ondemand', 21:59:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:59:34 INFO - 'tooltool.py': '/tools/tooltool.py', 21:59:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:59:34 INFO - '/tools/misc-python/virtualenv.py')}, 21:59:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:59:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:59:34 INFO - 'installer_path': 'installer.exe', 21:59:34 INFO - 'log_level': 'info', 21:59:34 INFO - 'log_name': 'talos', 21:59:34 INFO - 'log_to_console': True, 21:59:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:59:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:59:34 INFO - 'opt_config_files': (), 21:59:34 INFO - 'pip_index': False, 21:59:34 INFO - 'sps_profile': False, 21:59:34 INFO - 'sps_profile_interval': 0, 21:59:34 INFO - 'suite': 'dromaeojs', 21:59:34 INFO - 'system_bits': '32', 21:59:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:59:34 INFO - 'title': 'talos-linux64-ix-019', 21:59:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:59:34 INFO - 'use_talos_json': True, 21:59:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:59:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:59:34 INFO - 'work_dir': 'build'} 21:59:34 INFO - ##### 21:59:34 INFO - ##### Running clobber step. 21:59:34 INFO - ##### 21:59:34 INFO - Running pre-action listener: _resource_record_pre_action 21:59:34 INFO - Running main action method: clobber 21:59:34 INFO - rmtree: /builds/slave/test/build 21:59:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:59:35 INFO - Running post-action listener: _resource_record_post_action 21:59:35 INFO - ##### 21:59:35 INFO - ##### Running read-buildbot-config step. 21:59:35 INFO - ##### 21:59:35 INFO - Running pre-action listener: _resource_record_pre_action 21:59:35 INFO - Running main action method: read_buildbot_config 21:59:35 INFO - Using buildbot properties: 21:59:35 INFO - { 21:59:35 INFO - "project": "", 21:59:35 INFO - "product": "firefox", 21:59:35 INFO - "script_repo_revision": "production", 21:59:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 21:59:35 INFO - "repository": "", 21:59:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 21:59:35 INFO - "buildid": "20160503193626", 21:59:35 INFO - "pgo_build": "True", 21:59:35 INFO - "basedir": "/builds/slave/test", 21:59:35 INFO - "buildnumber": 934, 21:59:35 INFO - "slavename": "talos-linux64-ix-019", 21:59:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:59:35 INFO - "platform": "ubuntu64_hw", 21:59:35 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:59:35 INFO - "branch": "mozilla-inbound", 21:59:35 INFO - "repo_path": "integration/mozilla-inbound", 21:59:35 INFO - "revision": "54e84fa84d6defa32626421af67e634203256122", 21:59:35 INFO - "stage_platform": "linux64-pgo", 21:59:35 INFO - "builduid": "7222e98b2353437b84779ecb0b0cf852", 21:59:35 INFO - "slavebuilddir": "test" 21:59:35 INFO - } 21:59:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 21:59:35 INFO - Running post-action listener: _resource_record_post_action 21:59:35 INFO - ##### 21:59:35 INFO - ##### Running download-and-extract step. 21:59:35 INFO - ##### 21:59:35 INFO - Running pre-action listener: _resource_record_pre_action 21:59:35 INFO - Running main action method: download_and_extract 21:59:35 INFO - mkdir: /builds/slave/test/build/tests 21:59:35 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')]} 21:59:35 INFO - https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 21:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 21:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:00:05 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 22:00:05 INFO - retry: attempt #1 caught exception: timed out 22:00:05 INFO - retry: Failed, sleeping 30 seconds before retrying 22:00:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:01:05 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 22:01:05 INFO - retry: attempt #2 caught exception: timed out 22:01:05 INFO - retry: Failed, sleeping 60 seconds before retrying 22:02:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:02:35 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 22:02:35 INFO - retry: attempt #3 caught exception: timed out 22:02:35 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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! 22:02:35 INFO - Caught exception: timed out 22:02:35 INFO - Caught exception: timed out 22:02:35 INFO - Caught exception: timed out 22:02:35 INFO - trying https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:02:35 INFO - Downloading https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:02:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:02:36 INFO - Downloaded 1361 bytes. 22:02:36 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:02:36 INFO - Using the following test package requirements: 22:02:36 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:02:36 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:02:36 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:02:36 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:36 INFO - u'jsshell-linux-x86_64.zip'], 22:02:36 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:02:36 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:02:36 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:02:36 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:02:36 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:02:36 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:02:36 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:02:36 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:36 INFO - https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:02:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:02:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:02:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:02:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:03:06 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 22:03:06 INFO - retry: attempt #1 caught exception: timed out 22:03:06 INFO - retry: Failed, sleeping 30 seconds before retrying 22:03:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:04:06 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 22:04:06 INFO - retry: attempt #2 caught exception: timed out 22:04:06 INFO - retry: Failed, sleeping 60 seconds before retrying 22:05:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:05:36 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 22:05:36 INFO - retry: attempt #3 caught exception: timed out 22:05:36 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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! 22:05:36 INFO - Caught exception: timed out 22:05:36 INFO - Caught exception: timed out 22:05:36 INFO - Caught exception: timed out 22:05:36 INFO - trying https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:05:36 INFO - Downloading https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:05:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:05:38 INFO - Downloaded 23880131 bytes. 22:05:38 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'] 22:05:38 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 22:05:39 INFO - Return code: 0 22:05:39 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 22:05:39 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')]} 22:05:39 INFO - https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:05:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:05:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:05:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:05:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:06:09 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 22:06:09 INFO - retry: attempt #1 caught exception: timed out 22:06:09 INFO - retry: Failed, sleeping 30 seconds before retrying 22:06:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:07:10 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 22:07:10 INFO - retry: attempt #2 caught exception: timed out 22:07:10 INFO - retry: Failed, sleeping 60 seconds before retrying 22:08:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:08:40 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 22:08:40 INFO - retry: attempt #3 caught exception: timed out 22:08:40 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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! 22:08:40 INFO - Caught exception: timed out 22:08:40 INFO - Caught exception: timed out 22:08:40 INFO - Caught exception: timed out 22:08:40 INFO - trying https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:08:40 INFO - Downloading https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:08:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:08:42 INFO - Downloaded 23880131 bytes. 22:08:42 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'] 22:08:42 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 22:08:43 INFO - Return code: 0 22:08:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:08:43 INFO - https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:08:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:08:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:08:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:08:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:09:13 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 22:09:13 INFO - retry: attempt #1 caught exception: timed out 22:09:13 INFO - retry: Failed, sleeping 30 seconds before retrying 22:09:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:10:13 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 22:10:13 INFO - retry: attempt #2 caught exception: timed out 22:10:13 INFO - retry: Failed, sleeping 60 seconds before retrying 22:11:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:11:43 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 22:11:43 INFO - retry: attempt #3 caught exception: timed out 22:11:43 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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! 22:11:43 INFO - Caught exception: timed out 22:11:43 INFO - Caught exception: timed out 22:11:43 INFO - Caught exception: timed out 22:11:43 INFO - trying https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:11:43 INFO - Downloading https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:11:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:11:44 INFO - Downloaded 10840152 bytes. 22:11:44 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'] 22:11:44 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 22:11:44 INFO - Return code: 0 22:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:44 INFO - https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:11:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:11:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:11:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:11:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:12:14 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 22:12:14 INFO - retry: attempt #1 caught exception: timed out 22:12:14 INFO - retry: Failed, sleeping 30 seconds before retrying 22:12:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:13:15 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 22:13:15 INFO - retry: attempt #2 caught exception: timed out 22:13:15 INFO - retry: Failed, sleeping 60 seconds before retrying 22:14:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:14:45 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 22:14:45 INFO - retry: attempt #3 caught exception: timed out 22:14:45 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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! 22:14:45 INFO - Caught exception: timed out 22:14:45 INFO - Caught exception: timed out 22:14:45 INFO - Caught exception: timed out 22:14:45 INFO - trying https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:14:45 INFO - Downloading https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:14:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/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 22:14:48 INFO - Downloaded 58441403 bytes. 22:14:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:14:48 INFO - mkdir: /builds/slave/test/properties 22:14:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:14:48 INFO - Writing to file /builds/slave/test/properties/build_url 22:14:48 INFO - Contents: 22:14:48 INFO - build_url:https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:14:48 INFO - Running post-action listener: _resource_record_post_action 22:14:48 INFO - Running post-action listener: set_extra_try_arguments 22:14:48 INFO - ##### 22:14:48 INFO - ##### Running populate-webroot step. 22:14:48 INFO - ##### 22:14:48 INFO - Running pre-action listener: _resource_record_pre_action 22:14:48 INFO - Running main action method: populate_webroot 22:14:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:14:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:14:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:14:48 INFO - '--tppagecycles', 22:14:48 INFO - '7'], 22:14:48 INFO - 'tests': ['tsvgm']}}, 22:14:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:14:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:14:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:14:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:14:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:14:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:14:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:48 INFO - 'talos_options': ['--disable-e10s'], 22:14:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:14:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:14:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:48 INFO - 'talos_options': ['--disable-e10s'], 22:14:48 INFO - 'tests': ['damp', 'tps']}, 22:14:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:48 INFO - 'tests': ['damp', 'tps']}, 22:14:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:14:48 INFO - 'tests': ['dromaeo_dom']}, 22:14:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:14:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:14:48 INFO - 'tests': ['a11yr', 22:14:48 INFO - 'ts_paint', 22:14:48 INFO - 'tpaint', 22:14:48 INFO - 'sessionrestore', 22:14:48 INFO - 'sessionrestore_no_auto_restore', 22:14:48 INFO - 'tabpaint']}, 22:14:48 INFO - 'other-e10s': {'tests': ['a11yr', 22:14:48 INFO - 'ts_paint', 22:14:48 INFO - 'tpaint', 22:14:48 INFO - 'sessionrestore', 22:14:48 INFO - 'sessionrestore_no_auto_restore', 22:14:48 INFO - 'tabpaint']}, 22:14:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:14:48 INFO - 'ts_paint', 22:14:48 INFO - 'tpaint', 22:14:48 INFO - 'sessionrestore', 22:14:48 INFO - 'sessionrestore_no_auto_restore', 22:14:48 INFO - 'tabpaint']}, 22:14:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:14:48 INFO - 'ts_paint', 22:14:48 INFO - 'tpaint', 22:14:48 INFO - 'sessionrestore', 22:14:48 INFO - 'sessionrestore_no_auto_restore', 22:14:48 INFO - 'tabpaint']}, 22:14:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:14:48 INFO - 'tests': ['a11yr', 22:14:48 INFO - 'ts_paint', 22:14:48 INFO - 'tpaint', 22:14:48 INFO - 'sessionrestore', 22:14:48 INFO - 'sessionrestore_no_auto_restore', 22:14:48 INFO - 'tabpaint']}, 22:14:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:14:48 INFO - 'tests': ['a11yr', 22:14:48 INFO - 'ts_paint', 22:14:48 INFO - 'tpaint', 22:14:48 INFO - 'sessionrestore', 22:14:48 INFO - 'sessionrestore_no_auto_restore', 22:14:48 INFO - 'tabpaint']}, 22:14:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:14:48 INFO - 'tests': ['tsvgx', 22:14:48 INFO - 'tsvgr_opacity', 22:14:48 INFO - 'tart', 22:14:48 INFO - 'tscrollx', 22:14:48 INFO - 'cart']}, 22:14:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:14:48 INFO - 'tsvgr_opacity', 22:14:48 INFO - 'tart', 22:14:48 INFO - 'tscrollx', 22:14:48 INFO - 'cart']}, 22:14:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:48 INFO - 'talos_options': ['--disable-e10s'], 22:14:48 INFO - 'tests': ['tp5o']}, 22:14:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:48 INFO - 'tests': ['tp5o']}, 22:14:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:48 INFO - 'talos_options': ['--disable-e10s', 22:14:48 INFO - '--xperf_path', 22:14:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:14:48 INFO - 'tests': ['tp5n']}, 22:14:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:14:48 INFO - 'talos_options': ['--xperf_path', 22:14:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:14:48 INFO - 'tests': ['tp5n']}}, 22:14:48 INFO - 'talos.zip': {'path': '', 22:14:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:14:48 INFO - Running post-action listener: _resource_record_post_action 22:14:48 INFO - ##### 22:14:48 INFO - ##### Running create-virtualenv step. 22:14:48 INFO - ##### 22:14:48 INFO - Running pre-action listener: _resource_record_pre_action 22:14:48 INFO - Running main action method: create_virtualenv 22:14:48 INFO - Creating virtualenv /builds/slave/test/build/venv 22:14:48 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 22:14:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:14:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:14:49 INFO - Using real prefix '/usr' 22:14:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:14:49 INFO - Installing distribute.............................................................................................................................................................................................done. 22:14:51 INFO - Installing pip.................done. 22:14:51 INFO - Return code: 0 22:14:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:14:51 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')]} 22:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:51 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')]} 22:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:51 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 0x7f2998b3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11605a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef410>, '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 0x11f0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f07a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748', '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 22:14:51 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 22:14:51 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 22:14:51 INFO - Using env: {'DISPLAY': ':0', 22:14:51 INFO - 'HOME': '/home/cltbld', 22:14:51 INFO - 'LANG': 'en_US.UTF-8', 22:14:51 INFO - 'LANGUAGE': 'en_US:en', 22:14:51 INFO - 'LOGNAME': 'cltbld', 22:14:51 INFO - 'MAIL': '/var/mail/cltbld', 22:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:51 INFO - 'MOZ_NO_REMOTE': '1', 22:14:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:51 INFO - 'NO_EM_RESTART': '1', 22:14:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:51 INFO - 'PWD': '/builds/slave/test', 22:14:51 INFO - 'SHELL': '/bin/bash', 22:14:51 INFO - 'SHLVL': '1', 22:14:51 INFO - 'TERM': 'linux', 22:14:51 INFO - 'TMOUT': '86400', 22:14:51 INFO - 'USER': 'cltbld', 22:14:51 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748', 22:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:51 INFO - '_': '/tools/buildbot/bin/python'} 22:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:51 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 22:14:51 INFO - Cleaning up... 22:14:51 INFO - Return code: 0 22:14:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:14:51 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')]} 22:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:51 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')]} 22:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:51 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 0x7f2998b3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11605a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef410>, '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 0x11f0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f07a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748', '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 22:14:51 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 22:14:51 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 22:14:51 INFO - Using env: {'DISPLAY': ':0', 22:14:51 INFO - 'HOME': '/home/cltbld', 22:14:51 INFO - 'LANG': 'en_US.UTF-8', 22:14:51 INFO - 'LANGUAGE': 'en_US:en', 22:14:51 INFO - 'LOGNAME': 'cltbld', 22:14:51 INFO - 'MAIL': '/var/mail/cltbld', 22:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:51 INFO - 'MOZ_NO_REMOTE': '1', 22:14:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:51 INFO - 'NO_EM_RESTART': '1', 22:14:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:51 INFO - 'PWD': '/builds/slave/test', 22:14:51 INFO - 'SHELL': '/bin/bash', 22:14:51 INFO - 'SHLVL': '1', 22:14:51 INFO - 'TERM': 'linux', 22:14:51 INFO - 'TMOUT': '86400', 22:14:51 INFO - 'USER': 'cltbld', 22:14:51 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748', 22:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:51 INFO - '_': '/tools/buildbot/bin/python'} 22:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:51 INFO - Downloading/unpacking psutil>=0.7.1 22:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:14:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:14:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:14:53 INFO - Installing collected packages: psutil 22:14:53 INFO - Running setup.py install for psutil 22:14:54 INFO - building 'psutil._psutil_linux' extension 22:14:54 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 22:14:54 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 22:14:54 INFO - building 'psutil._psutil_posix' extension 22:14:54 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 22:14:54 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 22:14:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:14:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:14:54 INFO - Successfully installed psutil 22:14:54 INFO - Cleaning up... 22:14:54 INFO - Return code: 0 22:14:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2998b3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11605a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef410>, '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 0x11f0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f07a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748', '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 22:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:14:54 INFO - Using env: {'DISPLAY': ':0', 22:14:54 INFO - 'HOME': '/home/cltbld', 22:14:54 INFO - 'LANG': 'en_US.UTF-8', 22:14:54 INFO - 'LANGUAGE': 'en_US:en', 22:14:54 INFO - 'LOGNAME': 'cltbld', 22:14:54 INFO - 'MAIL': '/var/mail/cltbld', 22:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:54 INFO - 'MOZ_NO_REMOTE': '1', 22:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:54 INFO - 'NO_EM_RESTART': '1', 22:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:54 INFO - 'PWD': '/builds/slave/test', 22:14:54 INFO - 'SHELL': '/bin/bash', 22:14:54 INFO - 'SHLVL': '1', 22:14:54 INFO - 'TERM': 'linux', 22:14:54 INFO - 'TMOUT': '86400', 22:14:54 INFO - 'USER': 'cltbld', 22:14:54 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748', 22:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:54 INFO - '_': '/tools/buildbot/bin/python'} 22:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:14:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:14:56 INFO - Installing collected packages: mozsystemmonitor 22:14:56 INFO - Running setup.py install for mozsystemmonitor 22:14:56 INFO - Successfully installed mozsystemmonitor 22:14:56 INFO - Cleaning up... 22:14:56 INFO - Return code: 0 22:14:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:14:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2998b3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11605a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef410>, '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 0x11f0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f07a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748', '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 22:14:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:14:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:14:56 INFO - Using env: {'DISPLAY': ':0', 22:14:56 INFO - 'HOME': '/home/cltbld', 22:14:56 INFO - 'LANG': 'en_US.UTF-8', 22:14:56 INFO - 'LANGUAGE': 'en_US:en', 22:14:56 INFO - 'LOGNAME': 'cltbld', 22:14:56 INFO - 'MAIL': '/var/mail/cltbld', 22:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:14:56 INFO - 'MOZ_NO_REMOTE': '1', 22:14:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:14:56 INFO - 'NO_EM_RESTART': '1', 22:14:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:14:56 INFO - 'PWD': '/builds/slave/test', 22:14:56 INFO - 'SHELL': '/bin/bash', 22:14:56 INFO - 'SHLVL': '1', 22:14:56 INFO - 'TERM': 'linux', 22:14:56 INFO - 'TMOUT': '86400', 22:14:56 INFO - 'USER': 'cltbld', 22:14:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748', 22:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:14:56 INFO - '_': '/tools/buildbot/bin/python'} 22:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:14:57 INFO - Downloading/unpacking blobuploader==1.2.4 22:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:58 INFO - Downloading blobuploader-1.2.4.tar.gz 22:14:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:14:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:14:58 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 22:14:58 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 22:14:58 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 22:14:58 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 22:14:58 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 22:14:58 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 22:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:14:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:14:59 INFO - Downloading docopt-0.6.1.tar.gz 22:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:14:59 INFO - Installing collected packages: blobuploader, requests, docopt 22:14:59 INFO - Running setup.py install for blobuploader 22:14:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:14:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:14:59 INFO - Running setup.py install for requests 22:15:00 INFO - Running setup.py install for docopt 22:15:00 INFO - Successfully installed blobuploader requests docopt 22:15:00 INFO - Cleaning up... 22:15:00 INFO - Return code: 0 22:15:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:15: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')]} 22:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15: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')]} 22:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:00 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 0x7f2998b3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11605a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef410>, '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 0x11f0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f07a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748', '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 22:15:00 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 22:15:00 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 22:15:00 INFO - Using env: {'DISPLAY': ':0', 22:15:00 INFO - 'HOME': '/home/cltbld', 22:15:00 INFO - 'LANG': 'en_US.UTF-8', 22:15:00 INFO - 'LANGUAGE': 'en_US:en', 22:15:00 INFO - 'LOGNAME': 'cltbld', 22:15:00 INFO - 'MAIL': '/var/mail/cltbld', 22:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:00 INFO - 'MOZ_NO_REMOTE': '1', 22:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:00 INFO - 'NO_EM_RESTART': '1', 22:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:00 INFO - 'PWD': '/builds/slave/test', 22:15:00 INFO - 'SHELL': '/bin/bash', 22:15:00 INFO - 'SHLVL': '1', 22:15:00 INFO - 'TERM': 'linux', 22:15:00 INFO - 'TMOUT': '86400', 22:15:00 INFO - 'USER': 'cltbld', 22:15:00 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748', 22:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:00 INFO - '_': '/tools/buildbot/bin/python'} 22:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:15:00 INFO - Running setup.py (path:/tmp/pip-W8XkOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:15:00 INFO - Running setup.py (path:/tmp/pip-JxGfs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:15:00 INFO - Running setup.py (path:/tmp/pip-Yotedy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:15:00 INFO - Running setup.py (path:/tmp/pip-TPsNfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:15:00 INFO - Running setup.py (path:/tmp/pip-IQ_fbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:15:00 INFO - Running setup.py (path:/tmp/pip-jh06gL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:15:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:15:00 INFO - Running setup.py (path:/tmp/pip-Ays1OM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:15:01 INFO - Running setup.py (path:/tmp/pip-UBynXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:15:01 INFO - Running setup.py (path:/tmp/pip-ntK5Bq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:15:01 INFO - Running setup.py (path:/tmp/pip-dYlB6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:15:01 INFO - Running setup.py (path:/tmp/pip-iTGQz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:15:01 INFO - Running setup.py (path:/tmp/pip-YESlL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:15:01 INFO - Running setup.py (path:/tmp/pip-4GFWZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:15:01 INFO - Running setup.py (path:/tmp/pip-g7tBz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:15:01 INFO - Running setup.py (path:/tmp/pip-8ji3Em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:15:01 INFO - Running setup.py (path:/tmp/pip-pC_tlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:15:01 INFO - Running setup.py (path:/tmp/pip-izu6nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:15:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:15:01 INFO - Running setup.py install for manifestparser 22:15:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:15:01 INFO - Running setup.py install for mozcrash 22:15:01 INFO - Running setup.py install for mozdebug 22:15:02 INFO - Running setup.py install for mozdevice 22:15:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:15:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:15:02 INFO - Running setup.py install for mozfile 22:15:02 INFO - Running setup.py install for mozhttpd 22:15:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:15:02 INFO - Running setup.py install for mozinfo 22:15:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:15:02 INFO - Running setup.py install for mozInstall 22:15:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:15:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:15:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:15:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:15:02 INFO - Running setup.py install for mozleak 22:15:02 INFO - Running setup.py install for mozlog 22:15:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:15:02 INFO - Running setup.py install for moznetwork 22:15:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:15:02 INFO - Running setup.py install for mozprocess 22:15:02 INFO - Running setup.py install for mozprofile 22:15:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:15:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:15:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:15:03 INFO - Running setup.py install for mozrunner 22:15:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:15:03 INFO - Running setup.py install for mozscreenshot 22:15:03 INFO - Running setup.py install for moztest 22:15:03 INFO - Running setup.py install for mozversion 22:15:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:15:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:15:03 INFO - Cleaning up... 22:15:03 INFO - Return code: 0 22:15:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:15:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:03 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 0x7f2998b3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11605a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef410>, '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 0x11f0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f07a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748', '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 22:15:03 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 22:15:03 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 22:15:03 INFO - Using env: {'DISPLAY': ':0', 22:15:03 INFO - 'HOME': '/home/cltbld', 22:15:03 INFO - 'LANG': 'en_US.UTF-8', 22:15:03 INFO - 'LANGUAGE': 'en_US:en', 22:15:03 INFO - 'LOGNAME': 'cltbld', 22:15:03 INFO - 'MAIL': '/var/mail/cltbld', 22:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:03 INFO - 'MOZ_NO_REMOTE': '1', 22:15:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:03 INFO - 'NO_EM_RESTART': '1', 22:15:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:03 INFO - 'PWD': '/builds/slave/test', 22:15:03 INFO - 'SHELL': '/bin/bash', 22:15:03 INFO - 'SHLVL': '1', 22:15:03 INFO - 'TERM': 'linux', 22:15:03 INFO - 'TMOUT': '86400', 22:15:03 INFO - 'USER': 'cltbld', 22:15:03 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748', 22:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:03 INFO - '_': '/tools/buildbot/bin/python'} 22:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:15:03 INFO - Running setup.py (path:/tmp/pip-OUoeon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:15:03 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)) 22:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:15:03 INFO - Running setup.py (path:/tmp/pip-U9y_g_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:15:03 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)) 22:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:15:03 INFO - Running setup.py (path:/tmp/pip-_3_0Vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:15:03 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)) 22:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:15:03 INFO - Running setup.py (path:/tmp/pip-f4epDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:15:04 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)) 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:15:04 INFO - Running setup.py (path:/tmp/pip-HwnS4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:15:04 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)) 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:15:04 INFO - Running setup.py (path:/tmp/pip-zQziYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:15:04 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)) 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:15:04 INFO - Running setup.py (path:/tmp/pip-5TeP_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:15:04 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)) 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:15:04 INFO - Running setup.py (path:/tmp/pip-SsjJjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:15:04 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)) 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:15:04 INFO - Running setup.py (path:/tmp/pip-71cpTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:15:04 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)) 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:15:04 INFO - Running setup.py (path:/tmp/pip-WTgqEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:15:04 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)) 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:15:04 INFO - Running setup.py (path:/tmp/pip-8uC2RX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:15:04 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)) 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:15:04 INFO - Running setup.py (path:/tmp/pip-M_lCt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:15:04 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)) 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:15:04 INFO - Running setup.py (path:/tmp/pip-xlBJ95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:15:04 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)) 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:15:04 INFO - Running setup.py (path:/tmp/pip-0Wev7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:15:04 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)) 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:15:04 INFO - Running setup.py (path:/tmp/pip-V4ZtDO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:15:04 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)) 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:15:04 INFO - Running setup.py (path:/tmp/pip-CX6eXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:15:04 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)) 22:15:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:15:04 INFO - Running setup.py (path:/tmp/pip-vfY1TI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:15:04 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)) 22:15:04 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)) 22:15:04 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)) 22:15:04 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)) 22:15:04 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)) 22:15:04 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)) 22:15:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:06 INFO - Downloading blessings-1.6.tar.gz 22:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:15:06 INFO - Installing collected packages: blessings 22:15:06 INFO - Running setup.py install for blessings 22:15:06 INFO - Successfully installed blessings 22:15:06 INFO - Cleaning up... 22:15:07 INFO - Return code: 0 22:15:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:15:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:15:07 INFO - Reading from file tmpfile_stdout 22:15:07 INFO - Current package versions: 22:15:07 INFO - argparse == 1.2.1 22:15:07 INFO - blessings == 1.6 22:15:07 INFO - blobuploader == 1.2.4 22:15:07 INFO - docopt == 0.6.1 22:15:07 INFO - manifestparser == 1.1 22:15:07 INFO - mozInstall == 1.12 22:15:07 INFO - mozcrash == 0.17 22:15:07 INFO - mozdebug == 0.1 22:15:07 INFO - mozdevice == 0.48 22:15:07 INFO - mozfile == 1.2 22:15:07 INFO - mozhttpd == 0.7 22:15:07 INFO - mozinfo == 0.9 22:15:07 INFO - mozleak == 0.1 22:15:07 INFO - mozlog == 3.1 22:15:07 INFO - moznetwork == 0.27 22:15:07 INFO - mozprocess == 0.22 22:15:07 INFO - mozprofile == 0.28 22:15:07 INFO - mozrunner == 6.11 22:15:07 INFO - mozscreenshot == 0.1 22:15:07 INFO - mozsystemmonitor == 0.0 22:15:07 INFO - moztest == 0.7 22:15:07 INFO - mozversion == 1.4 22:15:07 INFO - psutil == 3.1.1 22:15:07 INFO - requests == 1.2.3 22:15:07 INFO - wsgiref == 0.1.2 22:15:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:07 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 0x7f2998b3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11605a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef410>, '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 0x11f0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f07a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748', '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 22:15:07 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 22:15:07 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 22:15:07 INFO - Using env: {'DISPLAY': ':0', 22:15:07 INFO - 'HOME': '/home/cltbld', 22:15:07 INFO - 'LANG': 'en_US.UTF-8', 22:15:07 INFO - 'LANGUAGE': 'en_US:en', 22:15:07 INFO - 'LOGNAME': 'cltbld', 22:15:07 INFO - 'MAIL': '/var/mail/cltbld', 22:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:07 INFO - 'MOZ_NO_REMOTE': '1', 22:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:07 INFO - 'NO_EM_RESTART': '1', 22:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:07 INFO - 'PWD': '/builds/slave/test', 22:15:07 INFO - 'SHELL': '/bin/bash', 22:15:07 INFO - 'SHLVL': '1', 22:15:07 INFO - 'TERM': 'linux', 22:15:07 INFO - 'TMOUT': '86400', 22:15:07 INFO - 'USER': 'cltbld', 22:15:07 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748', 22:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:07 INFO - '_': '/tools/buildbot/bin/python'} 22:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:07 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)) 22:15:07 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)) 22:15:07 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)) 22:15:07 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)) 22:15:07 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)) 22:15:07 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)) 22:15:07 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)) 22:15:07 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)) 22:15:07 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)) 22:15:07 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)) 22:15:07 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)) 22:15:07 INFO - Cleaning up... 22:15:07 INFO - Return code: 0 22:15:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:15:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:15:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:07 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 0x7f2998b3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11605a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef410>, '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 0x11f0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f07a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748', '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 22:15:07 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 22:15:07 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 22:15:07 INFO - Using env: {'DISPLAY': ':0', 22:15:07 INFO - 'HOME': '/home/cltbld', 22:15:07 INFO - 'LANG': 'en_US.UTF-8', 22:15:07 INFO - 'LANGUAGE': 'en_US:en', 22:15:07 INFO - 'LOGNAME': 'cltbld', 22:15:07 INFO - 'MAIL': '/var/mail/cltbld', 22:15:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:07 INFO - 'MOZ_NO_REMOTE': '1', 22:15:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:07 INFO - 'NO_EM_RESTART': '1', 22:15:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:07 INFO - 'PWD': '/builds/slave/test', 22:15:07 INFO - 'SHELL': '/bin/bash', 22:15:07 INFO - 'SHLVL': '1', 22:15:07 INFO - 'TERM': 'linux', 22:15:07 INFO - 'TMOUT': '86400', 22:15:07 INFO - 'USER': 'cltbld', 22:15:07 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748', 22:15:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:07 INFO - '_': '/tools/buildbot/bin/python'} 22:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:07 INFO - Downloading/unpacking jsonschema 22:15: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 22:15: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 22:15: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 22:15: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 22:15: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 22:15: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 22:15:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:15:09 INFO - Downloading/unpacking functools32 (from jsonschema) 22:15:09 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 22:15:09 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 22:15:09 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 22:15:09 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 22:15:09 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 22:15:09 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 22:15:09 INFO - Downloading functools32-3.2.3-2.tar.gz 22:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:15:09 INFO - warning: no files found matching '*.txt' 22:15:09 INFO - no previously-included directories found matching 'build' 22:15:09 INFO - no previously-included directories found matching 'dist' 22:15:09 INFO - no previously-included directories found matching '.git*' 22:15:09 INFO - Installing collected packages: jsonschema, functools32 22:15:09 INFO - Running setup.py install for functools32 22:15:10 INFO - warning: no files found matching '*.txt' 22:15:10 INFO - no previously-included directories found matching 'build' 22:15:10 INFO - no previously-included directories found matching 'dist' 22:15:10 INFO - no previously-included directories found matching '.git*' 22:15:10 INFO - Successfully installed jsonschema functools32 22:15:10 INFO - Cleaning up... 22:15:10 INFO - Return code: 0 22:15:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:15:10 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')]} 22:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:15:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:10 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')]} 22:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:15:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:15:10 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 0x7f2998b3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11605a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ef410>, '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 0x11f0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f07a0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748', '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 22:15:10 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 22:15:10 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 22:15:10 INFO - Using env: {'DISPLAY': ':0', 22:15:10 INFO - 'HOME': '/home/cltbld', 22:15:10 INFO - 'LANG': 'en_US.UTF-8', 22:15:10 INFO - 'LANGUAGE': 'en_US:en', 22:15:10 INFO - 'LOGNAME': 'cltbld', 22:15:10 INFO - 'MAIL': '/var/mail/cltbld', 22:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:10 INFO - 'MOZ_NO_REMOTE': '1', 22:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:10 INFO - 'NO_EM_RESTART': '1', 22:15:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:10 INFO - 'PWD': '/builds/slave/test', 22:15:10 INFO - 'SHELL': '/bin/bash', 22:15:10 INFO - 'SHLVL': '1', 22:15:10 INFO - 'TERM': 'linux', 22:15:10 INFO - 'TMOUT': '86400', 22:15:10 INFO - 'USER': 'cltbld', 22:15:10 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748', 22:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:10 INFO - '_': '/tools/buildbot/bin/python'} 22:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:15:10 INFO - Downloading/unpacking flake8 22:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:15:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:15:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:15:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:15:12 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 22:15:12 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 22:15:12 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 22:15:12 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 22:15:12 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 22:15:12 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 22:15:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:15:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:15:12 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 22:15:12 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 22:15:12 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 22:15:12 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 22:15:12 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 22:15:12 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 22:15:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:15:12 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 22:15:12 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 22:15:12 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 22:15:12 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 22:15:12 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 22:15:12 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 22:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:15:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:15:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:15:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:15:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:15:12 INFO - no previously-included directories found matching 'docs/_build' 22:15:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:15:12 INFO - Running setup.py install for pep8 22:15:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:15:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:15:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:15:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:15:13 INFO - no previously-included directories found matching 'docs/_build' 22:15:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:15:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:15:13 INFO - Cleaning up... 22:15:13 INFO - Return code: 0 22:15:13 INFO - Running post-action listener: _resource_record_post_action 22:15:13 INFO - Running post-action listener: _start_resource_monitoring 22:15:13 INFO - Starting resource monitoring. 22:15:13 INFO - ##### 22:15:13 INFO - ##### Running install step. 22:15:13 INFO - ##### 22:15:13 INFO - Running pre-action listener: _resource_record_pre_action 22:15:13 INFO - Running main action method: install 22:15:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:15:13 INFO - Reading from file tmpfile_stdout 22:15:13 INFO - Detecting whether we're running mozinstall >=1.0... 22:15:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:15:13 INFO - Reading from file tmpfile_stdout 22:15:13 INFO - Output received: 22:15:13 INFO - Usage: mozinstall [options] installer 22:15:13 INFO - Options: 22:15:13 INFO - -h, --help show this help message and exit 22:15:13 INFO - -d DEST, --destination=DEST 22:15:13 INFO - Directory to install application into. [default: 22:15:13 INFO - "/builds/slave/test"] 22:15:13 INFO - --app=APP Application being installed. [default: firefox] 22:15:13 INFO - mkdir: /builds/slave/test/build/application 22:15:13 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'] 22:15:13 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 22:15:30 INFO - Reading from file tmpfile_stdout 22:15:30 INFO - Output received: 22:15:30 INFO - /builds/slave/test/build/application/firefox/firefox 22:15:30 INFO - Running post-action listener: _resource_record_post_action 22:15:30 INFO - ##### 22:15:30 INFO - ##### Running run-tests step. 22:15:30 INFO - ##### 22:15:30 INFO - Running pre-action listener: _resource_record_pre_action 22:15:30 INFO - Running main action method: run_tests 22:15:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:15:30 INFO - Python 2.7.3 22:15:30 INFO - Return code: 0 22:15:30 INFO - grabbing minidump binary from tooltool 22:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:15:30 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 0x11ef410>, '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 0x11f0310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11f07a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:15:30 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 22:15:30 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 22:15:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:15:30 INFO - Return code: 0 22:15:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:15:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:15:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:15:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:15:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:15:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:15:31 INFO - Return code: 0 22:15:31 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 22:15:31 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 22:15:31 INFO - Using env: {'DISPLAY': ':0', 22:15:31 INFO - 'HOME': '/home/cltbld', 22:15:31 INFO - 'LANG': 'en_US.UTF-8', 22:15:31 INFO - 'LANGUAGE': 'en_US:en', 22:15:31 INFO - 'LOGNAME': 'cltbld', 22:15:31 INFO - 'MAIL': '/var/mail/cltbld', 22:15:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:15:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:15:31 INFO - 'MOZ_NO_REMOTE': '1', 22:15:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:15:31 INFO - 'NO_EM_RESTART': '1', 22:15:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:15:31 INFO - 'PWD': '/builds/slave/test', 22:15:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:15:31 INFO - 'SHELL': '/bin/bash', 22:15:31 INFO - 'SHLVL': '1', 22:15:31 INFO - 'TERM': 'linux', 22:15:31 INFO - 'TMOUT': '86400', 22:15:31 INFO - 'USER': 'cltbld', 22:15:31 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748', 22:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:15:31 INFO - '_': '/tools/buildbot/bin/python'} 22:15:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:15:31 INFO - mozversion application_buildid: 20160503193626 22:15:31 INFO - mozversion application_changeset: 54e84fa84d6defa32626421af67e634203256122 22:15:31 INFO - mozversion application_display_name: Nightly 22:15:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:15:31 INFO - mozversion application_name: Firefox 22:15:31 INFO - mozversion application_remotingname: firefox 22:15:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:15:31 INFO - mozversion application_vendor: Mozilla 22:15:31 INFO - mozversion application_version: 49.0a1 22:15:31 INFO - mozversion platform_buildid: 20160503193626 22:15:31 INFO - mozversion platform_changeset: 54e84fa84d6defa32626421af67e634203256122 22:15:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:15:31 INFO - mozversion platform_version: 49.0a1 22:15:31 INFO - using testdate: 1462338931 22:15:31 INFO - actual date: 1462338931 22:15:31 INFO - starting webserver on 'localhost:51224' 22:15:31 INFO - SUITE-START | Running 2 tests 22:15:31 INFO - TEST-START | dromaeo_css 22:15:31 INFO - operating with platform_type : linux_ 22:15:31 INFO - Initialising browser for dromaeo_css test... 22:15:31 INFO - TEST-INFO | started process 16516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0p9hWL/profile http://localhost:51224/getInfo.html) 22:15:35 INFO - PROCESS | 16516 | __metrics Screen width/height:1600/1200 22:15:35 INFO - PROCESS | 16516 | colorDepth:24 22:15:35 INFO - PROCESS | 16516 | Browser inner width/height: 1024/697 22:15:35 INFO - PROCESS | 16516 | __metrics 22:15:36 ERROR - PROCESS | 16516 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:15:37 INFO - TEST-INFO | 16516: exit 0 22:15:37 INFO - Browser initialized. 22:15:37 INFO - Running cycle 1/1 for dromaeo_css test... 22:15:37 INFO - TEST-INFO | started process 16598 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0p9hWL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:15:49 INFO - PROCESS | 16598 | RSS: Main: 154746880 22:15:49 INFO - PROCESS | 16598 | 22:16:40 INFO - PROCESS | 16598 | 1462339000562 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] 22:18:48 INFO - PROCESS | 16598 | Cycle 1(1): loaded http://localhost:51224/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51224/tests/dromaeo/cssquery-ext.html) 22:18:49 INFO - PROCESS | 16598 | RSS: Main: 254566400 22:18:49 INFO - PROCESS | 16598 | 22:21:51 INFO - PROCESS | 16598 | Cycle 1(1): loaded http://localhost:51224/tests/dromaeo/cssquery-ext.html (next: http://localhost:51224/tests/dromaeo/cssquery-jquery.html) 22:21:52 INFO - PROCESS | 16598 | RSS: Main: 238522368 22:21:52 INFO - PROCESS | 16598 | 22:24:54 INFO - PROCESS | 16598 | Cycle 1(1): loaded http://localhost:51224/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51224/tests/dromaeo/cssquery-mootools.html) 22:24:54 INFO - PROCESS | 16598 | RSS: Main: 239370240 22:24:54 INFO - PROCESS | 16598 | 22:27:56 INFO - PROCESS | 16598 | Cycle 1(1): loaded http://localhost:51224/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51224/tests/dromaeo/cssquery-prototype.html) 22:27:57 INFO - PROCESS | 16598 | RSS: Main: 234291200 22:27:57 INFO - PROCESS | 16598 | 22:30:59 INFO - PROCESS | 16598 | Cycle 1(1): loaded http://localhost:51224/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51224/tests/dromaeo/cssquery-yui.html) 22:31:00 INFO - PROCESS | 16598 | RSS: Main: 214044672 22:31:00 INFO - PROCESS | 16598 | 22:34:02 INFO - PROCESS | 16598 | Cycle 1(1): loaded http://localhost:51224/tests/dromaeo/cssquery-yui.html (next: http://localhost:51224/tests/dromaeo/cssquery-dojo.html) 22:34:03 INFO - PROCESS | 16598 | RSS: Main: 269942784 22:34:03 INFO - PROCESS | 16598 | 22:34:03 INFO - PROCESS | 16598 | __start_tp_report 22:34:03 INFO - PROCESS | 16598 | _x_x_mozilla_page_load 22:34:03 INFO - PROCESS | 16598 | _x_x_mozilla_page_load_details 22:34:03 INFO - PROCESS | 16598 | |i|pagename|runs| 22:34:03 INFO - PROCESS | 16598 | |0;dojo.html;3107.3474570340227;3127.4683303838347;3158.5578019077334;3170.9207269818253;3188.824614646195;5238.580913526918;5244.423113457521;5276.419593844674;5296.3114795076635;5369.838904832861;5324.414314425419;5330.493603107699;5365.7585408656605;5417.349918009844;5448.37343705474;4816.349792777965;4851.927221091686;4852.951470485285;4873.780679869415;4961.652684312099;4875.658703890729;4895.996320754237;4939.160342741725;4943.555080042795;4945.950540494585;4811.350467686852;4813.446453657839;4846.3457433246585;4877.219644856806;4930.359053323081;4844.176489996709;4860.125177468054;4871.512848715136;4873.658843880929;4925.13810083234;4714.4106986626675;4817.470078291385;4847.394075740533;4847.612191024745;4866.46468888422;5153.020926024081;5167.560757335594;5176.301199338116;5184.585233181374;5233.973830130825;5608.214849920973;5636.239107720447;5655.886882262373;5659;5663.7168141593165;5478.506934375925;5678.375378708339;5686;5692.231548740909;5746.712664366765;5373.059714549938;5386.596005299579;5387.030334539742;5392.325959255132;5421.349438067417;5853.473187413153;5859.472647461749;5876.44173803488;5876.823695289148;5878.882422351529;5437.374701909331;5530.889382212414;5581.972090139523;5587.161925711176;5617.38208797032;5681.119426488901;5697.4587414195585;5697.971510142505;5700;5707.143928410772;5658.236138121301;5660.915086273709;5680.6591604503865;5681.488666020078;5685.204071430003;5344.038073146871;5562.276904002454;5619.241402410704;5645;5672.971635141798;4278.315469524861;4281.721688090264;4282.379055037064;4296.93554596675;4316;3767.095896984704;3854.903627409281;3866.941995870064;3894.6689531389584;3907.706921980806;5284.815031473957;5314.574834013347;5320.547753440924;5359.544438722674;5365.865853353619;5649.6327738696855;5667.1782591524;5675.687837168913;5675.829725108253;5681.488666020078;5263.973680131575;5290.894182116336;5298.311219541512;5321.866953326198;5365.061114304981;4867.513248675175;4876.195427754381;4882.951170488321;4901.828436004794;4904.60763138948;5770.105633626795;5790.334111577138;5796.971015144897;5804.2744656917885;5822.941770582324;5577.581681373832;5619.747111380079;5632.239647647515;5664.122061080539;5691.032524470767;5889.617174883619;5891.1752354671235;5894.528437724886;5900.881982360243;5957.076653118774;5611.242482264842;5612.85967850807;5622.8313150605545;5623.1846382273525;5628.0432326505415;5567.387587365306;5596.384397716167;5632.436756324335;5688.061469857427;5702;5538;5539.556835453073;5546.889062218814;5555.916661250165;5587.664740115606;5470.781168753365;5485.890282194414;5488.5334746545395;5498.1752737089755;5511.22842802016;5340.038793017294;5413.783448662167;5470.480304371078;5475.945240547703;5536.197251398606;5620.213170156263;5624.8875022498505;5625.043742563856;5642.548596112383;5656.60403771732;5528.391876893619;5528.640638358494;5530.529904957963;5532.474414930736;5564.554835613222 22:34:03 INFO - PROCESS | 16598 | |1;ext.html;591.6627522312281;638.9648569328687;646.7703965092392;647.423792824386;664.5879554676098;32429.189270268227;37950.24099518012;38527.84416467507;38604.80697596508;38773.03067423316;41084.79457602708;41784.37323440151;41872.58127418725;41917.79041104798;41928.37107443391;7832.921670783305;8211.425200236;8571.185737354972;8593.398462107654;9938.453385063818;10023.04781045803;10224.335418197794;10234.130098941561;10234.385936843813;10234.948825255864;10149.594016239342;10300.12448941841;10300.948495257513;10302.896971030268;10304.484775761219;7810.258025487569;9855.753606159831;10133.59465621378;10136.442495662735;10160.644377446828;10023.749406264902;10101.949490252575;10162.542685579167;10173.491325433699;10183.949080254626;36715.449268261;37389.43915841264;37398.25203495915;37457;37471;3581.606023337431;3656.6160553142067;3725.869594564177;4209.284421648327;4339.435873336446;31921.201969950704;31956;32296.354072918646;32819.83590082058;33408;4214.873553793361;4304.677149213821;4319.460067491564;4342.32693932441;4402.5597440255715;314826;317836.82163178304;318459;318840;319936.9999999977;56852.71573642105;57554;57796.71101644465;57883;57956.420435795946;59973.40026599678;60078;60245.397546024855;60520.39479605236;60528.973551322255;16705.498835034967;17370.131493425277;17370.91314543419;17376.652466950844;17381;13382.263975481443;13383.799243011363;13471.12437691547;13484.39320230592;13534.59396218115;16200.270987805578;16320.9806185856;16395.836041639668;16429.83570164283;16447.177641117898;5281.366236051698;6470.450011749054;6564.573302735403;6580.967095164494;6588.143541339691;1003.7039073473343;1011.9494025298706;1065.8507808906759;1116.3636727065496;1129.3619105205696;30153.547696784564;32208.516872246935;33493.3301333972;33569.664303357145;33979.07303440987;1069.8546273954548;1093.3002878157986;1100.5432745410726;1135.0692432205512;1135.233717240859;17256.74114888278;17889.910550447163;17909.552261193312;17915.10424478797;17933.7309940351;459295;479138;480024;480437;480601;59481.40518594845;60165;60179.39820601825;60368;60406.09390859141;1323.2391374959436;1360.7617068467448;1370.8971827113007;1386.778115501515;1519.6504803895166;29422;30786.21099260048;31245.687543124277;32034.67965320317;33284.1678958028;50443.243351349025;51174.34733484623;51518;51696.48303516916;51713.22430163476;404799.6160307109;410194;413921;413991;414082;34514.82742586271;41824.37263441112;42420.5757942429;44514.55485445233;45179.77410112928;48370.274445882635;50082.74958625183;52165.7391713039;52233.21650175326;53489.46510534845;41970;42148;42817.78591107025;43388.34917476177;43907.34138987982;42674.78662606667;43148.56851431571;43459.34810977901;44151.11697766091;44214.778926105166;44440.33339499975;44518.55481445144;44561.331580025675;45320.69453401922;45618;38570.80714596409;39137.41293880537;39210.607893921835;39266.60733392744;40064.3990340151;29251.85374073116;29518.409631807674;29814;29995.400091997602;30219.848900755354 22:34:03 INFO - PROCESS | 16598 | |2;jquery.html;402.1755401427074;406.10453949042363;408.5607971430713;408.711858140011;415.6905746897273;13579.963005549173;17473.912630436847;17676.116194190305;18240.452786416412;18306.450806475812;18280.725789113174;18372.44882653519;18390;18582.907085464554;18911.81088189121;5416.674999500043;5629;5632.605717599769;5639.323281206261;5659.886802263953;4110.588941105895;5588.105903055512;5635.492805647491;5835.562332825034;6166.876662466748;6085.087236914476;6086.087086936951;6134.4478996890275;6137.9386206137815;6138.7237574309265;6151;6174.660393678346;6206.534509911729;6209.3790620938;6212.844678883019;5334.359876814807;5401.756920938567;5529.612927095105;5565.526930210937;5565.5825813063775;23002.194923177776;23003.42491437711;23009.654855177185;23173.88413057941;23248.883755581115;2332.498512819752;2347.6361164019604;2385.5109702510945;2458.43456005118;2857.8142420742583;13899.305034748222;14026.43894244229;14041.5085472008;14130;14186.290685465685;1914.5979344337566;1943.3295513047976;1949.461726965553;1988.6122206169803;2087.09211493001;54352.45647543514;55146.44853551494;65988.3401165987;79526.20473795246;79979.60010199912;10266.332688375232;10350.275480716278;10763.309172706824;11065.225434219527;11127.610533631285;14365.856341436662;14369.353379097965;14476.493322733864;14478.62453066957;14491.855081449261;7877.251661092187;8002.839943201104;8017.318527925192;8179.5501247430775;8229;8060.31487323584;8065.112837587861;8075.717349892726;8239.917600824036;8308.418410711192;6468.126802881551;6554.8361290968105;6621.205455345389;6707.5975441473665;6792.592444453348;1854.1470923375398;1929.5176205948512;1944.1251436853472;1959.471612142531;1966.2036875065621;933.673214374977;978.7308490165119;1033.7002269341806;1106.7162091973273;1112.2436743014828;18964.90517547431;19093.618127637368;19565.51086222856;19874;20029;962.5668449197889;983.326421401328;1008.9293749437616;1036.3419228789621;1056.7305337139135;10727;11423.885761142283;11460.16637338022;11483.827742583868;11499.885001150049;452007;509950;535339;535821;536739;79647.60176199082;80637.59681201556;81560.18439815525;81576.18423815805;81867.5906620463;980.3333733061587;1033.3644808442905;1042.4631314872847;1082.8538147350164;1099.6261271167841;15892.662540866548;16147.596310092342;16490.34038638441;17539.473815785546;17786.5553361167;38582;39169.2166156681;39529.209415812096;39682.40476392914;40736;56940;59999.10001349896;60648.39351606427;60801.69599152153;60803;7986.720464783704;8144.470609410369;8329.416940814328;8439.493630382196;8469;9204.585793639168;12328.137030407785;13016.47934082664;13356.732865342834;13526.79709804334;11886.405679716152;11973.940130299292;12076.758464830478;12236.877631223573;12272;11727.706807329885;11731.120165987415;12033.45849436795;12129;12198.817017744563;11959.701007474883;12016;12445.75108497843;12476.875231247572;12855.228686278853;8212.384071194565;8299.502029878227;8454.112318206746;8455.239028487465;8604.48373097616;10505.632302869362;12068.39658017078;12308.015358771456;12372.62882113538;12508.87491125077 22:34:03 INFO - PROCESS | 16598 | |3;mootools.html;1313.3498918035573;1452.3682198243762;1490.746573082576;1566.3812793946393;1713.5202143399852;7505.737299194522;7715.459917805756;7731.304182623563;7749.418793590489;7780.416468764851;7564.773056808304;7719.72980945667;7726.0342457192855;7727.995360603114;7744.535327880331;1990.3033938121687;2158.881261530615;2210.546837898235;2216.789405006522;2232.843700940935;2218.8890555472244;2222.799948004679;2229.0860747093693;2231;2236.4856083100817;2159.255057005331;2234.3743751749535;2239.8208143348493;2242.8654280743126;2243.1363924888956;1969.6257711034857;2150.2904041666293;2223.0774228695072;2224.065892325227;2230.174835310929;2123.437289118385;2138.9893050534647;2141.1114387529315;2143.2391501017228;2187.726534183227;7729.806754831118;7748.380129589619;7792.376609871197;7793.844123117563;7803.414743894231;4703.15343238217;4864.537868902448;4876.390451193601;4901.509849015106;4966.130927087781;3204.4071846708434;3242.789218700777;3319.186799234179;3338.0987133473827;3350.162459385154;1043.6660268714015;1072.163712304396;1107.0921844087852;1111.8554587903602;1122.0574717237478;11396.544138234462;11400.258983166068;11446.198766086378;11477.483513241925;11503.712407189803;4314.439122914064;4348.912771807049;4413.249747542925;4440.045390241114;4442.2892337225885;9699.951500242454;9703.563339649732;9716.708498745049;9720.75698107553;9731.318807683536;4512.210363186429;5057.317262169634;5061.240813877947;5062;5080.263361812516;4231.344141657986;4233;4238.321868501025;4622.884427889329;4765.618750499952;3693.1505753676806;3699.463577781207;3727.3849814780256;3759.661630453272;3799.4680744695765;1233.6114124050896;1246.9064820138526;1248.1200753468963;1248.7689777391213;1264.930428826405;873.4671850171391;960.3469640644289;982.2976571751232;984.7390441532999;986.5856340337076;5288.127458969304;5553.08374118266;5605.747741351649;5766.135079737989;5866.208061911588;960.6349587156975;1012.8885822559513;1019.1541020952592;1023.2530252915413;1029.6421195462458;3697.4638677391627;3776.584575696671;3853.190829925747;3983.46223259862;4004.15912658345;9985.850212246822;10400.947995259976;10429.061384475433;10452.790944181073;10468.842967355497;9983.950080249553;10342.482875856178;10374.533146008447;10406.843897341547;10411.271211015308;7500.474966752384;7511.286427789351;7553.886691699519;7598.696052157852;7614.581198034161;5548.0845660467185;5629.915551266652;5632.239647647515;5674.347450043298;5704.572157088318;9013.954930225307;9024.503652299187;9110.088991100836;9115.772105697411;9155.816883662157;9112.77218069527;9251.67619133327;9312.767180820263;9516.666916657883;9552.61789528439;6548.869022619616;6897.862042759217;7043.718251269892;7063.434925206074;7169.641517924188;8127.390445716476;8190.262876341158;8240.587970601326;8262.215089566482;8272.669093236203;6987.5108742389575;7346.5592064476305;7539.396848252017;7634.312911837961;7682.385409167141;6880.139982502187;6898.793036208922;6907.309269073254;6980.860382792417;6990.685419156049;6771.255161932085;6862.519623626498;6881.690323935335;6884.311568843075;6890.689918953559;4741.596964258077;4806.567408933212;4837.637177211653;4843.975780121077;4951.232558953368;4971.279164521196;5036.722980236123;5068.138416469283;5105.948940510696;5177.508136727005 22:34:03 INFO - PROCESS | 16598 | |4;prototype.html;327.5430774070172;330.0017447222153;331.03668325173743;336.122719701579;337.1167541042469;5286.414075777266;5326.8401947941575;5333.359996800389;5342.519173274404;5355.518003379695;5246.7901283948695;5256.395514515832;5270.947290527093;5277.70972596507;5289.867753306169;3663.7435379523445;3920.1571662092715;4009.178118485718;4033.9596604034023;4068.87793366198;4021.4772079629606;4093.263212621727;4114.917701645965;4117.547069822333;4121.299379105544;4054.0878302382025;4083.836646534135;4103.322951712964;4105.958940410587;4126.896827579305;3883.728139030269;3973;4114.835406583733;4116.958830411688;4121.608447197512;3498.195415054526;3513.5959364673135;3581.7313701472235;3596.5504311961004;3613.963860361389;4981.252812078181;5015.849524514234;5031.647784655075;5052.166392545226;5075.5178258065425;4490.281554951225;4672.836450724209;4676.462206846222;4683.039976804746;4686.109639168547;5471.890562188734;5536.806211782608;5542.140968149944;5546.112621980464;5578.219049333096;4016.096378314885;4026.9194616107807;4042.171354872244;4047.311956967293;4048;5265.473452654704;5341.866453338659;5677.971610141964;5724.912266669319;5803.285897025865;3993.6206060424215;4061.6953728470485;4076.8776936691947;4087.8773636790943;4091.85678501251;4109.773962432095;4115.135821477524;4119.0937993641355;4124.566920473367;4135.193637240769;4590.1737687215955;4651.697639653412;4686.109639168547;4686.695364801345;4726;5552.694601796859;5554.583406244547;5562.9443705563235;5564.972175139098;5567.3040869891265;1468.8616322350265;1480.6668499587506;1487.6504021554927;1489.47868246113;1493.4250313629332;1009.4448053570507;1033.2302434686208;1038.5067093130704;1039.4854546999284;1049.7165765243342;5619.426560563049;5623.775048998076;5641.9435805641415;5652.293463317085;5654.547636189095;5971.790987315423;6025.15647809307;6030.638161710312;6038.818835434944;6041.365656606081;5427.9185812212845;5625.353084395347;5642.689652069175;5678.943210567924;5694.5159661428415;3205.0705295464522;3236.158598764291;3236.288016636336;3238.919027024296;3243.870245190213;6027.276726792813;6265.780697675559;6266.404691554295;6275.246970363585;6279.623222606659;6066.484348830399;6120.724567394389;6153.938460615426;6159.969200153971;6172.4136207060255;6099.4815440688035;6189.288231853305;6209.36752000076;6211.9689401552705;6232.376762323732;5814.331351894586;5989.51435154406;6009.128676341818;6014.729337179925;6035.879282414239;5924.6149000314845;5925.377835327401;5927.792527261525;5960.8807823844145;5961.195238642727;5451.236826844166;5631.577631677558;5832.766689332549;5846.94153058464;6200.534959878118;4058.411530328027;4066.512018557792;4072.086119523819;4075.857344992911;4077.1845630874536;5699.629524080921;5702.315722113373;5703.572232082527;5718.199452076629;5729.627574207663;5396.97457483077;5426.213199086189;5519.641223320471;5530.308711411074;5547.278853748987;5453;5457.945420545744;5528.391876893458;5548.501904485847;5559.471850174227;5424.101564452568;5438.972805135949;5469.894090775159;5472.288602481652;5500.80747173847;5306.151015837448;5569.582281328835;5576.637518561281;5588.692621905671;5604;5378.946210537844;5414.214938833768;5437.673739575638;5441.156620723794;5450.482204190595 22:34:03 INFO - PROCESS | 16598 | |5;yui.html;830.7590798668386;844.8053877389325;861.1044513705742;875.4484674654966;876.3821505838384;14477.565673029812;14937.626559336022;14962.625934351647;14965.401383944656;14967.17680527572;13864.653383665389;13875.93062034691;13915.512957046505;13917.930410347959;13959;809.7692157735032;833.5207255827893;864.8097418567905;866.2896424931558;867.2974890338814;851.8594431918757;858.626497473601;862.9395942284043;863.5509535041774;863.6588547523725;887.8357503861774;889.937704360695;891.5765011619494;891.9821603567957;892.1034360467753;885.9246964008067;886.601029536711;886.6364790435922;886.7694399456155;887.1350433327518;646.6411141816291;647.3300134360961;647.7247169952751;648.044134901022;649.0199798304546;14573.125612463286;14602.342894569663;14629.78055329171;14647.194404307866;14711.190884501348;13675.384607692678;13809.654758631013;13845.446182152702;13856.515021974283;13884.166949983033;10935.945320273428;11132.165087618461;11140.944295278472;11164.162687798447;11291.604793832177;3879.4180872869015;3936.626020528045;3960.2277555876617;4036.091879327157;4037.6769858411258;44295.77852110751;47852;52638.73680631573;52678.73660631672;53446.73276633592;10985.340879547253;11018.669439916815;11061.115110791117;11183.888161118284;11214.719632009102;18843.811561884206;18920.52698682544;19070.618587628447;19085.427437176906;19101.426957191306;7336.633168341668;8358.874616880752;8623.827523449496;8697.521636310064;8833.33749968755;4819.2530157824895;4869.732164730974;4926.064047830901;4939.333190019373;4987.600991920638;3375.8480868360984;3469.705075068597;3473.8263086845554;3477.1307173206696;3483.703885169789;613.6502193749609;615.6798464798369;630.4672551693811;631.4285571557748;638.4796390941368;600.9759609615654;676.2865177238061;760.3499008347893;786.0724345272633;790.8655528560158;8927.732168034969;9107.863382049274;9121.954390228006;9141.862872056925;9167.587458564381;664.8504086580577;710.6553321639001;754.5585832288173;775.8991331126917;787.2127872127872;4228.429162063144;4375.409319741794;4434.246178149722;4470.150671372428;4487.977560112178;55900.72049639807;57613.13580296299;58273;58696.706516467995;60525;52839;53123.468765312624;53778.46221537813;54552.45447545474;59710.402895971354;50074.49925500698;50279.245811313594;51167.23249151266;51176;52279.47720522822;9465.479398632866;9572.56923438433;9615.423074615546;9684.51577421112;9693;32976;33711.3257734839;33775;33866.49200262047;34624;42667.78666106649;43221.78389108034;43339.78330108329;43689;44045.11909761851;11417.771644567229;11656.708582285512;11684.88315116872;11700.531978721096;12057;13880.305984700926;13931.651708706959;14059.086159399607;14075.507357242448;14202.928985355007;13185.53850615224;13286.86713132895;13366.532171373956;13470;13488.662783430493;12800.487980480677;13084;13232;13428.19430834153;13670.248136352597;13044.478220871059;13421.731565368442;13965.720685586435;14037.789433158716;14052.297385130907;10741.24811263204;11049.889501104886;11142.27575207609;11184.608538701106;11241.60654377093;10560.891106433714;10997.725056873642;11037.910023709246;11050.226484146033;11053.28153670009 22:34:03 INFO - PROCESS | 16598 | __end_tp_report 22:34:03 INFO - PROCESS | 16598 | __start_cc_report 22:34:03 INFO - PROCESS | 16598 | _x_x_mozilla_cycle_collect,871 22:34:03 INFO - PROCESS | 16598 | __end_cc_report 22:34:03 INFO - PROCESS | 16598 | __startTimestamp1462340043128__endTimestamp 22:34:03 INFO - PROCESS | 16598 | 22:34:03 INFO - PROCESS | 16598 | ------- Summary: start ------- 22:34:03 INFO - PROCESS | 16598 | Number of tests: 6 22:34:03 INFO - PROCESS | 16598 | 22:34:03 INFO - PROCESS | 16598 | [#0] dojo.html Cycles:165 Average:5272.47 Median:5478.51 stddev:585.91 (10.7%) stddev-sans-first:562.55 22:34:03 INFO - PROCESS | 16598 | Values: 3107.3 3127.5 3158.6 3170.9 3188.8 5238.6 5244.4 5276.4 5296.3 5369.8 5324.4 5330.5 5365.8 5417.3 5448.4 4816.3 4851.9 4853.0 4873.8 4961.7 4875.7 4896.0 4939.2 4943.6 4946.0 4811.4 4813.4 4846.3 4877.2 4930.4 4844.2 4860.1 4871.5 4873.7 4925.1 4714.4 4817.5 4847.4 4847.6 4866.5 5153.0 5167.6 5176.3 5184.6 5234.0 5608.2 5636.2 5655.9 5659.0 5663.7 5478.5 5678.4 5686.0 5692.2 5746.7 5373.1 5386.6 5387.0 5392.3 5421.3 5853.5 5859.5 5876.4 5876.8 5878.9 5437.4 5530.9 5582.0 5587.2 5617.4 5681.1 5697.5 5698.0 5700.0 5707.1 5658.2 5660.9 5680.7 5681.5 5685.2 5344.0 5562.3 5619.2 5645.0 5673.0 4278.3 4281.7 4282.4 4296.9 4316.0 3767.1 3854.9 3866.9 3894.7 3907.7 5284.8 5314.6 5320.5 5359.5 5365.9 5649.6 5667.2 5675.7 5675.8 5681.5 5264.0 5290.9 5298.3 5321.9 5365.1 4867.5 4876.2 4883.0 4901.8 4904.6 5770.1 5790.3 5797.0 5804.3 5822.9 5577.6 5619.7 5632.2 5664.1 5691.0 5889.6 5891.2 5894.5 5900.9 5957.1 5611.2 5612.9 5622.8 5623.2 5628.0 5567.4 5596.4 5632.4 5688.1 5702.0 5538.0 5539.6 5546.9 5555.9 5587.7 5470.8 5485.9 5488.5 5498.2 5511.2 5340.0 5413.8 5470.5 5475.9 5536.2 5620.2 5624.9 5625.0 5642.5 5656.6 5528.4 5528.6 5530.5 5532.5 5564.6 22:34:03 INFO - PROCESS | 16598 | 22:34:03 INFO - PROCESS | 16598 | [#1] ext.html Cycles:180 Average:57582.97 Median:38587.81 stddev:107351.01 (278.2%) stddev-sans-first:107566.88 22:34:03 INFO - PROCESS | 16598 | Values: 591.7 639.0 646.8 647.4 664.6 32429.2 37950.2 38527.8 38604.8 38773.0 41084.8 41784.4 41872.6 41917.8 41928.4 7832.9 8211.4 8571.2 8593.4 9938.5 10023.0 10224.3 10234.1 10234.4 10234.9 10149.6 10300.1 10300.9 10302.9 10304.5 7810.3 9855.8 10133.6 10136.4 10160.6 10023.7 10101.9 10162.5 10173.5 10183.9 36715.4 37389.4 37398.3 37457.0 37471.0 3581.6 3656.6 3725.9 4209.3 4339.4 31921.2 31956.0 32296.4 32819.8 33408.0 4214.9 4304.7 4319.5 4342.3 4402.6 314826.0 317836.8 318459.0 318840.0 319937.0 56852.7 57554.0 57796.7 57883.0 57956.4 59973.4 60078.0 60245.4 60520.4 60529.0 16705.5 17370.1 17370.9 17376.7 17381.0 13382.3 13383.8 13471.1 13484.4 13534.6 16200.3 16321.0 16395.8 16429.8 16447.2 5281.4 6470.5 6564.6 6581.0 6588.1 1003.7 1011.9 1065.9 1116.4 1129.4 30153.5 32208.5 33493.3 33569.7 33979.1 1069.9 1093.3 1100.5 1135.1 1135.2 17256.7 17889.9 17909.6 17915.1 17933.7 459295.0 479138.0 480024.0 480437.0 480601.0 59481.4 60165.0 60179.4 60368.0 60406.1 1323.2 1360.8 1370.9 1386.8 1519.7 29422.0 30786.2 31245.7 32034.7 33284.2 50443.2 51174.3 51518.0 51696.5 51713.2 404799.6 410194.0 413921.0 413991.0 414082.0 34514.8 41824.4 42420.6 44514.6 45179.8 48370.3 50082.7 52165.7 52233.2 53489.5 41970.0 42148.0 42817.8 43388.3 43907.3 42674.8 43148.6 43459.3 44151.1 44214.8 44440.3 44518.6 44561.3 45320.7 45618.0 38570.8 39137.4 39210.6 39266.6 40064.4 29251.9 29518.4 29814.0 29995.4 30219.8 22:34:03 INFO - PROCESS | 16598 | 22:34:03 INFO - PROCESS | 16598 | [#2] jquery.html Cycles:180 Average:29048.71 Median:2366.57 stddev:84381.01 (3565.5%) stddev-sans-first:84590.30 22:34:03 INFO - PROCESS | 16598 | Values: 402.2 406.1 408.6 408.7 415.7 13580.0 17473.9 17676.1 18240.5 18306.5 18280.7 18372.4 18390.0 18582.9 18911.8 5416.7 5629.0 5632.6 5639.3 5659.9 4110.6 5588.1 5635.5 5835.6 6166.9 6085.1 6086.1 6134.4 6137.9 6138.7 6151.0 6174.7 6206.5 6209.4 6212.8 5334.4 5401.8 5529.6 5565.5 5565.6 23002.2 23003.4 23009.7 23173.9 23248.9 2332.5 2347.6 2385.5 2458.4 2857.8 13899.3 14026.4 14041.5 14130.0 14186.3 1914.6 1943.3 1949.5 1988.6 2087.1 54352.5 55146.4 65988.3 79526.2 79979.6 10266.3 10350.3 10763.3 11065.2 11127.6 14365.9 14369.4 14476.5 14478.6 14491.9 7877.3 8002.8 8017.3 8179.6 8229.0 8060.3 8065.1 8075.7 8239.9 8308.4 6468.1 6554.8 6621.2 6707.6 6792.6 1854.1 1929.5 1944.1 1959.5 1966.2 933.7 978.7 1033.7 1106.7 1112.2 18964.9 19093.6 19565.5 19874.0 20029.0 962.6 983.3 1008.9 1036.3 1056.7 10727.0 11423.9 11460.2 11483.8 11499.9 452007.0 509950.0 535339.0 535821.0 536739.0 79647.6 80637.6 81560.2 81576.2 81867.6 980.3 1033.4 1042.5 1082.9 1099.6 15892.7 16147.6 16490.3 17539.5 17786.6 38582.0 39169.2 39529.2 39682.4 40736.0 56940.0 59999.1 60648.4 60801.7 60803.0 7986.7 8144.5 8329.4 8439.5 8469.0 9204.6 12328.1 13016.5 13356.7 13526.8 11886.4 11973.9 12076.8 12236.9 12272.0 11727.7 11731.1 12033.5 12129.0 12198.8 11959.7 12016.0 12445.8 12476.9 12855.2 8212.4 8299.5 8454.1 8455.2 8604.5 10505.6 12068.4 12308.0 12372.6 12508.9 22:34:03 INFO - PROCESS | 16598 | 22:34:03 INFO - PROCESS | 16598 | [#3] mootools.html Cycles:180 Average:5410.26 Median:4926.37 stddev:3023.86 (61.4%) stddev-sans-first:3016.66 22:34:03 INFO - PROCESS | 16598 | Values: 1313.3 1452.4 1490.7 1566.4 1713.5 7505.7 7715.5 7731.3 7749.4 7780.4 7564.8 7719.7 7726.0 7728.0 7744.5 1990.3 2158.9 2210.5 2216.8 2232.8 2218.9 2222.8 2229.1 2231.0 2236.5 2159.3 2234.4 2239.8 2242.9 2243.1 1969.6 2150.3 2223.1 2224.1 2230.2 2123.4 2139.0 2141.1 2143.2 2187.7 7729.8 7748.4 7792.4 7793.8 7803.4 4703.2 4864.5 4876.4 4901.5 4966.1 3204.4 3242.8 3319.2 3338.1 3350.2 1043.7 1072.2 1107.1 1111.9 1122.1 11396.5 11400.3 11446.2 11477.5 11503.7 4314.4 4348.9 4413.2 4440.0 4442.3 9700.0 9703.6 9716.7 9720.8 9731.3 4512.2 5057.3 5061.2 5062.0 5080.3 4231.3 4233.0 4238.3 4622.9 4765.6 3693.2 3699.5 3727.4 3759.7 3799.5 1233.6 1246.9 1248.1 1248.8 1264.9 873.5 960.3 982.3 984.7 986.6 5288.1 5553.1 5605.7 5766.1 5866.2 960.6 1012.9 1019.2 1023.3 1029.6 3697.5 3776.6 3853.2 3983.5 4004.2 9985.9 10400.9 10429.1 10452.8 10468.8 9984.0 10342.5 10374.5 10406.8 10411.3 7500.5 7511.3 7553.9 7598.7 7614.6 5548.1 5629.9 5632.2 5674.3 5704.6 9014.0 9024.5 9110.1 9115.8 9155.8 9112.8 9251.7 9312.8 9516.7 9552.6 6548.9 6897.9 7043.7 7063.4 7169.6 8127.4 8190.3 8240.6 8262.2 8272.7 6987.5 7346.6 7539.4 7634.3 7682.4 6880.1 6898.8 6907.3 6980.9 6990.7 6771.3 6862.5 6881.7 6884.3 6890.7 4741.6 4806.6 4837.6 4844.0 4951.2 4971.3 5036.7 5068.1 5105.9 5177.5 22:34:03 INFO - PROCESS | 16598 | 22:34:03 INFO - PROCESS | 16598 | [#4] prototype.html Cycles:180 Average:4731.75 Median:5342.19 stddev:1411.36 (26.4%) stddev-sans-first:1376.06 22:34:03 INFO - PROCESS | 16598 | Values: 327.5 330.0 331.0 336.1 337.1 5286.4 5326.8 5333.4 5342.5 5355.5 5246.8 5256.4 5270.9 5277.7 5289.9 3663.7 3920.2 4009.2 4034.0 4068.9 4021.5 4093.3 4114.9 4117.5 4121.3 4054.1 4083.8 4103.3 4106.0 4126.9 3883.7 3973.0 4114.8 4117.0 4121.6 3498.2 3513.6 3581.7 3596.6 3614.0 4981.3 5015.8 5031.6 5052.2 5075.5 4490.3 4672.8 4676.5 4683.0 4686.1 5471.9 5536.8 5542.1 5546.1 5578.2 4016.1 4026.9 4042.2 4047.3 4048.0 5265.5 5341.9 5678.0 5724.9 5803.3 3993.6 4061.7 4076.9 4087.9 4091.9 4109.8 4115.1 4119.1 4124.6 4135.2 4590.2 4651.7 4686.1 4686.7 4726.0 5552.7 5554.6 5562.9 5565.0 5567.3 1468.9 1480.7 1487.7 1489.5 1493.4 1009.4 1033.2 1038.5 1039.5 1049.7 5619.4 5623.8 5641.9 5652.3 5654.5 5971.8 6025.2 6030.6 6038.8 6041.4 5427.9 5625.4 5642.7 5678.9 5694.5 3205.1 3236.2 3236.3 3238.9 3243.9 6027.3 6265.8 6266.4 6275.2 6279.6 6066.5 6120.7 6153.9 6160.0 6172.4 6099.5 6189.3 6209.4 6212.0 6232.4 5814.3 5989.5 6009.1 6014.7 6035.9 5924.6 5925.4 5927.8 5960.9 5961.2 5451.2 5631.6 5832.8 5846.9 6200.5 4058.4 4066.5 4072.1 4075.9 4077.2 5699.6 5702.3 5703.6 5718.2 5729.6 5397.0 5426.2 5519.6 5530.3 5547.3 5453.0 5457.9 5528.4 5548.5 5559.5 5424.1 5439.0 5469.9 5472.3 5500.8 5306.2 5569.6 5576.6 5588.7 5604.0 5378.9 5414.2 5437.7 5441.2 5450.5 22:34:03 INFO - PROCESS | 16598 | 22:34:03 INFO - PROCESS | 16598 | [#5] yui.html Cycles:180 Average:14687.31 Median:24210.26 stddev:16425.17 (67.8%) stddev-sans-first:16438.29 22:34:03 INFO - PROCESS | 16598 | Values: 830.8 844.8 861.1 875.4 876.4 14477.6 14937.6 14962.6 14965.4 14967.2 13864.7 13875.9 13915.5 13917.9 13959.0 809.8 833.5 864.8 866.3 867.3 851.9 858.6 862.9 863.6 863.7 887.8 889.9 891.6 892.0 892.1 885.9 886.6 886.6 886.8 887.1 646.6 647.3 647.7 648.0 649.0 14573.1 14602.3 14629.8 14647.2 14711.2 13675.4 13809.7 13845.4 13856.5 13884.2 10935.9 11132.2 11140.9 11164.2 11291.6 3879.4 3936.6 3960.2 4036.1 4037.7 44295.8 47852.0 52638.7 52678.7 53446.7 10985.3 11018.7 11061.1 11183.9 11214.7 18843.8 18920.5 19070.6 19085.4 19101.4 7336.6 8358.9 8623.8 8697.5 8833.3 4819.3 4869.7 4926.1 4939.3 4987.6 3375.8 3469.7 3473.8 3477.1 3483.7 613.7 615.7 630.5 631.4 638.5 601.0 676.3 760.3 786.1 790.9 8927.7 9107.9 9122.0 9141.9 9167.6 664.9 710.7 754.6 775.9 787.2 4228.4 4375.4 4434.2 4470.2 4488.0 55900.7 57613.1 58273.0 58696.7 60525.0 52839.0 53123.5 53778.5 54552.5 59710.4 50074.5 50279.2 51167.2 51176.0 52279.5 9465.5 9572.6 9615.4 9684.5 9693.0 32976.0 33711.3 33775.0 33866.5 34624.0 42667.8 43221.8 43339.8 43689.0 44045.1 11417.8 11656.7 11684.9 11700.5 12057.0 13880.3 13931.7 14059.1 14075.5 14202.9 13185.5 13286.9 13366.5 13470.0 13488.7 12800.5 13084.0 13232.0 13428.2 13670.2 13044.5 13421.7 13965.7 14037.8 14052.3 10741.2 11049.9 11142.3 11184.6 11241.6 10560.9 10997.7 11037.9 11050.2 11053.3 22:34:03 INFO - PROCESS | 16598 | -------- Summary: end -------- 22:34:03 INFO - PROCESS | 16598 | 22:34:03 INFO - TEST-INFO | 16598: exit 0 22:34:03 INFO - TEST-OK | dromaeo_css | took 1112594ms 22:34:03 INFO - TEST-START | kraken 22:34:03 INFO - operating with platform_type : linux_ 22:34:03 INFO - Initialising browser for kraken test... 22:34:03 INFO - TEST-INFO | started process 16785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ8OCVC/profile http://localhost:51224/getInfo.html) 22:34:08 INFO - PROCESS | 16785 | __metrics Screen width/height:1600/1200 22:34:08 INFO - PROCESS | 16785 | colorDepth:24 22:34:08 INFO - PROCESS | 16785 | Browser inner width/height: 1024/697 22:34:08 INFO - PROCESS | 16785 | __metrics 22:34:09 ERROR - PROCESS | 16785 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:34:09 INFO - TEST-INFO | 16785: exit 0 22:34:09 INFO - Browser initialized. 22:34:09 INFO - Running cycle 1/1 for kraken test... 22:34:10 INFO - TEST-INFO | started process 16866 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ8OCVC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:34:21 INFO - PROCESS | 16866 | RSS: Main: 154497024 22:34:21 INFO - PROCESS | 16866 | 22:34:24 INFO - PROCESS | 16866 | Cycle 1(1): loaded http://localhost:51224/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51224/tests/kraken/driver.html?testName=audio-beat-detection) 22:34:25 INFO - PROCESS | 16866 | RSS: Main: 208826368 22:34:25 INFO - PROCESS | 16866 | 22:34:27 INFO - PROCESS | 16866 | Cycle 1(1): loaded http://localhost:51224/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51224/tests/kraken/driver.html?testName=audio-dft) 22:34:28 INFO - PROCESS | 16866 | RSS: Main: 196001792 22:34:28 INFO - PROCESS | 16866 | 22:34:31 INFO - PROCESS | 16866 | Cycle 1(1): loaded http://localhost:51224/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51224/tests/kraken/driver.html?testName=audio-fft) 22:34:31 INFO - PROCESS | 16866 | RSS: Main: 264790016 22:34:31 INFO - PROCESS | 16866 | 22:34:33 INFO - PROCESS | 16866 | Cycle 1(1): loaded http://localhost:51224/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51224/tests/kraken/driver.html?testName=audio-oscillator) 22:34:34 INFO - PROCESS | 16866 | RSS: Main: 173989888 22:34:34 INFO - PROCESS | 16866 | 22:34:36 INFO - PROCESS | 16866 | Cycle 1(1): loaded http://localhost:51224/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51224/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:34:37 INFO - PROCESS | 16866 | RSS: Main: 177704960 22:34:37 INFO - PROCESS | 16866 | 22:34:40 INFO - PROCESS | 16866 | Cycle 1(1): loaded http://localhost:51224/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51224/tests/kraken/driver.html?testName=imaging-darkroom) 22:34:40 INFO - PROCESS | 16866 | RSS: Main: 214188032 22:34:40 INFO - PROCESS | 16866 | 22:34:44 INFO - PROCESS | 16866 | Cycle 1(1): loaded http://localhost:51224/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51224/tests/kraken/driver.html?testName=imaging-desaturate) 22:34:44 INFO - PROCESS | 16866 | RSS: Main: 214540288 22:34:44 INFO - PROCESS | 16866 | 22:34:47 INFO - PROCESS | 16866 | Cycle 1(1): loaded http://localhost:51224/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51224/tests/kraken/driver.html?testName=json-parse-financial) 22:34:48 INFO - PROCESS | 16866 | RSS: Main: 214683648 22:34:48 INFO - PROCESS | 16866 | 22:34:49 INFO - PROCESS | 16866 | Cycle 1(1): loaded http://localhost:51224/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51224/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:34:50 INFO - PROCESS | 16866 | RSS: Main: 200978432 22:34:50 INFO - PROCESS | 16866 | 22:34:52 INFO - PROCESS | 16866 | Cycle 1(1): loaded http://localhost:51224/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51224/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:34:52 INFO - PROCESS | 16866 | RSS: Main: 200851456 22:34:52 INFO - PROCESS | 16866 | 22:34:54 INFO - PROCESS | 16866 | Cycle 1(1): loaded http://localhost:51224/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51224/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:34:55 INFO - PROCESS | 16866 | RSS: Main: 213970944 22:34:55 INFO - PROCESS | 16866 | 22:34:57 INFO - PROCESS | 16866 | Cycle 1(1): loaded http://localhost:51224/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51224/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:34:58 INFO - PROCESS | 16866 | RSS: Main: 222973952 22:34:58 INFO - PROCESS | 16866 | 22:35:01 INFO - PROCESS | 16866 | Cycle 1(1): loaded http://localhost:51224/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51224/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:35:01 INFO - PROCESS | 16866 | RSS: Main: 220028928 22:35:01 INFO - PROCESS | 16866 | 22:35:03 INFO - PROCESS | 16866 | Cycle 1(1): loaded http://localhost:51224/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51224/tests/kraken/driver.html?testName=ai-astar) 22:35:03 INFO - PROCESS | 16866 | RSS: Main: 284119040 22:35:03 INFO - PROCESS | 16866 | 22:35:03 INFO - PROCESS | 16866 | __start_tp_report 22:35:03 INFO - PROCESS | 16866 | _x_x_mozilla_page_load 22:35:03 INFO - PROCESS | 16866 | _x_x_mozilla_page_load_details 22:35:03 INFO - PROCESS | 16866 | |i|pagename|runs| 22:35:03 INFO - PROCESS | 16866 | |0;ai-astar;111;113;107;111;113;112;101;111;111;112 22:35:03 INFO - PROCESS | 16866 | |1;audio-beat-detection;151;127;153;185;136;158;161;127;184;133 22:35:03 INFO - PROCESS | 16866 | |2;audio-dft;159;160;161;160;159;159;159;163;163;162 22:35:03 INFO - PROCESS | 16866 | |3;audio-fft;72;77;106;106;76;76;76;131;111;72 22:35:03 INFO - PROCESS | 16866 | |4;audio-oscillator;93;93;160;93;92;92;154;92;91;146 22:35:03 INFO - PROCESS | 16866 | |5;imaging-gaussian-blur;117;117;117;118;118;118;117;118;119;117 22:35:03 INFO - PROCESS | 16866 | |6;imaging-darkroom;146;145;145;146;146;145;146;145;145;145 22:35:03 INFO - PROCESS | 16866 | |7;imaging-desaturate;95;96;94;95;95;95;95;94;94;94 22:35:03 INFO - PROCESS | 16866 | |8;json-parse-financial;56;56;57;55;56;58;56;84;55;54 22:35:03 INFO - PROCESS | 16866 | |9;json-stringify-tinderbox;58;57;57;58;59;58;59;58;58;58 22:35:03 INFO - PROCESS | 16866 | |10;stanford-crypto-aes;84;76;76;77;76;77;93;78;79;77 22:35:03 INFO - PROCESS | 16866 | |11;stanford-crypto-ccm;123;134;127;139;119;123;129;126;154;129 22:35:03 INFO - PROCESS | 16866 | |12;stanford-crypto-pbkdf2;175;177;177;169;174;173;172;170;176;172 22:35:03 INFO - PROCESS | 16866 | |13;stanford-crypto-sha256-iterative;69;69;67;68;67;69;69;67;69;68 22:35:03 INFO - PROCESS | 16866 | __end_tp_report 22:35:03 INFO - PROCESS | 16866 | __start_cc_report 22:35:03 INFO - PROCESS | 16866 | _x_x_mozilla_cycle_collect,1621 22:35:03 INFO - PROCESS | 16866 | __end_cc_report 22:35:03 INFO - PROCESS | 16866 | __startTimestamp1462340103953__endTimestamp 22:35:03 INFO - PROCESS | 16866 | 22:35:03 INFO - PROCESS | 16866 | ------- Summary: start ------- 22:35:03 INFO - PROCESS | 16866 | Number of tests: 14 22:35:03 INFO - PROCESS | 16866 | 22:35:03 INFO - PROCESS | 16866 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.50 stddev:3.65 (3.3%) stddev-sans-first:3.86 22:35:03 INFO - PROCESS | 16866 | Values: 111.0 113.0 107.0 111.0 113.0 112.0 101.0 111.0 111.0 112.0 22:35:03 INFO - PROCESS | 16866 | 22:35:03 INFO - PROCESS | 16866 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:155.50 stddev:21.33 (13.7%) stddev-sans-first:22.63 22:35:03 INFO - PROCESS | 16866 | Values: 151.0 127.0 153.0 185.0 136.0 158.0 161.0 127.0 184.0 133.0 22:35:03 INFO - PROCESS | 16866 | 22:35:03 INFO - PROCESS | 16866 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:1.65 (1.0%) stddev-sans-first:1.66 22:35:03 INFO - PROCESS | 16866 | Values: 159.0 160.0 161.0 160.0 159.0 159.0 159.0 163.0 163.0 162.0 22:35:03 INFO - PROCESS | 16866 | 22:35:03 INFO - PROCESS | 16866 | [#3] audio-fft Cycles:10 Average:90.30 Median:74.00 stddev:21.18 (28.6%) stddev-sans-first:21.41 22:35:03 INFO - PROCESS | 16866 | Values: 72.0 77.0 106.0 106.0 76.0 76.0 76.0 131.0 111.0 72.0 22:35:03 INFO - PROCESS | 16866 | 22:35:03 INFO - PROCESS | 16866 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:92.00 stddev:29.68 (32.3%) stddev-sans-first:30.79 22:35:03 INFO - PROCESS | 16866 | Values: 93.0 93.0 160.0 93.0 92.0 92.0 154.0 92.0 91.0 146.0 22:35:03 INFO - PROCESS | 16866 | 22:35:03 INFO - PROCESS | 16866 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 22:35:03 INFO - PROCESS | 16866 | Values: 117.0 117.0 117.0 118.0 118.0 118.0 117.0 118.0 119.0 117.0 22:35:03 INFO - PROCESS | 16866 | 22:35:03 INFO - PROCESS | 16866 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 22:35:03 INFO - PROCESS | 16866 | Values: 146.0 145.0 145.0 146.0 146.0 145.0 146.0 145.0 145.0 145.0 22:35:03 INFO - PROCESS | 16866 | 22:35:03 INFO - PROCESS | 16866 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 22:35:03 INFO - PROCESS | 16866 | Values: 95.0 96.0 94.0 95.0 95.0 95.0 95.0 94.0 94.0 94.0 22:35:03 INFO - PROCESS | 16866 | 22:35:03 INFO - PROCESS | 16866 | [#8] json-parse-financial Cycles:10 Average:58.70 Median:56.00 stddev:8.96 (16.0%) stddev-sans-first:9.45 22:35:03 INFO - PROCESS | 16866 | Values: 56.0 56.0 57.0 55.0 56.0 58.0 56.0 84.0 55.0 54.0 22:35:03 INFO - PROCESS | 16866 | 22:35:03 INFO - PROCESS | 16866 | [#9] json-stringify-tinderbox Cycles:10 Average:58.00 Median:58.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 22:35:03 INFO - PROCESS | 16866 | Values: 58.0 57.0 57.0 58.0 59.0 58.0 59.0 58.0 58.0 58.0 22:35:03 INFO - PROCESS | 16866 | 22:35:03 INFO - PROCESS | 16866 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:77.50 stddev:5.38 (6.9%) stddev-sans-first:5.43 22:35:03 INFO - PROCESS | 16866 | Values: 84.0 76.0 76.0 77.0 76.0 77.0 93.0 78.0 79.0 77.0 22:35:03 INFO - PROCESS | 16866 | 22:35:03 INFO - PROCESS | 16866 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:129.00 stddev:10.10 (7.8%) stddev-sans-first:10.36 22:35:03 INFO - PROCESS | 16866 | Values: 123.0 134.0 127.0 139.0 119.0 123.0 129.0 126.0 154.0 129.0 22:35:03 INFO - PROCESS | 16866 | 22:35:03 INFO - PROCESS | 16866 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:174.50 stddev:2.80 (1.6%) stddev-sans-first:2.92 22:35:03 INFO - PROCESS | 16866 | Values: 175.0 177.0 177.0 169.0 174.0 173.0 172.0 170.0 176.0 172.0 22:35:03 INFO - PROCESS | 16866 | 22:35:03 INFO - PROCESS | 16866 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:69.00 stddev:0.92 (1.3%) stddev-sans-first:0.93 22:35:03 INFO - PROCESS | 16866 | Values: 69.0 69.0 67.0 68.0 67.0 69.0 69.0 67.0 69.0 68.0 22:35:03 INFO - PROCESS | 16866 | -------- Summary: end -------- 22:35:03 INFO - PROCESS | 16866 | 22:35:04 INFO - TEST-INFO | 16866: exit 0 22:35:04 INFO - TEST-OK | kraken | took 61077ms 22:35:04 INFO - SUITE-END | took 1173s 22:35:05 INFO - Completed test suite (00:19:33) 22:35:05 INFO - javascript benchmark 22:35:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3107.3474570340227, 3127.4683303838347, 3158.5578019077334, 3170.9207269818253, 3188.824614646195, 5238.580913526918, 5244.423113457521, 5276.419593844674, 5296.3114795076635, 5369.838904832861, 5324.414314425419, 5330.493603107699, 5365.7585408656605, 5417.349918009844, 5448.37343705474, 4816.349792777965, 4851.927221091686, 4852.951470485285, 4873.780679869415, 4961.652684312099, 4875.658703890729, 4895.996320754237, 4939.160342741725, 4943.555080042795, 4945.950540494585, 4811.350467686852, 4813.446453657839, 4846.3457433246585, 4877.219644856806, 4930.359053323081, 4844.176489996709, 4860.125177468054, 4871.512848715136, 4873.658843880929, 4925.13810083234, 4714.4106986626675, 4817.470078291385, 4847.394075740533, 4847.612191024745, 4866.46468888422, 5153.020926024081, 5167.560757335594, 5176.301199338116, 5184.585233181374, 5233.973830130825, 5608.214849920973, 5636.239107720447, 5655.886882262373, 5659.0, 5663.7168141593165, 5478.506934375925, 5678.375378708339, 5686.0, 5692.231548740909, 5746.712664366765, 5373.059714549938, 5386.596005299579, 5387.030334539742, 5392.325959255132, 5421.349438067417, 5853.473187413153, 5859.472647461749, 5876.44173803488, 5876.823695289148, 5878.882422351529, 5437.374701909331, 5530.889382212414, 5581.972090139523, 5587.161925711176, 5617.38208797032, 5681.119426488901, 5697.4587414195585, 5697.971510142505, 5700.0, 5707.143928410772, 5658.236138121301, 5660.915086273709, 5680.6591604503865, 5681.488666020078, 5685.204071430003, 5344.038073146871, 5562.276904002454, 5619.241402410704, 5645.0, 5672.971635141798, 4278.315469524861, 4281.721688090264, 4282.379055037064, 4296.93554596675, 4316.0, 3767.095896984704, 3854.903627409281, 3866.941995870064, 3894.6689531389584, 3907.706921980806, 5284.815031473957, 5314.574834013347, 5320.547753440924, 5359.544438722674, 5365.865853353619, 5649.6327738696855, 5667.1782591524, 5675.687837168913, 5675.829725108253, 5681.488666020078, 5263.973680131575, 5290.894182116336, 5298.311219541512, 5321.866953326198, 5365.061114304981, 4867.513248675175, 4876.195427754381, 4882.951170488321, 4901.828436004794, 4904.60763138948, 5770.105633626795, 5790.334111577138, 5796.971015144897, 5804.2744656917885, 5822.941770582324, 5577.581681373832, 5619.747111380079, 5632.239647647515, 5664.122061080539, 5691.032524470767, 5889.617174883619, 5891.1752354671235, 5894.528437724886, 5900.881982360243, 5957.076653118774, 5611.242482264842, 5612.85967850807, 5622.8313150605545, 5623.1846382273525, 5628.0432326505415, 5567.387587365306, 5596.384397716167, 5632.436756324335, 5688.061469857427, 5702.0, 5538.0, 5539.556835453073, 5546.889062218814, 5555.916661250165, 5587.664740115606, 5470.781168753365, 5485.890282194414, 5488.5334746545395, 5498.1752737089755, 5511.22842802016, 5340.038793017294, 5413.783448662167, 5470.480304371078, 5475.945240547703, 5536.197251398606, 5620.213170156263, 5624.8875022498505, 5625.043742563856, 5642.548596112383, 5656.60403771732, 5528.391876893619, 5528.640638358494, 5530.529904957963, 5532.474414930736, 5564.554835613222], "value": 5233.972204054884, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.6627522312281, 638.9648569328687, 646.7703965092392, 647.423792824386, 664.5879554676098, 32429.189270268227, 37950.24099518012, 38527.84416467507, 38604.80697596508, 38773.03067423316, 41084.79457602708, 41784.37323440151, 41872.58127418725, 41917.79041104798, 41928.37107443391, 7832.921670783305, 8211.425200236, 8571.185737354972, 8593.398462107654, 9938.453385063818, 10023.04781045803, 10224.335418197794, 10234.130098941561, 10234.385936843813, 10234.948825255864, 10149.594016239342, 10300.12448941841, 10300.948495257513, 10302.896971030268, 10304.484775761219, 7810.258025487569, 9855.753606159831, 10133.59465621378, 10136.442495662735, 10160.644377446828, 10023.749406264902, 10101.949490252575, 10162.542685579167, 10173.491325433699, 10183.949080254626, 36715.449268261, 37389.43915841264, 37398.25203495915, 37457.0, 37471.0, 3581.606023337431, 3656.6160553142067, 3725.869594564177, 4209.284421648327, 4339.435873336446, 31921.201969950704, 31956.0, 32296.354072918646, 32819.83590082058, 33408.0, 4214.873553793361, 4304.677149213821, 4319.460067491564, 4342.32693932441, 4402.5597440255715, 314826.0, 317836.82163178304, 318459.0, 318840.0, 319936.9999999977, 56852.71573642105, 57554.0, 57796.71101644465, 57883.0, 57956.420435795946, 59973.40026599678, 60078.0, 60245.397546024855, 60520.39479605236, 60528.973551322255, 16705.498835034967, 17370.131493425277, 17370.91314543419, 17376.652466950844, 17381.0, 13382.263975481443, 13383.799243011363, 13471.12437691547, 13484.39320230592, 13534.59396218115, 16200.270987805578, 16320.9806185856, 16395.836041639668, 16429.83570164283, 16447.177641117898, 5281.366236051698, 6470.450011749054, 6564.573302735403, 6580.967095164494, 6588.143541339691, 1003.7039073473343, 1011.9494025298706, 1065.8507808906759, 1116.3636727065496, 1129.3619105205696, 30153.547696784564, 32208.516872246935, 33493.3301333972, 33569.664303357145, 33979.07303440987, 1069.8546273954548, 1093.3002878157986, 1100.5432745410726, 1135.0692432205512, 1135.233717240859, 17256.74114888278, 17889.910550447163, 17909.552261193312, 17915.10424478797, 17933.7309940351, 459295.0, 479138.0, 480024.0, 480437.0, 480601.0, 59481.40518594845, 60165.0, 60179.39820601825, 60368.0, 60406.09390859141, 1323.2391374959436, 1360.7617068467448, 1370.8971827113007, 1386.778115501515, 1519.6504803895166, 29422.0, 30786.21099260048, 31245.687543124277, 32034.67965320317, 33284.1678958028, 50443.243351349025, 51174.34733484623, 51518.0, 51696.48303516916, 51713.22430163476, 404799.6160307109, 410194.0, 413921.0, 413991.0, 414082.0, 34514.82742586271, 41824.37263441112, 42420.5757942429, 44514.55485445233, 45179.77410112928, 48370.274445882635, 50082.74958625183, 52165.7391713039, 52233.21650175326, 53489.46510534845, 41970.0, 42148.0, 42817.78591107025, 43388.34917476177, 43907.34138987982, 42674.78662606667, 43148.56851431571, 43459.34810977901, 44151.11697766091, 44214.778926105166, 44440.33339499975, 44518.55481445144, 44561.331580025675, 45320.69453401922, 45618.0, 38570.80714596409, 39137.41293880537, 39210.607893921835, 39266.60733392744, 40064.3990340151, 29251.85374073116, 29518.409631807674, 29814.0, 29995.400091997602, 30219.848900755354], "value": 20536.007132263014, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.1755401427074, 406.10453949042363, 408.5607971430713, 408.711858140011, 415.6905746897273, 13579.963005549173, 17473.912630436847, 17676.116194190305, 18240.452786416412, 18306.450806475812, 18280.725789113174, 18372.44882653519, 18390.0, 18582.907085464554, 18911.81088189121, 5416.674999500043, 5629.0, 5632.605717599769, 5639.323281206261, 5659.886802263953, 4110.588941105895, 5588.105903055512, 5635.492805647491, 5835.562332825034, 6166.876662466748, 6085.087236914476, 6086.087086936951, 6134.4478996890275, 6137.9386206137815, 6138.7237574309265, 6151.0, 6174.660393678346, 6206.534509911729, 6209.3790620938, 6212.844678883019, 5334.359876814807, 5401.756920938567, 5529.612927095105, 5565.526930210937, 5565.5825813063775, 23002.194923177776, 23003.42491437711, 23009.654855177185, 23173.88413057941, 23248.883755581115, 2332.498512819752, 2347.6361164019604, 2385.5109702510945, 2458.43456005118, 2857.8142420742583, 13899.305034748222, 14026.43894244229, 14041.5085472008, 14130.0, 14186.290685465685, 1914.5979344337566, 1943.3295513047976, 1949.461726965553, 1988.6122206169803, 2087.09211493001, 54352.45647543514, 55146.44853551494, 65988.3401165987, 79526.20473795246, 79979.60010199912, 10266.332688375232, 10350.275480716278, 10763.309172706824, 11065.225434219527, 11127.610533631285, 14365.856341436662, 14369.353379097965, 14476.493322733864, 14478.62453066957, 14491.855081449261, 7877.251661092187, 8002.839943201104, 8017.318527925192, 8179.5501247430775, 8229.0, 8060.31487323584, 8065.112837587861, 8075.717349892726, 8239.917600824036, 8308.418410711192, 6468.126802881551, 6554.8361290968105, 6621.205455345389, 6707.5975441473665, 6792.592444453348, 1854.1470923375398, 1929.5176205948512, 1944.1251436853472, 1959.471612142531, 1966.2036875065621, 933.673214374977, 978.7308490165119, 1033.7002269341806, 1106.7162091973273, 1112.2436743014828, 18964.90517547431, 19093.618127637368, 19565.51086222856, 19874.0, 20029.0, 962.5668449197889, 983.326421401328, 1008.9293749437616, 1036.3419228789621, 1056.7305337139135, 10727.0, 11423.885761142283, 11460.16637338022, 11483.827742583868, 11499.885001150049, 452007.0, 509950.0, 535339.0, 535821.0, 536739.0, 79647.60176199082, 80637.59681201556, 81560.18439815525, 81576.18423815805, 81867.5906620463, 980.3333733061587, 1033.3644808442905, 1042.4631314872847, 1082.8538147350164, 1099.6261271167841, 15892.662540866548, 16147.596310092342, 16490.34038638441, 17539.473815785546, 17786.5553361167, 38582.0, 39169.2166156681, 39529.209415812096, 39682.40476392914, 40736.0, 56940.0, 59999.10001349896, 60648.39351606427, 60801.69599152153, 60803.0, 7986.720464783704, 8144.470609410369, 8329.416940814328, 8439.493630382196, 8469.0, 9204.585793639168, 12328.137030407785, 13016.47934082664, 13356.732865342834, 13526.79709804334, 11886.405679716152, 11973.940130299292, 12076.758464830478, 12236.877631223573, 12272.0, 11727.706807329885, 11731.120165987415, 12033.45849436795, 12129.0, 12198.817017744563, 11959.701007474883, 12016.0, 12445.75108497843, 12476.875231247572, 12855.228686278853, 8212.384071194565, 8299.502029878227, 8454.112318206746, 8455.239028487465, 8604.48373097616, 10505.632302869362, 12068.39658017078, 12308.015358771456, 12372.62882113538, 12508.87491125077], "value": 9331.478119542646, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.3498918035573, 1452.3682198243762, 1490.746573082576, 1566.3812793946393, 1713.5202143399852, 7505.737299194522, 7715.459917805756, 7731.304182623563, 7749.418793590489, 7780.416468764851, 7564.773056808304, 7719.72980945667, 7726.0342457192855, 7727.995360603114, 7744.535327880331, 1990.3033938121687, 2158.881261530615, 2210.546837898235, 2216.789405006522, 2232.843700940935, 2218.8890555472244, 2222.799948004679, 2229.0860747093693, 2231.0, 2236.4856083100817, 2159.255057005331, 2234.3743751749535, 2239.8208143348493, 2242.8654280743126, 2243.1363924888956, 1969.6257711034857, 2150.2904041666293, 2223.0774228695072, 2224.065892325227, 2230.174835310929, 2123.437289118385, 2138.9893050534647, 2141.1114387529315, 2143.2391501017228, 2187.726534183227, 7729.806754831118, 7748.380129589619, 7792.376609871197, 7793.844123117563, 7803.414743894231, 4703.15343238217, 4864.537868902448, 4876.390451193601, 4901.509849015106, 4966.130927087781, 3204.4071846708434, 3242.789218700777, 3319.186799234179, 3338.0987133473827, 3350.162459385154, 1043.6660268714015, 1072.163712304396, 1107.0921844087852, 1111.8554587903602, 1122.0574717237478, 11396.544138234462, 11400.258983166068, 11446.198766086378, 11477.483513241925, 11503.712407189803, 4314.439122914064, 4348.912771807049, 4413.249747542925, 4440.045390241114, 4442.2892337225885, 9699.951500242454, 9703.563339649732, 9716.708498745049, 9720.75698107553, 9731.318807683536, 4512.210363186429, 5057.317262169634, 5061.240813877947, 5062.0, 5080.263361812516, 4231.344141657986, 4233.0, 4238.321868501025, 4622.884427889329, 4765.618750499952, 3693.1505753676806, 3699.463577781207, 3727.3849814780256, 3759.661630453272, 3799.4680744695765, 1233.6114124050896, 1246.9064820138526, 1248.1200753468963, 1248.7689777391213, 1264.930428826405, 873.4671850171391, 960.3469640644289, 982.2976571751232, 984.7390441532999, 986.5856340337076, 5288.127458969304, 5553.08374118266, 5605.747741351649, 5766.135079737989, 5866.208061911588, 960.6349587156975, 1012.8885822559513, 1019.1541020952592, 1023.2530252915413, 1029.6421195462458, 3697.4638677391627, 3776.584575696671, 3853.190829925747, 3983.46223259862, 4004.15912658345, 9985.850212246822, 10400.947995259976, 10429.061384475433, 10452.790944181073, 10468.842967355497, 9983.950080249553, 10342.482875856178, 10374.533146008447, 10406.843897341547, 10411.271211015308, 7500.474966752384, 7511.286427789351, 7553.886691699519, 7598.696052157852, 7614.581198034161, 5548.0845660467185, 5629.915551266652, 5632.239647647515, 5674.347450043298, 5704.572157088318, 9013.954930225307, 9024.503652299187, 9110.088991100836, 9115.772105697411, 9155.816883662157, 9112.77218069527, 9251.67619133327, 9312.767180820263, 9516.666916657883, 9552.61789528439, 6548.869022619616, 6897.862042759217, 7043.718251269892, 7063.434925206074, 7169.641517924188, 8127.390445716476, 8190.262876341158, 8240.587970601326, 8262.215089566482, 8272.669093236203, 6987.5108742389575, 7346.5592064476305, 7539.396848252017, 7634.312911837961, 7682.385409167141, 6880.139982502187, 6898.793036208922, 6907.309269073254, 6980.860382792417, 6990.685419156049, 6771.255161932085, 6862.519623626498, 6881.690323935335, 6884.311568843075, 6890.689918953559, 4741.596964258077, 4806.567408933212, 4837.637177211653, 4843.975780121077, 4951.232558953368, 4971.279164521196, 5036.722980236123, 5068.138416469283, 5105.948940510696, 5177.508136727005], "value": 4376.531485248076, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.5430774070172, 330.0017447222153, 331.03668325173743, 336.122719701579, 337.1167541042469, 5286.414075777266, 5326.8401947941575, 5333.359996800389, 5342.519173274404, 5355.518003379695, 5246.7901283948695, 5256.395514515832, 5270.947290527093, 5277.70972596507, 5289.867753306169, 3663.7435379523445, 3920.1571662092715, 4009.178118485718, 4033.9596604034023, 4068.87793366198, 4021.4772079629606, 4093.263212621727, 4114.917701645965, 4117.547069822333, 4121.299379105544, 4054.0878302382025, 4083.836646534135, 4103.322951712964, 4105.958940410587, 4126.896827579305, 3883.728139030269, 3973.0, 4114.835406583733, 4116.958830411688, 4121.608447197512, 3498.195415054526, 3513.5959364673135, 3581.7313701472235, 3596.5504311961004, 3613.963860361389, 4981.252812078181, 5015.849524514234, 5031.647784655075, 5052.166392545226, 5075.5178258065425, 4490.281554951225, 4672.836450724209, 4676.462206846222, 4683.039976804746, 4686.109639168547, 5471.890562188734, 5536.806211782608, 5542.140968149944, 5546.112621980464, 5578.219049333096, 4016.096378314885, 4026.9194616107807, 4042.171354872244, 4047.311956967293, 4048.0, 5265.473452654704, 5341.866453338659, 5677.971610141964, 5724.912266669319, 5803.285897025865, 3993.6206060424215, 4061.6953728470485, 4076.8776936691947, 4087.8773636790943, 4091.85678501251, 4109.773962432095, 4115.135821477524, 4119.0937993641355, 4124.566920473367, 4135.193637240769, 4590.1737687215955, 4651.697639653412, 4686.109639168547, 4686.695364801345, 4726.0, 5552.694601796859, 5554.583406244547, 5562.9443705563235, 5564.972175139098, 5567.3040869891265, 1468.8616322350265, 1480.6668499587506, 1487.6504021554927, 1489.47868246113, 1493.4250313629332, 1009.4448053570507, 1033.2302434686208, 1038.5067093130704, 1039.4854546999284, 1049.7165765243342, 5619.426560563049, 5623.775048998076, 5641.9435805641415, 5652.293463317085, 5654.547636189095, 5971.790987315423, 6025.15647809307, 6030.638161710312, 6038.818835434944, 6041.365656606081, 5427.9185812212845, 5625.353084395347, 5642.689652069175, 5678.943210567924, 5694.5159661428415, 3205.0705295464522, 3236.158598764291, 3236.288016636336, 3238.919027024296, 3243.870245190213, 6027.276726792813, 6265.780697675559, 6266.404691554295, 6275.246970363585, 6279.623222606659, 6066.484348830399, 6120.724567394389, 6153.938460615426, 6159.969200153971, 6172.4136207060255, 6099.4815440688035, 6189.288231853305, 6209.36752000076, 6211.9689401552705, 6232.376762323732, 5814.331351894586, 5989.51435154406, 6009.128676341818, 6014.729337179925, 6035.879282414239, 5924.6149000314845, 5925.377835327401, 5927.792527261525, 5960.8807823844145, 5961.195238642727, 5451.236826844166, 5631.577631677558, 5832.766689332549, 5846.94153058464, 6200.534959878118, 4058.411530328027, 4066.512018557792, 4072.086119523819, 4075.857344992911, 4077.1845630874536, 5699.629524080921, 5702.315722113373, 5703.572232082527, 5718.199452076629, 5729.627574207663, 5396.97457483077, 5426.213199086189, 5519.641223320471, 5530.308711411074, 5547.278853748987, 5453.0, 5457.945420545744, 5528.391876893458, 5548.501904485847, 5559.471850174227, 5424.101564452568, 5438.972805135949, 5469.894090775159, 5472.288602481652, 5500.80747173847, 5306.151015837448, 5569.582281328835, 5576.637518561281, 5588.692621905671, 5604.0, 5378.946210537844, 5414.214938833768, 5437.673739575638, 5441.156620723794, 5450.482204190595], "value": 4291.095718543607, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.7590798668386, 844.8053877389325, 861.1044513705742, 875.4484674654966, 876.3821505838384, 14477.565673029812, 14937.626559336022, 14962.625934351647, 14965.401383944656, 14967.17680527572, 13864.653383665389, 13875.93062034691, 13915.512957046505, 13917.930410347959, 13959.0, 809.7692157735032, 833.5207255827893, 864.8097418567905, 866.2896424931558, 867.2974890338814, 851.8594431918757, 858.626497473601, 862.9395942284043, 863.5509535041774, 863.6588547523725, 887.8357503861774, 889.937704360695, 891.5765011619494, 891.9821603567957, 892.1034360467753, 885.9246964008067, 886.601029536711, 886.6364790435922, 886.7694399456155, 887.1350433327518, 646.6411141816291, 647.3300134360961, 647.7247169952751, 648.044134901022, 649.0199798304546, 14573.125612463286, 14602.342894569663, 14629.78055329171, 14647.194404307866, 14711.190884501348, 13675.384607692678, 13809.654758631013, 13845.446182152702, 13856.515021974283, 13884.166949983033, 10935.945320273428, 11132.165087618461, 11140.944295278472, 11164.162687798447, 11291.604793832177, 3879.4180872869015, 3936.626020528045, 3960.2277555876617, 4036.091879327157, 4037.6769858411258, 44295.77852110751, 47852.0, 52638.73680631573, 52678.73660631672, 53446.73276633592, 10985.340879547253, 11018.669439916815, 11061.115110791117, 11183.888161118284, 11214.719632009102, 18843.811561884206, 18920.52698682544, 19070.618587628447, 19085.427437176906, 19101.426957191306, 7336.633168341668, 8358.874616880752, 8623.827523449496, 8697.521636310064, 8833.33749968755, 4819.2530157824895, 4869.732164730974, 4926.064047830901, 4939.333190019373, 4987.600991920638, 3375.8480868360984, 3469.705075068597, 3473.8263086845554, 3477.1307173206696, 3483.703885169789, 613.6502193749609, 615.6798464798369, 630.4672551693811, 631.4285571557748, 638.4796390941368, 600.9759609615654, 676.2865177238061, 760.3499008347893, 786.0724345272633, 790.8655528560158, 8927.732168034969, 9107.863382049274, 9121.954390228006, 9141.862872056925, 9167.587458564381, 664.8504086580577, 710.6553321639001, 754.5585832288173, 775.8991331126917, 787.2127872127872, 4228.429162063144, 4375.409319741794, 4434.246178149722, 4470.150671372428, 4487.977560112178, 55900.72049639807, 57613.13580296299, 58273.0, 58696.706516467995, 60525.0, 52839.0, 53123.468765312624, 53778.46221537813, 54552.45447545474, 59710.402895971354, 50074.49925500698, 50279.245811313594, 51167.23249151266, 51176.0, 52279.47720522822, 9465.479398632866, 9572.56923438433, 9615.423074615546, 9684.51577421112, 9693.0, 32976.0, 33711.3257734839, 33775.0, 33866.49200262047, 34624.0, 42667.78666106649, 43221.78389108034, 43339.78330108329, 43689.0, 44045.11909761851, 11417.771644567229, 11656.708582285512, 11684.88315116872, 11700.531978721096, 12057.0, 13880.305984700926, 13931.651708706959, 14059.086159399607, 14075.507357242448, 14202.928985355007, 13185.53850615224, 13286.86713132895, 13366.532171373956, 13470.0, 13488.662783430493, 12800.487980480677, 13084.0, 13232.0, 13428.19430834153, 13670.248136352597, 13044.478220871059, 13421.731565368442, 13965.720685586435, 14037.789433158716, 14052.297385130907, 10741.24811263204, 11049.889501104886, 11142.27575207609, 11184.608538701106, 11241.60654377093, 10560.891106433714, 10997.725056873642, 11037.910023709246, 11050.226484146033, 11053.28153670009], "value": 6866.139131810042, "unit": "score"}], "name": "dromaeo_css", "value": 7111.470962134421, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 107.0, 111.0, 113.0, 112.0, 101.0, 111.0, 111.0, 112.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 153.0, 185.0, 136.0, 158.0, 161.0, 127.0, 184.0, 133.0], "value": 151.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 161.0, 160.0, 159.0, 159.0, 159.0, 163.0, 163.0, 162.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 77.0, 106.0, 106.0, 76.0, 76.0, 76.0, 131.0, 111.0, 72.0], "value": 90.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 160.0, 93.0, 92.0, 92.0, 154.0, 92.0, 91.0, 146.0], "value": 110.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 119.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 55.0, 56.0, 58.0, 56.0, 84.0, 55.0, 54.0], "value": 58.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 58.0, 59.0, 58.0, 59.0, 58.0, 58.0, 58.0], "value": 58.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 76.0, 76.0, 77.0, 76.0, 77.0, 93.0, 78.0, 79.0, 77.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 134.0, 127.0, 139.0, 119.0, 123.0, 129.0, 126.0, 154.0, 129.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 177.0, 177.0, 169.0, 174.0, 173.0, 172.0, 170.0, 176.0, 172.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 68.0, 67.0, 69.0, 69.0, 67.0, 69.0, 68.0], "value": 68.2, "unit": "score"}], "name": "kraken", "value": 1548.8, "alertThreshold": 2.0}]} 22:35:05 INFO - Return code: 0 22:35:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:35:05 ERROR - # TBPL SUCCESS # 22:35:05 INFO - Running post-action listener: _resource_record_post_action 22:35:05 INFO - Running post-run listener: _resource_record_post_run 22:35:06 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 359800832; Read time: 8; Write time: 207276 22:35:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 72335360; Read time: 0; Write time: 46220 22:35:06 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287244288; Read time: 8; Write time: 161012 22:35:06 INFO - Running post-run listener: _upload_blobber_files 22:35:06 INFO - Blob upload gear active. 22:35:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:35:06 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 22:35:06 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'] 22:35:06 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 22:35:06 INFO - (blobuploader) - INFO - Open directory for files ... 22:35:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:35:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:35:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:35:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:35:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:35:07 INFO - (blobuploader) - INFO - Done attempting. 22:35:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:35:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:35:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:35:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:35:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:35:08 INFO - (blobuploader) - INFO - Done attempting. 22:35:08 INFO - (blobuploader) - INFO - Iteration through files over. 22:35:08 INFO - Return code: 0 22:35:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:35:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:35:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ee2f6e259b10a56eaa426ea31bc671c7d14207123768c79abba441a6a95e27ca79513aa0c8c9d01336b0fb7eaa1f01abac1d359f2c761280f2d6a3bc531f6db9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/448307e0fed3e172407574cf11870758578b5824faed9ae6a62ec3262b62ff98b07d2d45e273be0c187250f8b364ac9846b2f8e1aea10f17d8071b4c88f3d2e4"} 22:35:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:35:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:35:08 INFO - Contents: 22:35:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ee2f6e259b10a56eaa426ea31bc671c7d14207123768c79abba441a6a95e27ca79513aa0c8c9d01336b0fb7eaa1f01abac1d359f2c761280f2d6a3bc531f6db9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/448307e0fed3e172407574cf11870758578b5824faed9ae6a62ec3262b62ff98b07d2d45e273be0c187250f8b364ac9846b2f8e1aea10f17d8071b4c88f3d2e4"} 22:35:08 INFO - Running post-run listener: copy_logs_to_upload_dir 22:35:08 INFO - Copying logs to upload dir... 22:35:08 INFO - mkdir: /builds/slave/test/build/upload/logs 22:35:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2134.427425 ========= master_lag: 1.46 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 35 secs) (at 2016-05-03 22:35:09.745682) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-03 22:35:09.748819) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ee2f6e259b10a56eaa426ea31bc671c7d14207123768c79abba441a6a95e27ca79513aa0c8c9d01336b0fb7eaa1f01abac1d359f2c761280f2d6a3bc531f6db9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/448307e0fed3e172407574cf11870758578b5824faed9ae6a62ec3262b62ff98b07d2d45e273be0c187250f8b364ac9846b2f8e1aea10f17d8071b4c88f3d2e4"} build_url:https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/BhIWbYX3R_-5_6uQXArW2Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ee2f6e259b10a56eaa426ea31bc671c7d14207123768c79abba441a6a95e27ca79513aa0c8c9d01336b0fb7eaa1f01abac1d359f2c761280f2d6a3bc531f6db9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/448307e0fed3e172407574cf11870758578b5824faed9ae6a62ec3262b62ff98b07d2d45e273be0c187250f8b364ac9846b2f8e1aea10f17d8071b4c88f3d2e4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-03 22:35:09.783144) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 22:35:09.783474) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1462334879.798279-1757508748 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002996 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 22:35:09.829189) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-03 22:35:09.829552) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-03 22:35:09.829825) ========= ========= Total master_lag: 1.59 =========