builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1462166086.35 results: success (0) buildid: 20160501193652 builduid: c5b0bd7cba63473eb88356d0a4a7181c revision: bfd20783b793364e62e6dcd599ad7c6746a8224e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-01 22:14:46.347547) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-01 22:14:46.348459) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-01 22:14:46.348787) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-01 22:14:46.374909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 22:14:46.375440) ========= 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=4300f881736b422476174874000001bc-1462164413.46220-1464912918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-01 22:14:46-- 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% 38.3M=0s 2016-05-01 22:14:46 (38.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081734 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 22:14:46.470428) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 22:14:46.470775) ========= 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=4300f881736b422476174874000001bc-1462164413.46220-1464912918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013997 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 22:14:46.521561) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 22:14:46.521984) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev bfd20783b793364e62e6dcd599ad7c6746a8224e --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 bfd20783b793364e62e6dcd599ad7c6746a8224e --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=4300f881736b422476174874000001bc-1462164413.46220-1464912918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-01 22:14:46,808 truncating revision to first 12 chars 2016-05-01 22:14:46,809 Setting DEBUG logging. 2016-05-01 22:14:46,809 attempt 1/10 2016-05-01 22:14:46,809 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/bfd20783b793?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-01 22:14:47,051 unpacking tar archive at: mozilla-inbound-bfd20783b793/testing/mozharness/ program finished with exit code 0 elapsedTime=0.529430 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 22:14:47.073574) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-01 22:14:47.074016) ========= script_repo_revision: bfd20783b793364e62e6dcd599ad7c6746a8224e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-01 22:14:47.074621) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-01 22:14:47.075051) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-01 22:14:47.087275) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 30 secs) (at 2016-05-01 22:14:47.087719) ========= /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=4300f881736b422476174874000001bc-1462164413.46220-1464912918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:14:47 INFO - MultiFileLogger online at 20160501 22:14:47 in /builds/slave/test 22:14:47 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 22:14:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:14:47 INFO - {'append_to_log': False, 22:14:47 INFO - 'base_work_dir': '/builds/slave/test', 22:14:47 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 22:14:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:14:47 INFO - 'branch': 'Mozilla-Inbound', 22:14:47 INFO - 'buildbot_json_path': 'buildprops.json', 22:14:47 INFO - 'config_files': ('talos/linux_config.py',), 22:14:47 INFO - 'default_actions': ('clobber', 22:14:47 INFO - 'read-buildbot-config', 22:14:47 INFO - 'download-and-extract', 22:14:47 INFO - 'populate-webroot', 22:14:47 INFO - 'create-virtualenv', 22:14:47 INFO - 'install', 22:14:47 INFO - 'run-tests'), 22:14:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:14:47 INFO - 'download_minidump_stackwalk': True, 22:14:47 INFO - 'download_symbols': 'ondemand', 22:14:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:14:47 INFO - 'tooltool.py': '/tools/tooltool.py', 22:14:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:14:47 INFO - '/tools/misc-python/virtualenv.py')}, 22:14:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:14:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:14:47 INFO - 'installer_path': 'installer.exe', 22:14:47 INFO - 'log_level': 'info', 22:14:47 INFO - 'log_name': 'talos', 22:14:47 INFO - 'log_to_console': True, 22:14:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:14:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:14:47 INFO - 'opt_config_files': (), 22:14:47 INFO - 'pip_index': False, 22:14:47 INFO - 'sps_profile': False, 22:14:47 INFO - 'sps_profile_interval': 0, 22:14:47 INFO - 'suite': 'dromaeojs', 22:14:47 INFO - 'system_bits': '32', 22:14:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:14:47 INFO - 'title': 'talos-linux64-ix-045', 22:14:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:14:47 INFO - 'use_talos_json': True, 22:14:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:14:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:14:47 INFO - 'work_dir': 'build'} 22:14:47 INFO - ##### 22:14:47 INFO - ##### Running clobber step. 22:14:47 INFO - ##### 22:14:47 INFO - Running pre-action listener: _resource_record_pre_action 22:14:47 INFO - Running main action method: clobber 22:14:47 INFO - rmtree: /builds/slave/test/build 22:14:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:14:48 INFO - Running post-action listener: _resource_record_post_action 22:14:48 INFO - ##### 22:14:48 INFO - ##### Running read-buildbot-config 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: read_buildbot_config 22:14:48 INFO - Using buildbot properties: 22:14:48 INFO - { 22:14:48 INFO - "project": "", 22:14:48 INFO - "product": "firefox", 22:14:48 INFO - "script_repo_revision": "production", 22:14:48 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 22:14:48 INFO - "repository": "", 22:14:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 22:14:48 INFO - "buildid": "20160501193652", 22:14:48 INFO - "pgo_build": "True", 22:14:48 INFO - "basedir": "/builds/slave/test", 22:14:48 INFO - "buildnumber": 1769, 22:14:48 INFO - "slavename": "talos-linux64-ix-045", 22:14:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:14:48 INFO - "platform": "ubuntu64_hw", 22:14:48 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 22:14:48 INFO - "branch": "mozilla-inbound", 22:14:48 INFO - "repo_path": "integration/mozilla-inbound", 22:14:48 INFO - "revision": "bfd20783b793364e62e6dcd599ad7c6746a8224e", 22:14:48 INFO - "stage_platform": "linux64-pgo", 22:14:48 INFO - "builduid": "c5b0bd7cba63473eb88356d0a4a7181c", 22:14:48 INFO - "slavebuilddir": "test" 22:14:48 INFO - } 22:14:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/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 - ##### 22:14:48 INFO - ##### Running download-and-extract 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: download_and_extract 22:14:48 INFO - mkdir: /builds/slave/test/build/tests 22:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:14:48 INFO - https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:14:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:14:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:14:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:14:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:15:18 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 22:15:18 INFO - retry: attempt #1 caught exception: timed out 22:15:18 INFO - retry: Failed, sleeping 30 seconds before retrying 22:15:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:16:18 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 22:16:18 INFO - retry: attempt #2 caught exception: timed out 22:16:18 INFO - retry: Failed, sleeping 60 seconds before retrying 22:17:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:17:48 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 22:17:48 INFO - retry: attempt #3 caught exception: timed out 22:17:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:17:48 INFO - Caught exception: timed out 22:17:48 INFO - Caught exception: timed out 22:17:48 INFO - Caught exception: timed out 22:17:48 INFO - trying https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:17:48 INFO - Downloading https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/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:17:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/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:17:49 INFO - Downloaded 1361 bytes. 22:17:49 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 22:17:49 INFO - Using the following test package requirements: 22:17:49 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:17:49 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:17:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:17:49 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:17:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:17:49 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:17:49 INFO - u'jsshell-linux-x86_64.zip'], 22:17:49 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:17:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:17:49 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 22:17:49 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:17:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:17:49 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:17:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:17:49 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:17:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:17:49 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 22:17:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:17:49 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:17:49 INFO - https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:17:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:17:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:17:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:17:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:18:19 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 22:18:19 INFO - retry: attempt #1 caught exception: timed out 22:18:19 INFO - retry: Failed, sleeping 30 seconds before retrying 22:18:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:19:19 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 22:19:19 INFO - retry: attempt #2 caught exception: timed out 22:19:19 INFO - retry: Failed, sleeping 60 seconds before retrying 22:20:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:20:49 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 22:20:49 INFO - retry: attempt #3 caught exception: timed out 22:20:49 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:20:49 INFO - Caught exception: timed out 22:20:49 INFO - Caught exception: timed out 22:20:49 INFO - Caught exception: timed out 22:20:49 INFO - trying https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:20:49 INFO - Downloading https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/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:20:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/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:20:50 INFO - Downloaded 23879932 bytes. 22:20:50 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:20:50 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:20:51 INFO - Return code: 0 22:20:51 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:20: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:20:51 INFO - https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:20:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:20:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:20:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:20:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:21:21 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 22:21:21 INFO - retry: attempt #1 caught exception: timed out 22:21:21 INFO - retry: Failed, sleeping 30 seconds before retrying 22:21:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:22:21 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 22:22:21 INFO - retry: attempt #2 caught exception: timed out 22:22:21 INFO - retry: Failed, sleeping 60 seconds before retrying 22:23:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:23:52 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 22:23:52 INFO - retry: attempt #3 caught exception: timed out 22:23:52 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:23:52 INFO - Caught exception: timed out 22:23:52 INFO - Caught exception: timed out 22:23:52 INFO - Caught exception: timed out 22:23:52 INFO - trying https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 22:23:52 INFO - Downloading https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/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:23:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/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:23:53 INFO - Downloaded 23879932 bytes. 22:23:53 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:23:53 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:23:54 INFO - Return code: 0 22:23: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:23:54 INFO - https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:23:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:23:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:23:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:23:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:24:24 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 22:24:24 INFO - retry: attempt #1 caught exception: timed out 22:24:24 INFO - retry: Failed, sleeping 30 seconds before retrying 22:24:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:25:24 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 22:25:24 INFO - retry: attempt #2 caught exception: timed out 22:25:24 INFO - retry: Failed, sleeping 60 seconds before retrying 22:26:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:26:54 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 22:26:54 INFO - retry: attempt #3 caught exception: timed out 22:26:54 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:26:54 INFO - Caught exception: timed out 22:26:54 INFO - Caught exception: timed out 22:26:54 INFO - Caught exception: timed out 22:26:54 INFO - trying https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 22:26:54 INFO - Downloading https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/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:26:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/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:26:55 INFO - Downloaded 10840152 bytes. 22:26:55 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:26:55 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:26:55 INFO - Return code: 0 22:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:26:55 INFO - https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:26:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:26:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:26:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:26:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:27:25 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 22:27:25 INFO - retry: attempt #1 caught exception: timed out 22:27:25 INFO - retry: Failed, sleeping 30 seconds before retrying 22:27:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:28:26 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 22:28:26 INFO - retry: attempt #2 caught exception: timed out 22:28:26 INFO - retry: Failed, sleeping 60 seconds before retrying 22:29:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:29:56 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 22:29:56 INFO - retry: attempt #3 caught exception: timed out 22:29:56 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btkAZX_1RXieywRdWYimpA/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:29:56 INFO - Caught exception: timed out 22:29:56 INFO - Caught exception: timed out 22:29:56 INFO - Caught exception: timed out 22:29:56 INFO - trying https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:29:56 INFO - Downloading https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/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:29:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/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:29:57 INFO - Downloaded 58585461 bytes. 22:29:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:29:57 INFO - mkdir: /builds/slave/test/properties 22:29:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:29:57 INFO - Writing to file /builds/slave/test/properties/build_url 22:29:57 INFO - Contents: 22:29:57 INFO - build_url:https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 22:29:58 INFO - Running post-action listener: _resource_record_post_action 22:29:58 INFO - Running post-action listener: set_extra_try_arguments 22:29:58 INFO - ##### 22:29:58 INFO - ##### Running populate-webroot step. 22:29:58 INFO - ##### 22:29:58 INFO - Running pre-action listener: _resource_record_pre_action 22:29:58 INFO - Running main action method: populate_webroot 22:29:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:29:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:29:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:29:58 INFO - '--tppagecycles', 22:29:58 INFO - '7'], 22:29:58 INFO - 'tests': ['tsvgm']}}, 22:29:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:29:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:29:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:29:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:29:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:29:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:29:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:58 INFO - 'talos_options': ['--disable-e10s'], 22:29:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:29:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:29:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:58 INFO - 'talos_options': ['--disable-e10s'], 22:29:58 INFO - 'tests': ['damp', 'tps']}, 22:29:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:58 INFO - 'tests': ['damp', 'tps']}, 22:29:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:29:58 INFO - 'tests': ['dromaeo_dom']}, 22:29:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:29:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:29:58 INFO - 'tests': ['a11yr', 22:29:58 INFO - 'ts_paint', 22:29:58 INFO - 'tpaint', 22:29:58 INFO - 'sessionrestore', 22:29:58 INFO - 'sessionrestore_no_auto_restore', 22:29:58 INFO - 'tabpaint']}, 22:29:58 INFO - 'other-e10s': {'tests': ['a11yr', 22:29:58 INFO - 'ts_paint', 22:29:58 INFO - 'tpaint', 22:29:58 INFO - 'sessionrestore', 22:29:58 INFO - 'sessionrestore_no_auto_restore', 22:29:58 INFO - 'tabpaint']}, 22:29:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:29:58 INFO - 'ts_paint', 22:29:58 INFO - 'tpaint', 22:29:58 INFO - 'sessionrestore', 22:29:58 INFO - 'sessionrestore_no_auto_restore', 22:29:58 INFO - 'tabpaint']}, 22:29:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:29:58 INFO - 'ts_paint', 22:29:58 INFO - 'tpaint', 22:29:58 INFO - 'sessionrestore', 22:29:58 INFO - 'sessionrestore_no_auto_restore', 22:29:58 INFO - 'tabpaint']}, 22:29:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:29:58 INFO - 'tests': ['a11yr', 22:29:58 INFO - 'ts_paint', 22:29:58 INFO - 'tpaint', 22:29:58 INFO - 'sessionrestore', 22:29:58 INFO - 'sessionrestore_no_auto_restore', 22:29:58 INFO - 'tabpaint']}, 22:29:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:29:58 INFO - 'tests': ['a11yr', 22:29:58 INFO - 'ts_paint', 22:29:58 INFO - 'tpaint', 22:29:58 INFO - 'sessionrestore', 22:29:58 INFO - 'sessionrestore_no_auto_restore', 22:29:58 INFO - 'tabpaint']}, 22:29:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:29:58 INFO - 'tests': ['tsvgx', 22:29:58 INFO - 'tsvgr_opacity', 22:29:58 INFO - 'tart', 22:29:58 INFO - 'tscrollx', 22:29:58 INFO - 'cart']}, 22:29:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:29:58 INFO - 'tsvgr_opacity', 22:29:58 INFO - 'tart', 22:29:58 INFO - 'tscrollx', 22:29:58 INFO - 'cart']}, 22:29:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:58 INFO - 'talos_options': ['--disable-e10s'], 22:29:58 INFO - 'tests': ['tp5o']}, 22:29:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:58 INFO - 'tests': ['tp5o']}, 22:29:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:58 INFO - 'talos_options': ['--disable-e10s', 22:29:58 INFO - '--xperf_path', 22:29:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:29:58 INFO - 'tests': ['tp5n']}, 22:29:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:29:58 INFO - 'talos_options': ['--xperf_path', 22:29:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:29:58 INFO - 'tests': ['tp5n']}}, 22:29:58 INFO - 'talos.zip': {'path': '', 22:29:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:29:58 INFO - Running post-action listener: _resource_record_post_action 22:29:58 INFO - ##### 22:29:58 INFO - ##### Running create-virtualenv step. 22:29:58 INFO - ##### 22:29:58 INFO - Running pre-action listener: _resource_record_pre_action 22:29:58 INFO - Running main action method: create_virtualenv 22:29:58 INFO - Creating virtualenv /builds/slave/test/build/venv 22:29:58 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:29:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:29:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:29:58 INFO - Using real prefix '/usr' 22:29:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:29:59 INFO - Installing distribute.............................................................................................................................................................................................done. 22:30:00 INFO - Installing pip.................done. 22:30:00 INFO - Return code: 0 22:30:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:30: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:30:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30: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:30:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6246723f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b410>, '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 0x218c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c7a0>, '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': '4300f881736b422476174874000001bc-1462164413.46220-1464912918', '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:30:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:30:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:30:00 INFO - Using env: {'DISPLAY': ':0', 22:30:00 INFO - 'HOME': '/home/cltbld', 22:30:00 INFO - 'LANG': 'en_US.UTF-8', 22:30:00 INFO - 'LANGUAGE': 'en_US:en', 22:30:00 INFO - 'LOGNAME': 'cltbld', 22:30:00 INFO - 'MAIL': '/var/mail/cltbld', 22:30:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:00 INFO - 'MOZ_NO_REMOTE': '1', 22:30:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:00 INFO - 'NO_EM_RESTART': '1', 22:30:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:00 INFO - 'PWD': '/builds/slave/test', 22:30:00 INFO - 'SHELL': '/bin/bash', 22:30:00 INFO - 'SHLVL': '1', 22:30:01 INFO - 'TERM': 'linux', 22:30:01 INFO - 'TMOUT': '86400', 22:30:01 INFO - 'USER': 'cltbld', 22:30:01 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462164413.46220-1464912918', 22:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:01 INFO - '_': '/tools/buildbot/bin/python'} 22:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:01 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:30:01 INFO - Cleaning up... 22:30:01 INFO - Return code: 0 22:30:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:30:01 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:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:01 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:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:01 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 0x7f6246723f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b410>, '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 0x218c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c7a0>, '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': '4300f881736b422476174874000001bc-1462164413.46220-1464912918', '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:30:01 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:30:01 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:30:01 INFO - Using env: {'DISPLAY': ':0', 22:30:01 INFO - 'HOME': '/home/cltbld', 22:30:01 INFO - 'LANG': 'en_US.UTF-8', 22:30:01 INFO - 'LANGUAGE': 'en_US:en', 22:30:01 INFO - 'LOGNAME': 'cltbld', 22:30:01 INFO - 'MAIL': '/var/mail/cltbld', 22:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:01 INFO - 'MOZ_NO_REMOTE': '1', 22:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:01 INFO - 'NO_EM_RESTART': '1', 22:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:01 INFO - 'PWD': '/builds/slave/test', 22:30:01 INFO - 'SHELL': '/bin/bash', 22:30:01 INFO - 'SHLVL': '1', 22:30:01 INFO - 'TERM': 'linux', 22:30:01 INFO - 'TMOUT': '86400', 22:30:01 INFO - 'USER': 'cltbld', 22:30:01 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462164413.46220-1464912918', 22:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:01 INFO - '_': '/tools/buildbot/bin/python'} 22:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:01 INFO - Downloading/unpacking psutil>=0.7.1 22:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:30:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:30:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:30:03 INFO - Installing collected packages: psutil 22:30:03 INFO - Running setup.py install for psutil 22:30:03 INFO - building 'psutil._psutil_linux' extension 22:30:03 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:30:03 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:30:03 INFO - building 'psutil._psutil_posix' extension 22:30:03 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:30:03 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:30:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:30:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:30:03 INFO - Successfully installed psutil 22:30:03 INFO - Cleaning up... 22:30:03 INFO - Return code: 0 22:30:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:30: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:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30: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:30:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:03 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 0x7f6246723f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b410>, '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 0x218c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c7a0>, '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': '4300f881736b422476174874000001bc-1462164413.46220-1464912918', '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:30:03 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:30:03 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:30:03 INFO - Using env: {'DISPLAY': ':0', 22:30:03 INFO - 'HOME': '/home/cltbld', 22:30:03 INFO - 'LANG': 'en_US.UTF-8', 22:30:03 INFO - 'LANGUAGE': 'en_US:en', 22:30:03 INFO - 'LOGNAME': 'cltbld', 22:30:03 INFO - 'MAIL': '/var/mail/cltbld', 22:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:03 INFO - 'MOZ_NO_REMOTE': '1', 22:30:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:03 INFO - 'NO_EM_RESTART': '1', 22:30:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:03 INFO - 'PWD': '/builds/slave/test', 22:30:03 INFO - 'SHELL': '/bin/bash', 22:30:03 INFO - 'SHLVL': '1', 22:30:03 INFO - 'TERM': 'linux', 22:30:03 INFO - 'TMOUT': '86400', 22:30:03 INFO - 'USER': 'cltbld', 22:30:03 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462164413.46220-1464912918', 22:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:03 INFO - '_': '/tools/buildbot/bin/python'} 22:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:30: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:30: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:30: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:30: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:30: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:30: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:30:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:30:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:30:06 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:30:06 INFO - Installing collected packages: mozsystemmonitor 22:30:06 INFO - Running setup.py install for mozsystemmonitor 22:30:06 INFO - Successfully installed mozsystemmonitor 22:30:06 INFO - Cleaning up... 22:30:06 INFO - Return code: 0 22:30:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:30:06 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:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:06 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:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:06 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 0x7f6246723f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b410>, '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 0x218c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c7a0>, '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': '4300f881736b422476174874000001bc-1462164413.46220-1464912918', '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:30:06 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:30:06 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:30:06 INFO - Using env: {'DISPLAY': ':0', 22:30:06 INFO - 'HOME': '/home/cltbld', 22:30:06 INFO - 'LANG': 'en_US.UTF-8', 22:30:06 INFO - 'LANGUAGE': 'en_US:en', 22:30:06 INFO - 'LOGNAME': 'cltbld', 22:30:06 INFO - 'MAIL': '/var/mail/cltbld', 22:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:06 INFO - 'MOZ_NO_REMOTE': '1', 22:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:06 INFO - 'NO_EM_RESTART': '1', 22:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:06 INFO - 'PWD': '/builds/slave/test', 22:30:06 INFO - 'SHELL': '/bin/bash', 22:30:06 INFO - 'SHLVL': '1', 22:30:06 INFO - 'TERM': 'linux', 22:30:06 INFO - 'TMOUT': '86400', 22:30:06 INFO - 'USER': 'cltbld', 22:30:06 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462164413.46220-1464912918', 22:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:06 INFO - '_': '/tools/buildbot/bin/python'} 22:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:06 INFO - Downloading/unpacking blobuploader==1.2.4 22:30:06 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:30:06 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:30:06 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:30:06 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:30:06 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:30:06 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:30:08 INFO - Downloading blobuploader-1.2.4.tar.gz 22:30:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:30:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:30:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:09 INFO - Downloading docopt-0.6.1.tar.gz 22:30:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:30:09 INFO - Installing collected packages: blobuploader, requests, docopt 22:30:09 INFO - Running setup.py install for blobuploader 22:30:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:30:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:30:09 INFO - Running setup.py install for requests 22:30:09 INFO - Running setup.py install for docopt 22:30:09 INFO - Successfully installed blobuploader requests docopt 22:30:09 INFO - Cleaning up... 22:30:09 INFO - Return code: 0 22:30:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:09 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 0x7f6246723f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b410>, '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 0x218c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c7a0>, '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': '4300f881736b422476174874000001bc-1462164413.46220-1464912918', '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:30:09 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:30:09 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:30:09 INFO - Using env: {'DISPLAY': ':0', 22:30:09 INFO - 'HOME': '/home/cltbld', 22:30:09 INFO - 'LANG': 'en_US.UTF-8', 22:30:09 INFO - 'LANGUAGE': 'en_US:en', 22:30:09 INFO - 'LOGNAME': 'cltbld', 22:30:09 INFO - 'MAIL': '/var/mail/cltbld', 22:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:09 INFO - 'MOZ_NO_REMOTE': '1', 22:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:09 INFO - 'NO_EM_RESTART': '1', 22:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:09 INFO - 'PWD': '/builds/slave/test', 22:30:09 INFO - 'SHELL': '/bin/bash', 22:30:09 INFO - 'SHLVL': '1', 22:30:09 INFO - 'TERM': 'linux', 22:30:09 INFO - 'TMOUT': '86400', 22:30:09 INFO - 'USER': 'cltbld', 22:30:09 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462164413.46220-1464912918', 22:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:09 INFO - '_': '/tools/buildbot/bin/python'} 22:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:30:10 INFO - Running setup.py (path:/tmp/pip-U7sRxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:30:10 INFO - Running setup.py (path:/tmp/pip-houHJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:30:10 INFO - Running setup.py (path:/tmp/pip-cukGro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:30:10 INFO - Running setup.py (path:/tmp/pip-4NNv9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:30:10 INFO - Running setup.py (path:/tmp/pip-T8mDkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:30:10 INFO - Running setup.py (path:/tmp/pip-o9j9dZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:30:10 INFO - Running setup.py (path:/tmp/pip-Q75aGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:30:10 INFO - Running setup.py (path:/tmp/pip-IMX1B2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:30:10 INFO - Running setup.py (path:/tmp/pip-njxkb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:30:10 INFO - Running setup.py (path:/tmp/pip-VYrGPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:30:10 INFO - Running setup.py (path:/tmp/pip-b50sia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:30:10 INFO - Running setup.py (path:/tmp/pip-WjxCoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:30:10 INFO - Running setup.py (path:/tmp/pip-momF8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:30:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:30:11 INFO - Running setup.py (path:/tmp/pip-5Wwzza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:30:11 INFO - Running setup.py (path:/tmp/pip-r4CSMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:30:11 INFO - Running setup.py (path:/tmp/pip-mpGstd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:30:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:30:11 INFO - Running setup.py (path:/tmp/pip-0f986L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:30:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:30:11 INFO - Running setup.py install for manifestparser 22:30:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:30:11 INFO - Running setup.py install for mozcrash 22:30:11 INFO - Running setup.py install for mozdebug 22:30:11 INFO - Running setup.py install for mozdevice 22:30:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:30:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:30:11 INFO - Running setup.py install for mozfile 22:30:11 INFO - Running setup.py install for mozhttpd 22:30:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:30:11 INFO - Running setup.py install for mozinfo 22:30:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:30:11 INFO - Running setup.py install for mozInstall 22:30:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:30:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:30:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:30:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:30:12 INFO - Running setup.py install for mozleak 22:30:12 INFO - Running setup.py install for mozlog 22:30:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:30:12 INFO - Running setup.py install for moznetwork 22:30:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:30:12 INFO - Running setup.py install for mozprocess 22:30:12 INFO - Running setup.py install for mozprofile 22:30:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:30:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:30:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:30:12 INFO - Running setup.py install for mozrunner 22:30:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:30:12 INFO - Running setup.py install for mozscreenshot 22:30:12 INFO - Running setup.py install for moztest 22:30:12 INFO - Running setup.py install for mozversion 22:30:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:30:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:30:13 INFO - Cleaning up... 22:30:13 INFO - Return code: 0 22:30:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:13 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 0x7f6246723f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b410>, '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 0x218c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c7a0>, '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': '4300f881736b422476174874000001bc-1462164413.46220-1464912918', '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:30:13 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:30:13 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:30:13 INFO - Using env: {'DISPLAY': ':0', 22:30:13 INFO - 'HOME': '/home/cltbld', 22:30:13 INFO - 'LANG': 'en_US.UTF-8', 22:30:13 INFO - 'LANGUAGE': 'en_US:en', 22:30:13 INFO - 'LOGNAME': 'cltbld', 22:30:13 INFO - 'MAIL': '/var/mail/cltbld', 22:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:13 INFO - 'MOZ_NO_REMOTE': '1', 22:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:13 INFO - 'NO_EM_RESTART': '1', 22:30:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:13 INFO - 'PWD': '/builds/slave/test', 22:30:13 INFO - 'SHELL': '/bin/bash', 22:30:13 INFO - 'SHLVL': '1', 22:30:13 INFO - 'TERM': 'linux', 22:30:13 INFO - 'TMOUT': '86400', 22:30:13 INFO - 'USER': 'cltbld', 22:30:13 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462164413.46220-1464912918', 22:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:13 INFO - '_': '/tools/buildbot/bin/python'} 22:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:30:13 INFO - Running setup.py (path:/tmp/pip-a7yd_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:30:13 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:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:30:13 INFO - Running setup.py (path:/tmp/pip-he3CZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:30:13 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:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:30:13 INFO - Running setup.py (path:/tmp/pip-xO8258-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:30:13 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:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:30:13 INFO - Running setup.py (path:/tmp/pip-g3U8Lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:30:13 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:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:30:13 INFO - Running setup.py (path:/tmp/pip-V9QGoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:30:13 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:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:30:13 INFO - Running setup.py (path:/tmp/pip-edUC82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:30:13 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:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:30:13 INFO - Running setup.py (path:/tmp/pip-I6z5ON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:30:13 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:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:30:13 INFO - Running setup.py (path:/tmp/pip-bq3_lP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:30:13 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:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:30:13 INFO - Running setup.py (path:/tmp/pip-pZ4uak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:30:13 INFO - Running setup.py (path:/tmp/pip-tVCdAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:30:14 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:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:30:14 INFO - Running setup.py (path:/tmp/pip-IsRCgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:30:14 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:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:30:14 INFO - Running setup.py (path:/tmp/pip-AKn_PW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:30:14 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:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:30:14 INFO - Running setup.py (path:/tmp/pip-pREUWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:30:14 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:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:30:14 INFO - Running setup.py (path:/tmp/pip-n5CbZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:30:14 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:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:30:14 INFO - Running setup.py (path:/tmp/pip-xpJ4Ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:30:14 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:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:30:14 INFO - Running setup.py (path:/tmp/pip-Mjl9ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:30:14 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:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:30:14 INFO - Running setup.py (path:/tmp/pip-_xb9Ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:30:14 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:30:14 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:30:14 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:30:14 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:30:14 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:30:14 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:30:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:30:14 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:30:14 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:30:14 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:30:14 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:30:14 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:30:14 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:30:16 INFO - Downloading blessings-1.6.tar.gz 22:30:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:30:16 INFO - Installing collected packages: blessings 22:30:16 INFO - Running setup.py install for blessings 22:30:16 INFO - Successfully installed blessings 22:30:16 INFO - Cleaning up... 22:30:16 INFO - Return code: 0 22:30:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:30:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:30:16 INFO - Reading from file tmpfile_stdout 22:30:16 INFO - Current package versions: 22:30:16 INFO - argparse == 1.2.1 22:30:16 INFO - blessings == 1.6 22:30:16 INFO - blobuploader == 1.2.4 22:30:16 INFO - docopt == 0.6.1 22:30:16 INFO - manifestparser == 1.1 22:30:16 INFO - mozInstall == 1.12 22:30:16 INFO - mozcrash == 0.17 22:30:16 INFO - mozdebug == 0.1 22:30:16 INFO - mozdevice == 0.48 22:30:16 INFO - mozfile == 1.2 22:30:16 INFO - mozhttpd == 0.7 22:30:16 INFO - mozinfo == 0.9 22:30:16 INFO - mozleak == 0.1 22:30:16 INFO - mozlog == 3.1 22:30:16 INFO - moznetwork == 0.27 22:30:16 INFO - mozprocess == 0.22 22:30:16 INFO - mozprofile == 0.28 22:30:16 INFO - mozrunner == 6.11 22:30:16 INFO - mozscreenshot == 0.1 22:30:16 INFO - mozsystemmonitor == 0.0 22:30:16 INFO - moztest == 0.7 22:30:16 INFO - mozversion == 1.4 22:30:16 INFO - psutil == 3.1.1 22:30:16 INFO - requests == 1.2.3 22:30:16 INFO - wsgiref == 0.1.2 22:30:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:16 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 0x7f6246723f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b410>, '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 0x218c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c7a0>, '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': '4300f881736b422476174874000001bc-1462164413.46220-1464912918', '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:30:16 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:30:16 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:30:16 INFO - Using env: {'DISPLAY': ':0', 22:30:16 INFO - 'HOME': '/home/cltbld', 22:30:16 INFO - 'LANG': 'en_US.UTF-8', 22:30:16 INFO - 'LANGUAGE': 'en_US:en', 22:30:16 INFO - 'LOGNAME': 'cltbld', 22:30:16 INFO - 'MAIL': '/var/mail/cltbld', 22:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:16 INFO - 'MOZ_NO_REMOTE': '1', 22:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:16 INFO - 'NO_EM_RESTART': '1', 22:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:16 INFO - 'PWD': '/builds/slave/test', 22:30:16 INFO - 'SHELL': '/bin/bash', 22:30:16 INFO - 'SHLVL': '1', 22:30:16 INFO - 'TERM': 'linux', 22:30:16 INFO - 'TMOUT': '86400', 22:30:16 INFO - 'USER': 'cltbld', 22:30:16 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462164413.46220-1464912918', 22:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:16 INFO - '_': '/tools/buildbot/bin/python'} 22:30:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:17 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:30:17 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:30:17 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:30:17 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:30:17 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:30:17 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:30:17 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:30:17 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:30:17 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:30:17 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:30:17 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:30:17 INFO - Cleaning up... 22:30:17 INFO - Return code: 0 22:30:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:30:17 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:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:17 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:30:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:17 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 0x7f6246723f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b410>, '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 0x218c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c7a0>, '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': '4300f881736b422476174874000001bc-1462164413.46220-1464912918', '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:30:17 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:30:17 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:30:17 INFO - Using env: {'DISPLAY': ':0', 22:30:17 INFO - 'HOME': '/home/cltbld', 22:30:17 INFO - 'LANG': 'en_US.UTF-8', 22:30:17 INFO - 'LANGUAGE': 'en_US:en', 22:30:17 INFO - 'LOGNAME': 'cltbld', 22:30:17 INFO - 'MAIL': '/var/mail/cltbld', 22:30:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:17 INFO - 'MOZ_NO_REMOTE': '1', 22:30:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:17 INFO - 'NO_EM_RESTART': '1', 22:30:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:17 INFO - 'PWD': '/builds/slave/test', 22:30:17 INFO - 'SHELL': '/bin/bash', 22:30:17 INFO - 'SHLVL': '1', 22:30:17 INFO - 'TERM': 'linux', 22:30:17 INFO - 'TMOUT': '86400', 22:30:17 INFO - 'USER': 'cltbld', 22:30:17 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462164413.46220-1464912918', 22:30:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:17 INFO - '_': '/tools/buildbot/bin/python'} 22:30:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:17 INFO - Downloading/unpacking jsonschema 22:30:17 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:30:17 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:30:17 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:30:17 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:30:17 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:30:17 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:30:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:30:19 INFO - Downloading/unpacking functools32 (from jsonschema) 22:30:19 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:30:19 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:30:19 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:30:19 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:30:19 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:30:19 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:30:19 INFO - Downloading functools32-3.2.3-2.tar.gz 22:30:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:30:19 INFO - warning: no files found matching '*.txt' 22:30:19 INFO - no previously-included directories found matching 'build' 22:30:19 INFO - no previously-included directories found matching 'dist' 22:30:19 INFO - no previously-included directories found matching '.git*' 22:30:19 INFO - Installing collected packages: jsonschema, functools32 22:30:19 INFO - Running setup.py install for functools32 22:30:19 INFO - warning: no files found matching '*.txt' 22:30:19 INFO - no previously-included directories found matching 'build' 22:30:19 INFO - no previously-included directories found matching 'dist' 22:30:19 INFO - no previously-included directories found matching '.git*' 22:30:19 INFO - Successfully installed jsonschema functools32 22:30:19 INFO - Cleaning up... 22:30:19 INFO - Return code: 0 22:30:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:30:19 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:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:19 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:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:30:19 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 0x7f6246723f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20fc5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x218b410>, '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 0x218c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c7a0>, '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': '4300f881736b422476174874000001bc-1462164413.46220-1464912918', '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:30:19 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:30:19 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:30:19 INFO - Using env: {'DISPLAY': ':0', 22:30:19 INFO - 'HOME': '/home/cltbld', 22:30:19 INFO - 'LANG': 'en_US.UTF-8', 22:30:19 INFO - 'LANGUAGE': 'en_US:en', 22:30:19 INFO - 'LOGNAME': 'cltbld', 22:30:19 INFO - 'MAIL': '/var/mail/cltbld', 22:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:19 INFO - 'MOZ_NO_REMOTE': '1', 22:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:19 INFO - 'NO_EM_RESTART': '1', 22:30:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:19 INFO - 'PWD': '/builds/slave/test', 22:30:19 INFO - 'SHELL': '/bin/bash', 22:30:19 INFO - 'SHLVL': '1', 22:30:19 INFO - 'TERM': 'linux', 22:30:19 INFO - 'TMOUT': '86400', 22:30:19 INFO - 'USER': 'cltbld', 22:30:19 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462164413.46220-1464912918', 22:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:19 INFO - '_': '/tools/buildbot/bin/python'} 22:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:30:19 INFO - Downloading/unpacking flake8 22:30:19 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:30:19 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:30:19 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:30:19 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:30:19 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:30:19 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:30:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:30:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:30:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:30:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:30:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:30:22 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:30:22 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:30:22 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:30:22 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:30:22 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:30:22 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:30:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:30:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:30:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:30:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:30:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:30:22 INFO - no previously-included directories found matching 'docs/_build' 22:30:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:30:22 INFO - Running setup.py install for pep8 22:30:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:30:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:30:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:30:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:30:22 INFO - no previously-included directories found matching 'docs/_build' 22:30:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:30:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:30:22 INFO - Cleaning up... 22:30:22 INFO - Return code: 0 22:30:22 INFO - Running post-action listener: _resource_record_post_action 22:30:22 INFO - Running post-action listener: _start_resource_monitoring 22:30:22 INFO - Starting resource monitoring. 22:30:22 INFO - ##### 22:30:22 INFO - ##### Running install step. 22:30:22 INFO - ##### 22:30:22 INFO - Running pre-action listener: _resource_record_pre_action 22:30:22 INFO - Running main action method: install 22:30:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:30:22 INFO - Reading from file tmpfile_stdout 22:30:22 INFO - Detecting whether we're running mozinstall >=1.0... 22:30:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:30:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:30:22 INFO - Reading from file tmpfile_stdout 22:30:22 INFO - Output received: 22:30:22 INFO - Usage: mozinstall [options] installer 22:30:22 INFO - Options: 22:30:22 INFO - -h, --help show this help message and exit 22:30:22 INFO - -d DEST, --destination=DEST 22:30:22 INFO - Directory to install application into. [default: 22:30:22 INFO - "/builds/slave/test"] 22:30:22 INFO - --app=APP Application being installed. [default: firefox] 22:30:22 INFO - mkdir: /builds/slave/test/build/application 22:30:22 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:30:22 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:30:39 INFO - Reading from file tmpfile_stdout 22:30:39 INFO - Output received: 22:30:39 INFO - /builds/slave/test/build/application/firefox/firefox 22:30:39 INFO - Running post-action listener: _resource_record_post_action 22:30:39 INFO - ##### 22:30:39 INFO - ##### Running run-tests step. 22:30:39 INFO - ##### 22:30:39 INFO - Running pre-action listener: _resource_record_pre_action 22:30:39 INFO - Running main action method: run_tests 22:30:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:30:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:30:39 INFO - Python 2.7.3 22:30:39 INFO - Return code: 0 22:30:39 INFO - grabbing minidump binary from tooltool 22:30: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:30:39 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 0x218b410>, '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 0x218c310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x218c7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:30:39 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:30:39 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:30:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:30:39 INFO - Return code: 0 22:30:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:30:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:30:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:30:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:30:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:30:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:30:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:30:40 INFO - Return code: 0 22:30:40 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/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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:30:40 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/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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:30:40 INFO - Using env: {'DISPLAY': ':0', 22:30:40 INFO - 'HOME': '/home/cltbld', 22:30:40 INFO - 'LANG': 'en_US.UTF-8', 22:30:40 INFO - 'LANGUAGE': 'en_US:en', 22:30:40 INFO - 'LOGNAME': 'cltbld', 22:30:40 INFO - 'MAIL': '/var/mail/cltbld', 22:30:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:30:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:30:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:30:40 INFO - 'MOZ_NO_REMOTE': '1', 22:30:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:30:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:30:40 INFO - 'NO_EM_RESTART': '1', 22:30:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:30:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:30:40 INFO - 'PWD': '/builds/slave/test', 22:30:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:30:40 INFO - 'SHELL': '/bin/bash', 22:30:40 INFO - 'SHLVL': '1', 22:30:40 INFO - 'TERM': 'linux', 22:30:40 INFO - 'TMOUT': '86400', 22:30:40 INFO - 'USER': 'cltbld', 22:30:40 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1462164413.46220-1464912918', 22:30:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:30:40 INFO - '_': '/tools/buildbot/bin/python'} 22:30:40 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/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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:30:40 INFO - mozversion application_buildid: 20160501193652 22:30:40 INFO - mozversion application_changeset: bfd20783b793364e62e6dcd599ad7c6746a8224e 22:30:40 INFO - mozversion application_display_name: Nightly 22:30:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:30:40 INFO - mozversion application_name: Firefox 22:30:40 INFO - mozversion application_remotingname: firefox 22:30:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:30:40 INFO - mozversion application_vendor: Mozilla 22:30:40 INFO - mozversion application_version: 49.0a1 22:30:40 INFO - mozversion platform_buildid: 20160501193652 22:30:40 INFO - mozversion platform_changeset: bfd20783b793364e62e6dcd599ad7c6746a8224e 22:30:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 22:30:40 INFO - mozversion platform_version: 49.0a1 22:30:40 INFO - using testdate: 1462167040 22:30:40 INFO - actual date: 1462167040 22:30:40 INFO - starting webserver on 'localhost:50924' 22:30:40 INFO - SUITE-START | Running 2 tests 22:30:40 INFO - TEST-START | dromaeo_css 22:30:40 INFO - operating with platform_type : linux_ 22:30:40 INFO - Initialising browser for dromaeo_css test... 22:30:40 INFO - TEST-INFO | started process 1101 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8d0LYY/profile http://localhost:50924/getInfo.html) 22:30:44 INFO - PROCESS | 1101 | __metrics Screen width/height:1600/1200 22:30:44 INFO - PROCESS | 1101 | colorDepth:24 22:30:44 INFO - PROCESS | 1101 | Browser inner width/height: 1024/697 22:30:44 INFO - PROCESS | 1101 | __metrics 22:30:46 ERROR - PROCESS | 1101 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:30:46 INFO - TEST-INFO | 1101: exit 0 22:30:46 INFO - Browser initialized. 22:30:46 INFO - Running cycle 1/1 for dromaeo_css test... 22:30:46 INFO - TEST-INFO | started process 1253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8d0LYY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:30:58 INFO - PROCESS | 1253 | RSS: Main: 154521600 22:30:58 INFO - PROCESS | 1253 | 22:31:49 INFO - PROCESS | 1253 | 1462167109769 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:33:57 INFO - PROCESS | 1253 | Cycle 1(1): loaded http://localhost:50924/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50924/tests/dromaeo/cssquery-ext.html) 22:33:58 INFO - PROCESS | 1253 | RSS: Main: 232919040 22:33:58 INFO - PROCESS | 1253 | 22:37:00 INFO - PROCESS | 1253 | Cycle 1(1): loaded http://localhost:50924/tests/dromaeo/cssquery-ext.html (next: http://localhost:50924/tests/dromaeo/cssquery-jquery.html) 22:37:01 INFO - PROCESS | 1253 | RSS: Main: 239001600 22:37:01 INFO - PROCESS | 1253 | 22:40:02 INFO - PROCESS | 1253 | Cycle 1(1): loaded http://localhost:50924/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50924/tests/dromaeo/cssquery-mootools.html) 22:40:03 INFO - PROCESS | 1253 | RSS: Main: 234795008 22:40:03 INFO - PROCESS | 1253 | 22:43:05 INFO - PROCESS | 1253 | Cycle 1(1): loaded http://localhost:50924/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50924/tests/dromaeo/cssquery-prototype.html) 22:43:06 INFO - PROCESS | 1253 | RSS: Main: 233725952 22:43:06 INFO - PROCESS | 1253 | 22:46:08 INFO - PROCESS | 1253 | Cycle 1(1): loaded http://localhost:50924/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50924/tests/dromaeo/cssquery-yui.html) 22:46:09 INFO - PROCESS | 1253 | RSS: Main: 202752000 22:46:09 INFO - PROCESS | 1253 | 22:49:11 INFO - PROCESS | 1253 | Cycle 1(1): loaded http://localhost:50924/tests/dromaeo/cssquery-yui.html (next: http://localhost:50924/tests/dromaeo/cssquery-dojo.html) 22:49:11 INFO - PROCESS | 1253 | RSS: Main: 265535488 22:49:11 INFO - PROCESS | 1253 | 22:49:11 INFO - PROCESS | 1253 | __start_tp_report 22:49:11 INFO - PROCESS | 1253 | _x_x_mozilla_page_load 22:49:11 INFO - PROCESS | 1253 | _x_x_mozilla_page_load_details 22:49:11 INFO - PROCESS | 1253 | |i|pagename|runs| 22:49:11 INFO - PROCESS | 1253 | |0;dojo.html;3014.397120575885;3079.630444346679;3110.2535391506044;3111.533270009498;3140.513220450831;5008.699478031321;5091.465396133408;5163.793448262065;5206.193040078789;5237.397699264586;5109.20807274873;5148.5623721983675;5184.7407629618465;5194.37667479902;5204.609654275935;4617.607503362218;4657.604103651185;4685.906281874378;4745.098431298043;4805.063012712505;4714.292856071583;4762.928556071662;4774.307725379818;4777.928331075037;4805.519448055202;4657.278121891112;4666.789994450258;4743.573078422941;4748.477667456577;4759.666823322369;4676.742779147179;4700.976495117503;4705.106029854317;4708.882277943045;4742.9525704742855;4614.700044497131;4632.791524381411;4636.211843986531;4642.558956899089;4687.39063921688;4972.105021096201;5008.273800298936;5029.270755740434;5043.520865517807;5119.513646203604;5383.838484845461;5405.18922161675;5423.457654234585;5429.131338985783;5477.726113694339;5448.327019101996;5470.863228419282;5471.398146203915;5473.808416705396;5475.698836563987;5042.344495215599;5120.283160357553;5191.870203244911;5216.061109000379;5221.373435187802;5586.525145362609;5592.888142237132;5596.776128954878;5641.069223578145;5647.774089036392;5377.462253774669;5387.138057910715;5388.245645609618;5390;5392.811251606254;5323.467653234723;5420.051490989061;5435;5498.477644623755;5518.806841760519;5413.323334583177;5414.40441551429;5420.83737487876;5421.078416669176;5427.185922111715;5431.728413579384;5433.673979561239;5436.836894893159;5437.592180586472;5443.292371991695;4100.466939297872;4211.7472951623;4216.873493795191;4270.017895883964;4273.67947403946;3791;3797.905052373713;3798.3352913240074;3798.772073675588;3837.4435706822355;4942.827001055018;5175.637705360664;5191.844244672666;5197.7401129943355;5241.685498870003;5377.166539186433;5418.187271909166;5441.211024401439;5480.04099282624;5485.533729633026;5145.279660847485;5154.92267615986;5197.636165468381;5204.505571970657;5245.816396426107;4605.871561467462;4746.335513028179;4755.95244047562;4762.880927976759;4762.999770048259;5614.242077319591;5676.801311954145;5683.744231509592;5708;5739.053056245756;5492.80775172859;5501.752421140978;5511.118221084607;5512.834614961557;5513.58648101402;5512.779488820563;5583.218349431164;5661.433856614306;5662;5665.065264231355;5389.676619402849;5394.865128371665;5404.675719456845;5408.59435542328;5442.836714898559;5462.644928079662;5463.235147079333;5470.288862447856;5476.726163691879;5516.227728118147;5243.868903277296;5249.816256431007;5324.840254792362;5332.0402327581405;5333.093374126485;5291.603129765206;5306;5323.361196656426;5326.760295786621;5352.411234764095;5192.3769147702515;5243.082460569462;5247.291615631841;5255.894882102413;5300.31095957523;5185.818496352609;5341.118715411913;5354.223637572608;5422.8373148805595;5429.077056900415;5215.29593504872;5250.396204436539;5250.501202385767;5260.105782017143;5314.043472175045 22:49:11 INFO - PROCESS | 1253 | |1;ext.html;597.590650404473;617.9134921111042;618.919984626826;636.4049613611272;639.2840019178519;32629.347413051753;33917.49123763145;33932.151696207606;34112.97661070169;34449.13877153072;33135.83432082842;33435.49846752301;33573.66426335736;33747;33769;7971.36229101672;8202.343812494986;8202.958985205065;8215.917840821576;8218.753437396888;8276.21375969285;8396.160383961616;8406.705765298217;8683.044865064838;8693.174148455919;8746.737597872043;8773.649054037864;8813.911860881373;8820.162084601952;8824.294056475466;8619.870701939444;8668.60991255395;8681.956590217073;8683.609237584293;8685.652573897005;8493.532855692934;8619.61211745473;8633.913660863436;8640.956795215983;8658.437201581877;41051.7947410264;41363.586364136274;41553;41641;41729;3244.886428974998;3502.859885604573;3508.842102105386;3709;3878.1855810279594;31231.375372492425;31378.37243255145;31783.682163178302;32026.679733202604;32071.83964080188;4158.251514727348;4205.768682722449;4258.169656916903;4264.637505812009;4290.270653988799;226964;227667;228506;229019;229352;52921.2061819073;53232.73383633057;53265.2010219847;53312;53496.19755703668;49676.75161624169;51935;54872;61359.38640613537;61658.38341616526;15683.921580392025;15765.290561924741;15773.05361678303;15782.921085394499;15790.526284211492;13513.459461621622;13584.388702508213;13606.38771255296;13607.115537490032;13619;14954.177520236273;16301.266443010092;16478.6704265914;16687.91656041712;17459.47621571355;6062.363451837582;6157.4458298753325;6182.814515564541;6208.317085120633;6221.2845522765465;873.6330741088758;963.6290028339;1004.437514991607;1024.1141412678128;1062.3625824505389;25738.356541086247;26375.868120659274;26490.86754566215;26763;27206.183814485597;1133.2237417368963;1175.9294442333487;1192.2190964917993;1208.3112625803383;1256.6983923858209;14742.852571474148;15279.312430940634;15525.922370388302;15597;15657.843421565867;477258;482794;489015;489114;489313;57782.71108644514;58136;58259.70870145707;58444.415555843894;58484.70757646184;1360.9931950340185;1396.6229118138046;1400.5588239704462;1402.0746307437246;1417.4613646814144;29884.505774710742;30437.473175697505;31117.22206944754;31309.373812523165;31312.21719457032;51680.483195167566;51820.481795181564;51979.74010129925;52055;52155;407508;411415;411435;411549;411940.9402952966;23176.652350215096;24213.75786242115;27308.726912730617;27411.588826167226;27888.44223115567;38622.227555449295;39136.2172756549;39568.2086358277;39987;40013.39979900246;30754.53868191934;31312.843435782674;34076.82961585176;34262.31475370529;34434.48348274728;38115;38167.236655266184;38778.6122138775;38849;39357.606423935395;36920.63079369279;38461;38638.613613864625;39007.414888776126;39024.6097539021;30212.24469388283;30631.234219143807;31385.215369615027;32442.83778581092;34962.65037349594;26507;26585.33536661599;26840.177308685652;26899.86550067237;27114.45771084528 22:49:11 INFO - PROCESS | 1253 | |2;jquery.html;363.1502284653909;365.8664587425589;366.9137752628132;367.69297636473544;377.89607857839076;17246;19026.714599281004;19989.500262493446;20195.293164739236;20235.190592376304;17756.46730598084;18257.26970921165;18662.25350985959;18914.337998170067;18921.148548315323;5494.423085576017;5659.264295641561;5677.57418193635;5677.659340439566;5700.2589663343915;3802.429635554661;3963.544192417866;3964.068443915692;3965.2267807777494;5098.745062746866;5276.445973172819;5477.643953143033;5490.313710786152;5499.560035197174;5512.641678290898;5451.127819548873;5491.533219676312;5523.2543606613;5523.364813046471;5525.944740552583;3668.926621467582;5099.15863882459;5151.484851514856;5271.393789714193;5281.234221037928;11250.718732031683;11298.435078246055;11367.943160284229;11640.708982275426;11688;2005.2480319880044;2199.230269405711;2232.5311684546264;2241.652543855705;2712.9593056103977;9056.094390560957;9273.489958052305;9419.905800941971;11512.07903367737;12925.612231633066;1812.8459080978132;1830.8718389712726;1900.4583693647382;1934.8355389791884;1964.2437661500283;75636.24363756402;78638.60680696617;79722;79760;80103.5994820028;9914.256430767722;10220.642277520252;10316.277860549839;10419.843702344471;10423.322484038514;14267.143971361751;14281.285935703174;14370.065945713495;14380.424783008772;14394.20831854258;7608;8037.35701143907;8066.475679080841;8177.427580069338;8204.753857384288;7954.84090318202;8035.156308587631;8116.837663246702;8148.22591853773;8171.305439037629;4160.979195104005;4193.6645068394455;4293.656507479394;4344.891377715519;4496.123255965055;1721.8536424404067;1771.1852547828144;1771.9114044297992;1814.6461440019334;1829.773510952356;912.3203213605906;986.6891929042329;1022.9386236825815;1029.902159294866;1039.4542864995788;17312.22095005728;17633.206505707272;17812;17884.821151788317;18048.09759512019;995.3679413572434;1001;1001.1840350114634;1004.5328922051282;1083.6099004358425;9836.803263934824;10117.949410252902;10231.846522302172;10270.216570633906;10304.33021853592;480606;482514;483147;493120;498656;90443.54778226066;90796.54601726949;90841.54579227194;91580;91662.54168729113;925.8379783537854;1000.2198285337448;1037.7509397744486;1055.8785739640039;1066.6000249906285;14664.193469358861;15117.848821511645;15197.468088616846;15504.767428488356;15664.686706266039;26875.73124268732;32748.50877236891;32990.83504582462;34080.829595852854;35047.47428788519;46081.76959115317;47787.76106119447;49928.25107623316;49951;50344.49655503545;8015.078265999485;8164.224398682116;8177.141400152898;8186.362727454414;8286.792830179053;12043.879561204276;12960.481580736665;13053.543125990926;13057.673558161123;13077.869221307665;7839.451238413257;10414.698162729659;11104.888951110386;11273.549058037916;11611.303321800719;11074.5570177192;11146.108311334912;11267.718307042389;11393.316401015965;11400.828987565359;11242.213045086766;11471.770564588829;11475.311481311148;11722.58970936013;11785.233959792586;7815.413843961612;7931.087924888711;7944.245296696805;8084.959575202086;8201.671933122609;10710.678679639623;10927.726806829893;11122.221444499131;11375.601853935405;11571.421428928352 22:49:11 INFO - PROCESS | 1253 | |3;mootools.html;1247.2329517346834;1391.2556782121565;1422.7510185717497;1534.8541888520588;1746.1356628468902;7152.0702308699865;7483.027206463165;7485.812854678636;7498.81252968676;7505.924940750605;7196.676149573269;7313.268673132684;7318.780436586898;7319.30466605673;7345.7428989985365;1910.9808901910942;2084.3851063936177;2121.575684863026;2146.7638559758416;2150.7526634437004;2101.3275751759443;2112.566923780629;2114.8413868959888;2116.0477784996815;2122.108714339981;1992.163291417601;2073.8444616653737;2075.3462659262286;2076.9584608307823;2077.3144862195513;1814.5645045189192;2028.0974966140075;2093.0267425646994;2094.7591027031935;2095.036283309679;2105.4315334859657;2106.441792924876;2121.6075026120216;2130.2224687988773;2138.0592539282666;7271.309225623558;7322.157951835554;7353.1176258848745;7371.26287371264;7372.189059203483;4308.763018034007;4447.266201076818;4456.9331460028125;4483.125790470859;4517.096580683843;2850.2019434558356;2860.342121312089;2893.030834670388;2906.796524243304;2920.9123726288035;907.0883761819396;937.5546615357719;944.4191822029471;947.4599478297373;958.4872093429982;10154.136898363575;10179.592816287413;10181.18550515957;10215.336003159771;10247.077763001365;3925.1364699766004;3979.2439436507548;4031.23406552754;4047.0287131088326;4115.97942010294;8608.526531040729;8679.913200868037;8681.088485709037;8682.95658521716;8684.826303473896;4247.320428731388;4539.432570928634;4609.285560738091;4627.375304333872;4631.212693842055;4161.687873409506;4257.084726783756;4265.424167737316;4283.935740963888;4284.057507348379;3414.283000569908;3446.7070299024863;3447.775894566895;3484.756067075331;3526.4710293455673;1119.6025410979148;1128.774245150973;1133.0935251798528;1138.8177891537314;1139.9544018239178;765.689895592286;785.5247575217026;851;928.9024652411534;948.3361646847235;4919.926201106986;5084.3644544431945;5085.669431486942;5191.377034755778;5210.036143313499;349.2884864165609;354.27550658902607;359.63676686546773;371.35199077609747;383.44017734107956;3519.1720528173387;3558.4840198171637;3560.786352818839;3571;3634.9273014539563;8786.516741579147;9191.034941331063;9255;9272.165505104573;9287.442753434816;9042.63829446828;9112.271018318519;9115.68095116681;9183.678571249975;9184.265258779415;6869.347411995853;6995.545289556163;7059.047028651169;7063.717451301993;7064.646767661597;4845.830395936126;4994.126027945168;5025.396952365593;5095;5105.1576489880235;8521.744347669579;8588.871166932626;8617;8663.913360866563;8681.782955426164;8418.116097809887;8649.437786543855;8681.175288347597;8807.91192088071;8846.248068914214;6152.354002829638;6303.36966303366;6486.675666216576;6711.194656641234;6798.082258895183;6842.110525631835;6862.4853136016;6902.723891044503;6903.1716194055025;6922.61925594077;6394.552381333262;6582.11141495911;6599.934000660124;6615.4376877965915;6674.866502670016;6334.271558770801;6340.682965851781;6353.936460635335;6416.230052393743;6460.644664543495;5870.618409803349;5897.410258974069;5928.466438020599;5928.525717942468;5934.368048786619;4362.738235705868;4385.210662080856;4387.956120438883;4390.278027622894;4428.247197976288;4396.472423309224;4419.292913133883;4493.370928070138;4499.235130027838;4515.9774201128785 22:49:11 INFO - PROCESS | 1253 | |4;prototype.html;284.4368151060899;291.13532807561546;293.18640771858094;293.3121829310267;294.5625745767534;5060.4686507916595;5144.151215049513;5242.7640756165965;5321.733913304334;5346.786128554858;5222.477752224785;5253.789848406059;5257.526822585976;5267.973660131704;5268.631195816294;4016.979915100435;4026.879193624196;4039.555648878621;4055.128147448298;4059.3505039193733;3822.7132965027736;3828.3874580067195;4014.1971605678837;4015.7188996770237;4029.899252518696;3948.466956960817;4030.0932290234755;4031.395290706388;4036.9798151009204;4043.5147782266167;4000.299947509174;4001.5398229203724;4003.2794097062515;4012.4583181270445;4014.5383280922483;3455.9654403456148;3501.9824900875587;3506.7194624429985;3507.824608769551;3510.3856825055514;5022.146235139999;5025.572826309768;5056.898862022739;5057.747112644353;5061.797528098871;4541.750203738793;4564.908701825978;4569.497355290915;4580.587747102777;4585.449746030497;5206.557442617382;5424.694504835468;5456;5460.580249135213;5485.451454854522;3694.538182727159;3704.2035962267973;3728.6457786510236;3738.214974855284;3743.401055831054;5671.943280567183;5691.430856914317;5748.419184724193;5754.568407369422;5759.5968282220265;3578.141246100917;3782.3759079752085;3791.734578579473;3792.6965842732516;3804.7907365094634;3848.942265866014;3858.864939727096;3859.864904728377;3869.5356557212754;3874.903127421837;4468.64250859937;4481.2381895077915;4497.572730590588;4506.391637128946;4519.909601808011;5504.788946431779;5508;5516.448355164532;5518.751656175482;5571.164325351148;1366.4261010375667;1397.413086503671;1398.9020768546104;1400.4608225832924;1405.2341473896752;881.713443130985;882.7837179890968;900.8738776571286;904.7240591619619;910.4582773249906;5609.5512359012;5645.68948707825;5645.9717701412055;5646.802361917313;5648.661080335193;5967.970160149258;5976.193213916065;5985.880282394328;5993.820185394445;5998.910016349758;5098.694078355311;5339.650553756334;5360.785568577213;5618.539179813278;5623.297087864017;3227.9670505438503;3239.2873567815045;3250.7724459287624;3258.3483303339426;3259.511073339018;5745.454181852718;6284.4344009039405;6285.59143655661;6289.150964619809;6307.653079080603;5825.766969321265;5850.063989761617;5856.5944173398075;5867;5896.439838215363;5873.295204575478;5906.438888305604;5920.5559583031445;5938.257717785277;5942.940570594325;5531.529819965348;5712.400197979152;5735.225744524436;5736.913946290892;5762.423757624204;5677.574181936288;5690.174924635822;5694.174344720075;5696.772129114789;5702.287214098238;5626.465485778845;5846.5615078870105;5929.347771745019;5947.226860508106;5955.166276721176;3630.854765809338;3644.9635503645686;3751.15598990225;3813.866514671973;3814.942775858309;5654.180143879197;5681.488666020078;5686.175504551734;5698.549623661866;5709.0865461525955;5484.012877682056;5490.780368785204;5517.944820551743;5531.253280807039;5532.1425179097305;5296.602754793483;5465.207544906046;5480.177973304037;5492.121260598445;5527.281453411031;5360.2227676987395;5427.6200665953;5442.537384322377;5450.945490545202;5474.151506516497;5413.188021796762;5457.645253058538;5550.306211723535;5552.500274975271;5574.749136288796;5386.353637563518;5434.402215756185;5446.210299506629;5451.945480545144;5454.209139674805 22:49:11 INFO - PROCESS | 1253 | |5;yui.html;691.1740470138185;713.9892901606473;736.6169591812258;744.3301029073833;782.4483738964024;12829.679258018554;13603.591892243236;13622.523211687592;13783.724325513484;13894.791578126336;12923.09538332317;12979.740405191891;12980.675483112927;13017.08880378374;13018;680.2924958043628;794.876794096913;800.451690591945;824.5959479854888;825.5748289630845;810.623060276971;817.2195553246635;818.0306336990656;820.4011071917504;821.1747194069951;854.9871751923727;855.8502262104138;856.4133568505563;856.6659002988808;860.793409581699;705.6471764117941;816.5264146794874;852.3266619370689;856.8500512410303;857.5969294431607;616.0574321288391;620.4106099205773;626.8808926303988;627.8179327994922;628.4815027602201;13575;13600.115992460458;13606.795898061537;13637.454501819915;13914.30428478572;13004.349782510837;13276.734465310736;13286.468541258339;13331.266780327078;13630.727385452235;10746.516406761715;10867.215926553868;10894.782104357868;11289.435528223637;11369;3728.645778651051;3759.588636938395;3782.0733920189455;3834.789086600236;3924.058226025762;50647.493525064645;50820.74589627065;52817.47182528164;53237.20144197879;53247;10824.78350432987;10998.230123891411;11040.779184416268;11053.115750739922;11265.436728163559;19158.71261931072;19185.61628767445;19365.709514357295;19371.4188574343;19584.412467625993;7974.52152870818;8006.759797206093;8070.959645201737;8090.150534193943;8097.433179677366;4587.977060114678;4644.233701439292;4722.456917454468;4749.525047495223;4774.236122220497;3104.767142464324;3199.77601567888;3203.743700503954;3213.6304325002925;3217.951730724041;578.3233616668424;595.1816252652603;598.3537779198455;605.7425594122568;614.4163045107166;594.4293478260831;679.2256827216977;696.7004188199123;711.4841739738752;717.9533330333512;8860.158284962918;9017.639294428149;9059.22996545301;9117.225035871892;9311.580978855833;674.8043067510465;689.2074114768056;711.1466240511407;716.6022857314136;734.9816254593678;4261.680373971964;4375.387445757597;4387.758673273001;4494.910101797946;4513.119941611354;52445;63914;65257.347426526074;65645.34354656488;65816.01275980864;48509;49357.01285974332;53875;54049.72975135099;54351;49056;49647.50352496501;49845;50138.74930625324;50673.99672338538;8863.512506812187;8906.376553641183;8941.776455588662;8962.759310172456;9037.09629037091;32858.50712239271;33017.33965320728;33291.334173316885;33311.50032749559;34489.31021379609;40853.59146408498;44677.55322446864;44744.105117898114;45284.09431811411;45401;12039.699007524881;12206.938965305117;12247.693807654523;12344.62966111018;12477.126601137834;13075.607731768063;13190.868091318964;13286.601401957956;13401.66495837612;13423.993200510196;11851.585194518151;11883.287002779514;11971.940140299243;12015.339156346485;12498.500059997497;12414.441350139085;12486.43811028524;12712.872871271538;12753.234805911305;12884.613461596167;11970.22193557416;12161.87838121643;12313.692157696129;12320.137590368588;12807.10350275509;10009.449480278654;10113.393196407944;10209.84685229737;10232;10668.89331106679;10036.598536058476;10370.222233332379;10396.064354208158;10407.375557466576;10482.790344192921 22:49:11 INFO - PROCESS | 1253 | __end_tp_report 22:49:11 INFO - PROCESS | 1253 | __start_cc_report 22:49:11 INFO - PROCESS | 1253 | _x_x_mozilla_cycle_collect,949 22:49:11 INFO - PROCESS | 1253 | __end_cc_report 22:49:11 INFO - PROCESS | 1253 | __startTimestamp1462168151860__endTimestamp 22:49:11 INFO - PROCESS | 1253 | 22:49:11 INFO - PROCESS | 1253 | ------- Summary: start ------- 22:49:11 INFO - PROCESS | 1253 | Number of tests: 6 22:49:11 INFO - PROCESS | 1253 | 22:49:11 INFO - PROCESS | 1253 | [#0] dojo.html Cycles:165 Average:5091.04 Median:5250.40 stddev:545.19 (10.4%) stddev-sans-first:521.96 22:49:11 INFO - PROCESS | 1253 | Values: 3014.4 3079.6 3110.3 3111.5 3140.5 5008.7 5091.5 5163.8 5206.2 5237.4 5109.2 5148.6 5184.7 5194.4 5204.6 4617.6 4657.6 4685.9 4745.1 4805.1 4714.3 4762.9 4774.3 4777.9 4805.5 4657.3 4666.8 4743.6 4748.5 4759.7 4676.7 4701.0 4705.1 4708.9 4743.0 4614.7 4632.8 4636.2 4642.6 4687.4 4972.1 5008.3 5029.3 5043.5 5119.5 5383.8 5405.2 5423.5 5429.1 5477.7 5448.3 5470.9 5471.4 5473.8 5475.7 5042.3 5120.3 5191.9 5216.1 5221.4 5586.5 5592.9 5596.8 5641.1 5647.8 5377.5 5387.1 5388.2 5390.0 5392.8 5323.5 5420.1 5435.0 5498.5 5518.8 5413.3 5414.4 5420.8 5421.1 5427.2 5431.7 5433.7 5436.8 5437.6 5443.3 4100.5 4211.7 4216.9 4270.0 4273.7 3791.0 3797.9 3798.3 3798.8 3837.4 4942.8 5175.6 5191.8 5197.7 5241.7 5377.2 5418.2 5441.2 5480.0 5485.5 5145.3 5154.9 5197.6 5204.5 5245.8 4605.9 4746.3 4756.0 4762.9 4763.0 5614.2 5676.8 5683.7 5708.0 5739.1 5492.8 5501.8 5511.1 5512.8 5513.6 5512.8 5583.2 5661.4 5662.0 5665.1 5389.7 5394.9 5404.7 5408.6 5442.8 5462.6 5463.2 5470.3 5476.7 5516.2 5243.9 5249.8 5324.8 5332.0 5333.1 5291.6 5306.0 5323.4 5326.8 5352.4 5192.4 5243.1 5247.3 5255.9 5300.3 5185.8 5341.1 5354.2 5422.8 5429.1 5215.3 5250.4 5250.5 5260.1 5314.0 22:49:11 INFO - PROCESS | 1253 | 22:49:11 INFO - PROCESS | 1253 | [#1] ext.html Cycles:180 Average:52719.39 Median:38541.61 stddev:103657.02 (268.9%) stddev-sans-first:103873.94 22:49:11 INFO - PROCESS | 1253 | Values: 597.6 617.9 618.9 636.4 639.3 32629.3 33917.5 33932.2 34113.0 34449.1 33135.8 33435.5 33573.7 33747.0 33769.0 7971.4 8202.3 8203.0 8215.9 8218.8 8276.2 8396.2 8406.7 8683.0 8693.2 8746.7 8773.6 8813.9 8820.2 8824.3 8619.9 8668.6 8682.0 8683.6 8685.7 8493.5 8619.6 8633.9 8641.0 8658.4 41051.8 41363.6 41553.0 41641.0 41729.0 3244.9 3502.9 3508.8 3709.0 3878.2 31231.4 31378.4 31783.7 32026.7 32071.8 4158.3 4205.8 4258.2 4264.6 4290.3 226964.0 227667.0 228506.0 229019.0 229352.0 52921.2 53232.7 53265.2 53312.0 53496.2 49676.8 51935.0 54872.0 61359.4 61658.4 15683.9 15765.3 15773.1 15782.9 15790.5 13513.5 13584.4 13606.4 13607.1 13619.0 14954.2 16301.3 16478.7 16687.9 17459.5 6062.4 6157.4 6182.8 6208.3 6221.3 873.6 963.6 1004.4 1024.1 1062.4 25738.4 26375.9 26490.9 26763.0 27206.2 1133.2 1175.9 1192.2 1208.3 1256.7 14742.9 15279.3 15525.9 15597.0 15657.8 477258.0 482794.0 489015.0 489114.0 489313.0 57782.7 58136.0 58259.7 58444.4 58484.7 1361.0 1396.6 1400.6 1402.1 1417.5 29884.5 30437.5 31117.2 31309.4 31312.2 51680.5 51820.5 51979.7 52055.0 52155.0 407508.0 411415.0 411435.0 411549.0 411940.9 23176.7 24213.8 27308.7 27411.6 27888.4 38622.2 39136.2 39568.2 39987.0 40013.4 30754.5 31312.8 34076.8 34262.3 34434.5 38115.0 38167.2 38778.6 38849.0 39357.6 36920.6 38461.0 38638.6 39007.4 39024.6 30212.2 30631.2 31385.2 32442.8 34962.7 26507.0 26585.3 26840.2 26899.9 27114.5 22:49:11 INFO - PROCESS | 1253 | 22:49:11 INFO - PROCESS | 1253 | [#2] jquery.html Cycles:180 Average:27634.59 Median:17730.73 stddev:80374.41 (453.3%) stddev-sans-first:80573.79 22:49:11 INFO - PROCESS | 1253 | Values: 363.2 365.9 366.9 367.7 377.9 17246.0 19026.7 19989.5 20195.3 20235.2 17756.5 18257.3 18662.3 18914.3 18921.1 5494.4 5659.3 5677.6 5677.7 5700.3 3802.4 3963.5 3964.1 3965.2 5098.7 5276.4 5477.6 5490.3 5499.6 5512.6 5451.1 5491.5 5523.3 5523.4 5525.9 3668.9 5099.2 5151.5 5271.4 5281.2 11250.7 11298.4 11367.9 11640.7 11688.0 2005.2 2199.2 2232.5 2241.7 2713.0 9056.1 9273.5 9419.9 11512.1 12925.6 1812.8 1830.9 1900.5 1934.8 1964.2 75636.2 78638.6 79722.0 79760.0 80103.6 9914.3 10220.6 10316.3 10419.8 10423.3 14267.1 14281.3 14370.1 14380.4 14394.2 7608.0 8037.4 8066.5 8177.4 8204.8 7954.8 8035.2 8116.8 8148.2 8171.3 4161.0 4193.7 4293.7 4344.9 4496.1 1721.9 1771.2 1771.9 1814.6 1829.8 912.3 986.7 1022.9 1029.9 1039.5 17312.2 17633.2 17812.0 17884.8 18048.1 995.4 1001.0 1001.2 1004.5 1083.6 9836.8 10117.9 10231.8 10270.2 10304.3 480606.0 482514.0 483147.0 493120.0 498656.0 90443.5 90796.5 90841.5 91580.0 91662.5 925.8 1000.2 1037.8 1055.9 1066.6 14664.2 15117.8 15197.5 15504.8 15664.7 26875.7 32748.5 32990.8 34080.8 35047.5 46081.8 47787.8 49928.3 49951.0 50344.5 8015.1 8164.2 8177.1 8186.4 8286.8 12043.9 12960.5 13053.5 13057.7 13077.9 7839.5 10414.7 11104.9 11273.5 11611.3 11074.6 11146.1 11267.7 11393.3 11400.8 11242.2 11471.8 11475.3 11722.6 11785.2 7815.4 7931.1 7944.2 8085.0 8201.7 10710.7 10927.7 11122.2 11375.6 11571.4 22:49:11 INFO - PROCESS | 1253 | 22:49:11 INFO - PROCESS | 1253 | [#3] mootools.html Cycles:180 Average:4918.05 Median:4882.88 stddev:2745.82 (56.2%) stddev-sans-first:2739.67 22:49:11 INFO - PROCESS | 1253 | Values: 1247.2 1391.3 1422.8 1534.9 1746.1 7152.1 7483.0 7485.8 7498.8 7505.9 7196.7 7313.3 7318.8 7319.3 7345.7 1911.0 2084.4 2121.6 2146.8 2150.8 2101.3 2112.6 2114.8 2116.0 2122.1 1992.2 2073.8 2075.3 2077.0 2077.3 1814.6 2028.1 2093.0 2094.8 2095.0 2105.4 2106.4 2121.6 2130.2 2138.1 7271.3 7322.2 7353.1 7371.3 7372.2 4308.8 4447.3 4456.9 4483.1 4517.1 2850.2 2860.3 2893.0 2906.8 2920.9 907.1 937.6 944.4 947.5 958.5 10154.1 10179.6 10181.2 10215.3 10247.1 3925.1 3979.2 4031.2 4047.0 4116.0 8608.5 8679.9 8681.1 8683.0 8684.8 4247.3 4539.4 4609.3 4627.4 4631.2 4161.7 4257.1 4265.4 4283.9 4284.1 3414.3 3446.7 3447.8 3484.8 3526.5 1119.6 1128.8 1133.1 1138.8 1140.0 765.7 785.5 851.0 928.9 948.3 4919.9 5084.4 5085.7 5191.4 5210.0 349.3 354.3 359.6 371.4 383.4 3519.2 3558.5 3560.8 3571.0 3634.9 8786.5 9191.0 9255.0 9272.2 9287.4 9042.6 9112.3 9115.7 9183.7 9184.3 6869.3 6995.5 7059.0 7063.7 7064.6 4845.8 4994.1 5025.4 5095.0 5105.2 8521.7 8588.9 8617.0 8663.9 8681.8 8418.1 8649.4 8681.2 8807.9 8846.2 6152.4 6303.4 6486.7 6711.2 6798.1 6842.1 6862.5 6902.7 6903.2 6922.6 6394.6 6582.1 6599.9 6615.4 6674.9 6334.3 6340.7 6353.9 6416.2 6460.6 5870.6 5897.4 5928.5 5928.5 5934.4 4362.7 4385.2 4388.0 4390.3 4428.2 4396.5 4419.3 4493.4 4499.2 4516.0 22:49:11 INFO - PROCESS | 1253 | 22:49:11 INFO - PROCESS | 1253 | [#4] prototype.html Cycles:180 Average:4636.14 Median:5373.57 stddev:1419.86 (26.4%) stddev-sans-first:1385.76 22:49:11 INFO - PROCESS | 1253 | Values: 284.4 291.1 293.2 293.3 294.6 5060.5 5144.2 5242.8 5321.7 5346.8 5222.5 5253.8 5257.5 5268.0 5268.6 4017.0 4026.9 4039.6 4055.1 4059.4 3822.7 3828.4 4014.2 4015.7 4029.9 3948.5 4030.1 4031.4 4037.0 4043.5 4000.3 4001.5 4003.3 4012.5 4014.5 3456.0 3502.0 3506.7 3507.8 3510.4 5022.1 5025.6 5056.9 5057.7 5061.8 4541.8 4564.9 4569.5 4580.6 4585.4 5206.6 5424.7 5456.0 5460.6 5485.5 3694.5 3704.2 3728.6 3738.2 3743.4 5671.9 5691.4 5748.4 5754.6 5759.6 3578.1 3782.4 3791.7 3792.7 3804.8 3848.9 3858.9 3859.9 3869.5 3874.9 4468.6 4481.2 4497.6 4506.4 4519.9 5504.8 5508.0 5516.4 5518.8 5571.2 1366.4 1397.4 1398.9 1400.5 1405.2 881.7 882.8 900.9 904.7 910.5 5609.6 5645.7 5646.0 5646.8 5648.7 5968.0 5976.2 5985.9 5993.8 5998.9 5098.7 5339.7 5360.8 5618.5 5623.3 3228.0 3239.3 3250.8 3258.3 3259.5 5745.5 6284.4 6285.6 6289.2 6307.7 5825.8 5850.1 5856.6 5867.0 5896.4 5873.3 5906.4 5920.6 5938.3 5942.9 5531.5 5712.4 5735.2 5736.9 5762.4 5677.6 5690.2 5694.2 5696.8 5702.3 5626.5 5846.6 5929.3 5947.2 5955.2 3630.9 3645.0 3751.2 3813.9 3814.9 5654.2 5681.5 5686.2 5698.5 5709.1 5484.0 5490.8 5517.9 5531.3 5532.1 5296.6 5465.2 5480.2 5492.1 5527.3 5360.2 5427.6 5442.5 5450.9 5474.2 5413.2 5457.6 5550.3 5552.5 5574.7 5386.4 5434.4 5446.2 5451.9 5454.2 22:49:11 INFO - PROCESS | 1253 | 22:49:11 INFO - PROCESS | 1253 | [#5] yui.html Cycles:180 Average:14474.27 Median:24619.51 stddev:16734.63 (68.0%) stddev-sans-first:16749.57 22:49:11 INFO - PROCESS | 1253 | Values: 691.2 714.0 736.6 744.3 782.4 12829.7 13603.6 13622.5 13783.7 13894.8 12923.1 12979.7 12980.7 13017.1 13018.0 680.3 794.9 800.5 824.6 825.6 810.6 817.2 818.0 820.4 821.2 855.0 855.9 856.4 856.7 860.8 705.6 816.5 852.3 856.9 857.6 616.1 620.4 626.9 627.8 628.5 13575.0 13600.1 13606.8 13637.5 13914.3 13004.3 13276.7 13286.5 13331.3 13630.7 10746.5 10867.2 10894.8 11289.4 11369.0 3728.6 3759.6 3782.1 3834.8 3924.1 50647.5 50820.7 52817.5 53237.2 53247.0 10824.8 10998.2 11040.8 11053.1 11265.4 19158.7 19185.6 19365.7 19371.4 19584.4 7974.5 8006.8 8071.0 8090.2 8097.4 4588.0 4644.2 4722.5 4749.5 4774.2 3104.8 3199.8 3203.7 3213.6 3218.0 578.3 595.2 598.4 605.7 614.4 594.4 679.2 696.7 711.5 718.0 8860.2 9017.6 9059.2 9117.2 9311.6 674.8 689.2 711.1 716.6 735.0 4261.7 4375.4 4387.8 4494.9 4513.1 52445.0 63914.0 65257.3 65645.3 65816.0 48509.0 49357.0 53875.0 54049.7 54351.0 49056.0 49647.5 49845.0 50138.7 50674.0 8863.5 8906.4 8941.8 8962.8 9037.1 32858.5 33017.3 33291.3 33311.5 34489.3 40853.6 44677.6 44744.1 45284.1 45401.0 12039.7 12206.9 12247.7 12344.6 12477.1 13075.6 13190.9 13286.6 13401.7 13424.0 11851.6 11883.3 11971.9 12015.3 12498.5 12414.4 12486.4 12712.9 12753.2 12884.6 11970.2 12161.9 12313.7 12320.1 12807.1 10009.4 10113.4 10209.8 10232.0 10668.9 10036.6 10370.2 10396.1 10407.4 10482.8 22:49:11 INFO - PROCESS | 1253 | -------- Summary: end -------- 22:49:11 INFO - PROCESS | 1253 | 22:49:12 INFO - TEST-INFO | 1253: exit 0 22:49:12 INFO - TEST-OK | dromaeo_css | took 1111701ms 22:49:12 INFO - TEST-START | kraken 22:49:12 INFO - operating with platform_type : linux_ 22:49:12 INFO - Initialising browser for kraken test... 22:49:12 INFO - TEST-INFO | started process 1434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZDSWNg/profile http://localhost:50924/getInfo.html) 22:49:16 INFO - PROCESS | 1434 | __metrics Screen width/height:1600/1200 22:49:16 INFO - PROCESS | 1434 | colorDepth:24 22:49:16 INFO - PROCESS | 1434 | Browser inner width/height: 1024/697 22:49:16 INFO - PROCESS | 1434 | __metrics 22:49:17 ERROR - PROCESS | 1434 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:49:18 INFO - TEST-INFO | 1434: exit 0 22:49:18 INFO - Browser initialized. 22:49:18 INFO - Running cycle 1/1 for kraken test... 22:49:18 INFO - TEST-INFO | started process 1514 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZDSWNg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:49:30 INFO - PROCESS | 1514 | RSS: Main: 154365952 22:49:30 INFO - PROCESS | 1514 | 22:49:32 INFO - PROCESS | 1514 | Cycle 1(1): loaded http://localhost:50924/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50924/tests/kraken/driver.html?testName=audio-beat-detection) 22:49:33 INFO - PROCESS | 1514 | RSS: Main: 209793024 22:49:33 INFO - PROCESS | 1514 | 22:49:36 INFO - PROCESS | 1514 | Cycle 1(1): loaded http://localhost:50924/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50924/tests/kraken/driver.html?testName=audio-dft) 22:49:37 INFO - PROCESS | 1514 | RSS: Main: 196001792 22:49:37 INFO - PROCESS | 1514 | 22:49:40 INFO - PROCESS | 1514 | Cycle 1(1): loaded http://localhost:50924/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50924/tests/kraken/driver.html?testName=audio-fft) 22:49:40 INFO - PROCESS | 1514 | RSS: Main: 266661888 22:49:40 INFO - PROCESS | 1514 | 22:49:42 INFO - PROCESS | 1514 | Cycle 1(1): loaded http://localhost:50924/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50924/tests/kraken/driver.html?testName=audio-oscillator) 22:49:43 INFO - PROCESS | 1514 | RSS: Main: 174850048 22:49:43 INFO - PROCESS | 1514 | 22:49:45 INFO - PROCESS | 1514 | Cycle 1(1): loaded http://localhost:50924/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50924/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:49:46 INFO - PROCESS | 1514 | RSS: Main: 178565120 22:49:46 INFO - PROCESS | 1514 | 22:49:49 INFO - PROCESS | 1514 | Cycle 1(1): loaded http://localhost:50924/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50924/tests/kraken/driver.html?testName=imaging-darkroom) 22:49:49 INFO - PROCESS | 1514 | RSS: Main: 214450176 22:49:49 INFO - PROCESS | 1514 | 22:49:53 INFO - PROCESS | 1514 | Cycle 1(1): loaded http://localhost:50924/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50924/tests/kraken/driver.html?testName=imaging-desaturate) 22:49:53 INFO - PROCESS | 1514 | RSS: Main: 215592960 22:49:53 INFO - PROCESS | 1514 | 22:49:56 INFO - PROCESS | 1514 | Cycle 1(1): loaded http://localhost:50924/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50924/tests/kraken/driver.html?testName=json-parse-financial) 22:49:57 INFO - PROCESS | 1514 | RSS: Main: 215474176 22:49:57 INFO - PROCESS | 1514 | 22:49:58 INFO - PROCESS | 1514 | Cycle 1(1): loaded http://localhost:50924/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50924/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:49:59 INFO - PROCESS | 1514 | RSS: Main: 205144064 22:49:59 INFO - PROCESS | 1514 | 22:50:01 INFO - PROCESS | 1514 | Cycle 1(1): loaded http://localhost:50924/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50924/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:50:01 INFO - PROCESS | 1514 | RSS: Main: 205312000 22:50:01 INFO - PROCESS | 1514 | 22:50:03 INFO - PROCESS | 1514 | Cycle 1(1): loaded http://localhost:50924/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50924/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:50:04 INFO - PROCESS | 1514 | RSS: Main: 216440832 22:50:04 INFO - PROCESS | 1514 | 22:50:07 INFO - PROCESS | 1514 | Cycle 1(1): loaded http://localhost:50924/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50924/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:50:07 INFO - PROCESS | 1514 | RSS: Main: 224358400 22:50:07 INFO - PROCESS | 1514 | 22:50:10 INFO - PROCESS | 1514 | Cycle 1(1): loaded http://localhost:50924/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50924/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:50:11 INFO - PROCESS | 1514 | RSS: Main: 220893184 22:50:11 INFO - PROCESS | 1514 | 22:50:12 INFO - PROCESS | 1514 | Cycle 1(1): loaded http://localhost:50924/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50924/tests/kraken/driver.html?testName=ai-astar) 22:50:13 INFO - PROCESS | 1514 | RSS: Main: 285429760 22:50:13 INFO - PROCESS | 1514 | 22:50:13 INFO - PROCESS | 1514 | __start_tp_report 22:50:13 INFO - PROCESS | 1514 | _x_x_mozilla_page_load 22:50:13 INFO - PROCESS | 1514 | _x_x_mozilla_page_load_details 22:50:13 INFO - PROCESS | 1514 | |i|pagename|runs| 22:50:13 INFO - PROCESS | 1514 | |0;ai-astar;112;113;110;111;112;113;102;112;112;111 22:50:13 INFO - PROCESS | 1514 | |1;audio-beat-detection;158;127;155;182;138;157;156;128;184;131 22:50:13 INFO - PROCESS | 1514 | |2;audio-dft;160;159;161;159;160;159;160;161;161;161 22:50:13 INFO - PROCESS | 1514 | |3;audio-fft;78;87;109;113;78;79;79;127;105;78 22:50:13 INFO - PROCESS | 1514 | |4;audio-oscillator;93;94;149;94;93;94;149;92;92;151 22:50:13 INFO - PROCESS | 1514 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 22:50:13 INFO - PROCESS | 1514 | |6;imaging-darkroom;145;146;146;146;145;146;146;145;145;145 22:50:13 INFO - PROCESS | 1514 | |7;imaging-desaturate;94;94;95;95;95;94;95;95;95;94 22:50:13 INFO - PROCESS | 1514 | |8;json-parse-financial;56;57;57;58;58;57;57;76;55;54 22:50:13 INFO - PROCESS | 1514 | |9;json-stringify-tinderbox;64;62;62;63;63;62;63;63;65;69 22:50:13 INFO - PROCESS | 1514 | |10;stanford-crypto-aes;79;76;77;78;79;79;79;79;80;80 22:50:13 INFO - PROCESS | 1514 | |11;stanford-crypto-ccm;126;131;124;122;121;123;126;123;164;122 22:50:13 INFO - PROCESS | 1514 | |12;stanford-crypto-pbkdf2;167;172;168;170;168;173;168;175;163;166 22:50:13 INFO - PROCESS | 1514 | |13;stanford-crypto-sha256-iterative;72;71;70;72;69;70;69;69;71;68 22:50:13 INFO - PROCESS | 1514 | __end_tp_report 22:50:13 INFO - PROCESS | 1514 | __start_cc_report 22:50:13 INFO - PROCESS | 1514 | _x_x_mozilla_cycle_collect,1665 22:50:13 INFO - PROCESS | 1514 | __end_cc_report 22:50:13 INFO - PROCESS | 1514 | __startTimestamp1462168213182__endTimestamp 22:50:13 INFO - PROCESS | 1514 | 22:50:13 INFO - PROCESS | 1514 | ------- Summary: start ------- 22:50:13 INFO - PROCESS | 1514 | Number of tests: 14 22:50:13 INFO - PROCESS | 1514 | 22:50:13 INFO - PROCESS | 1514 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.22 (2.9%) stddev-sans-first:3.39 22:50:13 INFO - PROCESS | 1514 | Values: 112.0 113.0 110.0 111.0 112.0 113.0 102.0 112.0 112.0 111.0 22:50:13 INFO - PROCESS | 1514 | 22:50:13 INFO - PROCESS | 1514 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:156.50 stddev:20.67 (13.2%) stddev-sans-first:21.80 22:50:13 INFO - PROCESS | 1514 | Values: 158.0 127.0 155.0 182.0 138.0 157.0 156.0 128.0 184.0 131.0 22:50:13 INFO - PROCESS | 1514 | 22:50:13 INFO - PROCESS | 1514 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.50 stddev:0.88 (0.5%) stddev-sans-first:0.93 22:50:13 INFO - PROCESS | 1514 | Values: 160.0 159.0 161.0 159.0 160.0 159.0 160.0 161.0 161.0 161.0 22:50:13 INFO - PROCESS | 1514 | 22:50:13 INFO - PROCESS | 1514 | [#3] audio-fft Cycles:10 Average:93.30 Median:78.00 stddev:18.43 (23.6%) stddev-sans-first:18.70 22:50:13 INFO - PROCESS | 1514 | Values: 78.0 87.0 109.0 113.0 78.0 79.0 79.0 127.0 105.0 78.0 22:50:13 INFO - PROCESS | 1514 | 22:50:13 INFO - PROCESS | 1514 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:93.00 stddev:27.32 (29.4%) stddev-sans-first:28.27 22:50:13 INFO - PROCESS | 1514 | Values: 93.0 94.0 149.0 94.0 93.0 94.0 149.0 92.0 92.0 151.0 22:50:13 INFO - PROCESS | 1514 | 22:50:13 INFO - PROCESS | 1514 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 22:50:13 INFO - PROCESS | 1514 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 22:50:13 INFO - PROCESS | 1514 | 22:50:13 INFO - PROCESS | 1514 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 22:50:13 INFO - PROCESS | 1514 | Values: 145.0 146.0 146.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 22:50:13 INFO - PROCESS | 1514 | 22:50:13 INFO - PROCESS | 1514 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 22:50:13 INFO - PROCESS | 1514 | Values: 94.0 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 22:50:13 INFO - PROCESS | 1514 | 22:50:13 INFO - PROCESS | 1514 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:57.00 stddev:6.28 (11.0%) stddev-sans-first:6.59 22:50:13 INFO - PROCESS | 1514 | Values: 56.0 57.0 57.0 58.0 58.0 57.0 57.0 76.0 55.0 54.0 22:50:13 INFO - PROCESS | 1514 | 22:50:13 INFO - PROCESS | 1514 | [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:63.00 stddev:2.12 (3.4%) stddev-sans-first:2.24 22:50:13 INFO - PROCESS | 1514 | Values: 64.0 62.0 62.0 63.0 63.0 62.0 63.0 63.0 65.0 69.0 22:50:13 INFO - PROCESS | 1514 | 22:50:13 INFO - PROCESS | 1514 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:79.00 stddev:1.26 (1.6%) stddev-sans-first:1.33 22:50:13 INFO - PROCESS | 1514 | Values: 79.0 76.0 77.0 78.0 79.0 79.0 79.0 79.0 80.0 80.0 22:50:13 INFO - PROCESS | 1514 | 22:50:13 INFO - PROCESS | 1514 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:125.00 stddev:12.91 (10.3%) stddev-sans-first:13.67 22:50:13 INFO - PROCESS | 1514 | Values: 126.0 131.0 124.0 122.0 121.0 123.0 126.0 123.0 164.0 122.0 22:50:13 INFO - PROCESS | 1514 | 22:50:13 INFO - PROCESS | 1514 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:169.00 stddev:3.56 (2.1%) stddev-sans-first:3.70 22:50:13 INFO - PROCESS | 1514 | Values: 167.0 172.0 168.0 170.0 168.0 173.0 168.0 175.0 163.0 166.0 22:50:13 INFO - PROCESS | 1514 | 22:50:13 INFO - PROCESS | 1514 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.50 stddev:1.37 (1.9%) stddev-sans-first:1.27 22:50:13 INFO - PROCESS | 1514 | Values: 72.0 71.0 70.0 72.0 69.0 70.0 69.0 69.0 71.0 68.0 22:50:13 INFO - PROCESS | 1514 | -------- Summary: end -------- 22:50:13 INFO - PROCESS | 1514 | 22:50:14 INFO - TEST-INFO | 1514: exit 0 22:50:14 INFO - TEST-OK | kraken | took 61618ms 22:50:14 INFO - SUITE-END | took 1173s 22:50:14 INFO - Completed test suite (00:19:33) 22:50:14 INFO - javascript benchmark 22:50:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3014.397120575885, 3079.630444346679, 3110.2535391506044, 3111.533270009498, 3140.513220450831, 5008.699478031321, 5091.465396133408, 5163.793448262065, 5206.193040078789, 5237.397699264586, 5109.20807274873, 5148.5623721983675, 5184.7407629618465, 5194.37667479902, 5204.609654275935, 4617.607503362218, 4657.604103651185, 4685.906281874378, 4745.098431298043, 4805.063012712505, 4714.292856071583, 4762.928556071662, 4774.307725379818, 4777.928331075037, 4805.519448055202, 4657.278121891112, 4666.789994450258, 4743.573078422941, 4748.477667456577, 4759.666823322369, 4676.742779147179, 4700.976495117503, 4705.106029854317, 4708.882277943045, 4742.9525704742855, 4614.700044497131, 4632.791524381411, 4636.211843986531, 4642.558956899089, 4687.39063921688, 4972.105021096201, 5008.273800298936, 5029.270755740434, 5043.520865517807, 5119.513646203604, 5383.838484845461, 5405.18922161675, 5423.457654234585, 5429.131338985783, 5477.726113694339, 5448.327019101996, 5470.863228419282, 5471.398146203915, 5473.808416705396, 5475.698836563987, 5042.344495215599, 5120.283160357553, 5191.870203244911, 5216.061109000379, 5221.373435187802, 5586.525145362609, 5592.888142237132, 5596.776128954878, 5641.069223578145, 5647.774089036392, 5377.462253774669, 5387.138057910715, 5388.245645609618, 5390.0, 5392.811251606254, 5323.467653234723, 5420.051490989061, 5435.0, 5498.477644623755, 5518.806841760519, 5413.323334583177, 5414.40441551429, 5420.83737487876, 5421.078416669176, 5427.185922111715, 5431.728413579384, 5433.673979561239, 5436.836894893159, 5437.592180586472, 5443.292371991695, 4100.466939297872, 4211.7472951623, 4216.873493795191, 4270.017895883964, 4273.67947403946, 3791.0, 3797.905052373713, 3798.3352913240074, 3798.772073675588, 3837.4435706822355, 4942.827001055018, 5175.637705360664, 5191.844244672666, 5197.7401129943355, 5241.685498870003, 5377.166539186433, 5418.187271909166, 5441.211024401439, 5480.04099282624, 5485.533729633026, 5145.279660847485, 5154.92267615986, 5197.636165468381, 5204.505571970657, 5245.816396426107, 4605.871561467462, 4746.335513028179, 4755.95244047562, 4762.880927976759, 4762.999770048259, 5614.242077319591, 5676.801311954145, 5683.744231509592, 5708.0, 5739.053056245756, 5492.80775172859, 5501.752421140978, 5511.118221084607, 5512.834614961557, 5513.58648101402, 5512.779488820563, 5583.218349431164, 5661.433856614306, 5662.0, 5665.065264231355, 5389.676619402849, 5394.865128371665, 5404.675719456845, 5408.59435542328, 5442.836714898559, 5462.644928079662, 5463.235147079333, 5470.288862447856, 5476.726163691879, 5516.227728118147, 5243.868903277296, 5249.816256431007, 5324.840254792362, 5332.0402327581405, 5333.093374126485, 5291.603129765206, 5306.0, 5323.361196656426, 5326.760295786621, 5352.411234764095, 5192.3769147702515, 5243.082460569462, 5247.291615631841, 5255.894882102413, 5300.31095957523, 5185.818496352609, 5341.118715411913, 5354.223637572608, 5422.8373148805595, 5429.077056900415, 5215.29593504872, 5250.396204436539, 5250.501202385767, 5260.105782017143, 5314.043472175045], "value": 5056.782336519267, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.590650404473, 617.9134921111042, 618.919984626826, 636.4049613611272, 639.2840019178519, 32629.347413051753, 33917.49123763145, 33932.151696207606, 34112.97661070169, 34449.13877153072, 33135.83432082842, 33435.49846752301, 33573.66426335736, 33747.0, 33769.0, 7971.36229101672, 8202.343812494986, 8202.958985205065, 8215.917840821576, 8218.753437396888, 8276.21375969285, 8396.160383961616, 8406.705765298217, 8683.044865064838, 8693.174148455919, 8746.737597872043, 8773.649054037864, 8813.911860881373, 8820.162084601952, 8824.294056475466, 8619.870701939444, 8668.60991255395, 8681.956590217073, 8683.609237584293, 8685.652573897005, 8493.532855692934, 8619.61211745473, 8633.913660863436, 8640.956795215983, 8658.437201581877, 41051.7947410264, 41363.586364136274, 41553.0, 41641.0, 41729.0, 3244.886428974998, 3502.859885604573, 3508.842102105386, 3709.0, 3878.1855810279594, 31231.375372492425, 31378.37243255145, 31783.682163178302, 32026.679733202604, 32071.83964080188, 4158.251514727348, 4205.768682722449, 4258.169656916903, 4264.637505812009, 4290.270653988799, 226964.0, 227667.0, 228506.0, 229019.0, 229352.0, 52921.2061819073, 53232.73383633057, 53265.2010219847, 53312.0, 53496.19755703668, 49676.75161624169, 51935.0, 54872.0, 61359.38640613537, 61658.38341616526, 15683.921580392025, 15765.290561924741, 15773.05361678303, 15782.921085394499, 15790.526284211492, 13513.459461621622, 13584.388702508213, 13606.38771255296, 13607.115537490032, 13619.0, 14954.177520236273, 16301.266443010092, 16478.6704265914, 16687.91656041712, 17459.47621571355, 6062.363451837582, 6157.4458298753325, 6182.814515564541, 6208.317085120633, 6221.2845522765465, 873.6330741088758, 963.6290028339, 1004.437514991607, 1024.1141412678128, 1062.3625824505389, 25738.356541086247, 26375.868120659274, 26490.86754566215, 26763.0, 27206.183814485597, 1133.2237417368963, 1175.9294442333487, 1192.2190964917993, 1208.3112625803383, 1256.6983923858209, 14742.852571474148, 15279.312430940634, 15525.922370388302, 15597.0, 15657.843421565867, 477258.0, 482794.0, 489015.0, 489114.0, 489313.0, 57782.71108644514, 58136.0, 58259.70870145707, 58444.415555843894, 58484.70757646184, 1360.9931950340185, 1396.6229118138046, 1400.5588239704462, 1402.0746307437246, 1417.4613646814144, 29884.505774710742, 30437.473175697505, 31117.22206944754, 31309.373812523165, 31312.21719457032, 51680.483195167566, 51820.481795181564, 51979.74010129925, 52055.0, 52155.0, 407508.0, 411415.0, 411435.0, 411549.0, 411940.9402952966, 23176.652350215096, 24213.75786242115, 27308.726912730617, 27411.588826167226, 27888.44223115567, 38622.227555449295, 39136.2172756549, 39568.2086358277, 39987.0, 40013.39979900246, 30754.53868191934, 31312.843435782674, 34076.82961585176, 34262.31475370529, 34434.48348274728, 38115.0, 38167.236655266184, 38778.6122138775, 38849.0, 39357.606423935395, 36920.63079369279, 38461.0, 38638.613613864625, 39007.414888776126, 39024.6097539021, 30212.24469388283, 30631.234219143807, 31385.215369615027, 32442.83778581092, 34962.65037349594, 26507.0, 26585.33536661599, 26840.177308685652, 26899.86550067237, 27114.45771084528], "value": 18597.68722588196, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.1502284653909, 365.8664587425589, 366.9137752628132, 367.69297636473544, 377.89607857839076, 17246.0, 19026.714599281004, 19989.500262493446, 20195.293164739236, 20235.190592376304, 17756.46730598084, 18257.26970921165, 18662.25350985959, 18914.337998170067, 18921.148548315323, 5494.423085576017, 5659.264295641561, 5677.57418193635, 5677.659340439566, 5700.2589663343915, 3802.429635554661, 3963.544192417866, 3964.068443915692, 3965.2267807777494, 5098.745062746866, 5276.445973172819, 5477.643953143033, 5490.313710786152, 5499.560035197174, 5512.641678290898, 5451.127819548873, 5491.533219676312, 5523.2543606613, 5523.364813046471, 5525.944740552583, 3668.926621467582, 5099.15863882459, 5151.484851514856, 5271.393789714193, 5281.234221037928, 11250.718732031683, 11298.435078246055, 11367.943160284229, 11640.708982275426, 11688.0, 2005.2480319880044, 2199.230269405711, 2232.5311684546264, 2241.652543855705, 2712.9593056103977, 9056.094390560957, 9273.489958052305, 9419.905800941971, 11512.07903367737, 12925.612231633066, 1812.8459080978132, 1830.8718389712726, 1900.4583693647382, 1934.8355389791884, 1964.2437661500283, 75636.24363756402, 78638.60680696617, 79722.0, 79760.0, 80103.5994820028, 9914.256430767722, 10220.642277520252, 10316.277860549839, 10419.843702344471, 10423.322484038514, 14267.143971361751, 14281.285935703174, 14370.065945713495, 14380.424783008772, 14394.20831854258, 7608.0, 8037.35701143907, 8066.475679080841, 8177.427580069338, 8204.753857384288, 7954.84090318202, 8035.156308587631, 8116.837663246702, 8148.22591853773, 8171.305439037629, 4160.979195104005, 4193.6645068394455, 4293.656507479394, 4344.891377715519, 4496.123255965055, 1721.8536424404067, 1771.1852547828144, 1771.9114044297992, 1814.6461440019334, 1829.773510952356, 912.3203213605906, 986.6891929042329, 1022.9386236825815, 1029.902159294866, 1039.4542864995788, 17312.22095005728, 17633.206505707272, 17812.0, 17884.821151788317, 18048.09759512019, 995.3679413572434, 1001.0, 1001.1840350114634, 1004.5328922051282, 1083.6099004358425, 9836.803263934824, 10117.949410252902, 10231.846522302172, 10270.216570633906, 10304.33021853592, 480606.0, 482514.0, 483147.0, 493120.0, 498656.0, 90443.54778226066, 90796.54601726949, 90841.54579227194, 91580.0, 91662.54168729113, 925.8379783537854, 1000.2198285337448, 1037.7509397744486, 1055.8785739640039, 1066.6000249906285, 14664.193469358861, 15117.848821511645, 15197.468088616846, 15504.767428488356, 15664.686706266039, 26875.73124268732, 32748.50877236891, 32990.83504582462, 34080.829595852854, 35047.47428788519, 46081.76959115317, 47787.76106119447, 49928.25107623316, 49951.0, 50344.49655503545, 8015.078265999485, 8164.224398682116, 8177.141400152898, 8186.362727454414, 8286.792830179053, 12043.879561204276, 12960.481580736665, 13053.543125990926, 13057.673558161123, 13077.869221307665, 7839.451238413257, 10414.698162729659, 11104.888951110386, 11273.549058037916, 11611.303321800719, 11074.5570177192, 11146.108311334912, 11267.718307042389, 11393.316401015965, 11400.828987565359, 11242.213045086766, 11471.770564588829, 11475.311481311148, 11722.58970936013, 11785.233959792586, 7815.413843961612, 7931.087924888711, 7944.245296696805, 8084.959575202086, 8201.671933122609, 10710.678679639623, 10927.726806829893, 11122.221444499131, 11375.601853935405, 11571.421428928352], "value": 8539.578684027048, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1247.2329517346834, 1391.2556782121565, 1422.7510185717497, 1534.8541888520588, 1746.1356628468902, 7152.0702308699865, 7483.027206463165, 7485.812854678636, 7498.81252968676, 7505.924940750605, 7196.676149573269, 7313.268673132684, 7318.780436586898, 7319.30466605673, 7345.7428989985365, 1910.9808901910942, 2084.3851063936177, 2121.575684863026, 2146.7638559758416, 2150.7526634437004, 2101.3275751759443, 2112.566923780629, 2114.8413868959888, 2116.0477784996815, 2122.108714339981, 1992.163291417601, 2073.8444616653737, 2075.3462659262286, 2076.9584608307823, 2077.3144862195513, 1814.5645045189192, 2028.0974966140075, 2093.0267425646994, 2094.7591027031935, 2095.036283309679, 2105.4315334859657, 2106.441792924876, 2121.6075026120216, 2130.2224687988773, 2138.0592539282666, 7271.309225623558, 7322.157951835554, 7353.1176258848745, 7371.26287371264, 7372.189059203483, 4308.763018034007, 4447.266201076818, 4456.9331460028125, 4483.125790470859, 4517.096580683843, 2850.2019434558356, 2860.342121312089, 2893.030834670388, 2906.796524243304, 2920.9123726288035, 907.0883761819396, 937.5546615357719, 944.4191822029471, 947.4599478297373, 958.4872093429982, 10154.136898363575, 10179.592816287413, 10181.18550515957, 10215.336003159771, 10247.077763001365, 3925.1364699766004, 3979.2439436507548, 4031.23406552754, 4047.0287131088326, 4115.97942010294, 8608.526531040729, 8679.913200868037, 8681.088485709037, 8682.95658521716, 8684.826303473896, 4247.320428731388, 4539.432570928634, 4609.285560738091, 4627.375304333872, 4631.212693842055, 4161.687873409506, 4257.084726783756, 4265.424167737316, 4283.935740963888, 4284.057507348379, 3414.283000569908, 3446.7070299024863, 3447.775894566895, 3484.756067075331, 3526.4710293455673, 1119.6025410979148, 1128.774245150973, 1133.0935251798528, 1138.8177891537314, 1139.9544018239178, 765.689895592286, 785.5247575217026, 851.0, 928.9024652411534, 948.3361646847235, 4919.926201106986, 5084.3644544431945, 5085.669431486942, 5191.377034755778, 5210.036143313499, 349.2884864165609, 354.27550658902607, 359.63676686546773, 371.35199077609747, 383.44017734107956, 3519.1720528173387, 3558.4840198171637, 3560.786352818839, 3571.0, 3634.9273014539563, 8786.516741579147, 9191.034941331063, 9255.0, 9272.165505104573, 9287.442753434816, 9042.63829446828, 9112.271018318519, 9115.68095116681, 9183.678571249975, 9184.265258779415, 6869.347411995853, 6995.545289556163, 7059.047028651169, 7063.717451301993, 7064.646767661597, 4845.830395936126, 4994.126027945168, 5025.396952365593, 5095.0, 5105.1576489880235, 8521.744347669579, 8588.871166932626, 8617.0, 8663.913360866563, 8681.782955426164, 8418.116097809887, 8649.437786543855, 8681.175288347597, 8807.91192088071, 8846.248068914214, 6152.354002829638, 6303.36966303366, 6486.675666216576, 6711.194656641234, 6798.082258895183, 6842.110525631835, 6862.4853136016, 6902.723891044503, 6903.1716194055025, 6922.61925594077, 6394.552381333262, 6582.11141495911, 6599.934000660124, 6615.4376877965915, 6674.866502670016, 6334.271558770801, 6340.682965851781, 6353.936460635335, 6416.230052393743, 6460.644664543495, 5870.618409803349, 5897.410258974069, 5928.466438020599, 5928.525717942468, 5934.368048786619, 4362.738235705868, 4385.210662080856, 4387.956120438883, 4390.278027622894, 4428.247197976288, 4396.472423309224, 4419.292913133883, 4493.370928070138, 4499.235130027838, 4515.9774201128785], "value": 3905.298428385533, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.4368151060899, 291.13532807561546, 293.18640771858094, 293.3121829310267, 294.5625745767534, 5060.4686507916595, 5144.151215049513, 5242.7640756165965, 5321.733913304334, 5346.786128554858, 5222.477752224785, 5253.789848406059, 5257.526822585976, 5267.973660131704, 5268.631195816294, 4016.979915100435, 4026.879193624196, 4039.555648878621, 4055.128147448298, 4059.3505039193733, 3822.7132965027736, 3828.3874580067195, 4014.1971605678837, 4015.7188996770237, 4029.899252518696, 3948.466956960817, 4030.0932290234755, 4031.395290706388, 4036.9798151009204, 4043.5147782266167, 4000.299947509174, 4001.5398229203724, 4003.2794097062515, 4012.4583181270445, 4014.5383280922483, 3455.9654403456148, 3501.9824900875587, 3506.7194624429985, 3507.824608769551, 3510.3856825055514, 5022.146235139999, 5025.572826309768, 5056.898862022739, 5057.747112644353, 5061.797528098871, 4541.750203738793, 4564.908701825978, 4569.497355290915, 4580.587747102777, 4585.449746030497, 5206.557442617382, 5424.694504835468, 5456.0, 5460.580249135213, 5485.451454854522, 3694.538182727159, 3704.2035962267973, 3728.6457786510236, 3738.214974855284, 3743.401055831054, 5671.943280567183, 5691.430856914317, 5748.419184724193, 5754.568407369422, 5759.5968282220265, 3578.141246100917, 3782.3759079752085, 3791.734578579473, 3792.6965842732516, 3804.7907365094634, 3848.942265866014, 3858.864939727096, 3859.864904728377, 3869.5356557212754, 3874.903127421837, 4468.64250859937, 4481.2381895077915, 4497.572730590588, 4506.391637128946, 4519.909601808011, 5504.788946431779, 5508.0, 5516.448355164532, 5518.751656175482, 5571.164325351148, 1366.4261010375667, 1397.413086503671, 1398.9020768546104, 1400.4608225832924, 1405.2341473896752, 881.713443130985, 882.7837179890968, 900.8738776571286, 904.7240591619619, 910.4582773249906, 5609.5512359012, 5645.68948707825, 5645.9717701412055, 5646.802361917313, 5648.661080335193, 5967.970160149258, 5976.193213916065, 5985.880282394328, 5993.820185394445, 5998.910016349758, 5098.694078355311, 5339.650553756334, 5360.785568577213, 5618.539179813278, 5623.297087864017, 3227.9670505438503, 3239.2873567815045, 3250.7724459287624, 3258.3483303339426, 3259.511073339018, 5745.454181852718, 6284.4344009039405, 6285.59143655661, 6289.150964619809, 6307.653079080603, 5825.766969321265, 5850.063989761617, 5856.5944173398075, 5867.0, 5896.439838215363, 5873.295204575478, 5906.438888305604, 5920.5559583031445, 5938.257717785277, 5942.940570594325, 5531.529819965348, 5712.400197979152, 5735.225744524436, 5736.913946290892, 5762.423757624204, 5677.574181936288, 5690.174924635822, 5694.174344720075, 5696.772129114789, 5702.287214098238, 5626.465485778845, 5846.5615078870105, 5929.347771745019, 5947.226860508106, 5955.166276721176, 3630.854765809338, 3644.9635503645686, 3751.15598990225, 3813.866514671973, 3814.942775858309, 5654.180143879197, 5681.488666020078, 5686.175504551734, 5698.549623661866, 5709.0865461525955, 5484.012877682056, 5490.780368785204, 5517.944820551743, 5531.253280807039, 5532.1425179097305, 5296.602754793483, 5465.207544906046, 5480.177973304037, 5492.121260598445, 5527.281453411031, 5360.2227676987395, 5427.6200665953, 5442.537384322377, 5450.945490545202, 5474.151506516497, 5413.188021796762, 5457.645253058538, 5550.306211723535, 5552.500274975271, 5574.749136288796, 5386.353637563518, 5434.402215756185, 5446.210299506629, 5451.945480545144, 5454.209139674805], "value": 4171.781850963747, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.1740470138185, 713.9892901606473, 736.6169591812258, 744.3301029073833, 782.4483738964024, 12829.679258018554, 13603.591892243236, 13622.523211687592, 13783.724325513484, 13894.791578126336, 12923.09538332317, 12979.740405191891, 12980.675483112927, 13017.08880378374, 13018.0, 680.2924958043628, 794.876794096913, 800.451690591945, 824.5959479854888, 825.5748289630845, 810.623060276971, 817.2195553246635, 818.0306336990656, 820.4011071917504, 821.1747194069951, 854.9871751923727, 855.8502262104138, 856.4133568505563, 856.6659002988808, 860.793409581699, 705.6471764117941, 816.5264146794874, 852.3266619370689, 856.8500512410303, 857.5969294431607, 616.0574321288391, 620.4106099205773, 626.8808926303988, 627.8179327994922, 628.4815027602201, 13575.0, 13600.115992460458, 13606.795898061537, 13637.454501819915, 13914.30428478572, 13004.349782510837, 13276.734465310736, 13286.468541258339, 13331.266780327078, 13630.727385452235, 10746.516406761715, 10867.215926553868, 10894.782104357868, 11289.435528223637, 11369.0, 3728.645778651051, 3759.588636938395, 3782.0733920189455, 3834.789086600236, 3924.058226025762, 50647.493525064645, 50820.74589627065, 52817.47182528164, 53237.20144197879, 53247.0, 10824.78350432987, 10998.230123891411, 11040.779184416268, 11053.115750739922, 11265.436728163559, 19158.71261931072, 19185.61628767445, 19365.709514357295, 19371.4188574343, 19584.412467625993, 7974.52152870818, 8006.759797206093, 8070.959645201737, 8090.150534193943, 8097.433179677366, 4587.977060114678, 4644.233701439292, 4722.456917454468, 4749.525047495223, 4774.236122220497, 3104.767142464324, 3199.77601567888, 3203.743700503954, 3213.6304325002925, 3217.951730724041, 578.3233616668424, 595.1816252652603, 598.3537779198455, 605.7425594122568, 614.4163045107166, 594.4293478260831, 679.2256827216977, 696.7004188199123, 711.4841739738752, 717.9533330333512, 8860.158284962918, 9017.639294428149, 9059.22996545301, 9117.225035871892, 9311.580978855833, 674.8043067510465, 689.2074114768056, 711.1466240511407, 716.6022857314136, 734.9816254593678, 4261.680373971964, 4375.387445757597, 4387.758673273001, 4494.910101797946, 4513.119941611354, 52445.0, 63914.0, 65257.347426526074, 65645.34354656488, 65816.01275980864, 48509.0, 49357.01285974332, 53875.0, 54049.72975135099, 54351.0, 49056.0, 49647.50352496501, 49845.0, 50138.74930625324, 50673.99672338538, 8863.512506812187, 8906.376553641183, 8941.776455588662, 8962.759310172456, 9037.09629037091, 32858.50712239271, 33017.33965320728, 33291.334173316885, 33311.50032749559, 34489.31021379609, 40853.59146408498, 44677.55322446864, 44744.105117898114, 45284.09431811411, 45401.0, 12039.699007524881, 12206.938965305117, 12247.693807654523, 12344.62966111018, 12477.126601137834, 13075.607731768063, 13190.868091318964, 13286.601401957956, 13401.66495837612, 13423.993200510196, 11851.585194518151, 11883.287002779514, 11971.940140299243, 12015.339156346485, 12498.500059997497, 12414.441350139085, 12486.43811028524, 12712.872871271538, 12753.234805911305, 12884.613461596167, 11970.22193557416, 12161.87838121643, 12313.692157696129, 12320.137590368588, 12807.10350275509, 10009.449480278654, 10113.393196407944, 10209.84685229737, 10232.0, 10668.89331106679, 10036.598536058476, 10370.222233332379, 10396.064354208158, 10407.375557466576, 10482.790344192921], "value": 6587.631819588418, "unit": "score"}], "name": "dromaeo_css", "value": 6646.4132323391095, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 110.0, 111.0, 112.0, 113.0, 102.0, 112.0, 112.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 127.0, 155.0, 182.0, 138.0, 157.0, 156.0, 128.0, 184.0, 131.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 161.0, 159.0, 160.0, 159.0, 160.0, 161.0, 161.0, 161.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 87.0, 109.0, 113.0, 78.0, 79.0, 79.0, 127.0, 105.0, 78.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 149.0, 94.0, 93.0, 94.0, 149.0, 92.0, 92.0, 151.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 58.0, 58.0, 57.0, 57.0, 76.0, 55.0, 54.0], "value": 58.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 62.0, 63.0, 63.0, 62.0, 63.0, 63.0, 65.0, 69.0], "value": 63.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 77.0, 78.0, 79.0, 79.0, 79.0, 79.0, 80.0, 80.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 131.0, 124.0, 122.0, 121.0, 123.0, 126.0, 123.0, 164.0, 122.0], "value": 128.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 172.0, 168.0, 170.0, 168.0, 173.0, 168.0, 175.0, 163.0, 166.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 70.0, 72.0, 69.0, 70.0, 69.0, 69.0, 71.0, 68.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1550.8999999999999, "alertThreshold": 2.0}]} 22:50:14 INFO - Return code: 0 22:50:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:50:14 ERROR - # TBPL SUCCESS # 22:50:14 INFO - Running post-action listener: _resource_record_post_action 22:50:14 INFO - Running post-run listener: _resource_record_post_run 22:50:15 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 359043072; Read time: 0; Write time: 284336 22:50:15 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 73875456; Read time: 0; Write time: 65704 22:50:15 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 285167616; Read time: 0; Write time: 218632 22:50:15 INFO - Running post-run listener: _upload_blobber_files 22:50:15 INFO - Blob upload gear active. 22:50:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:50:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:50:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:50:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:50:16 INFO - (blobuploader) - INFO - Open directory for files ... 22:50:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:50:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:50:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:50:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:50:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:50:17 INFO - (blobuploader) - INFO - Done attempting. 22:50:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:50:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:50:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:50:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:50:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:50:17 INFO - (blobuploader) - INFO - Done attempting. 22:50:17 INFO - (blobuploader) - INFO - Iteration through files over. 22:50:17 INFO - Return code: 0 22:50:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:50:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:50:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fea06c4d3cda9b9ecf8660bb981eb8e6f292b464c06cd801c118bd267c811abd28e4f23a2b56c84443801095ec05e4c10baf3ef50c808c8a648a7a8bd8030fef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4cb1fd3d2480317b45594baf98123a5d3ced73a2f58a8e8ee4d22b549477575a2c25db541db02a48ad631c013d8a5a49914238a3177209ab378746a29dcf242"} 22:50:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:50:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:50:17 INFO - Contents: 22:50:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fea06c4d3cda9b9ecf8660bb981eb8e6f292b464c06cd801c118bd267c811abd28e4f23a2b56c84443801095ec05e4c10baf3ef50c808c8a648a7a8bd8030fef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4cb1fd3d2480317b45594baf98123a5d3ced73a2f58a8e8ee4d22b549477575a2c25db541db02a48ad631c013d8a5a49914238a3177209ab378746a29dcf242"} 22:50:17 INFO - Running post-run listener: copy_logs_to_upload_dir 22:50:17 INFO - Copying logs to upload dir... 22:50:17 INFO - mkdir: /builds/slave/test/build/upload/logs 22:50:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2130.535436 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 30 secs) (at 2016-05-01 22:50:17.633541) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-01 22:50:17.637152) ========= 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=4300f881736b422476174874000001bc-1462164413.46220-1464912918 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/fea06c4d3cda9b9ecf8660bb981eb8e6f292b464c06cd801c118bd267c811abd28e4f23a2b56c84443801095ec05e4c10baf3ef50c808c8a648a7a8bd8030fef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4cb1fd3d2480317b45594baf98123a5d3ced73a2f58a8e8ee4d22b549477575a2c25db541db02a48ad631c013d8a5a49914238a3177209ab378746a29dcf242"} build_url:https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/btkAZX_1RXieywRdWYimpA/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/fea06c4d3cda9b9ecf8660bb981eb8e6f292b464c06cd801c118bd267c811abd28e4f23a2b56c84443801095ec05e4c10baf3ef50c808c8a648a7a8bd8030fef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4cb1fd3d2480317b45594baf98123a5d3ced73a2f58a8e8ee4d22b549477575a2c25db541db02a48ad631c013d8a5a49914238a3177209ab378746a29dcf242"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-01 22:50:17.661997) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 22:50:17.662325) ========= 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=4300f881736b422476174874000001bc-1462164413.46220-1464912918 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-01 22:50:17.747068) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-01 22:50:17.747420) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-01 22:50:17.747765) ========= ========= Total master_lag: 0.18 =========