builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1462269955.8 results: success (0) buildid: 20160503022239 builduid: d9ca01a6e1294735bffd7658b0c5613e revision: a78cd451a84ae97c7118a3f25152c18248810547 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-03 03:05:55.802543) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-03 03:05:55.802965) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-03 03:05:55.803233) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-03 03:05:56.022172) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 03:05:56.022439) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-03 03:05:58-- 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% 46.5M=0s 2016-05-03 03:05:58 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079040 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 03:05:56.117087) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 03:05:56.117505) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022649 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 03:05:56.168954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 03:05:56.169433) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a78cd451a84ae97c7118a3f25152c18248810547 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a78cd451a84ae97c7118a3f25152c18248810547 --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=a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-03 03:05:58,473 truncating revision to first 12 chars 2016-05-03 03:05:58,473 Setting DEBUG logging. 2016-05-03 03:05:58,473 attempt 1/10 2016-05-03 03:05:58,473 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a78cd451a84a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-03 03:05:58,815 unpacking tar archive at: fx-team-a78cd451a84a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.625190 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 03:05:56.810051) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-03 03:05:56.810367) ========= script_repo_revision: a78cd451a84ae97c7118a3f25152c18248810547 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-03 03:05:56.810748) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-03 03:05:56.811080) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-03 03:05:56.824348) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 35 secs) (at 2016-05-03 03:05:56.824598) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:05:59 INFO - MultiFileLogger online at 20160503 03:05:59 in /builds/slave/test 03:05:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:05:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:05:59 INFO - {'append_to_log': False, 03:05:59 INFO - 'base_work_dir': '/builds/slave/test', 03:05:59 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:05:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:05:59 INFO - 'branch': 'Fx-Team-Non-PGO', 03:05:59 INFO - 'buildbot_json_path': 'buildprops.json', 03:05:59 INFO - 'config_files': ('talos/linux_config.py',), 03:05:59 INFO - 'default_actions': ('clobber', 03:05:59 INFO - 'read-buildbot-config', 03:05:59 INFO - 'download-and-extract', 03:05:59 INFO - 'populate-webroot', 03:05:59 INFO - 'create-virtualenv', 03:05:59 INFO - 'install', 03:05:59 INFO - 'run-tests'), 03:05:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:05:59 INFO - 'download_minidump_stackwalk': True, 03:05:59 INFO - 'download_symbols': 'ondemand', 03:05:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:05:59 INFO - 'tooltool.py': '/tools/tooltool.py', 03:05:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:05:59 INFO - '/tools/misc-python/virtualenv.py')}, 03:05:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:05:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:05:59 INFO - 'installer_path': 'installer.exe', 03:05:59 INFO - 'log_level': 'info', 03:05:59 INFO - 'log_name': 'talos', 03:05:59 INFO - 'log_to_console': True, 03:05:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:05:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:05:59 INFO - 'opt_config_files': (), 03:05:59 INFO - 'pip_index': False, 03:05:59 INFO - 'sps_profile': False, 03:05:59 INFO - 'sps_profile_interval': 0, 03:05:59 INFO - 'suite': 'dromaeojs-e10s', 03:05:59 INFO - 'system_bits': '32', 03:05:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:05:59 INFO - 'title': 'talos-linux64-ix-064', 03:05:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:05:59 INFO - 'use_talos_json': True, 03:05:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:05:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:05:59 INFO - 'work_dir': 'build'} 03:05:59 INFO - ##### 03:05:59 INFO - ##### Running clobber step. 03:05:59 INFO - ##### 03:05:59 INFO - Running pre-action listener: _resource_record_pre_action 03:05:59 INFO - Running main action method: clobber 03:05:59 INFO - rmtree: /builds/slave/test/build 03:05:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:05:59 INFO - Running post-action listener: _resource_record_post_action 03:05:59 INFO - ##### 03:05:59 INFO - ##### Running read-buildbot-config step. 03:05:59 INFO - ##### 03:05:59 INFO - Running pre-action listener: _resource_record_pre_action 03:05:59 INFO - Running main action method: read_buildbot_config 03:05:59 INFO - Using buildbot properties: 03:05:59 INFO - { 03:05:59 INFO - "project": "", 03:05:59 INFO - "product": "firefox", 03:05:59 INFO - "script_repo_revision": "production", 03:05:59 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 03:05:59 INFO - "repository": "", 03:05:59 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 03:05:59 INFO - "buildid": "20160503022239", 03:05:59 INFO - "pgo_build": "False", 03:05:59 INFO - "basedir": "/builds/slave/test", 03:05:59 INFO - "buildnumber": 1226, 03:05:59 INFO - "slavename": "talos-linux64-ix-064", 03:05:59 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:05:59 INFO - "platform": "ubuntu64_hw", 03:05:59 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:05:59 INFO - "branch": "fx-team", 03:05:59 INFO - "repo_path": "integration/fx-team", 03:05:59 INFO - "revision": "a78cd451a84ae97c7118a3f25152c18248810547", 03:05:59 INFO - "stage_platform": "linux64", 03:05:59 INFO - "builduid": "d9ca01a6e1294735bffd7658b0c5613e", 03:05:59 INFO - "slavebuilddir": "test" 03:05:59 INFO - } 03:05:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 03:05:59 INFO - Running post-action listener: _resource_record_post_action 03:05:59 INFO - ##### 03:05:59 INFO - ##### Running download-and-extract step. 03:05:59 INFO - ##### 03:05:59 INFO - Running pre-action listener: _resource_record_pre_action 03:05:59 INFO - Running main action method: download_and_extract 03:05:59 INFO - mkdir: /builds/slave/test/build/tests 03:05:59 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')]} 03:05:59 INFO - https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:05:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:05:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:05:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:05:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:06:29 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 03:06:29 INFO - retry: attempt #1 caught exception: timed out 03:06:29 INFO - retry: Failed, sleeping 30 seconds before retrying 03:06:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:07:29 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 03:07:29 INFO - retry: attempt #2 caught exception: timed out 03:07:29 INFO - retry: Failed, sleeping 60 seconds before retrying 03:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:08:59 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 03:08:59 INFO - retry: attempt #3 caught exception: timed out 03:08:59 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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! 03:08:59 INFO - Caught exception: timed out 03:08:59 INFO - Caught exception: timed out 03:08:59 INFO - Caught exception: timed out 03:08:59 INFO - trying https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:08:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:08:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:09:00 INFO - Downloaded 1361 bytes. 03:09:00 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 03:09:00 INFO - Using the following test package requirements: 03:09:00 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:09:00 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:09:00 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:09:00 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:00 INFO - u'jsshell-linux-x86_64.zip'], 03:09:00 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:09:00 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 03:09:00 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:09:00 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:09:00 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:09:00 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 03:09:00 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:09:00 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:09: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')]} 03:09:00 INFO - https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:09:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:09:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:09:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:09:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:09:30 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 03:09:30 INFO - retry: attempt #1 caught exception: timed out 03:09:30 INFO - retry: Failed, sleeping 30 seconds before retrying 03:10:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:10:30 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 03:10:30 INFO - retry: attempt #2 caught exception: timed out 03:10:30 INFO - retry: Failed, sleeping 60 seconds before retrying 03:11:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:12:00 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 03:12:00 INFO - retry: attempt #3 caught exception: timed out 03:12:00 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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! 03:12:00 INFO - Caught exception: timed out 03:12:00 INFO - Caught exception: timed out 03:12:00 INFO - Caught exception: timed out 03:12:00 INFO - trying https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:12:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:12:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:12:02 INFO - Downloaded 22305783 bytes. 03:12:02 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'] 03:12:02 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 03:12:03 INFO - Return code: 0 03:12:03 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 03:12: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')]} 03:12:03 INFO - https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:12:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:12:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:12:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:12:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:12:33 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 03:12:33 INFO - retry: attempt #1 caught exception: timed out 03:12:33 INFO - retry: Failed, sleeping 30 seconds before retrying 03:13:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:13:33 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 03:13:33 INFO - retry: attempt #2 caught exception: timed out 03:13:33 INFO - retry: Failed, sleeping 60 seconds before retrying 03:14:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:15:03 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 03:15:03 INFO - retry: attempt #3 caught exception: timed out 03:15:03 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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! 03:15:03 INFO - Caught exception: timed out 03:15:03 INFO - Caught exception: timed out 03:15:03 INFO - Caught exception: timed out 03:15:03 INFO - trying https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 03:15:03 INFO - Downloading https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:15:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:15:05 INFO - Downloaded 22305783 bytes. 03:15:05 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'] 03:15:05 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 03:15:06 INFO - Return code: 0 03:15: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')]} 03:15:06 INFO - https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:15:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:15:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:15:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:15:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:15:36 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 03:15:36 INFO - retry: attempt #1 caught exception: timed out 03:15:36 INFO - retry: Failed, sleeping 30 seconds before retrying 03:16:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:16:36 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 03:16:36 INFO - retry: attempt #2 caught exception: timed out 03:16:36 INFO - retry: Failed, sleeping 60 seconds before retrying 03:17:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:18:06 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 03:18:06 INFO - retry: attempt #3 caught exception: timed out 03:18:06 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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! 03:18:06 INFO - Caught exception: timed out 03:18:06 INFO - Caught exception: timed out 03:18:06 INFO - Caught exception: timed out 03:18:06 INFO - trying https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 03:18:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:18:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:18:07 INFO - Downloaded 10840152 bytes. 03:18:07 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'] 03:18:07 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 03:18:07 INFO - Return code: 0 03:18:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:18:07 INFO - https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:18:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:18:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:18:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:18:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:18:37 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 03:18:37 INFO - retry: attempt #1 caught exception: timed out 03:18:37 INFO - retry: Failed, sleeping 30 seconds before retrying 03:19:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:19:38 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 03:19:38 INFO - retry: attempt #2 caught exception: timed out 03:19:38 INFO - retry: Failed, sleeping 60 seconds before retrying 03:20:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:21:08 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 03:21:08 INFO - retry: attempt #3 caught exception: timed out 03:21:08 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Gm502NH6Scm3o64AvhSdNg/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! 03:21:08 INFO - Caught exception: timed out 03:21:08 INFO - Caught exception: timed out 03:21:08 INFO - Caught exception: timed out 03:21:08 INFO - trying https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:21:08 INFO - Downloading https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:21:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/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 03:21:09 INFO - Downloaded 54967280 bytes. 03:21:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:21:09 INFO - mkdir: /builds/slave/test/properties 03:21:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:21:09 INFO - Writing to file /builds/slave/test/properties/build_url 03:21:09 INFO - Contents: 03:21:09 INFO - build_url:https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 03:21:10 INFO - Running post-action listener: _resource_record_post_action 03:21:10 INFO - Running post-action listener: set_extra_try_arguments 03:21:10 INFO - ##### 03:21:10 INFO - ##### Running populate-webroot step. 03:21:10 INFO - ##### 03:21:10 INFO - Running pre-action listener: _resource_record_pre_action 03:21:10 INFO - Running main action method: populate_webroot 03:21:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:21:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:21:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:21:10 INFO - '--tppagecycles', 03:21:10 INFO - '7'], 03:21:10 INFO - 'tests': ['tsvgm']}}, 03:21:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:21:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:21:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:21:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:21:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:21:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:21:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:10 INFO - 'talos_options': ['--disable-e10s'], 03:21:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:10 INFO - 'talos_options': ['--disable-e10s'], 03:21:10 INFO - 'tests': ['damp', 'tps']}, 03:21:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:10 INFO - 'tests': ['damp', 'tps']}, 03:21:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:21:10 INFO - 'tests': ['dromaeo_dom']}, 03:21:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:21:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:21:10 INFO - 'tests': ['a11yr', 03:21:10 INFO - 'ts_paint', 03:21:10 INFO - 'tpaint', 03:21:10 INFO - 'sessionrestore', 03:21:10 INFO - 'sessionrestore_no_auto_restore', 03:21:10 INFO - 'tabpaint']}, 03:21:10 INFO - 'other-e10s': {'tests': ['a11yr', 03:21:10 INFO - 'ts_paint', 03:21:10 INFO - 'tpaint', 03:21:10 INFO - 'sessionrestore', 03:21:10 INFO - 'sessionrestore_no_auto_restore', 03:21:10 INFO - 'tabpaint']}, 03:21:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:21:10 INFO - 'ts_paint', 03:21:10 INFO - 'tpaint', 03:21:10 INFO - 'sessionrestore', 03:21:10 INFO - 'sessionrestore_no_auto_restore', 03:21:10 INFO - 'tabpaint']}, 03:21:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:21:10 INFO - 'ts_paint', 03:21:10 INFO - 'tpaint', 03:21:10 INFO - 'sessionrestore', 03:21:10 INFO - 'sessionrestore_no_auto_restore', 03:21:10 INFO - 'tabpaint']}, 03:21:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:21:10 INFO - 'tests': ['a11yr', 03:21:10 INFO - 'ts_paint', 03:21:10 INFO - 'tpaint', 03:21:10 INFO - 'sessionrestore', 03:21:10 INFO - 'sessionrestore_no_auto_restore', 03:21:10 INFO - 'tabpaint']}, 03:21:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:21:10 INFO - 'tests': ['a11yr', 03:21:10 INFO - 'ts_paint', 03:21:10 INFO - 'tpaint', 03:21:10 INFO - 'sessionrestore', 03:21:10 INFO - 'sessionrestore_no_auto_restore', 03:21:10 INFO - 'tabpaint']}, 03:21:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:21:10 INFO - 'tests': ['tsvgx', 03:21:10 INFO - 'tsvgr_opacity', 03:21:10 INFO - 'tart', 03:21:10 INFO - 'tscrollx', 03:21:10 INFO - 'cart']}, 03:21:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:21:10 INFO - 'tsvgr_opacity', 03:21:10 INFO - 'tart', 03:21:10 INFO - 'tscrollx', 03:21:10 INFO - 'cart']}, 03:21:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:10 INFO - 'talos_options': ['--disable-e10s'], 03:21:10 INFO - 'tests': ['tp5o']}, 03:21:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:10 INFO - 'tests': ['tp5o']}, 03:21:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:10 INFO - 'talos_options': ['--disable-e10s', 03:21:10 INFO - '--xperf_path', 03:21:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:10 INFO - 'tests': ['tp5n']}, 03:21:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:10 INFO - 'talos_options': ['--xperf_path', 03:21:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:10 INFO - 'tests': ['tp5n']}}, 03:21:10 INFO - 'talos.zip': {'path': '', 03:21:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:21:10 INFO - Running post-action listener: _resource_record_post_action 03:21:10 INFO - ##### 03:21:10 INFO - ##### Running create-virtualenv step. 03:21:10 INFO - ##### 03:21:10 INFO - Running pre-action listener: _resource_record_pre_action 03:21:10 INFO - Running main action method: create_virtualenv 03:21:10 INFO - Creating virtualenv /builds/slave/test/build/venv 03:21:10 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 03:21:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:21:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:21:10 INFO - Using real prefix '/usr' 03:21:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:21:10 INFO - Installing distribute.............................................................................................................................................................................................done. 03:21:12 INFO - Installing pip.................done. 03:21:12 INFO - Return code: 0 03:21:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:12 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 0x7f7675e4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b07d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f640>, '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 0x1340540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13409d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776', '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 03:21:12 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 03:21:12 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 03:21:12 INFO - Using env: {'DISPLAY': ':0', 03:21:12 INFO - 'HOME': '/home/cltbld', 03:21:12 INFO - 'LANG': 'en_US.UTF-8', 03:21:12 INFO - 'LANGUAGE': 'en_US:en', 03:21:12 INFO - 'LOGNAME': 'cltbld', 03:21:12 INFO - 'MAIL': '/var/mail/cltbld', 03:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:12 INFO - 'MOZ_NO_REMOTE': '1', 03:21:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:12 INFO - 'NO_EM_RESTART': '1', 03:21:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:12 INFO - 'PWD': '/builds/slave/test', 03:21:12 INFO - 'SHELL': '/bin/bash', 03:21:12 INFO - 'SHLVL': '1', 03:21:12 INFO - 'TERM': 'linux', 03:21:12 INFO - 'TMOUT': '86400', 03:21:12 INFO - 'USER': 'cltbld', 03:21:12 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776', 03:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:12 INFO - '_': '/tools/buildbot/bin/python'} 03:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:13 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 03:21:13 INFO - Cleaning up... 03:21:13 INFO - Return code: 0 03:21:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:21: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')]} 03:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21: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')]} 03:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:13 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 0x7f7675e4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b07d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f640>, '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 0x1340540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13409d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776', '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 03:21:13 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 03:21:13 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 03:21:13 INFO - Using env: {'DISPLAY': ':0', 03:21:13 INFO - 'HOME': '/home/cltbld', 03:21:13 INFO - 'LANG': 'en_US.UTF-8', 03:21:13 INFO - 'LANGUAGE': 'en_US:en', 03:21:13 INFO - 'LOGNAME': 'cltbld', 03:21:13 INFO - 'MAIL': '/var/mail/cltbld', 03:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:13 INFO - 'MOZ_NO_REMOTE': '1', 03:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:13 INFO - 'NO_EM_RESTART': '1', 03:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:13 INFO - 'PWD': '/builds/slave/test', 03:21:13 INFO - 'SHELL': '/bin/bash', 03:21:13 INFO - 'SHLVL': '1', 03:21:13 INFO - 'TERM': 'linux', 03:21:13 INFO - 'TMOUT': '86400', 03:21:13 INFO - 'USER': 'cltbld', 03:21:13 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776', 03:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:13 INFO - '_': '/tools/buildbot/bin/python'} 03:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:13 INFO - Downloading/unpacking psutil>=0.7.1 03:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:21:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:15 INFO - Installing collected packages: psutil 03:21:15 INFO - Running setup.py install for psutil 03:21:15 INFO - building 'psutil._psutil_linux' extension 03:21:15 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 03:21:15 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 03:21:15 INFO - building 'psutil._psutil_posix' extension 03:21:15 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 03:21:15 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 03:21:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:15 INFO - Successfully installed psutil 03:21:15 INFO - Cleaning up... 03:21:15 INFO - Return code: 0 03:21:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:15 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 0x7f7675e4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b07d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f640>, '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 0x1340540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13409d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776', '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 03:21:15 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 03:21:15 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 03:21:15 INFO - Using env: {'DISPLAY': ':0', 03:21:15 INFO - 'HOME': '/home/cltbld', 03:21:15 INFO - 'LANG': 'en_US.UTF-8', 03:21:15 INFO - 'LANGUAGE': 'en_US:en', 03:21:15 INFO - 'LOGNAME': 'cltbld', 03:21:15 INFO - 'MAIL': '/var/mail/cltbld', 03:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:15 INFO - 'MOZ_NO_REMOTE': '1', 03:21:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:15 INFO - 'NO_EM_RESTART': '1', 03:21:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:15 INFO - 'PWD': '/builds/slave/test', 03:21:15 INFO - 'SHELL': '/bin/bash', 03:21:15 INFO - 'SHLVL': '1', 03:21:15 INFO - 'TERM': 'linux', 03:21:15 INFO - 'TMOUT': '86400', 03:21:15 INFO - 'USER': 'cltbld', 03:21:15 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776', 03:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:15 INFO - '_': '/tools/buildbot/bin/python'} 03:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:21:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:21:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:21:18 INFO - Installing collected packages: mozsystemmonitor 03:21:18 INFO - Running setup.py install for mozsystemmonitor 03:21:18 INFO - Successfully installed mozsystemmonitor 03:21:18 INFO - Cleaning up... 03:21:18 INFO - Return code: 0 03:21:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f7675e4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b07d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f640>, '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 0x1340540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13409d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776', '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 03:21:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:21:18 INFO - Using env: {'DISPLAY': ':0', 03:21:18 INFO - 'HOME': '/home/cltbld', 03:21:18 INFO - 'LANG': 'en_US.UTF-8', 03:21:18 INFO - 'LANGUAGE': 'en_US:en', 03:21:18 INFO - 'LOGNAME': 'cltbld', 03:21:18 INFO - 'MAIL': '/var/mail/cltbld', 03:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:18 INFO - 'MOZ_NO_REMOTE': '1', 03:21:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:18 INFO - 'NO_EM_RESTART': '1', 03:21:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:18 INFO - 'PWD': '/builds/slave/test', 03:21:18 INFO - 'SHELL': '/bin/bash', 03:21:18 INFO - 'SHLVL': '1', 03:21:18 INFO - 'TERM': 'linux', 03:21:18 INFO - 'TMOUT': '86400', 03:21:18 INFO - 'USER': 'cltbld', 03:21:18 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776', 03:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:18 INFO - '_': '/tools/buildbot/bin/python'} 03:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:18 INFO - Downloading/unpacking blobuploader==1.2.4 03:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:20 INFO - Downloading blobuploader-1.2.4.tar.gz 03:21:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:21:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:21:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:21: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 03:21: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 03:21: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 03:21: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 03:21: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 03:21: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 03:21:21 INFO - Downloading docopt-0.6.1.tar.gz 03:21:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:21:21 INFO - Installing collected packages: blobuploader, requests, docopt 03:21:21 INFO - Running setup.py install for blobuploader 03:21:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:21:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:21:21 INFO - Running setup.py install for requests 03:21:21 INFO - Running setup.py install for docopt 03:21:21 INFO - Successfully installed blobuploader requests docopt 03:21:21 INFO - Cleaning up... 03:21:21 INFO - Return code: 0 03:21:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:21 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 0x7f7675e4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b07d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f640>, '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 0x1340540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13409d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776', '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 03:21:21 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 03:21:21 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 03:21:21 INFO - Using env: {'DISPLAY': ':0', 03:21:21 INFO - 'HOME': '/home/cltbld', 03:21:21 INFO - 'LANG': 'en_US.UTF-8', 03:21:21 INFO - 'LANGUAGE': 'en_US:en', 03:21:21 INFO - 'LOGNAME': 'cltbld', 03:21:21 INFO - 'MAIL': '/var/mail/cltbld', 03:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:21 INFO - 'MOZ_NO_REMOTE': '1', 03:21:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:21 INFO - 'NO_EM_RESTART': '1', 03:21:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:21 INFO - 'PWD': '/builds/slave/test', 03:21:21 INFO - 'SHELL': '/bin/bash', 03:21:21 INFO - 'SHLVL': '1', 03:21:21 INFO - 'TERM': 'linux', 03:21:21 INFO - 'TMOUT': '86400', 03:21:21 INFO - 'USER': 'cltbld', 03:21:21 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776', 03:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:21 INFO - '_': '/tools/buildbot/bin/python'} 03:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:22 INFO - Running setup.py (path:/tmp/pip-PFsFBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:22 INFO - Running setup.py (path:/tmp/pip-JwZDeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:22 INFO - Running setup.py (path:/tmp/pip-j0RmAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:22 INFO - Running setup.py (path:/tmp/pip-wyO6yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:22 INFO - Running setup.py (path:/tmp/pip-jkQ5pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:22 INFO - Running setup.py (path:/tmp/pip-MGI602-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:22 INFO - Running setup.py (path:/tmp/pip-JXSItg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:22 INFO - Running setup.py (path:/tmp/pip-NVaqDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:22 INFO - Running setup.py (path:/tmp/pip-DIXiSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:22 INFO - Running setup.py (path:/tmp/pip-Jfn_Tl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:22 INFO - Running setup.py (path:/tmp/pip-Vb0cbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:22 INFO - Running setup.py (path:/tmp/pip-iEbVnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:22 INFO - Running setup.py (path:/tmp/pip-hOETO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:23 INFO - Running setup.py (path:/tmp/pip-jxL5Ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:23 INFO - Running setup.py (path:/tmp/pip-sax4cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:23 INFO - Running setup.py (path:/tmp/pip-NNy8Y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:23 INFO - Running setup.py (path:/tmp/pip-gYyUyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:21:23 INFO - Running setup.py install for manifestparser 03:21:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:21:23 INFO - Running setup.py install for mozcrash 03:21:23 INFO - Running setup.py install for mozdebug 03:21:23 INFO - Running setup.py install for mozdevice 03:21:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:21:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:21:23 INFO - Running setup.py install for mozfile 03:21:23 INFO - Running setup.py install for mozhttpd 03:21:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:21:23 INFO - Running setup.py install for mozinfo 03:21:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:21:24 INFO - Running setup.py install for mozInstall 03:21:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:21:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:21:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:21:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:21:24 INFO - Running setup.py install for mozleak 03:21:24 INFO - Running setup.py install for mozlog 03:21:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:21:24 INFO - Running setup.py install for moznetwork 03:21:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:21:24 INFO - Running setup.py install for mozprocess 03:21:24 INFO - Running setup.py install for mozprofile 03:21:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:21:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:21:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:21:24 INFO - Running setup.py install for mozrunner 03:21:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:21:24 INFO - Running setup.py install for mozscreenshot 03:21:24 INFO - Running setup.py install for moztest 03:21:24 INFO - Running setup.py install for mozversion 03:21:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:21:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:21:25 INFO - Cleaning up... 03:21:25 INFO - Return code: 0 03:21:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:25 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')]} 03:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:25 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')]} 03:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:25 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 0x7f7675e4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b07d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f640>, '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 0x1340540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13409d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776', '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 03:21:25 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 03:21:25 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 03:21:25 INFO - Using env: {'DISPLAY': ':0', 03:21:25 INFO - 'HOME': '/home/cltbld', 03:21:25 INFO - 'LANG': 'en_US.UTF-8', 03:21:25 INFO - 'LANGUAGE': 'en_US:en', 03:21:25 INFO - 'LOGNAME': 'cltbld', 03:21:25 INFO - 'MAIL': '/var/mail/cltbld', 03:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:25 INFO - 'MOZ_NO_REMOTE': '1', 03:21:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:25 INFO - 'NO_EM_RESTART': '1', 03:21:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:25 INFO - 'PWD': '/builds/slave/test', 03:21:25 INFO - 'SHELL': '/bin/bash', 03:21:25 INFO - 'SHLVL': '1', 03:21:25 INFO - 'TERM': 'linux', 03:21:25 INFO - 'TMOUT': '86400', 03:21:25 INFO - 'USER': 'cltbld', 03:21:25 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776', 03:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:25 INFO - '_': '/tools/buildbot/bin/python'} 03:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:21:25 INFO - Running setup.py (path:/tmp/pip-_rOqAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:21:25 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)) 03:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:21:25 INFO - Running setup.py (path:/tmp/pip-6zmeAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:21:25 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)) 03:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:21:25 INFO - Running setup.py (path:/tmp/pip-wovmiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:21:25 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)) 03:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:21:25 INFO - Running setup.py (path:/tmp/pip-d_9_Dk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:21:25 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)) 03:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:21:25 INFO - Running setup.py (path:/tmp/pip-zUCjvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:21:25 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)) 03:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:21:25 INFO - Running setup.py (path:/tmp/pip-W5h7IY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:21:25 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)) 03:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:21:25 INFO - Running setup.py (path:/tmp/pip-b8LyWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:21:25 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)) 03:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:21:25 INFO - Running setup.py (path:/tmp/pip-e3PhG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:21:25 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)) 03:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:21:25 INFO - Running setup.py (path:/tmp/pip-dgr3OX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:21:25 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)) 03:21:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:21:25 INFO - Running setup.py (path:/tmp/pip-4o4J4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:21:26 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)) 03:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:21:26 INFO - Running setup.py (path:/tmp/pip-A7Lhxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:21:26 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)) 03:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:21:26 INFO - Running setup.py (path:/tmp/pip-EFdwVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:21:26 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)) 03:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:21:26 INFO - Running setup.py (path:/tmp/pip-X3N1Kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:21:26 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)) 03:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:21:26 INFO - Running setup.py (path:/tmp/pip-Pki9MQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:21:26 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)) 03:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:26 INFO - Running setup.py (path:/tmp/pip-3JLCBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:21:26 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)) 03:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:21:26 INFO - Running setup.py (path:/tmp/pip-B0eZsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:21:26 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)) 03:21:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:21:26 INFO - Running setup.py (path:/tmp/pip-rf4LJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:21:26 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)) 03:21:26 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)) 03:21:26 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)) 03:21:26 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)) 03:21:26 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)) 03:21:26 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)) 03:21:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:28 INFO - Downloading blessings-1.6.tar.gz 03:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:21:28 INFO - Installing collected packages: blessings 03:21:28 INFO - Running setup.py install for blessings 03:21:28 INFO - Successfully installed blessings 03:21:28 INFO - Cleaning up... 03:21:28 INFO - Return code: 0 03:21:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:21:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:28 INFO - Reading from file tmpfile_stdout 03:21:28 INFO - Current package versions: 03:21:28 INFO - argparse == 1.2.1 03:21:28 INFO - blessings == 1.6 03:21:28 INFO - blobuploader == 1.2.4 03:21:28 INFO - docopt == 0.6.1 03:21:28 INFO - manifestparser == 1.1 03:21:28 INFO - mozInstall == 1.12 03:21:28 INFO - mozcrash == 0.17 03:21:28 INFO - mozdebug == 0.1 03:21:28 INFO - mozdevice == 0.48 03:21:28 INFO - mozfile == 1.2 03:21:28 INFO - mozhttpd == 0.7 03:21:28 INFO - mozinfo == 0.9 03:21:28 INFO - mozleak == 0.1 03:21:28 INFO - mozlog == 3.1 03:21:28 INFO - moznetwork == 0.27 03:21:28 INFO - mozprocess == 0.22 03:21:28 INFO - mozprofile == 0.28 03:21:28 INFO - mozrunner == 6.11 03:21:28 INFO - mozscreenshot == 0.1 03:21:28 INFO - mozsystemmonitor == 0.0 03:21:28 INFO - moztest == 0.7 03:21:28 INFO - mozversion == 1.4 03:21:28 INFO - psutil == 3.1.1 03:21:28 INFO - requests == 1.2.3 03:21:28 INFO - wsgiref == 0.1.2 03:21:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:21:28 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')]} 03:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:28 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')]} 03:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:28 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 0x7f7675e4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b07d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f640>, '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 0x1340540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13409d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776', '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 03:21:28 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 03:21:28 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 03:21:28 INFO - Using env: {'DISPLAY': ':0', 03:21:28 INFO - 'HOME': '/home/cltbld', 03:21:28 INFO - 'LANG': 'en_US.UTF-8', 03:21:28 INFO - 'LANGUAGE': 'en_US:en', 03:21:28 INFO - 'LOGNAME': 'cltbld', 03:21:28 INFO - 'MAIL': '/var/mail/cltbld', 03:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:28 INFO - 'MOZ_NO_REMOTE': '1', 03:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:28 INFO - 'NO_EM_RESTART': '1', 03:21:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:28 INFO - 'PWD': '/builds/slave/test', 03:21:28 INFO - 'SHELL': '/bin/bash', 03:21:28 INFO - 'SHLVL': '1', 03:21:28 INFO - 'TERM': 'linux', 03:21:28 INFO - 'TMOUT': '86400', 03:21:28 INFO - 'USER': 'cltbld', 03:21:28 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776', 03:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:28 INFO - '_': '/tools/buildbot/bin/python'} 03:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:29 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)) 03:21:29 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)) 03:21:29 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)) 03:21:29 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)) 03:21:29 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)) 03:21:29 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)) 03:21:29 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)) 03:21:29 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)) 03:21:29 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)) 03:21:29 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)) 03:21:29 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)) 03:21:29 INFO - Cleaning up... 03:21:29 INFO - Return code: 0 03:21:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:29 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 0x7f7675e4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b07d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f640>, '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 0x1340540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13409d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776', '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 03:21:29 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 03:21:29 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 03:21:29 INFO - Using env: {'DISPLAY': ':0', 03:21:29 INFO - 'HOME': '/home/cltbld', 03:21:29 INFO - 'LANG': 'en_US.UTF-8', 03:21:29 INFO - 'LANGUAGE': 'en_US:en', 03:21:29 INFO - 'LOGNAME': 'cltbld', 03:21:29 INFO - 'MAIL': '/var/mail/cltbld', 03:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:29 INFO - 'MOZ_NO_REMOTE': '1', 03:21:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:29 INFO - 'NO_EM_RESTART': '1', 03:21:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:29 INFO - 'PWD': '/builds/slave/test', 03:21:29 INFO - 'SHELL': '/bin/bash', 03:21:29 INFO - 'SHLVL': '1', 03:21:29 INFO - 'TERM': 'linux', 03:21:29 INFO - 'TMOUT': '86400', 03:21:29 INFO - 'USER': 'cltbld', 03:21:29 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776', 03:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:29 INFO - '_': '/tools/buildbot/bin/python'} 03:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:29 INFO - Downloading/unpacking jsonschema 03:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:21:31 INFO - Downloading/unpacking functools32 (from jsonschema) 03:21:31 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 03:21:31 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 03:21:31 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 03:21:31 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 03:21:31 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 03:21:31 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 03:21:31 INFO - Downloading functools32-3.2.3-2.tar.gz 03:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:21:31 INFO - warning: no files found matching '*.txt' 03:21:31 INFO - no previously-included directories found matching 'build' 03:21:31 INFO - no previously-included directories found matching 'dist' 03:21:31 INFO - no previously-included directories found matching '.git*' 03:21:31 INFO - Installing collected packages: jsonschema, functools32 03:21:31 INFO - Running setup.py install for functools32 03:21:31 INFO - warning: no files found matching '*.txt' 03:21:31 INFO - no previously-included directories found matching 'build' 03:21:31 INFO - no previously-included directories found matching 'dist' 03:21:31 INFO - no previously-included directories found matching '.git*' 03:21:31 INFO - Successfully installed jsonschema functools32 03:21:31 INFO - Cleaning up... 03:21:31 INFO - Return code: 0 03:21:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:21:31 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')]} 03:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:31 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')]} 03:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:31 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 0x7f7675e4ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12b07d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f640>, '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 0x1340540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13409d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776', '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 03:21:31 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 03:21:31 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 03:21:31 INFO - Using env: {'DISPLAY': ':0', 03:21:31 INFO - 'HOME': '/home/cltbld', 03:21:31 INFO - 'LANG': 'en_US.UTF-8', 03:21:31 INFO - 'LANGUAGE': 'en_US:en', 03:21:31 INFO - 'LOGNAME': 'cltbld', 03:21:31 INFO - 'MAIL': '/var/mail/cltbld', 03:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:31 INFO - 'MOZ_NO_REMOTE': '1', 03:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:31 INFO - 'NO_EM_RESTART': '1', 03:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:31 INFO - 'PWD': '/builds/slave/test', 03:21:31 INFO - 'SHELL': '/bin/bash', 03:21:31 INFO - 'SHLVL': '1', 03:21:31 INFO - 'TERM': 'linux', 03:21:31 INFO - 'TMOUT': '86400', 03:21:31 INFO - 'USER': 'cltbld', 03:21:31 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776', 03:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:31 INFO - '_': '/tools/buildbot/bin/python'} 03:21:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:31 INFO - Downloading/unpacking flake8 03:21:31 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 03:21:31 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 03:21:31 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 03:21:31 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 03:21:31 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 03:21:31 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 03:21:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:21:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:21:33 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 03:21:33 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 03:21:33 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 03:21:33 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 03:21:33 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 03:21:33 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 03:21:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:21:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:21:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:21:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:21:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:21:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:21:34 INFO - no previously-included directories found matching 'docs/_build' 03:21:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:21:34 INFO - Running setup.py install for pep8 03:21:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:21:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:21:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:21:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:21:34 INFO - no previously-included directories found matching 'docs/_build' 03:21:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:21:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:21:34 INFO - Cleaning up... 03:21:34 INFO - Return code: 0 03:21:34 INFO - Running post-action listener: _resource_record_post_action 03:21:34 INFO - Running post-action listener: _start_resource_monitoring 03:21:34 INFO - Starting resource monitoring. 03:21:34 INFO - ##### 03:21:34 INFO - ##### Running install step. 03:21:34 INFO - ##### 03:21:34 INFO - Running pre-action listener: _resource_record_pre_action 03:21:34 INFO - Running main action method: install 03:21:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:21:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:21:35 INFO - Reading from file tmpfile_stdout 03:21:35 INFO - Detecting whether we're running mozinstall >=1.0... 03:21:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:21:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:21:35 INFO - Reading from file tmpfile_stdout 03:21:35 INFO - Output received: 03:21:35 INFO - Usage: mozinstall [options] installer 03:21:35 INFO - Options: 03:21:35 INFO - -h, --help show this help message and exit 03:21:35 INFO - -d DEST, --destination=DEST 03:21:35 INFO - Directory to install application into. [default: 03:21:35 INFO - "/builds/slave/test"] 03:21:35 INFO - --app=APP Application being installed. [default: firefox] 03:21:35 INFO - mkdir: /builds/slave/test/build/application 03:21:35 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'] 03:21:35 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 03:21:50 INFO - Reading from file tmpfile_stdout 03:21:50 INFO - Output received: 03:21:50 INFO - /builds/slave/test/build/application/firefox/firefox 03:21:50 INFO - Running post-action listener: _resource_record_post_action 03:21:50 INFO - ##### 03:21:50 INFO - ##### Running run-tests step. 03:21:50 INFO - ##### 03:21:50 INFO - Running pre-action listener: _resource_record_pre_action 03:21:50 INFO - Running main action method: run_tests 03:21:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:21:50 INFO - Python 2.7.3 03:21:50 INFO - Return code: 0 03:21:50 INFO - grabbing minidump binary from tooltool 03:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:50 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 0x133f640>, '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 0x1340540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13409d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:21:50 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 03:21:50 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 03:21:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:21:50 INFO - Return code: 0 03:21:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:21:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:21:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:21:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:21:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:21:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:21:51 INFO - Return code: 0 03:21:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:21:51 INFO - Using env: {'DISPLAY': ':0', 03:21:51 INFO - 'HOME': '/home/cltbld', 03:21:51 INFO - 'LANG': 'en_US.UTF-8', 03:21:51 INFO - 'LANGUAGE': 'en_US:en', 03:21:51 INFO - 'LOGNAME': 'cltbld', 03:21:51 INFO - 'MAIL': '/var/mail/cltbld', 03:21:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:21:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:51 INFO - 'MOZ_NO_REMOTE': '1', 03:21:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:51 INFO - 'NO_EM_RESTART': '1', 03:21:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:21:51 INFO - 'PWD': '/builds/slave/test', 03:21:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:21:51 INFO - 'SHELL': '/bin/bash', 03:21:51 INFO - 'SHLVL': '1', 03:21:51 INFO - 'TERM': 'linux', 03:21:51 INFO - 'TMOUT': '86400', 03:21:51 INFO - 'USER': 'cltbld', 03:21:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776', 03:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:51 INFO - '_': '/tools/buildbot/bin/python'} 03:21:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:21:52 INFO - mozversion application_buildid: 20160503022239 03:21:52 INFO - mozversion application_changeset: a78cd451a84ae97c7118a3f25152c18248810547 03:21:52 INFO - mozversion application_display_name: Nightly 03:21:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:21:52 INFO - mozversion application_name: Firefox 03:21:52 INFO - mozversion application_remotingname: firefox 03:21:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:21:52 INFO - mozversion application_vendor: Mozilla 03:21:52 INFO - mozversion application_version: 49.0a1 03:21:52 INFO - mozversion platform_buildid: 20160503022239 03:21:52 INFO - mozversion platform_changeset: a78cd451a84ae97c7118a3f25152c18248810547 03:21:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:21:52 INFO - mozversion platform_version: 49.0a1 03:21:52 INFO - using testdate: 1462270912 03:21:52 INFO - actual date: 1462270912 03:21:52 INFO - starting webserver on 'localhost:53904' 03:21:52 INFO - SUITE-START | Running 2 tests 03:21:52 INFO - TEST-START | dromaeo_css 03:21:52 INFO - operating with platform_type : linux_ 03:21:52 INFO - Initialising browser for dromaeo_css test... 03:21:52 INFO - TEST-INFO | started process 4287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCLuTsK/profile http://localhost:53904/getInfo.html) 03:21:56 INFO - PROCESS | 4287 | 03:21:56 INFO - PROCESS | 4287 | (process:4357): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:21:57 INFO - PROCESS | 4287 | __metrics Screen width/height:1600/1200 03:21:57 INFO - PROCESS | 4287 | colorDepth:24 03:21:57 INFO - PROCESS | 4287 | Browser inner width/height: 1024/697 03:21:57 INFO - PROCESS | 4287 | __metrics 03:21:58 ERROR - PROCESS | 4287 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:21:59 INFO - TEST-INFO | 4287: exit 0 03:21:59 INFO - Browser initialized. 03:21:59 INFO - Running cycle 1/1 for dromaeo_css test... 03:21:59 INFO - TEST-INFO | started process 4408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCLuTsK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:22:01 INFO - PROCESS | 4408 | 03:22:01 INFO - PROCESS | 4408 | (process:4467): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:22:11 INFO - PROCESS | 4408 | RSS: Main: 165445632 03:22:11 INFO - PROCESS | 4408 | 03:23:00 INFO - PROCESS | 4408 | 1462270980824 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] 03:25:10 INFO - PROCESS | 4408 | Cycle 1(1): loaded http://localhost:53904/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53904/tests/dromaeo/cssquery-ext.html) 03:25:12 INFO - PROCESS | 4408 | RSS: Main: 169545728 03:25:12 INFO - PROCESS | 4408 | 03:28:14 INFO - PROCESS | 4408 | Cycle 1(1): loaded http://localhost:53904/tests/dromaeo/cssquery-ext.html (next: http://localhost:53904/tests/dromaeo/cssquery-jquery.html) 03:28:14 INFO - PROCESS | 4408 | RSS: Main: 166731776 03:28:14 INFO - PROCESS | 4408 | 03:31:16 INFO - PROCESS | 4408 | Cycle 1(1): loaded http://localhost:53904/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53904/tests/dromaeo/cssquery-mootools.html) 03:31:17 INFO - PROCESS | 4408 | RSS: Main: 168382464 03:31:17 INFO - PROCESS | 4408 | 03:34:19 INFO - PROCESS | 4408 | Cycle 1(1): loaded http://localhost:53904/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53904/tests/dromaeo/cssquery-prototype.html) 03:34:19 INFO - PROCESS | 4408 | RSS: Main: 166412288 03:34:19 INFO - PROCESS | 4408 | 03:37:22 INFO - PROCESS | 4408 | Cycle 1(1): loaded http://localhost:53904/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53904/tests/dromaeo/cssquery-yui.html) 03:37:23 INFO - PROCESS | 4408 | RSS: Main: 167825408 03:37:23 INFO - PROCESS | 4408 | 03:40:25 INFO - PROCESS | 4408 | Cycle 1(1): loaded http://localhost:53904/tests/dromaeo/cssquery-yui.html (next: http://localhost:53904/tests/dromaeo/cssquery-dojo.html) 03:40:25 INFO - PROCESS | 4408 | RSS: Main: 169742336 03:40:25 INFO - PROCESS | 4408 | 03:40:25 INFO - PROCESS | 4408 | __start_tp_report 03:40:25 INFO - PROCESS | 4408 | _x_x_mozilla_page_load 03:40:25 INFO - PROCESS | 4408 | _x_x_mozilla_page_load_details 03:40:25 INFO - PROCESS | 4408 | |i|pagename|runs| 03:40:25 INFO - PROCESS | 4408 | |0;dojo.html;2586.3146266239446;2665.093868084851;2712.4981878352496;2715.1990162901943;2719.95920061199;4563.589276965073;4585.082983403316;4586.082783443312;4590.334401511779;4656.1153380857695;4514.616257618107;4538.115067561826;4550.90898182037;4581.152486789938;4613.6539759518;4107.630313271805;4171.353440216772;4178.35235538492;4178.623923846853;4220.451341325639;123.76950624143971;4140.979295103535;4200.0339921818;4209.074003719177;4209.85265515707;4151.107511884944;4205.789710514493;4218.8523401681105;4228.957710422903;4258.723182993095;4194.454720886296;4207.074443622429;4212.052288235153;4218.493780746299;4224.281872081723;4165.66674666029;4175.144095460423;4238.5761423857675;4238.894027649302;4257.042165512766;4471.262241730111;4486.371907932892;4499.460064792213;4523.95476045242;4563.133004729124;4885.120678277908;4887.120318342697;4905.681130726527;4905.8773530661665;4906.1168989581865;4794.904101917942;4818.34952281441;4896.363472748555;4912.066707325596;4942.827001054946;4575.588197062247;4595.149897268982;4597.609203217764;4604.677672562889;4637.25803871379;4949.950500495021;5021.924671129936;5024.422191447957;5033.119204139261;5075.086484432837;4707.552782485658;4771;4776.402949631296;4812.663113582085;4822.7829747661435;4849.830255941025;4879.731614761222;4880.585150262196;4881.121398148367;4924.43369012561;4778.5699287064335;4830.855074347775;4835.298881662139;4836.056968891103;4880.170371036932;4810.6632535722165;4826.348442960156;4838.298446725205;4850.8787280317565;4886.169351210303;4122.835086596562;4127.6491498222385;4131.235721391492;4175.770332631673;4181.97909010453;3556.9644303556634;3620.2397496525496;3654.3787556115526;3692.630736926286;3700.629937006278;4284.421603083544;4327.588879056485;4412.911741765147;4429;4443.111377724404;4855.514448555187;4859.586935110485;4860.1737704590305;4875.609951203895;4906.90186196274;4295.055087880662;4308.827646894152;4320.740755554677;4333.848315308949;4355.477342718894;4408.228560001987;4413.205622987893;4414.293713005968;4449;4457.955420445819;4629.259318509023;4645.86062418128;4680.602148817388;4687.718736875799;4726.338312636165;4878.90242195147;4894.290327902506;4908.9263661045825;4909.288153217834;4999.950000500094;4635.837745678885;4636.049609829909;4640.535946405333;4657.580817726421;4691.9061618766755;4765.880852978703;4766.880827979189;4774.450938142019;4776.450708168605;4809.2064809306075;4832.975835120943;4844.854654360375;4892;4918.360613120414;4932.630052745986;4730.290456431563;4738;4767.594754445772;4774.546418090275;4837.05677392905;4743.193657078236;4777.3311736356245;4779;4783.4738178801;4852.17513022794;4639.953600463952;4671.696339737906;4679;4745.501722319244;4760.738159401266;4750.857474275777;4804.231322988305;4807.326974223682;4811.350467686818;4833.806647734052;4607.677462577587;4700.952990470051;4701.788419521062;4734.6449016324605;4752.334673145831 03:40:25 INFO - PROCESS | 4408 | |1;ext.html;572.9169270455784;584.2404873664236;602.7739597650881;610.8656095658955;628.7956414165394;28329;34144.65855341449;34738;35050.29899402011;35058.298834023306;36750.448743268804;37488.250234995285;37511;37524.43713344302;37549.24901501968;7427.740029098983;7604.353629941462;7660.693572257103;7690.5770182639935;7694.653740581659;7554.546727196386;7701.884471732928;7716.614169291541;7717.151113377552;7901.446898717092;7812.140664526897;7912.80217994549;7913.643886025114;7917.56453395063;7937.841243175133;7810;7824.256695613907;7871.330936870373;7873.685052597889;7897.60511974399;7698.730544430974;7751.186125456802;7756.689732410697;7762.611869406507;7785.18255583167;38436.61563384386;38772.80613596942;38858;38895.222095558216;38961.41557876634;3071.324308652093;3201.7438604911786;3209.293955329824;3523.594786599548;3751.718621103428;28450.146495605164;29145.271368215963;29687.25781855449;29698.25754356137;30259.848700756356;2966.851657417142;3014.849257537114;3309.96690033099;3313.8508767105536;3405.5743032120986;170421;171172;172909;173288;173436.13281933634;50839.491605084215;51334.74332628313;51849.48150518522;51880.48119518832;51900;51094.74452627787;52244.73877630587;52633.210501842506;52674.47325526772;54386.728066359414;14106.788398174036;14270.928645356915;14335;14361.210133442552;14374.137551746719;11121.55513779456;11159.386233757059;11184.049355804847;11187.832182517268;11224.158188135922;17674.293028278982;18423.72364414535;18425.788905331447;18491;18522.0738963054;6922.688479018356;7080;7155.785326440215;7233.855322893618;7356.37470814976;795.550513959611;900.1808354397467;985.7190700650424;996.6461906023402;1009.6415772400838;24526.386840329134;25022.064213092814;25059.4988100237;25347.746522534537;25495.23514294574;954.6420092465326;981.2787601113176;992.6426486464867;1005.959761609542;1007.37039350406;13565.932170339085;13870.583882483541;13935.094218875944;13976.440942362395;14489.927550362392;257189;261202;262920;262988;263548;49849.750751246014;50288.74855625771;50305.24542131871;50410.74794626003;50524;1191.493615213548;1250.206119114369;1262.280500114944;1262.9431675574622;1269.1877198592908;27416.862915685295;28472.430551389272;28590.857045714638;28625.570616440353;28780.568291475225;42676.573234267256;43498.34752478652;43661.34507982447;43695.12609747724;43780.78109609432;311948;314965;315204;316491;316760;24849.627255591542;24877.626835597843;25578.744212557634;25683.87158064198;25815.225543233733;41852.37221441742;41892.16215675609;41994.58005420029;42333.153336933705;42526.149477010906;35372.82313588416;36110.4583431254;36209.81895090508;36352.63647363598;36407.81796091109;35669.643303566634;35766.64233357633;36171.457428139125;36220.456693150154;36404.63595364012;26933.326666833487;31186.220344490663;32020.83989580037;34511.4823277656;35417;30480.780768769888;30513.23716907095;31437.056888293388;31480.842595786875;31728.206794830316;23779.286621401385;24284.514309713355;24567;24650.13724519705;24754.628680570167 03:40:25 INFO - PROCESS | 4408 | |2;jquery.html;367.0859559696357;367.366293144326;369.62667705617326;373.68610367291467;385.50077649443966;15896.364145434183;16902.91548542257;17773.7333939991;17814.287428502845;17861.64276714465;15368.308426120824;16057.197140142975;16358.672826543492;16410.09744464054;16451.670966580692;4540.160070386981;4667.346571479996;4686.90626187476;4695.577398034176;4698.882527936812;3491.389006923791;4634.74508902012;5108.591312694975;5390.811321603745;5393.622446428752;5369.355677318707;5370.892582148354;5388.245645609598;5390.649607775502;5394;5195.818146364878;5231.346081739783;5386.380566234874;5396.460353964611;5397.487238712316;5184.274201611777;5193.143131383317;5199.66202196856;5206.531412172884;5224.712640804754;17338;19715.80284197154;20449.4887627809;20899.5820083599;20961.056752446177;1713.2718594597247;1831.4871835885974;1861.1531753052464;1874.6625607390665;1897.4212865076147;8694.17405346491;8766.904136982877;8943.821123577558;9070.954645226731;9145.405548639385;1637.9181040948024;1710.9401170958956;1724.7840272607782;1727.7322015087682;1762.9559261018449;66521.33478665199;69411.30588694099;71295;71369.28630713679;71643;9887;9893.109620134222;10016.198704103654;10149.391036537683;10387.896121038693;14166;14294.785578216128;14296.142231466145;14304.28478576067;14321.928390357982;7277.563346199245;7316.817079572947;7428.591427471433;7487.3261406473675;7526.623668816646;7128.358447739728;7133.393661538724;7141.89287160693;7278.344948954514;7415.85168296631;4372.562743725602;4422.29243321067;4440.111977604427;4499.325101234841;4520.480144783326;1754.6841568517789;1834.2112891456802;1869.26164165154;1871.6256748650324;1922.9808201653145;862.6204470033291;881.8976279650437;890.7283278599959;904.5296445848122;995.3778888194878;16675.91662041706;16869.915650421914;16970.321187152374;16984.57538561546;17679.381221657437;877.7279043496536;897.5512243878061;937.6530683647094;951.6383774165772;957.9329446938648;9604.372982641955;9621;9648.614055437703;9676.177524910461;9868.161206297402;383829;384129;384656;388103;397389;79060;79811.60094199608;81674;84387.5780621093;85799;928.3687092776977;962.7785609309898;976.4678250353575;986.8207492047078;992.5235886774244;15561.84438155604;15646.608834778766;15951.68096638084;16154;16244.593885152966;35226.295474089864;35266.29467410586;36058.27883442264;37110.8144459276;37386.81306593558;49880.75059624824;50006;50627;50991.490085098674;50994.49005509898;6035.69821508914;7595.772126836204;7754.896133540577;7800.4929679572915;7926.603669816371;10622.89377106219;11735;11949.22330048544;12058.638240852788;12174.727673187723;9947.159775441567;10151.492425378554;10173.389596624227;10281.280310378203;10696.518656660624;10376.584936602452;10491.527881245514;10569.471526423802;10619.203559733205;10686;10271.383716977005;10388.324758890649;10609.734756631146;10756.247062705535;10811.189160812813;7609.2010338913615;7774.961125194338;7902.841943161219;7946.64240109208;8029.277365037175;10290.691279261635;10654.73363165927;10759.3544387337;10850.728731781768;10870.782584348426 03:40:25 INFO - PROCESS | 4408 | |3;mootools.html;1414.2787178538945;1445.4290555230684;1565.6633823727896;1722.5349155727945;1735.895846249225;6569.310222426648;7098.467614928875;7204.459665525087;7496.175420703725;7524.24757524248;7090.85818283634;7185.461090418226;7197.424206063515;7214.927850721491;7222.241664625204;2049.026712311655;2077.5637116205617;2081.8542702010864;2089.1538926734697;2092.7174831397797;2071.2129390831465;2083.156321689718;2088.6971389148566;2105.0842883345717;2129.818965387944;2094.8428867834896;2123.7770034146424;2126.5215326551556;2127.4362293992103;2128.6168489671854;2086.405374468269;2087.5198704298023;2089.707440958267;2097.3078883968255;2097.318371529259;2056.1364227024687;2101.842361822854;2106.136484041536;2118.60805750935;2121.554473560554;7354.705811767523;7356.227596102386;7419.6661150248365;7465.365443937272;7472.29013243741;4278.122984788111;4465.82136714531;4508.549145085498;4509.819607215707;4512.481064677539;2650.827696199741;2663.8268512546815;2692.5998480790076;2733.808633395663;2746.6429364182727;866.51908190954;887.8135591525787;909.4634165842185;915.9908400915972;916.6470908700198;9822.26333025026;9981.051800078982;9992.500374981295;9997.400155990665;10015.949920250425;3896.8636097736444;4016.1566071124807;4042.15114825884;4079.755214687128;4084.7957602119777;8639.092895246034;8641.395102342776;8644.308455323684;8714.302855771522;8719.564021798884;4359.912801743947;4411.933820992687;4418.094290670405;4440.289553671397;4447.799849006802;3454.6199918008997;3836.290286297044;4027.2146931348693;4072.8778136655947;4087.7547347159266;3446.672566106216;3447.793132412063;3454.9481757773656;3540.3627347077772;3542.5926018507685;1100.5432745410565;1119.339589642115;1124.3085502415956;1127.881572434899;1137.4938152522213;653.6535636112868;747.312472525278;799.0725583755891;813.0852790610563;818.9140140285303;4972.57733092684;5080.364954380702;5092.159793634009;5093.9745301274;5134.691918484903;368.69766791231467;375.1222140191964;375.212054685159;375.80270358062234;377.5657993307718;3301.554290170844;3380.9486072037225;3393.4400823863784;3437.071990562534;3446.190145315849;8825.470471771714;9202.033786452326;9226;9232.353735238603;9243.352965292364;9104.089591040974;9148.2681385489;9169.724908252763;9172.816543669089;9206.309526785384;6944.618046007417;7022.262662420474;7076.504644674823;7082.618889316534;7174.0315057467615;4953.603711702983;5033.521815427529;5041.521055499722;5077.1876499759865;5237.738113094406;8027.2775450209765;8334.79163020905;8346.415750897622;8358.83282334362;8370.288525475402;8259;8343.582820859054;8353.16468353184;8383.664653413794;8575.271101956403;5589.748461319169;5762.279715035621;6187.597806142587;6270.686465676789;6429.2284925807335;7106.289371062852;7127.572345659277;7135.250798666066;7135.357817796424;7138.286171382821;6361.045843123568;6488.480921526361;6551.6069035858;6578.407943285128;6613.10723052401;6370.29926708071;6464;6511.088447617432;6513.218413790375;6523.64119973406;6065.302490213506;6264.467520260829;6285.937140628718;6292.968535157295;6302.3067462578165;4447.976965298064;4522.796474158605;4542.364069030273;4561.612262957686;4616.538346165356;4576.565226303496;4637.304404339376;4664.043871006504;4683.250679891201;4771.165046116985 03:40:25 INFO - PROCESS | 4408 | |4;prototype.html;305.80734137493374;306.72394844639837;307.51719799914133;310.55745562573327;312.89830804988384;4774.809007639695;4835.791052236941;4837.177679794435;4844.467108618049;4849.175640141176;4768.308595253686;4769.451513075997;4773.236282194849;4779.211430114027;4835.443923948747;3589.910252243689;3686.2443199144113;3827.1962887793457;3853.2293541291715;3859.1702783901455;3797.525309336333;3826.1391186982846;3826.3112639724836;3836.482074919892;3865.845366185349;3752.6810221131236;3810.9618903810883;3814.408766641175;3817.1220619257588;3819.4652748615217;3537.001594099351;3779.168582911755;3784.7539909905768;3806.371948628473;3808.0099174214765;3280.5243239730107;3282.917927051843;3299.6700329967052;3308.586426696663;3324.268660894599;4588.426446694163;4596.88507787308;4607.723536587815;4625.421822272216;4626.236670949289;4263.509696384894;4301.2902871026245;4302.419173411612;4303.289957157065;4333.826646934119;4969.049267192226;4970.5526502614575;5050;5060.873478163038;5081.8475445736685;3607.863522990276;3613.7831730096277;3618.185908170667;3619.2761447710564;3634.9273014539563;5218.895622087575;5257.316548848664;5270.209468579744;5283.63014588979;5286.471352864683;3576.2668652926086;3688.133288677159;3695.187058847103;3695.8336874840697;3719.1817800083936;3725.4784330193793;3738.513993180869;3760.8683696070507;3765.7928813915496;3784.1863999240295;4179.498460184797;4245.12974840157;4252.829886804555;4278.0374415756205;4284.850030248988;4942.382202224722;5005.974970125126;5022.799088036438;5023.422306434733;5042.773075211624;1338.0967846703436;1344.5428554291589;1349.5479014530047;1352.9458821647024;1353.5195005773005;852.6120615120105;904.7602385367883;909.6497848328308;925.5048549026238;927.5269612497675;4423.314386270134;4550.294704320836;4567.1550763108935;4568.200564901129;4583.633309335245;5212.40057393397;5222;5224.138017227191;5241.31862857826;5251.133562962068;4451.532589078165;4563.041761230179;4563.881848946963;4576.748278844696;4581.152486789888;2967.554866770002;2973.8215707057648;2984.224101733565;2989.2078599171236;2997.5953246311906;5283.75831679555;5313.123334649739;5313.309269794902;5323.1749078892835;5330.546903513167;5542.251796007487;5687.772489100473;5703.771849125988;5732.914006289909;5781;5305.549028332635;5310.787568497217;5317.760700768475;5332.640436525042;5347.679139251657;5546.972265138648;5565.1374037024325;5586.217929489956;5599.80400685974;5599.944000560105;5365.758540865749;5445.945540544702;5472.835814925558;5513.476219759116;5515.641483303572;5272.789088436573;5296.708681022581;5313.787448502017;5317.760700768397;5359.946400535945;3818.8543436969353;3819.255245227154;3824.7513911595656;3825.3688141456346;3832.827522761538;5439.5104440600535;5507.201455788968;5545.667259964253;5558.861028474321;5586.776528938797;5306.442823503631;5359.705216213146;5361.115415956324;5369.892602148013;5375.462453754593;5246.790128394821;5379.327584051994;5387.434319396407;5392.676439413648;5406.540444062299;5304.761285742074;5312.123499622519;5324.760385782572;5339.145736682112;5340.546053585489;4835.492273311252;4930.975345123252;5094.719790411563;5111.87220319495;5440.510354068153;4968.105740966661;4975.203967365204;4978.502149785138;4980.128477516492;5008.474110218521 03:40:25 INFO - PROCESS | 4408 | |5;yui.html;644.6035688051848;755.7921571567819;756.4591317208192;759.6125975752371;765.5712800831535;11141;11428.42857857108;11444.14168937329;11458.312501249931;11467.08263338933;11371.31772093673;11480.311181329125;13127.80308295374;13618.523351682694;13647.317634118304;785.9449838511307;791.4341246009102;792.8771040488705;797.314309693663;805.4563169860351;635.7457017193113;767.1829501580798;802.1417083720421;805.287320721163;806.1776987472774;838.7819167016589;850.974470765878;854.372036553136;857.2284943550823;857.3526987124712;835.2107258640588;836.9288610468118;840.8696652018947;844.8352571248608;844.8352571248639;602.4276936909953;607.4775692904099;608.5679167790873;610.3682688417466;611.1779656362186;12550.68623284416;12621.179623324546;12676.80984785229;12698.682532936658;12705.936470317589;12299.631011069681;12888.484460621657;12923.289219092947;13087.541936032289;13144.14563053408;9475;9618.470984095871;9661.758456038655;9867.654632087842;9925.057119573628;4120.814563344627;4155.563665815076;4183.205191013698;4196.139791342767;4230.894227644303;40712.38931416031;41387.586124138674;41410.58589414127;41414.1717165655;41586.792066039474;8870.689525866565;9071.863922041175;9169.312301577409;9182.67860624875;9450.621975121056;17308.221130048925;17833.732494012602;17936.282548698167;17946.820531794776;17989.910050449664;6306.085617585424;6431.774887878902;6703.530752847351;6771.72913083481;6950.478714096463;3399.7280217582534;3558;3592.9640703593154;3659.341318562631;3731.7014638828828;2615.2285075902655;2659.3617531792615;2687.032668239432;2690.5157071727276;2697.2447714639934;503.3230305239447;503.59963828756224;528.125951550185;534.2493796216322;538.1148011521026;501.92722055302505;527.8723562889862;584.8128598848327;608.0301918440081;652.5627829354344;8145.79635509117;8206.466579672302;8220.917790822135;8278.958605206935;8409.369297302726;641.9197600299963;644.1625886347729;650.4828661214345;656.8883289840738;664.0935123556408;3814;3891.922161556753;4012.719109662354;4091.161311931047;4096.836126554905;53409.465905341225;54033.72983135059;54629;54666.45333546614;54741.72629136909;48263.27605085926;49126;49670.25494617584;49878.50121498739;50272.99454010899;44148.77925610352;44315;44345;44936.12774451098;45068.19727210875;7616.885746713914;7945.404094692805;7984;7985.840283194188;8216.958915205385;26025.21924342273;29703.554446682883;30194.09417717472;30327.696723032488;30731.846340768152;36581.08547286232;37158.25683486369;38818.80590597029;39472.21055578815;39534;10532;10599.417032063311;10668.786624267626;10884.51019704131;10994.780104397707;10704.785904282027;11037.172212083966;11361.488733006869;11490.712732181428;12413.379331033593;10599.364038157735;11125.499352529318;11292.49183786748;11331;11565.595204167814;10766.623168189075;11400.600978965696;11441.199116061796;11499.712507187052;11534.423278836193;10715.946420267848;10819.621313253998;10829.620963266249;11156.107511398906;11290.66128016128;8873.334499912662;8922.286217102746;9172.724818255463;9258.259339252978;9348.065193480597;9459.290553208399;9477.24182065447;9589.42463452195;9734.951325243328;9736.75658108553 03:40:25 INFO - PROCESS | 4408 | __end_tp_report 03:40:25 INFO - PROCESS | 4408 | __start_cc_report 03:40:25 INFO - PROCESS | 4408 | _x_x_mozilla_cycle_collect,383 03:40:25 INFO - PROCESS | 4408 | __end_cc_report 03:40:25 INFO - PROCESS | 4408 | __startTimestamp1462272025728__endTimestamp 03:40:25 INFO - PROCESS | 4408 | 03:40:25 INFO - PROCESS | 4408 | ------- Summary: start ------- 03:40:25 INFO - PROCESS | 4408 | Number of tests: 6 03:40:25 INFO - PROCESS | 4408 | 03:40:25 INFO - PROCESS | 4408 | [#0] dojo.html Cycles:165 Average:4506.69 Median:4657.58 stddev:565.32 (12.1%) stddev-sans-first:546.61 03:40:25 INFO - PROCESS | 4408 | Values: 2586.3 2665.1 2712.5 2715.2 2720.0 4563.6 4585.1 4586.1 4590.3 4656.1 4514.6 4538.1 4550.9 4581.2 4613.7 4107.6 4171.4 4178.4 4178.6 4220.5 123.8 4141.0 4200.0 4209.1 4209.9 4151.1 4205.8 4218.9 4229.0 4258.7 4194.5 4207.1 4212.1 4218.5 4224.3 4165.7 4175.1 4238.6 4238.9 4257.0 4471.3 4486.4 4499.5 4524.0 4563.1 4885.1 4887.1 4905.7 4905.9 4906.1 4794.9 4818.3 4896.4 4912.1 4942.8 4575.6 4595.1 4597.6 4604.7 4637.3 4950.0 5021.9 5024.4 5033.1 5075.1 4707.6 4771.0 4776.4 4812.7 4822.8 4849.8 4879.7 4880.6 4881.1 4924.4 4778.6 4830.9 4835.3 4836.1 4880.2 4810.7 4826.3 4838.3 4850.9 4886.2 4122.8 4127.6 4131.2 4175.8 4182.0 3557.0 3620.2 3654.4 3692.6 3700.6 4284.4 4327.6 4412.9 4429.0 4443.1 4855.5 4859.6 4860.2 4875.6 4906.9 4295.1 4308.8 4320.7 4333.8 4355.5 4408.2 4413.2 4414.3 4449.0 4458.0 4629.3 4645.9 4680.6 4687.7 4726.3 4878.9 4894.3 4908.9 4909.3 5000.0 4635.8 4636.0 4640.5 4657.6 4691.9 4765.9 4766.9 4774.5 4776.5 4809.2 4833.0 4844.9 4892.0 4918.4 4932.6 4730.3 4738.0 4767.6 4774.5 4837.1 4743.2 4777.3 4779.0 4783.5 4852.2 4640.0 4671.7 4679.0 4745.5 4760.7 4750.9 4804.2 4807.3 4811.4 4833.8 4607.7 4701.0 4701.8 4734.6 4752.3 03:40:25 INFO - PROCESS | 4408 | 03:40:25 INFO - PROCESS | 4408 | [#1] ext.html Cycles:180 Average:41126.27 Median:19448.21 stddev:67167.13 (345.4%) stddev-sans-first:67286.54 03:40:25 INFO - PROCESS | 4408 | Values: 572.9 584.2 602.8 610.9 628.8 28329.0 34144.7 34738.0 35050.3 35058.3 36750.4 37488.3 37511.0 37524.4 37549.2 7427.7 7604.4 7660.7 7690.6 7694.7 7554.5 7701.9 7716.6 7717.2 7901.4 7812.1 7912.8 7913.6 7917.6 7937.8 7810.0 7824.3 7871.3 7873.7 7897.6 7698.7 7751.2 7756.7 7762.6 7785.2 38436.6 38772.8 38858.0 38895.2 38961.4 3071.3 3201.7 3209.3 3523.6 3751.7 28450.1 29145.3 29687.3 29698.3 30259.8 2966.9 3014.8 3310.0 3313.9 3405.6 170421.0 171172.0 172909.0 173288.0 173436.1 50839.5 51334.7 51849.5 51880.5 51900.0 51094.7 52244.7 52633.2 52674.5 54386.7 14106.8 14270.9 14335.0 14361.2 14374.1 11121.6 11159.4 11184.0 11187.8 11224.2 17674.3 18423.7 18425.8 18491.0 18522.1 6922.7 7080.0 7155.8 7233.9 7356.4 795.6 900.2 985.7 996.6 1009.6 24526.4 25022.1 25059.5 25347.7 25495.2 954.6 981.3 992.6 1006.0 1007.4 13565.9 13870.6 13935.1 13976.4 14489.9 257189.0 261202.0 262920.0 262988.0 263548.0 49849.8 50288.7 50305.2 50410.7 50524.0 1191.5 1250.2 1262.3 1262.9 1269.2 27416.9 28472.4 28590.9 28625.6 28780.6 42676.6 43498.3 43661.3 43695.1 43780.8 311948.0 314965.0 315204.0 316491.0 316760.0 24849.6 24877.6 25578.7 25683.9 25815.2 41852.4 41892.2 41994.6 42333.2 42526.1 35372.8 36110.5 36209.8 36352.6 36407.8 35669.6 35766.6 36171.5 36220.5 36404.6 26933.3 31186.2 32020.8 34511.5 35417.0 30480.8 30513.2 31437.1 31480.8 31728.2 23779.3 24284.5 24567.0 24650.1 24754.6 03:40:25 INFO - PROCESS | 4408 | 03:40:25 INFO - PROCESS | 4408 | [#2] jquery.html Cycles:180 Average:24381.35 Median:4469.72 stddev:64154.85 (1435.3%) stddev-sans-first:64309.48 03:40:25 INFO - PROCESS | 4408 | Values: 367.1 367.4 369.6 373.7 385.5 15896.4 16902.9 17773.7 17814.3 17861.6 15368.3 16057.2 16358.7 16410.1 16451.7 4540.2 4667.3 4686.9 4695.6 4698.9 3491.4 4634.7 5108.6 5390.8 5393.6 5369.4 5370.9 5388.2 5390.6 5394.0 5195.8 5231.3 5386.4 5396.5 5397.5 5184.3 5193.1 5199.7 5206.5 5224.7 17338.0 19715.8 20449.5 20899.6 20961.1 1713.3 1831.5 1861.2 1874.7 1897.4 8694.2 8766.9 8943.8 9071.0 9145.4 1637.9 1710.9 1724.8 1727.7 1763.0 66521.3 69411.3 71295.0 71369.3 71643.0 9887.0 9893.1 10016.2 10149.4 10387.9 14166.0 14294.8 14296.1 14304.3 14321.9 7277.6 7316.8 7428.6 7487.3 7526.6 7128.4 7133.4 7141.9 7278.3 7415.9 4372.6 4422.3 4440.1 4499.3 4520.5 1754.7 1834.2 1869.3 1871.6 1923.0 862.6 881.9 890.7 904.5 995.4 16675.9 16869.9 16970.3 16984.6 17679.4 877.7 897.6 937.7 951.6 957.9 9604.4 9621.0 9648.6 9676.2 9868.2 383829.0 384129.0 384656.0 388103.0 397389.0 79060.0 79811.6 81674.0 84387.6 85799.0 928.4 962.8 976.5 986.8 992.5 15561.8 15646.6 15951.7 16154.0 16244.6 35226.3 35266.3 36058.3 37110.8 37386.8 49880.8 50006.0 50627.0 50991.5 50994.5 6035.7 7595.8 7754.9 7800.5 7926.6 10622.9 11735.0 11949.2 12058.6 12174.7 9947.2 10151.5 10173.4 10281.3 10696.5 10376.6 10491.5 10569.5 10619.2 10686.0 10271.4 10388.3 10609.7 10756.2 10811.2 7609.2 7775.0 7902.8 7946.6 8029.3 10290.7 10654.7 10759.4 10850.7 10870.8 03:40:25 INFO - PROCESS | 4408 | 03:40:25 INFO - PROCESS | 4408 | [#3] mootools.html Cycles:180 Average:4883.27 Median:5078.78 stddev:2717.47 (53.5%) stddev-sans-first:2712.59 03:40:25 INFO - PROCESS | 4408 | Values: 1414.3 1445.4 1565.7 1722.5 1735.9 6569.3 7098.5 7204.5 7496.2 7524.2 7090.9 7185.5 7197.4 7214.9 7222.2 2049.0 2077.6 2081.9 2089.2 2092.7 2071.2 2083.2 2088.7 2105.1 2129.8 2094.8 2123.8 2126.5 2127.4 2128.6 2086.4 2087.5 2089.7 2097.3 2097.3 2056.1 2101.8 2106.1 2118.6 2121.6 7354.7 7356.2 7419.7 7465.4 7472.3 4278.1 4465.8 4508.5 4509.8 4512.5 2650.8 2663.8 2692.6 2733.8 2746.6 866.5 887.8 909.5 916.0 916.6 9822.3 9981.1 9992.5 9997.4 10015.9 3896.9 4016.2 4042.2 4079.8 4084.8 8639.1 8641.4 8644.3 8714.3 8719.6 4359.9 4411.9 4418.1 4440.3 4447.8 3454.6 3836.3 4027.2 4072.9 4087.8 3446.7 3447.8 3454.9 3540.4 3542.6 1100.5 1119.3 1124.3 1127.9 1137.5 653.7 747.3 799.1 813.1 818.9 4972.6 5080.4 5092.2 5094.0 5134.7 368.7 375.1 375.2 375.8 377.6 3301.6 3380.9 3393.4 3437.1 3446.2 8825.5 9202.0 9226.0 9232.4 9243.4 9104.1 9148.3 9169.7 9172.8 9206.3 6944.6 7022.3 7076.5 7082.6 7174.0 4953.6 5033.5 5041.5 5077.2 5237.7 8027.3 8334.8 8346.4 8358.8 8370.3 8259.0 8343.6 8353.2 8383.7 8575.3 5589.7 5762.3 6187.6 6270.7 6429.2 7106.3 7127.6 7135.3 7135.4 7138.3 6361.0 6488.5 6551.6 6578.4 6613.1 6370.3 6464.0 6511.1 6513.2 6523.6 6065.3 6264.5 6285.9 6293.0 6302.3 4448.0 4522.8 4542.4 4561.6 4616.5 4576.6 4637.3 4664.0 4683.3 4771.2 03:40:25 INFO - PROCESS | 4408 | 03:40:25 INFO - PROCESS | 4408 | [#4] prototype.html Cycles:180 Average:4320.91 Median:4835.47 stddev:1282.57 (26.5%) stddev-sans-first:1250.27 03:40:25 INFO - PROCESS | 4408 | Values: 305.8 306.7 307.5 310.6 312.9 4774.8 4835.8 4837.2 4844.5 4849.2 4768.3 4769.5 4773.2 4779.2 4835.4 3589.9 3686.2 3827.2 3853.2 3859.2 3797.5 3826.1 3826.3 3836.5 3865.8 3752.7 3811.0 3814.4 3817.1 3819.5 3537.0 3779.2 3784.8 3806.4 3808.0 3280.5 3282.9 3299.7 3308.6 3324.3 4588.4 4596.9 4607.7 4625.4 4626.2 4263.5 4301.3 4302.4 4303.3 4333.8 4969.0 4970.6 5050.0 5060.9 5081.8 3607.9 3613.8 3618.2 3619.3 3634.9 5218.9 5257.3 5270.2 5283.6 5286.5 3576.3 3688.1 3695.2 3695.8 3719.2 3725.5 3738.5 3760.9 3765.8 3784.2 4179.5 4245.1 4252.8 4278.0 4284.9 4942.4 5006.0 5022.8 5023.4 5042.8 1338.1 1344.5 1349.5 1352.9 1353.5 852.6 904.8 909.6 925.5 927.5 4423.3 4550.3 4567.2 4568.2 4583.6 5212.4 5222.0 5224.1 5241.3 5251.1 4451.5 4563.0 4563.9 4576.7 4581.2 2967.6 2973.8 2984.2 2989.2 2997.6 5283.8 5313.1 5313.3 5323.2 5330.5 5542.3 5687.8 5703.8 5732.9 5781.0 5305.5 5310.8 5317.8 5332.6 5347.7 5547.0 5565.1 5586.2 5599.8 5599.9 5365.8 5445.9 5472.8 5513.5 5515.6 5272.8 5296.7 5313.8 5317.8 5359.9 3818.9 3819.3 3824.8 3825.4 3832.8 5439.5 5507.2 5545.7 5558.9 5586.8 5306.4 5359.7 5361.1 5369.9 5375.5 5246.8 5379.3 5387.4 5392.7 5406.5 5304.8 5312.1 5324.8 5339.1 5340.5 4835.5 4931.0 5094.7 5111.9 5440.5 4968.1 4975.2 4978.5 4980.1 5008.5 03:40:25 INFO - PROCESS | 4408 | 03:40:25 INFO - PROCESS | 4408 | [#5] yui.html Cycles:180 Average:12818.06 Median:48694.64 stddev:14614.58 (30.0%) stddev-sans-first:14626.98 03:40:25 INFO - PROCESS | 4408 | Values: 644.6 755.8 756.5 759.6 765.6 11141.0 11428.4 11444.1 11458.3 11467.1 11371.3 11480.3 13127.8 13618.5 13647.3 785.9 791.4 792.9 797.3 805.5 635.7 767.2 802.1 805.3 806.2 838.8 851.0 854.4 857.2 857.4 835.2 836.9 840.9 844.8 844.8 602.4 607.5 608.6 610.4 611.2 12550.7 12621.2 12676.8 12698.7 12705.9 12299.6 12888.5 12923.3 13087.5 13144.1 9475.0 9618.5 9661.8 9867.7 9925.1 4120.8 4155.6 4183.2 4196.1 4230.9 40712.4 41387.6 41410.6 41414.2 41586.8 8870.7 9071.9 9169.3 9182.7 9450.6 17308.2 17833.7 17936.3 17946.8 17989.9 6306.1 6431.8 6703.5 6771.7 6950.5 3399.7 3558.0 3593.0 3659.3 3731.7 2615.2 2659.4 2687.0 2690.5 2697.2 503.3 503.6 528.1 534.2 538.1 501.9 527.9 584.8 608.0 652.6 8145.8 8206.5 8220.9 8279.0 8409.4 641.9 644.2 650.5 656.9 664.1 3814.0 3891.9 4012.7 4091.2 4096.8 53409.5 54033.7 54629.0 54666.5 54741.7 48263.3 49126.0 49670.3 49878.5 50273.0 44148.8 44315.0 44345.0 44936.1 45068.2 7616.9 7945.4 7984.0 7985.8 8217.0 26025.2 29703.6 30194.1 30327.7 30731.8 36581.1 37158.3 38818.8 39472.2 39534.0 10532.0 10599.4 10668.8 10884.5 10994.8 10704.8 11037.2 11361.5 11490.7 12413.4 10599.4 11125.5 11292.5 11331.0 11565.6 10766.6 11400.6 11441.2 11499.7 11534.4 10715.9 10819.6 10829.6 11156.1 11290.7 8873.3 8922.3 9172.7 9258.3 9348.1 9459.3 9477.2 9589.4 9735.0 9736.8 03:40:25 INFO - PROCESS | 4408 | -------- Summary: end -------- 03:40:25 INFO - PROCESS | 4408 | 03:40:26 INFO - TEST-INFO | 4408: exit 0 03:40:26 INFO - TEST-OK | dromaeo_css | took 1114373ms 03:40:26 INFO - TEST-START | kraken 03:40:26 INFO - operating with platform_type : linux_ 03:40:26 INFO - Initialising browser for kraken test... 03:40:26 INFO - TEST-INFO | started process 4638 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTg5D8i/profile http://localhost:53904/getInfo.html) 03:40:30 INFO - PROCESS | 4638 | 03:40:30 INFO - PROCESS | 4638 | (process:4706): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:40:31 INFO - PROCESS | 4638 | __metrics Screen width/height:1600/1200 03:40:31 INFO - PROCESS | 4638 | colorDepth:24 03:40:31 INFO - PROCESS | 4638 | Browser inner width/height: 1024/697 03:40:31 INFO - PROCESS | 4638 | __metrics 03:40:32 ERROR - PROCESS | 4638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:40:33 INFO - TEST-INFO | 4638: exit 0 03:40:33 INFO - Browser initialized. 03:40:33 INFO - Running cycle 1/1 for kraken test... 03:40:33 INFO - TEST-INFO | started process 4757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTg5D8i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:40:35 INFO - PROCESS | 4757 | 03:40:35 INFO - PROCESS | 4757 | (process:4816): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:40:45 INFO - PROCESS | 4757 | RSS: Main: 165736448 03:40:45 INFO - PROCESS | 4757 | 03:40:47 INFO - PROCESS | 4757 | Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53904/tests/kraken/driver.html?testName=audio-beat-detection) 03:40:48 INFO - PROCESS | 4757 | RSS: Main: 170221568 03:40:48 INFO - PROCESS | 4757 | 03:40:51 INFO - PROCESS | 4757 | Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53904/tests/kraken/driver.html?testName=audio-dft) 03:40:52 INFO - PROCESS | 4757 | RSS: Main: 172679168 03:40:52 INFO - PROCESS | 4757 | 03:40:55 INFO - PROCESS | 4757 | Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53904/tests/kraken/driver.html?testName=audio-fft) 03:40:55 INFO - PROCESS | 4757 | RSS: Main: 164974592 03:40:55 INFO - PROCESS | 4757 | 03:40:57 INFO - PROCESS | 4757 | Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53904/tests/kraken/driver.html?testName=audio-oscillator) 03:40:58 INFO - PROCESS | 4757 | RSS: Main: 164659200 03:40:58 INFO - PROCESS | 4757 | 03:41:00 INFO - PROCESS | 4757 | Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53904/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:41:01 INFO - PROCESS | 4757 | RSS: Main: 166158336 03:41:01 INFO - PROCESS | 4757 | 03:41:04 INFO - PROCESS | 4757 | Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53904/tests/kraken/driver.html?testName=imaging-darkroom) 03:41:05 INFO - PROCESS | 4757 | RSS: Main: 166572032 03:41:05 INFO - PROCESS | 4757 | 03:41:08 INFO - PROCESS | 4757 | Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53904/tests/kraken/driver.html?testName=imaging-desaturate) 03:41:09 INFO - PROCESS | 4757 | RSS: Main: 165105664 03:41:09 INFO - PROCESS | 4757 | 03:41:12 INFO - PROCESS | 4757 | Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53904/tests/kraken/driver.html?testName=json-parse-financial) 03:41:13 INFO - PROCESS | 4757 | RSS: Main: 165949440 03:41:13 INFO - PROCESS | 4757 | 03:41:14 INFO - PROCESS | 4757 | Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53904/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:41:15 INFO - PROCESS | 4757 | RSS: Main: 166113280 03:41:15 INFO - PROCESS | 4757 | 03:41:17 INFO - PROCESS | 4757 | Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53904/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:41:17 INFO - PROCESS | 4757 | RSS: Main: 166588416 03:41:17 INFO - PROCESS | 4757 | 03:41:20 INFO - PROCESS | 4757 | Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53904/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:41:20 INFO - PROCESS | 4757 | RSS: Main: 167399424 03:41:20 INFO - PROCESS | 4757 | 03:41:23 INFO - PROCESS | 4757 | Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53904/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:41:24 INFO - PROCESS | 4757 | RSS: Main: 167501824 03:41:24 INFO - PROCESS | 4757 | 03:41:27 INFO - PROCESS | 4757 | Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53904/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:41:27 INFO - PROCESS | 4757 | RSS: Main: 166760448 03:41:27 INFO - PROCESS | 4757 | 03:41:29 INFO - PROCESS | 4757 | Cycle 1(1): loaded http://localhost:53904/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53904/tests/kraken/driver.html?testName=ai-astar) 03:41:30 INFO - PROCESS | 4757 | RSS: Main: 168493056 03:41:30 INFO - PROCESS | 4757 | 03:41:30 INFO - PROCESS | 4757 | __start_tp_report 03:41:30 INFO - PROCESS | 4757 | _x_x_mozilla_page_load 03:41:30 INFO - PROCESS | 4757 | _x_x_mozilla_page_load_details 03:41:30 INFO - PROCESS | 4757 | |i|pagename|runs| 03:41:30 INFO - PROCESS | 4757 | |0;ai-astar;116;111;115;113;116;127;115;115;116;115 03:41:30 INFO - PROCESS | 4757 | |1;audio-beat-detection;164;130;158;189;147;158;159;137;201;146 03:41:30 INFO - PROCESS | 4757 | |2;audio-dft;162;162;161;166;171;163;162;162;166;162 03:41:30 INFO - PROCESS | 4757 | |3;audio-fft;80;76;76;173;77;77;80;76;163;77 03:41:30 INFO - PROCESS | 4757 | |4;audio-oscillator;94;94;149;95;96;94;135;94;93;144 03:41:30 INFO - PROCESS | 4757 | |5;imaging-gaussian-blur;118;119;118;118;118;118;118;118;118;118 03:41:30 INFO - PROCESS | 4757 | |6;imaging-darkroom;148;148;147;148;147;147;147;148;152;151 03:41:30 INFO - PROCESS | 4757 | |7;imaging-desaturate;95;95;95;96;96;97;96;96;95;95 03:41:30 INFO - PROCESS | 4757 | |8;json-parse-financial;67;68;69;67;68;71;68;68;67;69 03:41:30 INFO - PROCESS | 4757 | |9;json-stringify-tinderbox;64;65;67;64;65;64;65;65;64;65 03:41:30 INFO - PROCESS | 4757 | |10;stanford-crypto-aes;82;101;82;90;82;83;85;85;109;82 03:41:30 INFO - PROCESS | 4757 | |11;stanford-crypto-ccm;135;138;136;146;138;136;136;138;137;139 03:41:30 INFO - PROCESS | 4757 | |12;stanford-crypto-pbkdf2;183;182;182;178;179;188;192;193;181;185 03:41:30 INFO - PROCESS | 4757 | |13;stanford-crypto-sha256-iterative;77;78;75;75;77;75;77;73;75;79 03:41:30 INFO - PROCESS | 4757 | __end_tp_report 03:41:30 INFO - PROCESS | 4757 | __start_cc_report 03:41:30 INFO - PROCESS | 4757 | _x_x_mozilla_cycle_collect,930 03:41:30 INFO - PROCESS | 4757 | __end_cc_report 03:41:30 INFO - PROCESS | 4757 | __startTimestamp1462272090020__endTimestamp 03:41:30 INFO - PROCESS | 4757 | 03:41:30 INFO - PROCESS | 4757 | ------- Summary: start ------- 03:41:30 INFO - PROCESS | 4757 | Number of tests: 14 03:41:30 INFO - PROCESS | 4757 | 03:41:30 INFO - PROCESS | 4757 | [#0] ai-astar Cycles:10 Average:115.90 Median:115.50 stddev:4.20 (3.6%) stddev-sans-first:4.46 03:41:30 INFO - PROCESS | 4757 | Values: 116.0 111.0 115.0 113.0 116.0 127.0 115.0 115.0 116.0 115.0 03:41:30 INFO - PROCESS | 4757 | 03:41:30 INFO - PROCESS | 4757 | [#1] audio-beat-detection Cycles:10 Average:158.90 Median:158.50 stddev:21.93 (13.8%) stddev-sans-first:23.18 03:41:30 INFO - PROCESS | 4757 | Values: 164.0 130.0 158.0 189.0 147.0 158.0 159.0 137.0 201.0 146.0 03:41:30 INFO - PROCESS | 4757 | 03:41:30 INFO - PROCESS | 4757 | [#2] audio-dft Cycles:10 Average:163.70 Median:162.50 stddev:3.09 (1.9%) stddev-sans-first:3.22 03:41:30 INFO - PROCESS | 4757 | Values: 162.0 162.0 161.0 166.0 171.0 163.0 162.0 162.0 166.0 162.0 03:41:30 INFO - PROCESS | 4757 | 03:41:30 INFO - PROCESS | 4757 | [#3] audio-fft Cycles:10 Average:95.50 Median:77.00 stddev:38.31 (49.8%) stddev-sans-first:40.22 03:41:30 INFO - PROCESS | 4757 | Values: 80.0 76.0 76.0 173.0 77.0 77.0 80.0 76.0 163.0 77.0 03:41:30 INFO - PROCESS | 4757 | 03:41:30 INFO - PROCESS | 4757 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:94.00 stddev:23.62 (25.1%) stddev-sans-first:24.44 03:41:30 INFO - PROCESS | 4757 | Values: 94.0 94.0 149.0 95.0 96.0 94.0 135.0 94.0 93.0 144.0 03:41:30 INFO - PROCESS | 4757 | 03:41:30 INFO - PROCESS | 4757 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:41:30 INFO - PROCESS | 4757 | Values: 118.0 119.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 118.0 03:41:30 INFO - PROCESS | 4757 | 03:41:30 INFO - PROCESS | 4757 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:1.77 (1.2%) stddev-sans-first:1.87 03:41:30 INFO - PROCESS | 4757 | Values: 148.0 148.0 147.0 148.0 147.0 147.0 147.0 148.0 152.0 151.0 03:41:30 INFO - PROCESS | 4757 | 03:41:30 INFO - PROCESS | 4757 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 03:41:30 INFO - PROCESS | 4757 | Values: 95.0 95.0 95.0 96.0 96.0 97.0 96.0 96.0 95.0 95.0 03:41:30 INFO - PROCESS | 4757 | 03:41:30 INFO - PROCESS | 4757 | [#8] json-parse-financial Cycles:10 Average:68.20 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:1.22 03:41:30 INFO - PROCESS | 4757 | Values: 67.0 68.0 69.0 67.0 68.0 71.0 68.0 68.0 67.0 69.0 03:41:30 INFO - PROCESS | 4757 | 03:41:30 INFO - PROCESS | 4757 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 03:41:30 INFO - PROCESS | 4757 | Values: 64.0 65.0 67.0 64.0 65.0 64.0 65.0 65.0 64.0 65.0 03:41:30 INFO - PROCESS | 4757 | 03:41:30 INFO - PROCESS | 4757 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:82.50 stddev:9.43 (11.4%) stddev-sans-first:9.74 03:41:30 INFO - PROCESS | 4757 | Values: 82.0 101.0 82.0 90.0 82.0 83.0 85.0 85.0 109.0 82.0 03:41:30 INFO - PROCESS | 4757 | 03:41:30 INFO - PROCESS | 4757 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:138.00 stddev:3.11 (2.3%) stddev-sans-first:3.11 03:41:30 INFO - PROCESS | 4757 | Values: 135.0 138.0 136.0 146.0 138.0 136.0 136.0 138.0 137.0 139.0 03:41:30 INFO - PROCESS | 4757 | 03:41:30 INFO - PROCESS | 4757 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.30 Median:184.00 stddev:5.17 (2.8%) stddev-sans-first:5.46 03:41:30 INFO - PROCESS | 4757 | Values: 183.0 182.0 182.0 178.0 179.0 188.0 192.0 193.0 181.0 185.0 03:41:30 INFO - PROCESS | 4757 | 03:41:30 INFO - PROCESS | 4757 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.10 Median:77.00 stddev:1.79 (2.3%) stddev-sans-first:1.87 03:41:30 INFO - PROCESS | 4757 | Values: 77.0 78.0 75.0 75.0 77.0 75.0 77.0 73.0 75.0 79.0 03:41:30 INFO - PROCESS | 4757 | -------- Summary: end -------- 03:41:30 INFO - PROCESS | 4757 | 03:41:31 INFO - TEST-INFO | 4757: exit 0 03:41:31 INFO - TEST-OK | kraken | took 64606ms 03:41:31 INFO - SUITE-END | took 1178s 03:41:31 INFO - Completed test suite (00:19:39) 03:41:31 INFO - javascript benchmark 03:41:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2586.3146266239446, 2665.093868084851, 2712.4981878352496, 2715.1990162901943, 2719.95920061199, 4563.589276965073, 4585.082983403316, 4586.082783443312, 4590.334401511779, 4656.1153380857695, 4514.616257618107, 4538.115067561826, 4550.90898182037, 4581.152486789938, 4613.6539759518, 4107.630313271805, 4171.353440216772, 4178.35235538492, 4178.623923846853, 4220.451341325639, 123.76950624143971, 4140.979295103535, 4200.0339921818, 4209.074003719177, 4209.85265515707, 4151.107511884944, 4205.789710514493, 4218.8523401681105, 4228.957710422903, 4258.723182993095, 4194.454720886296, 4207.074443622429, 4212.052288235153, 4218.493780746299, 4224.281872081723, 4165.66674666029, 4175.144095460423, 4238.5761423857675, 4238.894027649302, 4257.042165512766, 4471.262241730111, 4486.371907932892, 4499.460064792213, 4523.95476045242, 4563.133004729124, 4885.120678277908, 4887.120318342697, 4905.681130726527, 4905.8773530661665, 4906.1168989581865, 4794.904101917942, 4818.34952281441, 4896.363472748555, 4912.066707325596, 4942.827001054946, 4575.588197062247, 4595.149897268982, 4597.609203217764, 4604.677672562889, 4637.25803871379, 4949.950500495021, 5021.924671129936, 5024.422191447957, 5033.119204139261, 5075.086484432837, 4707.552782485658, 4771.0, 4776.402949631296, 4812.663113582085, 4822.7829747661435, 4849.830255941025, 4879.731614761222, 4880.585150262196, 4881.121398148367, 4924.43369012561, 4778.5699287064335, 4830.855074347775, 4835.298881662139, 4836.056968891103, 4880.170371036932, 4810.6632535722165, 4826.348442960156, 4838.298446725205, 4850.8787280317565, 4886.169351210303, 4122.835086596562, 4127.6491498222385, 4131.235721391492, 4175.770332631673, 4181.97909010453, 3556.9644303556634, 3620.2397496525496, 3654.3787556115526, 3692.630736926286, 3700.629937006278, 4284.421603083544, 4327.588879056485, 4412.911741765147, 4429.0, 4443.111377724404, 4855.514448555187, 4859.586935110485, 4860.1737704590305, 4875.609951203895, 4906.90186196274, 4295.055087880662, 4308.827646894152, 4320.740755554677, 4333.848315308949, 4355.477342718894, 4408.228560001987, 4413.205622987893, 4414.293713005968, 4449.0, 4457.955420445819, 4629.259318509023, 4645.86062418128, 4680.602148817388, 4687.718736875799, 4726.338312636165, 4878.90242195147, 4894.290327902506, 4908.9263661045825, 4909.288153217834, 4999.950000500094, 4635.837745678885, 4636.049609829909, 4640.535946405333, 4657.580817726421, 4691.9061618766755, 4765.880852978703, 4766.880827979189, 4774.450938142019, 4776.450708168605, 4809.2064809306075, 4832.975835120943, 4844.854654360375, 4892.0, 4918.360613120414, 4932.630052745986, 4730.290456431563, 4738.0, 4767.594754445772, 4774.546418090275, 4837.05677392905, 4743.193657078236, 4777.3311736356245, 4779.0, 4783.4738178801, 4852.17513022794, 4639.953600463952, 4671.696339737906, 4679.0, 4745.501722319244, 4760.738159401266, 4750.857474275777, 4804.231322988305, 4807.326974223682, 4811.350467686818, 4833.806647734052, 4607.677462577587, 4700.952990470051, 4701.788419521062, 4734.6449016324605, 4752.334673145831], "value": 4475.158748195379, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.9169270455784, 584.2404873664236, 602.7739597650881, 610.8656095658955, 628.7956414165394, 28329.0, 34144.65855341449, 34738.0, 35050.29899402011, 35058.298834023306, 36750.448743268804, 37488.250234995285, 37511.0, 37524.43713344302, 37549.24901501968, 7427.740029098983, 7604.353629941462, 7660.693572257103, 7690.5770182639935, 7694.653740581659, 7554.546727196386, 7701.884471732928, 7716.614169291541, 7717.151113377552, 7901.446898717092, 7812.140664526897, 7912.80217994549, 7913.643886025114, 7917.56453395063, 7937.841243175133, 7810.0, 7824.256695613907, 7871.330936870373, 7873.685052597889, 7897.60511974399, 7698.730544430974, 7751.186125456802, 7756.689732410697, 7762.611869406507, 7785.18255583167, 38436.61563384386, 38772.80613596942, 38858.0, 38895.222095558216, 38961.41557876634, 3071.324308652093, 3201.7438604911786, 3209.293955329824, 3523.594786599548, 3751.718621103428, 28450.146495605164, 29145.271368215963, 29687.25781855449, 29698.25754356137, 30259.848700756356, 2966.851657417142, 3014.849257537114, 3309.96690033099, 3313.8508767105536, 3405.5743032120986, 170421.0, 171172.0, 172909.0, 173288.0, 173436.13281933634, 50839.491605084215, 51334.74332628313, 51849.48150518522, 51880.48119518832, 51900.0, 51094.74452627787, 52244.73877630587, 52633.210501842506, 52674.47325526772, 54386.728066359414, 14106.788398174036, 14270.928645356915, 14335.0, 14361.210133442552, 14374.137551746719, 11121.55513779456, 11159.386233757059, 11184.049355804847, 11187.832182517268, 11224.158188135922, 17674.293028278982, 18423.72364414535, 18425.788905331447, 18491.0, 18522.0738963054, 6922.688479018356, 7080.0, 7155.785326440215, 7233.855322893618, 7356.37470814976, 795.550513959611, 900.1808354397467, 985.7190700650424, 996.6461906023402, 1009.6415772400838, 24526.386840329134, 25022.064213092814, 25059.4988100237, 25347.746522534537, 25495.23514294574, 954.6420092465326, 981.2787601113176, 992.6426486464867, 1005.959761609542, 1007.37039350406, 13565.932170339085, 13870.583882483541, 13935.094218875944, 13976.440942362395, 14489.927550362392, 257189.0, 261202.0, 262920.0, 262988.0, 263548.0, 49849.750751246014, 50288.74855625771, 50305.24542131871, 50410.74794626003, 50524.0, 1191.493615213548, 1250.206119114369, 1262.280500114944, 1262.9431675574622, 1269.1877198592908, 27416.862915685295, 28472.430551389272, 28590.857045714638, 28625.570616440353, 28780.568291475225, 42676.573234267256, 43498.34752478652, 43661.34507982447, 43695.12609747724, 43780.78109609432, 311948.0, 314965.0, 315204.0, 316491.0, 316760.0, 24849.627255591542, 24877.626835597843, 25578.744212557634, 25683.87158064198, 25815.225543233733, 41852.37221441742, 41892.16215675609, 41994.58005420029, 42333.153336933705, 42526.149477010906, 35372.82313588416, 36110.4583431254, 36209.81895090508, 36352.63647363598, 36407.81796091109, 35669.643303566634, 35766.64233357633, 36171.457428139125, 36220.456693150154, 36404.63595364012, 26933.326666833487, 31186.220344490663, 32020.83989580037, 34511.4823277656, 35417.0, 30480.780768769888, 30513.23716907095, 31437.056888293388, 31480.842595786875, 31728.206794830316, 23779.286621401385, 24284.514309713355, 24567.0, 24650.13724519705, 24754.628680570167], "value": 16951.407129994823, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.0859559696357, 367.366293144326, 369.62667705617326, 373.68610367291467, 385.50077649443966, 15896.364145434183, 16902.91548542257, 17773.7333939991, 17814.287428502845, 17861.64276714465, 15368.308426120824, 16057.197140142975, 16358.672826543492, 16410.09744464054, 16451.670966580692, 4540.160070386981, 4667.346571479996, 4686.90626187476, 4695.577398034176, 4698.882527936812, 3491.389006923791, 4634.74508902012, 5108.591312694975, 5390.811321603745, 5393.622446428752, 5369.355677318707, 5370.892582148354, 5388.245645609598, 5390.649607775502, 5394.0, 5195.818146364878, 5231.346081739783, 5386.380566234874, 5396.460353964611, 5397.487238712316, 5184.274201611777, 5193.143131383317, 5199.66202196856, 5206.531412172884, 5224.712640804754, 17338.0, 19715.80284197154, 20449.4887627809, 20899.5820083599, 20961.056752446177, 1713.2718594597247, 1831.4871835885974, 1861.1531753052464, 1874.6625607390665, 1897.4212865076147, 8694.17405346491, 8766.904136982877, 8943.821123577558, 9070.954645226731, 9145.405548639385, 1637.9181040948024, 1710.9401170958956, 1724.7840272607782, 1727.7322015087682, 1762.9559261018449, 66521.33478665199, 69411.30588694099, 71295.0, 71369.28630713679, 71643.0, 9887.0, 9893.109620134222, 10016.198704103654, 10149.391036537683, 10387.896121038693, 14166.0, 14294.785578216128, 14296.142231466145, 14304.28478576067, 14321.928390357982, 7277.563346199245, 7316.817079572947, 7428.591427471433, 7487.3261406473675, 7526.623668816646, 7128.358447739728, 7133.393661538724, 7141.89287160693, 7278.344948954514, 7415.85168296631, 4372.562743725602, 4422.29243321067, 4440.111977604427, 4499.325101234841, 4520.480144783326, 1754.6841568517789, 1834.2112891456802, 1869.26164165154, 1871.6256748650324, 1922.9808201653145, 862.6204470033291, 881.8976279650437, 890.7283278599959, 904.5296445848122, 995.3778888194878, 16675.91662041706, 16869.915650421914, 16970.321187152374, 16984.57538561546, 17679.381221657437, 877.7279043496536, 897.5512243878061, 937.6530683647094, 951.6383774165772, 957.9329446938648, 9604.372982641955, 9621.0, 9648.614055437703, 9676.177524910461, 9868.161206297402, 383829.0, 384129.0, 384656.0, 388103.0, 397389.0, 79060.0, 79811.60094199608, 81674.0, 84387.5780621093, 85799.0, 928.3687092776977, 962.7785609309898, 976.4678250353575, 986.8207492047078, 992.5235886774244, 15561.84438155604, 15646.608834778766, 15951.68096638084, 16154.0, 16244.593885152966, 35226.295474089864, 35266.29467410586, 36058.27883442264, 37110.8144459276, 37386.81306593558, 49880.75059624824, 50006.0, 50627.0, 50991.490085098674, 50994.49005509898, 6035.69821508914, 7595.772126836204, 7754.896133540577, 7800.4929679572915, 7926.603669816371, 10622.89377106219, 11735.0, 11949.22330048544, 12058.638240852788, 12174.727673187723, 9947.159775441567, 10151.492425378554, 10173.389596624227, 10281.280310378203, 10696.518656660624, 10376.584936602452, 10491.527881245514, 10569.471526423802, 10619.203559733205, 10686.0, 10271.383716977005, 10388.324758890649, 10609.734756631146, 10756.247062705535, 10811.189160812813, 7609.2010338913615, 7774.961125194338, 7902.841943161219, 7946.64240109208, 8029.277365037175, 10290.691279261635, 10654.73363165927, 10759.3544387337, 10850.728731781768, 10870.782584348426], "value": 8227.412420806719, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.2787178538945, 1445.4290555230684, 1565.6633823727896, 1722.5349155727945, 1735.895846249225, 6569.310222426648, 7098.467614928875, 7204.459665525087, 7496.175420703725, 7524.24757524248, 7090.85818283634, 7185.461090418226, 7197.424206063515, 7214.927850721491, 7222.241664625204, 2049.026712311655, 2077.5637116205617, 2081.8542702010864, 2089.1538926734697, 2092.7174831397797, 2071.2129390831465, 2083.156321689718, 2088.6971389148566, 2105.0842883345717, 2129.818965387944, 2094.8428867834896, 2123.7770034146424, 2126.5215326551556, 2127.4362293992103, 2128.6168489671854, 2086.405374468269, 2087.5198704298023, 2089.707440958267, 2097.3078883968255, 2097.318371529259, 2056.1364227024687, 2101.842361822854, 2106.136484041536, 2118.60805750935, 2121.554473560554, 7354.705811767523, 7356.227596102386, 7419.6661150248365, 7465.365443937272, 7472.29013243741, 4278.122984788111, 4465.82136714531, 4508.549145085498, 4509.819607215707, 4512.481064677539, 2650.827696199741, 2663.8268512546815, 2692.5998480790076, 2733.808633395663, 2746.6429364182727, 866.51908190954, 887.8135591525787, 909.4634165842185, 915.9908400915972, 916.6470908700198, 9822.26333025026, 9981.051800078982, 9992.500374981295, 9997.400155990665, 10015.949920250425, 3896.8636097736444, 4016.1566071124807, 4042.15114825884, 4079.755214687128, 4084.7957602119777, 8639.092895246034, 8641.395102342776, 8644.308455323684, 8714.302855771522, 8719.564021798884, 4359.912801743947, 4411.933820992687, 4418.094290670405, 4440.289553671397, 4447.799849006802, 3454.6199918008997, 3836.290286297044, 4027.2146931348693, 4072.8778136655947, 4087.7547347159266, 3446.672566106216, 3447.793132412063, 3454.9481757773656, 3540.3627347077772, 3542.5926018507685, 1100.5432745410565, 1119.339589642115, 1124.3085502415956, 1127.881572434899, 1137.4938152522213, 653.6535636112868, 747.312472525278, 799.0725583755891, 813.0852790610563, 818.9140140285303, 4972.57733092684, 5080.364954380702, 5092.159793634009, 5093.9745301274, 5134.691918484903, 368.69766791231467, 375.1222140191964, 375.212054685159, 375.80270358062234, 377.5657993307718, 3301.554290170844, 3380.9486072037225, 3393.4400823863784, 3437.071990562534, 3446.190145315849, 8825.470471771714, 9202.033786452326, 9226.0, 9232.353735238603, 9243.352965292364, 9104.089591040974, 9148.2681385489, 9169.724908252763, 9172.816543669089, 9206.309526785384, 6944.618046007417, 7022.262662420474, 7076.504644674823, 7082.618889316534, 7174.0315057467615, 4953.603711702983, 5033.521815427529, 5041.521055499722, 5077.1876499759865, 5237.738113094406, 8027.2775450209765, 8334.79163020905, 8346.415750897622, 8358.83282334362, 8370.288525475402, 8259.0, 8343.582820859054, 8353.16468353184, 8383.664653413794, 8575.271101956403, 5589.748461319169, 5762.279715035621, 6187.597806142587, 6270.686465676789, 6429.2284925807335, 7106.289371062852, 7127.572345659277, 7135.250798666066, 7135.357817796424, 7138.286171382821, 6361.045843123568, 6488.480921526361, 6551.6069035858, 6578.407943285128, 6613.10723052401, 6370.29926708071, 6464.0, 6511.088447617432, 6513.218413790375, 6523.64119973406, 6065.302490213506, 6264.467520260829, 6285.937140628718, 6292.968535157295, 6302.3067462578165, 4447.976965298064, 4522.796474158605, 4542.364069030273, 4561.612262957686, 4616.538346165356, 4576.565226303496, 4637.304404339376, 4664.043871006504, 4683.250679891201, 4771.165046116985], "value": 3877.2093321516572, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.80734137493374, 306.72394844639837, 307.51719799914133, 310.55745562573327, 312.89830804988384, 4774.809007639695, 4835.791052236941, 4837.177679794435, 4844.467108618049, 4849.175640141176, 4768.308595253686, 4769.451513075997, 4773.236282194849, 4779.211430114027, 4835.443923948747, 3589.910252243689, 3686.2443199144113, 3827.1962887793457, 3853.2293541291715, 3859.1702783901455, 3797.525309336333, 3826.1391186982846, 3826.3112639724836, 3836.482074919892, 3865.845366185349, 3752.6810221131236, 3810.9618903810883, 3814.408766641175, 3817.1220619257588, 3819.4652748615217, 3537.001594099351, 3779.168582911755, 3784.7539909905768, 3806.371948628473, 3808.0099174214765, 3280.5243239730107, 3282.917927051843, 3299.6700329967052, 3308.586426696663, 3324.268660894599, 4588.426446694163, 4596.88507787308, 4607.723536587815, 4625.421822272216, 4626.236670949289, 4263.509696384894, 4301.2902871026245, 4302.419173411612, 4303.289957157065, 4333.826646934119, 4969.049267192226, 4970.5526502614575, 5050.0, 5060.873478163038, 5081.8475445736685, 3607.863522990276, 3613.7831730096277, 3618.185908170667, 3619.2761447710564, 3634.9273014539563, 5218.895622087575, 5257.316548848664, 5270.209468579744, 5283.63014588979, 5286.471352864683, 3576.2668652926086, 3688.133288677159, 3695.187058847103, 3695.8336874840697, 3719.1817800083936, 3725.4784330193793, 3738.513993180869, 3760.8683696070507, 3765.7928813915496, 3784.1863999240295, 4179.498460184797, 4245.12974840157, 4252.829886804555, 4278.0374415756205, 4284.850030248988, 4942.382202224722, 5005.974970125126, 5022.799088036438, 5023.422306434733, 5042.773075211624, 1338.0967846703436, 1344.5428554291589, 1349.5479014530047, 1352.9458821647024, 1353.5195005773005, 852.6120615120105, 904.7602385367883, 909.6497848328308, 925.5048549026238, 927.5269612497675, 4423.314386270134, 4550.294704320836, 4567.1550763108935, 4568.200564901129, 4583.633309335245, 5212.40057393397, 5222.0, 5224.138017227191, 5241.31862857826, 5251.133562962068, 4451.532589078165, 4563.041761230179, 4563.881848946963, 4576.748278844696, 4581.152486789888, 2967.554866770002, 2973.8215707057648, 2984.224101733565, 2989.2078599171236, 2997.5953246311906, 5283.75831679555, 5313.123334649739, 5313.309269794902, 5323.1749078892835, 5330.546903513167, 5542.251796007487, 5687.772489100473, 5703.771849125988, 5732.914006289909, 5781.0, 5305.549028332635, 5310.787568497217, 5317.760700768475, 5332.640436525042, 5347.679139251657, 5546.972265138648, 5565.1374037024325, 5586.217929489956, 5599.80400685974, 5599.944000560105, 5365.758540865749, 5445.945540544702, 5472.835814925558, 5513.476219759116, 5515.641483303572, 5272.789088436573, 5296.708681022581, 5313.787448502017, 5317.760700768397, 5359.946400535945, 3818.8543436969353, 3819.255245227154, 3824.7513911595656, 3825.3688141456346, 3832.827522761538, 5439.5104440600535, 5507.201455788968, 5545.667259964253, 5558.861028474321, 5586.776528938797, 5306.442823503631, 5359.705216213146, 5361.115415956324, 5369.892602148013, 5375.462453754593, 5246.790128394821, 5379.327584051994, 5387.434319396407, 5392.676439413648, 5406.540444062299, 5304.761285742074, 5312.123499622519, 5324.760385782572, 5339.145736682112, 5340.546053585489, 4835.492273311252, 4930.975345123252, 5094.719790411563, 5111.87220319495, 5440.510354068153, 4968.105740966661, 4975.203967365204, 4978.502149785138, 4980.128477516492, 5008.474110218521], "value": 3918.772056212466, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [644.6035688051848, 755.7921571567819, 756.4591317208192, 759.6125975752371, 765.5712800831535, 11141.0, 11428.42857857108, 11444.14168937329, 11458.312501249931, 11467.08263338933, 11371.31772093673, 11480.311181329125, 13127.80308295374, 13618.523351682694, 13647.317634118304, 785.9449838511307, 791.4341246009102, 792.8771040488705, 797.314309693663, 805.4563169860351, 635.7457017193113, 767.1829501580798, 802.1417083720421, 805.287320721163, 806.1776987472774, 838.7819167016589, 850.974470765878, 854.372036553136, 857.2284943550823, 857.3526987124712, 835.2107258640588, 836.9288610468118, 840.8696652018947, 844.8352571248608, 844.8352571248639, 602.4276936909953, 607.4775692904099, 608.5679167790873, 610.3682688417466, 611.1779656362186, 12550.68623284416, 12621.179623324546, 12676.80984785229, 12698.682532936658, 12705.936470317589, 12299.631011069681, 12888.484460621657, 12923.289219092947, 13087.541936032289, 13144.14563053408, 9475.0, 9618.470984095871, 9661.758456038655, 9867.654632087842, 9925.057119573628, 4120.814563344627, 4155.563665815076, 4183.205191013698, 4196.139791342767, 4230.894227644303, 40712.38931416031, 41387.586124138674, 41410.58589414127, 41414.1717165655, 41586.792066039474, 8870.689525866565, 9071.863922041175, 9169.312301577409, 9182.67860624875, 9450.621975121056, 17308.221130048925, 17833.732494012602, 17936.282548698167, 17946.820531794776, 17989.910050449664, 6306.085617585424, 6431.774887878902, 6703.530752847351, 6771.72913083481, 6950.478714096463, 3399.7280217582534, 3558.0, 3592.9640703593154, 3659.341318562631, 3731.7014638828828, 2615.2285075902655, 2659.3617531792615, 2687.032668239432, 2690.5157071727276, 2697.2447714639934, 503.3230305239447, 503.59963828756224, 528.125951550185, 534.2493796216322, 538.1148011521026, 501.92722055302505, 527.8723562889862, 584.8128598848327, 608.0301918440081, 652.5627829354344, 8145.79635509117, 8206.466579672302, 8220.917790822135, 8278.958605206935, 8409.369297302726, 641.9197600299963, 644.1625886347729, 650.4828661214345, 656.8883289840738, 664.0935123556408, 3814.0, 3891.922161556753, 4012.719109662354, 4091.161311931047, 4096.836126554905, 53409.465905341225, 54033.72983135059, 54629.0, 54666.45333546614, 54741.72629136909, 48263.27605085926, 49126.0, 49670.25494617584, 49878.50121498739, 50272.99454010899, 44148.77925610352, 44315.0, 44345.0, 44936.12774451098, 45068.19727210875, 7616.885746713914, 7945.404094692805, 7984.0, 7985.840283194188, 8216.958915205385, 26025.21924342273, 29703.554446682883, 30194.09417717472, 30327.696723032488, 30731.846340768152, 36581.08547286232, 37158.25683486369, 38818.80590597029, 39472.21055578815, 39534.0, 10532.0, 10599.417032063311, 10668.786624267626, 10884.51019704131, 10994.780104397707, 10704.785904282027, 11037.172212083966, 11361.488733006869, 11490.712732181428, 12413.379331033593, 10599.364038157735, 11125.499352529318, 11292.49183786748, 11331.0, 11565.595204167814, 10766.623168189075, 11400.600978965696, 11441.199116061796, 11499.712507187052, 11534.423278836193, 10715.946420267848, 10819.621313253998, 10829.620963266249, 11156.107511398906, 11290.66128016128, 8873.334499912662, 8922.286217102746, 9172.724818255463, 9258.259339252978, 9348.065193480597, 9459.290553208399, 9477.24182065447, 9589.42463452195, 9734.951325243328, 9736.75658108553], "value": 5961.188361082511, "unit": "score"}], "name": "dromaeo_css", "value": 6195.195465465452, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 111.0, 115.0, 113.0, 116.0, 127.0, 115.0, 115.0, 116.0, 115.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 130.0, 158.0, 189.0, 147.0, 158.0, 159.0, 137.0, 201.0, 146.0], "value": 158.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 166.0, 171.0, 163.0, 162.0, 162.0, 166.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 76.0, 76.0, 173.0, 77.0, 77.0, 80.0, 76.0, 163.0, 77.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 149.0, 95.0, 96.0, 94.0, 135.0, 94.0, 93.0, 144.0], "value": 108.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 152.0, 151.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 67.0, 68.0, 71.0, 68.0, 68.0, 67.0, 69.0], "value": 68.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 67.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 101.0, 82.0, 90.0, 82.0, 83.0, 85.0, 85.0, 109.0, 82.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 138.0, 136.0, 146.0, 138.0, 136.0, 136.0, 138.0, 137.0, 139.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 182.0, 178.0, 179.0, 188.0, 192.0, 193.0, 181.0, 185.0], "value": 184.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 75.0, 75.0, 77.0, 75.0, 77.0, 73.0, 75.0, 79.0], "value": 76.1, "unit": "score"}], "name": "kraken", "value": 1624.1999999999998, "alertThreshold": 2.0}]} 03:41:31 INFO - Return code: 0 03:41:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:41:31 ERROR - # TBPL SUCCESS # 03:41:31 INFO - Running post-action listener: _resource_record_post_action 03:41:31 INFO - Running post-run listener: _resource_record_post_run 03:41:32 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 360448000; Read time: 4; Write time: 246276 03:41:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 69025792; Read time: 0; Write time: 46964 03:41:32 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291422208; Read time: 4; Write time: 199312 03:41:32 INFO - Running post-run listener: _upload_blobber_files 03:41:32 INFO - Blob upload gear active. 03:41:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:41:32 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 03:41:32 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:41:32 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:41:32 INFO - (blobuploader) - INFO - Open directory for files ... 03:41:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:41:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:41:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:33 INFO - (blobuploader) - INFO - Done attempting. 03:41:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:41:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:41:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:41:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:41:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:41:34 INFO - (blobuploader) - INFO - Done attempting. 03:41:34 INFO - (blobuploader) - INFO - Iteration through files over. 03:41:34 INFO - Return code: 0 03:41:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:41:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:41:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33270b459ebe505d2b4a2139f95a22e82d4f8de92ace9b01a427923c03e09f52ff15076726a22d360182bdf836babe8d23a5aa92026960431d34ffe4c183d6f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9d4d3df4269eb2de276f9a72037559bf96e699da483a6fb2c6abe8da18401622a64fc6b738f92eb3e54f87ab8641b621862d66f4dc957879864abce951c6cd7"} 03:41:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:41:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:41:34 INFO - Contents: 03:41:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33270b459ebe505d2b4a2139f95a22e82d4f8de92ace9b01a427923c03e09f52ff15076726a22d360182bdf836babe8d23a5aa92026960431d34ffe4c183d6f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9d4d3df4269eb2de276f9a72037559bf96e699da483a6fb2c6abe8da18401622a64fc6b738f92eb3e54f87ab8641b621862d66f4dc957879864abce951c6cd7"} 03:41:34 INFO - Running post-run listener: copy_logs_to_upload_dir 03:41:34 INFO - Copying logs to upload dir... 03:41:34 INFO - mkdir: /builds/slave/test/build/upload/logs 03:41:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2135.542267 ========= master_lag: -0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 35 secs) (at 2016-05-03 03:41:32.340365) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-03 03:41:32.344221) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33270b459ebe505d2b4a2139f95a22e82d4f8de92ace9b01a427923c03e09f52ff15076726a22d360182bdf836babe8d23a5aa92026960431d34ffe4c183d6f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9d4d3df4269eb2de276f9a72037559bf96e699da483a6fb2c6abe8da18401622a64fc6b738f92eb3e54f87ab8641b621862d66f4dc957879864abce951c6cd7"} build_url:https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011418 build_url: 'https://queue.taskcluster.net/v1/task/Gm502NH6Scm3o64AvhSdNg/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/33270b459ebe505d2b4a2139f95a22e82d4f8de92ace9b01a427923c03e09f52ff15076726a22d360182bdf836babe8d23a5aa92026960431d34ffe4c183d6f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9d4d3df4269eb2de276f9a72037559bf96e699da483a6fb2c6abe8da18401622a64fc6b738f92eb3e54f87ab8641b621862d66f4dc957879864abce951c6cd7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-03 03:41:32.375290) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 03:41:32.375784) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1462269229.649024-85575776 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 03:41:32.456855) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-03 03:41:32.457236) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-03 03:41:32.457567) ========= ========= Total master_lag: 0.13 =========