builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1462290260.07 results: success (0) buildid: 20160503053028 builduid: 6f7ca55cf85f47eba4fab82e5d2bf523 revision: c49359cf04ff0398969ed5c5a4ceb4d939d734af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-03 08:44:20.071973) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-03 08:44:20.072429) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-03 08:44:20.072717) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-03 08:44:20.089564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 08:44:20.090021) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-03 08:44:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-05-03 08:44:21 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093322 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 08:44:20.197720) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 08:44:20.198040) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020139 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 08:44:20.247672) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-03 08:44:20.248039) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c49359cf04ff0398969ed5c5a4ceb4d939d734af --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 c49359cf04ff0398969ed5c5a4ceb4d939d734af --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=b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-03 08:44:21,296 truncating revision to first 12 chars 2016-05-03 08:44:21,296 Setting DEBUG logging. 2016-05-03 08:44:21,296 attempt 1/10 2016-05-03 08:44:21,296 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c49359cf04ff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-03 08:44:22,276 unpacking tar archive at: fx-team-c49359cf04ff/testing/mozharness/ program finished with exit code 0 elapsedTime=1.251814 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-03 08:44:21.512840) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-03 08:44:21.513199) ========= script_repo_revision: c49359cf04ff0398969ed5c5a4ceb4d939d734af ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-03 08:44:21.513594) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-03 08:44:21.513881) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-03 08:44:21.523972) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 28 secs) (at 2016-05-03 08:44:21.524279) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:44:22 INFO - MultiFileLogger online at 20160503 08:44:22 in /builds/slave/test 08:44:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:44:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:44:22 INFO - {'append_to_log': False, 08:44:22 INFO - 'base_work_dir': '/builds/slave/test', 08:44:22 INFO - 'blob_upload_branch': 'Fx-Team', 08:44:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:44:22 INFO - 'branch': 'Fx-Team', 08:44:22 INFO - 'buildbot_json_path': 'buildprops.json', 08:44:22 INFO - 'config_files': ('talos/linux_config.py',), 08:44:22 INFO - 'default_actions': ('clobber', 08:44:22 INFO - 'read-buildbot-config', 08:44:22 INFO - 'download-and-extract', 08:44:22 INFO - 'populate-webroot', 08:44:22 INFO - 'create-virtualenv', 08:44:22 INFO - 'install', 08:44:22 INFO - 'run-tests'), 08:44:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:44:22 INFO - 'download_minidump_stackwalk': True, 08:44:22 INFO - 'download_symbols': 'ondemand', 08:44:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:44:22 INFO - 'tooltool.py': '/tools/tooltool.py', 08:44:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:44:22 INFO - '/tools/misc-python/virtualenv.py')}, 08:44:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:44:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:44:22 INFO - 'installer_path': 'installer.exe', 08:44:22 INFO - 'log_level': 'info', 08:44:22 INFO - 'log_name': 'talos', 08:44:22 INFO - 'log_to_console': True, 08:44:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:44:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:44:22 INFO - 'opt_config_files': (), 08:44:22 INFO - 'pip_index': False, 08:44:22 INFO - 'sps_profile': False, 08:44:22 INFO - 'sps_profile_interval': 0, 08:44:22 INFO - 'suite': 'dromaeojs-e10s', 08:44:22 INFO - 'system_bits': '32', 08:44:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:44:22 INFO - 'title': 'talos-linux64-ix-007', 08:44:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:44:22 INFO - 'use_talos_json': True, 08:44:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:44:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:44:22 INFO - 'work_dir': 'build'} 08:44:22 INFO - ##### 08:44:22 INFO - ##### Running clobber step. 08:44:22 INFO - ##### 08:44:22 INFO - Running pre-action listener: _resource_record_pre_action 08:44:22 INFO - Running main action method: clobber 08:44:22 INFO - rmtree: /builds/slave/test/build 08:44:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:44:23 INFO - Running post-action listener: _resource_record_post_action 08:44:23 INFO - ##### 08:44:23 INFO - ##### Running read-buildbot-config step. 08:44:23 INFO - ##### 08:44:23 INFO - Running pre-action listener: _resource_record_pre_action 08:44:23 INFO - Running main action method: read_buildbot_config 08:44:23 INFO - Using buildbot properties: 08:44:23 INFO - { 08:44:23 INFO - "project": "", 08:44:23 INFO - "product": "firefox", 08:44:23 INFO - "script_repo_revision": "production", 08:44:23 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:44:23 INFO - "repository": "", 08:44:23 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:44:23 INFO - "buildid": "20160503053028", 08:44:23 INFO - "pgo_build": "True", 08:44:23 INFO - "basedir": "/builds/slave/test", 08:44:23 INFO - "buildnumber": 713, 08:44:23 INFO - "slavename": "talos-linux64-ix-007", 08:44:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:44:23 INFO - "platform": "ubuntu64_hw", 08:44:23 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:44:23 INFO - "branch": "fx-team", 08:44:23 INFO - "repo_path": "integration/fx-team", 08:44:23 INFO - "revision": "c49359cf04ff0398969ed5c5a4ceb4d939d734af", 08:44:23 INFO - "stage_platform": "linux64-pgo", 08:44:23 INFO - "builduid": "6f7ca55cf85f47eba4fab82e5d2bf523", 08:44:23 INFO - "slavebuilddir": "test" 08:44:23 INFO - } 08:44:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 08:44:23 INFO - Running post-action listener: _resource_record_post_action 08:44:23 INFO - ##### 08:44:23 INFO - ##### Running download-and-extract step. 08:44:23 INFO - ##### 08:44:23 INFO - Running pre-action listener: _resource_record_pre_action 08:44:23 INFO - Running main action method: download_and_extract 08:44:23 INFO - mkdir: /builds/slave/test/build/tests 08:44:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:23 INFO - https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:44:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:44:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:44:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:44:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:44:53 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 08:44:53 INFO - retry: attempt #1 caught exception: timed out 08:44:53 INFO - retry: Failed, sleeping 30 seconds before retrying 08:45:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:45:53 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 08:45:53 INFO - retry: attempt #2 caught exception: timed out 08:45:53 INFO - retry: Failed, sleeping 60 seconds before retrying 08:46:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:47:23 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json: timed out 08:47:23 INFO - retry: attempt #3 caught exception: timed out 08:47:23 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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! 08:47:23 INFO - Caught exception: timed out 08:47:23 INFO - Caught exception: timed out 08:47:23 INFO - Caught exception: timed out 08:47:23 INFO - trying https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:47:23 INFO - Downloading https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:47:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:47:23 INFO - Downloaded 1361 bytes. 08:47:23 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 08:47:23 INFO - Using the following test package requirements: 08:47:23 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:47:23 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:47:23 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:47:23 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:23 INFO - u'jsshell-linux-x86_64.zip'], 08:47:23 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:47:23 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 08:47:23 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:47:23 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:47:23 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:47:23 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 08:47:23 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:47:23 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:23 INFO - https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:47:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:47:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:47:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:47:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:47:54 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 08:47:54 INFO - retry: attempt #1 caught exception: timed out 08:47:54 INFO - retry: Failed, sleeping 30 seconds before retrying 08:48:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:48:54 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 08:48:54 INFO - retry: attempt #2 caught exception: timed out 08:48:54 INFO - retry: Failed, sleeping 60 seconds before retrying 08:49:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:50:24 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 08:50:24 INFO - retry: attempt #3 caught exception: timed out 08:50:24 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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! 08:50:24 INFO - Caught exception: timed out 08:50:24 INFO - Caught exception: timed out 08:50:24 INFO - Caught exception: timed out 08:50:24 INFO - trying https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:50:24 INFO - Downloading https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:50:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:50:25 INFO - Downloaded 23878354 bytes. 08:50:25 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'] 08:50:25 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 08:50:26 INFO - Return code: 0 08:50:26 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 08:50:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:50:26 INFO - https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:50:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:50:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:50:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:50:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:50:56 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 08:50:56 INFO - retry: attempt #1 caught exception: timed out 08:50:56 INFO - retry: Failed, sleeping 30 seconds before retrying 08:51:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:51:56 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 08:51:56 INFO - retry: attempt #2 caught exception: timed out 08:51:56 INFO - retry: Failed, sleeping 60 seconds before retrying 08:52:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:53:26 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip: timed out 08:53:26 INFO - retry: attempt #3 caught exception: timed out 08:53:26 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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! 08:53:26 INFO - Caught exception: timed out 08:53:26 INFO - Caught exception: timed out 08:53:26 INFO - Caught exception: timed out 08:53:26 INFO - trying https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 08:53:26 INFO - Downloading https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:53:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:53:27 INFO - Downloaded 23878354 bytes. 08:53:27 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'] 08:53:27 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 08:53:29 INFO - Return code: 0 08:53: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')]} 08:53:29 INFO - https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:53:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:53:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:53:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:53:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:53:59 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 08:53:59 INFO - retry: attempt #1 caught exception: timed out 08:53:59 INFO - retry: Failed, sleeping 30 seconds before retrying 08:54:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:54:59 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 08:54:59 INFO - retry: attempt #2 caught exception: timed out 08:54:59 INFO - retry: Failed, sleeping 60 seconds before retrying 08:55:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:56:29 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip: timed out 08:56:29 INFO - retry: attempt #3 caught exception: timed out 08:56:29 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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! 08:56:29 INFO - Caught exception: timed out 08:56:29 INFO - Caught exception: timed out 08:56:29 INFO - Caught exception: timed out 08:56:29 INFO - trying https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 08:56:29 INFO - Downloading https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:56:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:56:30 INFO - Downloaded 10840152 bytes. 08:56:30 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'] 08:56:30 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 08:56:30 INFO - Return code: 0 08:56:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:30 INFO - https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:56:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:56:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:56:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:56:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:57:00 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 08:57:00 INFO - retry: attempt #1 caught exception: timed out 08:57:00 INFO - retry: Failed, sleeping 30 seconds before retrying 08:57:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:58:00 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 08:58:00 INFO - retry: attempt #2 caught exception: timed out 08:58:00 INFO - retry: Failed, sleeping 60 seconds before retrying 08:59:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:59:30 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2: timed out 08:59:30 INFO - retry: attempt #3 caught exception: timed out 08:59:30 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WgHVTbHkTHenwgTtRuhu3g/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! 08:59:30 INFO - Caught exception: timed out 08:59:30 INFO - Caught exception: timed out 08:59:30 INFO - Caught exception: timed out 08:59:30 INFO - trying https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:59:30 INFO - Downloading https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:59:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/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 08:59:32 INFO - Downloaded 58616718 bytes. 08:59:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:59:32 INFO - mkdir: /builds/slave/test/properties 08:59:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:59:32 INFO - Writing to file /builds/slave/test/properties/build_url 08:59:32 INFO - Contents: 08:59:32 INFO - build_url:https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 08:59:32 INFO - Running post-action listener: _resource_record_post_action 08:59:32 INFO - Running post-action listener: set_extra_try_arguments 08:59:32 INFO - ##### 08:59:32 INFO - ##### Running populate-webroot step. 08:59:32 INFO - ##### 08:59:32 INFO - Running pre-action listener: _resource_record_pre_action 08:59:32 INFO - Running main action method: populate_webroot 08:59:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:59:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:59:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:59:32 INFO - '--tppagecycles', 08:59:32 INFO - '7'], 08:59:32 INFO - 'tests': ['tsvgm']}}, 08:59:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:59:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:59:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:59:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:59:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:59:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:59:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:32 INFO - 'talos_options': ['--disable-e10s'], 08:59:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:32 INFO - 'talos_options': ['--disable-e10s'], 08:59:32 INFO - 'tests': ['damp', 'tps']}, 08:59:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:32 INFO - 'tests': ['damp', 'tps']}, 08:59:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:59:32 INFO - 'tests': ['dromaeo_dom']}, 08:59:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:59:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:59:32 INFO - 'tests': ['a11yr', 08:59:32 INFO - 'ts_paint', 08:59:32 INFO - 'tpaint', 08:59:32 INFO - 'sessionrestore', 08:59:32 INFO - 'sessionrestore_no_auto_restore', 08:59:32 INFO - 'tabpaint']}, 08:59:32 INFO - 'other-e10s': {'tests': ['a11yr', 08:59:32 INFO - 'ts_paint', 08:59:32 INFO - 'tpaint', 08:59:32 INFO - 'sessionrestore', 08:59:32 INFO - 'sessionrestore_no_auto_restore', 08:59:32 INFO - 'tabpaint']}, 08:59:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:59:32 INFO - 'ts_paint', 08:59:32 INFO - 'tpaint', 08:59:32 INFO - 'sessionrestore', 08:59:32 INFO - 'sessionrestore_no_auto_restore', 08:59:32 INFO - 'tabpaint']}, 08:59:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:59:32 INFO - 'ts_paint', 08:59:32 INFO - 'tpaint', 08:59:32 INFO - 'sessionrestore', 08:59:32 INFO - 'sessionrestore_no_auto_restore', 08:59:32 INFO - 'tabpaint']}, 08:59:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:59:32 INFO - 'tests': ['a11yr', 08:59:32 INFO - 'ts_paint', 08:59:32 INFO - 'tpaint', 08:59:32 INFO - 'sessionrestore', 08:59:32 INFO - 'sessionrestore_no_auto_restore', 08:59:32 INFO - 'tabpaint']}, 08:59:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:59:32 INFO - 'tests': ['a11yr', 08:59:32 INFO - 'ts_paint', 08:59:32 INFO - 'tpaint', 08:59:32 INFO - 'sessionrestore', 08:59:32 INFO - 'sessionrestore_no_auto_restore', 08:59:32 INFO - 'tabpaint']}, 08:59:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:59:32 INFO - 'tests': ['tsvgx', 08:59:32 INFO - 'tsvgr_opacity', 08:59:32 INFO - 'tart', 08:59:32 INFO - 'tscrollx', 08:59:32 INFO - 'cart']}, 08:59:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:59:32 INFO - 'tsvgr_opacity', 08:59:32 INFO - 'tart', 08:59:32 INFO - 'tscrollx', 08:59:32 INFO - 'cart']}, 08:59:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:32 INFO - 'talos_options': ['--disable-e10s'], 08:59:32 INFO - 'tests': ['tp5o']}, 08:59:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:32 INFO - 'tests': ['tp5o']}, 08:59:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:32 INFO - 'talos_options': ['--disable-e10s', 08:59:32 INFO - '--xperf_path', 08:59:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:32 INFO - 'tests': ['tp5n']}, 08:59:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:59:32 INFO - 'talos_options': ['--xperf_path', 08:59:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:32 INFO - 'tests': ['tp5n']}}, 08:59:32 INFO - 'talos.zip': {'path': '', 08:59:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:59:32 INFO - Running post-action listener: _resource_record_post_action 08:59:32 INFO - ##### 08:59:32 INFO - ##### Running create-virtualenv step. 08:59:32 INFO - ##### 08:59:32 INFO - Running pre-action listener: _resource_record_pre_action 08:59:32 INFO - Running main action method: create_virtualenv 08:59:32 INFO - Creating virtualenv /builds/slave/test/build/venv 08:59:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:59:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:59:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:59:33 INFO - Using real prefix '/usr' 08:59:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:59:33 INFO - Installing distribute.............................................................................................................................................................................................done. 08:59:35 INFO - Installing pip.................done. 08:59:35 INFO - Return code: 0 08:59:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:35 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 0x7f2cb35fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c40410>, '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 0x1c41310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c417a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:59:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:59:35 INFO - Using env: {'DISPLAY': ':0', 08:59:35 INFO - 'HOME': '/home/cltbld', 08:59:35 INFO - 'LANG': 'en_US.UTF-8', 08:59:35 INFO - 'LANGUAGE': 'en_US:en', 08:59:35 INFO - 'LOGNAME': 'cltbld', 08:59:35 INFO - 'MAIL': '/var/mail/cltbld', 08:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:35 INFO - 'MOZ_NO_REMOTE': '1', 08:59:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:35 INFO - 'NO_EM_RESTART': '1', 08:59:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:35 INFO - 'PWD': '/builds/slave/test', 08:59:35 INFO - 'SHELL': '/bin/bash', 08:59:35 INFO - 'SHLVL': '1', 08:59:35 INFO - 'TERM': 'linux', 08:59:35 INFO - 'TMOUT': '86400', 08:59:35 INFO - 'USER': 'cltbld', 08:59:35 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772', 08:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:35 INFO - '_': '/tools/buildbot/bin/python'} 08:59:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:59:35 INFO - Cleaning up... 08:59:35 INFO - Return code: 0 08:59:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:35 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 0x7f2cb35fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c40410>, '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 0x1c41310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c417a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:59:35 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 08:59:35 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 08:59:35 INFO - Using env: {'DISPLAY': ':0', 08:59:35 INFO - 'HOME': '/home/cltbld', 08:59:35 INFO - 'LANG': 'en_US.UTF-8', 08:59:35 INFO - 'LANGUAGE': 'en_US:en', 08:59:35 INFO - 'LOGNAME': 'cltbld', 08:59:35 INFO - 'MAIL': '/var/mail/cltbld', 08:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:35 INFO - 'MOZ_NO_REMOTE': '1', 08:59:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:35 INFO - 'NO_EM_RESTART': '1', 08:59:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:35 INFO - 'PWD': '/builds/slave/test', 08:59:35 INFO - 'SHELL': '/bin/bash', 08:59:35 INFO - 'SHLVL': '1', 08:59:35 INFO - 'TERM': 'linux', 08:59:35 INFO - 'TMOUT': '86400', 08:59:35 INFO - 'USER': 'cltbld', 08:59:35 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772', 08:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:35 INFO - '_': '/tools/buildbot/bin/python'} 08:59:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:35 INFO - Downloading/unpacking psutil>=0.7.1 08:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:59:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:59:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:59:37 INFO - Installing collected packages: psutil 08:59:37 INFO - Running setup.py install for psutil 08:59:37 INFO - building 'psutil._psutil_linux' extension 08:59:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:59:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:59:38 INFO - building 'psutil._psutil_posix' extension 08:59:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:59:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:59:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:59:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:59:38 INFO - Successfully installed psutil 08:59:38 INFO - Cleaning up... 08:59:38 INFO - Return code: 0 08:59:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:38 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 0x7f2cb35fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c40410>, '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 0x1c41310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c417a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:59:38 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 08:59:38 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 08:59:38 INFO - Using env: {'DISPLAY': ':0', 08:59:38 INFO - 'HOME': '/home/cltbld', 08:59:38 INFO - 'LANG': 'en_US.UTF-8', 08:59:38 INFO - 'LANGUAGE': 'en_US:en', 08:59:38 INFO - 'LOGNAME': 'cltbld', 08:59:38 INFO - 'MAIL': '/var/mail/cltbld', 08:59:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:38 INFO - 'MOZ_NO_REMOTE': '1', 08:59:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:38 INFO - 'NO_EM_RESTART': '1', 08:59:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:38 INFO - 'PWD': '/builds/slave/test', 08:59:38 INFO - 'SHELL': '/bin/bash', 08:59:38 INFO - 'SHLVL': '1', 08:59:38 INFO - 'TERM': 'linux', 08:59:38 INFO - 'TMOUT': '86400', 08:59:38 INFO - 'USER': 'cltbld', 08:59:38 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772', 08:59:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:38 INFO - '_': '/tools/buildbot/bin/python'} 08:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:59:40 INFO - Installing collected packages: mozsystemmonitor 08:59:40 INFO - Running setup.py install for mozsystemmonitor 08:59:40 INFO - Successfully installed mozsystemmonitor 08:59:40 INFO - Cleaning up... 08:59:40 INFO - Return code: 0 08:59:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:40 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 0x7f2cb35fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c40410>, '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 0x1c41310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c417a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:59:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:59:40 INFO - Using env: {'DISPLAY': ':0', 08:59:40 INFO - 'HOME': '/home/cltbld', 08:59:40 INFO - 'LANG': 'en_US.UTF-8', 08:59:40 INFO - 'LANGUAGE': 'en_US:en', 08:59:40 INFO - 'LOGNAME': 'cltbld', 08:59:40 INFO - 'MAIL': '/var/mail/cltbld', 08:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:40 INFO - 'MOZ_NO_REMOTE': '1', 08:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:40 INFO - 'NO_EM_RESTART': '1', 08:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:40 INFO - 'PWD': '/builds/slave/test', 08:59:40 INFO - 'SHELL': '/bin/bash', 08:59:40 INFO - 'SHLVL': '1', 08:59:40 INFO - 'TERM': 'linux', 08:59:40 INFO - 'TMOUT': '86400', 08:59:40 INFO - 'USER': 'cltbld', 08:59:40 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772', 08:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:40 INFO - '_': '/tools/buildbot/bin/python'} 08:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:40 INFO - Downloading/unpacking blobuploader==1.2.4 08:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:42 INFO - Downloading blobuploader-1.2.4.tar.gz 08:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:59:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:59:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:43 INFO - Downloading docopt-0.6.1.tar.gz 08:59:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:59:43 INFO - Installing collected packages: blobuploader, requests, docopt 08:59:43 INFO - Running setup.py install for blobuploader 08:59:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:59:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:59:43 INFO - Running setup.py install for requests 08:59:44 INFO - Running setup.py install for docopt 08:59:44 INFO - Successfully installed blobuploader requests docopt 08:59:44 INFO - Cleaning up... 08:59:44 INFO - Return code: 0 08:59:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:44 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 0x7f2cb35fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c40410>, '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 0x1c41310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c417a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:59:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:59:44 INFO - Using env: {'DISPLAY': ':0', 08:59:44 INFO - 'HOME': '/home/cltbld', 08:59:44 INFO - 'LANG': 'en_US.UTF-8', 08:59:44 INFO - 'LANGUAGE': 'en_US:en', 08:59:44 INFO - 'LOGNAME': 'cltbld', 08:59:44 INFO - 'MAIL': '/var/mail/cltbld', 08:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:44 INFO - 'MOZ_NO_REMOTE': '1', 08:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:44 INFO - 'NO_EM_RESTART': '1', 08:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:44 INFO - 'PWD': '/builds/slave/test', 08:59:44 INFO - 'SHELL': '/bin/bash', 08:59:44 INFO - 'SHLVL': '1', 08:59:44 INFO - 'TERM': 'linux', 08:59:44 INFO - 'TMOUT': '86400', 08:59:44 INFO - 'USER': 'cltbld', 08:59:44 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772', 08:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:44 INFO - '_': '/tools/buildbot/bin/python'} 08:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:59:44 INFO - Running setup.py (path:/tmp/pip-SXoe3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:59:44 INFO - Running setup.py (path:/tmp/pip-wMtUhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:59:44 INFO - Running setup.py (path:/tmp/pip-Prxa1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:59:44 INFO - Running setup.py (path:/tmp/pip-60vULP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:59:44 INFO - Running setup.py (path:/tmp/pip-f4ahhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:59:44 INFO - Running setup.py (path:/tmp/pip-dyAh4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:59:45 INFO - Running setup.py (path:/tmp/pip-W3k8qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:59:45 INFO - Running setup.py (path:/tmp/pip-1u0lLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:59:45 INFO - Running setup.py (path:/tmp/pip-Keq1KW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:59:45 INFO - Running setup.py (path:/tmp/pip-OTJu5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:59:45 INFO - Running setup.py (path:/tmp/pip-rvEGDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:59:45 INFO - Running setup.py (path:/tmp/pip-0E_AqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:59:45 INFO - Running setup.py (path:/tmp/pip-JZ8Tdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:59:45 INFO - Running setup.py (path:/tmp/pip-AnFukb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:45 INFO - Running setup.py (path:/tmp/pip-pfC0tY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:59:45 INFO - Running setup.py (path:/tmp/pip-Vfvrh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:59:45 INFO - Running setup.py (path:/tmp/pip-9BzNl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:59:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:59:45 INFO - Running setup.py install for manifestparser 08:59:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:59:45 INFO - Running setup.py install for mozcrash 08:59:45 INFO - Running setup.py install for mozdebug 08:59:46 INFO - Running setup.py install for mozdevice 08:59:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:59:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:59:46 INFO - Running setup.py install for mozfile 08:59:46 INFO - Running setup.py install for mozhttpd 08:59:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:59:46 INFO - Running setup.py install for mozinfo 08:59:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:59:46 INFO - Running setup.py install for mozInstall 08:59:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:59:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:59:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:59:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:59:46 INFO - Running setup.py install for mozleak 08:59:46 INFO - Running setup.py install for mozlog 08:59:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:59:46 INFO - Running setup.py install for moznetwork 08:59:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:59:46 INFO - Running setup.py install for mozprocess 08:59:47 INFO - Running setup.py install for mozprofile 08:59:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:59:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:59:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:59:47 INFO - Running setup.py install for mozrunner 08:59:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:59:47 INFO - Running setup.py install for mozscreenshot 08:59:47 INFO - Running setup.py install for moztest 08:59:47 INFO - Running setup.py install for mozversion 08:59:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:59:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:59:47 INFO - Cleaning up... 08:59:47 INFO - Return code: 0 08:59:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:47 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 0x7f2cb35fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c40410>, '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 0x1c41310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c417a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:59:47 INFO - Using env: {'DISPLAY': ':0', 08:59:47 INFO - 'HOME': '/home/cltbld', 08:59:47 INFO - 'LANG': 'en_US.UTF-8', 08:59:47 INFO - 'LANGUAGE': 'en_US:en', 08:59:47 INFO - 'LOGNAME': 'cltbld', 08:59:47 INFO - 'MAIL': '/var/mail/cltbld', 08:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:47 INFO - 'MOZ_NO_REMOTE': '1', 08:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:47 INFO - 'NO_EM_RESTART': '1', 08:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:47 INFO - 'PWD': '/builds/slave/test', 08:59:47 INFO - 'SHELL': '/bin/bash', 08:59:47 INFO - 'SHLVL': '1', 08:59:47 INFO - 'TERM': 'linux', 08:59:47 INFO - 'TMOUT': '86400', 08:59:47 INFO - 'USER': 'cltbld', 08:59:47 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772', 08:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:47 INFO - '_': '/tools/buildbot/bin/python'} 08:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:59:47 INFO - Running setup.py (path:/tmp/pip-IEzbiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:59:47 INFO - Running setup.py (path:/tmp/pip-mA2LE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:59:47 INFO - Running setup.py (path:/tmp/pip-61GgoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:59:48 INFO - Running setup.py (path:/tmp/pip-2Wbvem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:59:48 INFO - Running setup.py (path:/tmp/pip-ZHJ6DB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:59:48 INFO - Running setup.py (path:/tmp/pip-rUq8Hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:59:48 INFO - Running setup.py (path:/tmp/pip-dWDPYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:59:48 INFO - Running setup.py (path:/tmp/pip-9Gg_CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:59:48 INFO - Running setup.py (path:/tmp/pip-Wc_xYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:59:48 INFO - Running setup.py (path:/tmp/pip-7HYww3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:59:48 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)) 08:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:59:48 INFO - Running setup.py (path:/tmp/pip-ebwFbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:59:48 INFO - Running setup.py (path:/tmp/pip-zapL7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:59:48 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)) 08:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:59:48 INFO - Running setup.py (path:/tmp/pip-s_oNzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:59:48 INFO - Running setup.py (path:/tmp/pip-zbX_PB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:59:48 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)) 08:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:48 INFO - Running setup.py (path:/tmp/pip-yCFoXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:59:48 INFO - Running setup.py (path:/tmp/pip-5t9Omc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:59:48 INFO - Running setup.py (path:/tmp/pip-R9KOX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:59:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:50 INFO - Downloading blessings-1.6.tar.gz 08:59:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:59:51 INFO - Installing collected packages: blessings 08:59:51 INFO - Running setup.py install for blessings 08:59:51 INFO - Successfully installed blessings 08:59:51 INFO - Cleaning up... 08:59:51 INFO - Return code: 0 08:59:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:59:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:59:51 INFO - Reading from file tmpfile_stdout 08:59:51 INFO - Current package versions: 08:59:51 INFO - argparse == 1.2.1 08:59:51 INFO - blessings == 1.6 08:59:51 INFO - blobuploader == 1.2.4 08:59:51 INFO - docopt == 0.6.1 08:59:51 INFO - manifestparser == 1.1 08:59:51 INFO - mozInstall == 1.12 08:59:51 INFO - mozcrash == 0.17 08:59:51 INFO - mozdebug == 0.1 08:59:51 INFO - mozdevice == 0.48 08:59:51 INFO - mozfile == 1.2 08:59:51 INFO - mozhttpd == 0.7 08:59:51 INFO - mozinfo == 0.9 08:59:51 INFO - mozleak == 0.1 08:59:51 INFO - mozlog == 3.1 08:59:51 INFO - moznetwork == 0.27 08:59:51 INFO - mozprocess == 0.22 08:59:51 INFO - mozprofile == 0.28 08:59:51 INFO - mozrunner == 6.11 08:59:51 INFO - mozscreenshot == 0.1 08:59:51 INFO - mozsystemmonitor == 0.0 08:59:51 INFO - moztest == 0.7 08:59:51 INFO - mozversion == 1.4 08:59:51 INFO - psutil == 3.1.1 08:59:51 INFO - requests == 1.2.3 08:59:51 INFO - wsgiref == 0.1.2 08:59:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:51 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 0x7f2cb35fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c40410>, '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 0x1c41310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c417a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:59:51 INFO - Using env: {'DISPLAY': ':0', 08:59:51 INFO - 'HOME': '/home/cltbld', 08:59:51 INFO - 'LANG': 'en_US.UTF-8', 08:59:51 INFO - 'LANGUAGE': 'en_US:en', 08:59:51 INFO - 'LOGNAME': 'cltbld', 08:59:51 INFO - 'MAIL': '/var/mail/cltbld', 08:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:51 INFO - 'MOZ_NO_REMOTE': '1', 08:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:51 INFO - 'NO_EM_RESTART': '1', 08:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:51 INFO - 'PWD': '/builds/slave/test', 08:59:51 INFO - 'SHELL': '/bin/bash', 08:59:51 INFO - 'SHLVL': '1', 08:59:51 INFO - 'TERM': 'linux', 08:59:51 INFO - 'TMOUT': '86400', 08:59:51 INFO - 'USER': 'cltbld', 08:59:51 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772', 08:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:51 INFO - '_': '/tools/buildbot/bin/python'} 08:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:59:51 INFO - Cleaning up... 08:59:51 INFO - Return code: 0 08:59:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2cb35fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c40410>, '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 0x1c41310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c417a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:59:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:59:51 INFO - Using env: {'DISPLAY': ':0', 08:59:51 INFO - 'HOME': '/home/cltbld', 08:59:51 INFO - 'LANG': 'en_US.UTF-8', 08:59:51 INFO - 'LANGUAGE': 'en_US:en', 08:59:51 INFO - 'LOGNAME': 'cltbld', 08:59:51 INFO - 'MAIL': '/var/mail/cltbld', 08:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:51 INFO - 'MOZ_NO_REMOTE': '1', 08:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:51 INFO - 'NO_EM_RESTART': '1', 08:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:51 INFO - 'PWD': '/builds/slave/test', 08:59:51 INFO - 'SHELL': '/bin/bash', 08:59:51 INFO - 'SHLVL': '1', 08:59:51 INFO - 'TERM': 'linux', 08:59:51 INFO - 'TMOUT': '86400', 08:59:51 INFO - 'USER': 'cltbld', 08:59:51 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772', 08:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:51 INFO - '_': '/tools/buildbot/bin/python'} 08:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:51 INFO - Downloading/unpacking jsonschema 08:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:59:53 INFO - Downloading/unpacking functools32 (from jsonschema) 08:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:53 INFO - Downloading functools32-3.2.3-2.tar.gz 08:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:59:53 INFO - warning: no files found matching '*.txt' 08:59:53 INFO - no previously-included directories found matching 'build' 08:59:53 INFO - no previously-included directories found matching 'dist' 08:59:53 INFO - no previously-included directories found matching '.git*' 08:59:53 INFO - Installing collected packages: jsonschema, functools32 08:59:54 INFO - Running setup.py install for functools32 08:59:54 INFO - warning: no files found matching '*.txt' 08:59:54 INFO - no previously-included directories found matching 'build' 08:59:54 INFO - no previously-included directories found matching 'dist' 08:59:54 INFO - no previously-included directories found matching '.git*' 08:59:54 INFO - Successfully installed jsonschema functools32 08:59:54 INFO - Cleaning up... 08:59:54 INFO - Return code: 0 08:59:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2cb35fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c40410>, '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 0x1c41310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c417a0>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:59:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:59:54 INFO - Using env: {'DISPLAY': ':0', 08:59:54 INFO - 'HOME': '/home/cltbld', 08:59:54 INFO - 'LANG': 'en_US.UTF-8', 08:59:54 INFO - 'LANGUAGE': 'en_US:en', 08:59:54 INFO - 'LOGNAME': 'cltbld', 08:59:54 INFO - 'MAIL': '/var/mail/cltbld', 08:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:54 INFO - 'MOZ_NO_REMOTE': '1', 08:59:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:54 INFO - 'NO_EM_RESTART': '1', 08:59:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:54 INFO - 'PWD': '/builds/slave/test', 08:59:54 INFO - 'SHELL': '/bin/bash', 08:59:54 INFO - 'SHLVL': '1', 08:59:54 INFO - 'TERM': 'linux', 08:59:54 INFO - 'TMOUT': '86400', 08:59:54 INFO - 'USER': 'cltbld', 08:59:54 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772', 08:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:54 INFO - '_': '/tools/buildbot/bin/python'} 08:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:54 INFO - Downloading/unpacking flake8 08:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:59:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:59:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:59:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:59:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:59:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:59:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:59:56 INFO - no previously-included directories found matching 'docs/_build' 08:59:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:59:57 INFO - Running setup.py install for pep8 08:59:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:59:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:59:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:59:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:59:57 INFO - no previously-included directories found matching 'docs/_build' 08:59:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:59:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:59:57 INFO - Cleaning up... 08:59:57 INFO - Return code: 0 08:59:57 INFO - Running post-action listener: _resource_record_post_action 08:59:57 INFO - Running post-action listener: _start_resource_monitoring 08:59:57 INFO - Starting resource monitoring. 08:59:57 INFO - ##### 08:59:57 INFO - ##### Running install step. 08:59:57 INFO - ##### 08:59:57 INFO - Running pre-action listener: _resource_record_pre_action 08:59:57 INFO - Running main action method: install 08:59:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:59:57 INFO - Reading from file tmpfile_stdout 08:59:57 INFO - Detecting whether we're running mozinstall >=1.0... 08:59:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:59:57 INFO - Reading from file tmpfile_stdout 08:59:57 INFO - Output received: 08:59:57 INFO - Usage: mozinstall [options] installer 08:59:57 INFO - Options: 08:59:57 INFO - -h, --help show this help message and exit 08:59:57 INFO - -d DEST, --destination=DEST 08:59:57 INFO - Directory to install application into. [default: 08:59:57 INFO - "/builds/slave/test"] 08:59:57 INFO - --app=APP Application being installed. [default: firefox] 08:59:57 INFO - mkdir: /builds/slave/test/build/application 08:59:57 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'] 08:59:57 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 09:00:14 INFO - Reading from file tmpfile_stdout 09:00:14 INFO - Output received: 09:00:14 INFO - /builds/slave/test/build/application/firefox/firefox 09:00:14 INFO - Running post-action listener: _resource_record_post_action 09:00:14 INFO - ##### 09:00:14 INFO - ##### Running run-tests step. 09:00:14 INFO - ##### 09:00:14 INFO - Running pre-action listener: _resource_record_pre_action 09:00:14 INFO - Running main action method: run_tests 09:00:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:00:14 INFO - Python 2.7.3 09:00:14 INFO - Return code: 0 09:00:14 INFO - grabbing minidump binary from tooltool 09:00:14 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')]} 09:00:14 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 0x1c40410>, '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 0x1c41310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c417a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:00:14 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 09:00:14 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 09:00:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:00:14 INFO - Return code: 0 09:00:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:00:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:00:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:00:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:00:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:00:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:00:15 INFO - Return code: 0 09:00:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 09:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 09:00:15 INFO - Using env: {'DISPLAY': ':0', 09:00:15 INFO - 'HOME': '/home/cltbld', 09:00:15 INFO - 'LANG': 'en_US.UTF-8', 09:00:15 INFO - 'LANGUAGE': 'en_US:en', 09:00:15 INFO - 'LOGNAME': 'cltbld', 09:00:15 INFO - 'MAIL': '/var/mail/cltbld', 09:00:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:00:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:15 INFO - 'MOZ_NO_REMOTE': '1', 09:00:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:15 INFO - 'NO_EM_RESTART': '1', 09:00:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:15 INFO - 'PWD': '/builds/slave/test', 09:00:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:00:15 INFO - 'SHELL': '/bin/bash', 09:00:15 INFO - 'SHLVL': '1', 09:00:15 INFO - 'TERM': 'linux', 09:00:15 INFO - 'TMOUT': '86400', 09:00:15 INFO - 'USER': 'cltbld', 09:00:15 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772', 09:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:15 INFO - '_': '/tools/buildbot/bin/python'} 09:00:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 09:00:15 INFO - mozversion application_buildid: 20160503053028 09:00:15 INFO - mozversion application_changeset: c49359cf04ff0398969ed5c5a4ceb4d939d734af 09:00:15 INFO - mozversion application_display_name: Nightly 09:00:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:00:15 INFO - mozversion application_name: Firefox 09:00:15 INFO - mozversion application_remotingname: firefox 09:00:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:00:15 INFO - mozversion application_vendor: Mozilla 09:00:15 INFO - mozversion application_version: 49.0a1 09:00:15 INFO - mozversion platform_buildid: 20160503053028 09:00:15 INFO - mozversion platform_changeset: c49359cf04ff0398969ed5c5a4ceb4d939d734af 09:00:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:00:15 INFO - mozversion platform_version: 49.0a1 09:00:15 INFO - using testdate: 1462291215 09:00:15 INFO - actual date: 1462291215 09:00:15 INFO - starting webserver on 'localhost:55990' 09:00:15 INFO - SUITE-START | Running 2 tests 09:00:15 INFO - TEST-START | dromaeo_css 09:00:15 INFO - operating with platform_type : linux_ 09:00:15 INFO - Initialising browser for dromaeo_css test... 09:00:15 INFO - TEST-INFO | started process 18481 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDWtcNA/profile http://localhost:55990/getInfo.html) 09:00:19 INFO - PROCESS | 18481 | 09:00:19 INFO - PROCESS | 18481 | (process:18549): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:00:20 INFO - PROCESS | 18481 | __metrics Screen width/height:1600/1200 09:00:20 INFO - PROCESS | 18481 | colorDepth:24 09:00:20 INFO - PROCESS | 18481 | Browser inner width/height: 1024/697 09:00:20 INFO - PROCESS | 18481 | __metrics 09:00:20 ERROR - PROCESS | 18481 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 09:00:21 INFO - TEST-INFO | 18481: exit 0 09:00:21 INFO - Browser initialized. 09:00:21 INFO - Running cycle 1/1 for dromaeo_css test... 09:00:21 INFO - TEST-INFO | started process 18600 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDWtcNA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:23 INFO - PROCESS | 18600 | 09:00:23 INFO - PROCESS | 18600 | (process:18664): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:00:33 INFO - PROCESS | 18600 | RSS: Main: 164835328 09:00:33 INFO - PROCESS | 18600 | 09:01:23 INFO - PROCESS | 18600 | 1462291283168 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] 09:03:30 INFO - PROCESS | 18600 | Cycle 1(1): loaded http://localhost:55990/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55990/tests/dromaeo/cssquery-ext.html) 09:03:31 INFO - PROCESS | 18600 | RSS: Main: 170397696 09:03:31 INFO - PROCESS | 18600 | 09:06:33 INFO - PROCESS | 18600 | Cycle 1(1): loaded http://localhost:55990/tests/dromaeo/cssquery-ext.html (next: http://localhost:55990/tests/dromaeo/cssquery-jquery.html) 09:06:33 INFO - PROCESS | 18600 | RSS: Main: 167501824 09:06:33 INFO - PROCESS | 18600 | 09:09:35 INFO - PROCESS | 18600 | Cycle 1(1): loaded http://localhost:55990/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55990/tests/dromaeo/cssquery-mootools.html) 09:09:36 INFO - PROCESS | 18600 | RSS: Main: 168173568 09:09:36 INFO - PROCESS | 18600 | 09:12:37 INFO - PROCESS | 18600 | Cycle 1(1): loaded http://localhost:55990/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55990/tests/dromaeo/cssquery-prototype.html) 09:12:38 INFO - PROCESS | 18600 | RSS: Main: 166109184 09:12:38 INFO - PROCESS | 18600 | 09:15:40 INFO - PROCESS | 18600 | Cycle 1(1): loaded http://localhost:55990/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55990/tests/dromaeo/cssquery-yui.html) 09:15:41 INFO - PROCESS | 18600 | RSS: Main: 167559168 09:15:41 INFO - PROCESS | 18600 | 09:18:43 INFO - PROCESS | 18600 | Cycle 1(1): loaded http://localhost:55990/tests/dromaeo/cssquery-yui.html (next: http://localhost:55990/tests/dromaeo/cssquery-dojo.html) 09:18:43 INFO - PROCESS | 18600 | RSS: Main: 169824256 09:18:43 INFO - PROCESS | 18600 | 09:18:43 INFO - PROCESS | 18600 | __start_tp_report 09:18:43 INFO - PROCESS | 18600 | _x_x_mozilla_page_load 09:18:43 INFO - PROCESS | 18600 | _x_x_mozilla_page_load_details 09:18:43 INFO - PROCESS | 18600 | |i|pagename|runs| 09:18:43 INFO - PROCESS | 18600 | |0;dojo.html;3094.3656550407163;3211.1329940915966;3221.5006673965536;3264.281857991241;3265.3142840003597;5240.816571420001;5311.468853114691;5318.76065577049;5324.3610766708;5427.701476418795;5261.947380526193;5449.891002179954;5460.153676180198;5501.092319767244;5560;4922.5569698727195;4960.727160006199;4989;5006.474320196382;5053.898922021557;525.154457193292;4862.489438608948;4882.43851957026;4929.06347793918;4940.678855874375;4893.657443978923;4905.043516514281;4921.729304888229;4925.018315565993;4968.378952630903;4826.300186472977;4942.802287908479;4989.501049895018;5012.498750124995;5055.368078990126;4841.782119804582;4873.415190177166;4877.731724755137;4932.136876046713;4996.100701873697;5191.740412979374;5227.921581176285;5235.738213089368;5236.7119808410525;5284.550813180885;5646.096624540054;5664.20701101846;5691.032524470808;5849.502792262663;5929.881402371929;5677.772889084473;5736.627119237236;5743.994800909824;5749.137629355589;5796.362400135981;5340.893182136374;5341.786328546892;5349.117395629716;5351.7324133793545;5352.652077614982;5800.59395842287;5886.499647529922;5946.851328716817;6032.668203248776;6034.969825150934;5604.9911016016695;5613.663180209201;5622.550195984311;5626.774929002794;5651.858703532444;5695.288088988877;5696.11710184922;5697.601167918288;5698.230738850202;5701.372848986608;5619.80330688424;5732.512736417451;5767.769289228384;5786.276715410574;5812.244408226988;5592.692401917852;5709.0865461525955;5710.628809127394;5731;5819.359870414251;4348.717333373321;4436.401085853433;4437.290033594674;4439.489458712224;4489.977550112294;3852.499175107218;3940.231654827281;3942.4086387042175;3960.0495880988356;3967.900802479961;5436.320459942507;5470;5523.171524271392;5533.695646739468;5539.335279766373;5786.363500014995;5817.534597232211;5847.678377689268;5854.531637468992;5869.735861886225;5333.066713325153;5570.3315602128005;5604.159376093618;5608.775648974077;5608.887822243532;4866;4899.6570240083565;4942.654014219042;4977.676451030671;4990.076835785391;6055.455009049118;6059.757609695563;6089.756409743561;6106.4809491192855;6117.694115294306;5651.43485651448;5741.91387129185;5922.585419020627;5927.73325200367;5946.316173640087;5963.880722385441;5993.310769261417;6030.246219222598;6061.333253342041;6064.787732429344;5540.667559946416;5583.581231407579;5588.469095435927;5594.104943209067;5617.297837770278;5538.418466061005;5643.1535269709875;5687.146927960674;5691.658500489983;5729.1119876419225;5702.258706368146;5706.629069110494;5706.771729130788;5722.971385143048;5776.306843178677;5665.12190610456;5680.233168522197;5699.544036476989;5723.513501352431;5734.082546792493;5524.392316845224;5647.7176141193595;5662.915056274242;5677.318721753416;5739.655620662774;5569.10894256917;5714.142878568248;5720.08478643415;5732.942670573408;5753.280839895013;5635.408282130317;5660.207570940154;5662.150677398258;5666.688332141772;5671.602987790815 09:18:43 INFO - PROCESS | 18600 | |1;ext.html;579.9913001304978;593.8307582339035;654.4829584628144;658.8715200535895;664.4916638771339;36126.458103128476;37484;37581.812090939544;37671.434928476025;37689.246215075684;39694;40102.59897401025;40482.59517404825;40527.39208911861;40574.797126014404;8252.752417427457;8439.789005274855;8466.872996905051;8466.915330846705;8475.618597163142;8473.406861519696;8510.829783404328;8585.441946273504;8750.299976001905;8785.560721963877;8730.126987301282;8847.646094156225;8901.465912045265;8908.331875109361;8911.955440222822;8682.392232543725;8798.912010879938;8801.163889430525;8808.207261346446;8835.204831565157;8602.483850968962;8649.48103113809;8714.738557843275;8715.215630593213;8717.782055448664;41416.58583414157;41439.585604143875;41667.7916610418;41759.58240417617;41852.372214416806;3308.0902751743224;3355.328934213143;4015.538213105501;4178.707490475668;4221.324588065895;31927.52108718371;32172.678273217436;32540.18649533757;32554.837225813957;32678.509822352684;4316.82732690692;4350.71720338177;4401.5378385269405;4409.360642706822;4496.2805951048;286494;289922.9999999979;291066.7146628286;291924;292061;59049.40950590439;59305.40694593085;59697.40302597005;59719.40280597138;59967.70016149891;55280.44719552834;55925.72037139788;56270.43729562734;56326.71836640873;56562.43437565654;14108.858911410754;14252.358643860844;14319;14361.281935903164;14393.92803035978;10603.469826508644;10621.787564248827;10671.413072281099;10693.251472397013;10708.571657133627;18901.43295701131;19095.61808763817;19103.140358683893;19222.8077719221;19972.400827975183;7322.487425880137;7498.475106742476;7584.4311676624475;7592.81017974555;7599.810004749926;1008.5814387029301;1041.3127335958231;1087.9782404351868;1131.9434028298551;1158.7219067423757;31775.84112079471;31818.363632727214;31833.789326276416;31949.361012779613;32498.512522312183;1103.713034610991;1109.0960866893456;1158.0816342816056;1213.3205404973244;1242.8011518157052;14996.850031499545;14997.625059373384;15055.171965542;15382.846171538366;15391.923040384727;479799;490735;493595;493684;499089;56662.71668641713;57708.71145644245;57762.422375775706;57768;57795.71102144462;1340.604521666111;1369.657585603599;1404.3048690898072;1412.032757561074;1421.5522110535148;30168.09495715132;30370;30719.385612288075;30932.381352373275;31034.689653104084;48229.276560850914;49180.75409622929;49307.75346123247;49362.506374935794;49378.75310623424;437666;439221;439770;441236;442517;26377.736222637526;26674.3995360279;37921.4311785329;39024.2926921942;39048.6095139045;43543.12913741644;45273.54726452693;46442.30336545022;47044.7647761759;47739.76130119327;38711.6128838708;38805.6119438802;39142.412863806494;39555;39930.2013959725;38953.41569876397;39549.80225098856;40030.59969400269;40075.39886901757;40713.59286407217;37914.43128353022;39503.20993580055;39509.40735889022;39906.60093399029;40390.59609403869;34403.483947741304;34867.65132348746;35341.29317413586;35682.28635427225;36115.638843611225;27255.727442725318;27288;27405.31486712848;27483.45033099287;27617.74028502291 09:18:43 INFO - PROCESS | 18600 | |2;jquery.html;373.372733807204;382.74164938666394;388.7065265724378;389.54034239597274;403.59841957252536;16934.661306773858;18559.536011599685;18770.718439223423;18849.905750471262;18885.62228755426;17709.91145044273;18443.631127377444;18504.907475462605;18772.53068673284;18781.43655690328;5566.86082847929;5647.322321321447;5770.2210201622875;5795.82612521625;5811.447912448331;5495.313085864267;5607;5615.073512870372;5691.886162276752;5694.117411801178;4980.800767969277;5626.268585083933;5627.634203776762;5647.09646456567;5651.745671444774;5188.273641690166;5215.452377500384;5229.137192363255;5256.159014557691;5274.894502109955;4992.600591952635;5240.187770895517;5247.47525247476;5265.262863199156;5276.947230527722;12228.755424891542;12358.876411235862;12503.187292826027;17208.311667533282;22055.66916496254;2015.899205039757;2182.3562049195525;2279.3845661671257;2445.6698345723457;2538;9282.257419406498;9425.670101546482;9430.575624096931;9448.858267126;9626.75933101671;1885.424945391655;1968.0258272155374;2003.8797672139572;2010.7184994100837;2058.0635810706094;57680.71159644217;67774.32225677778;69299;73966;78037.60981195058;9924.603015879284;10201.540930658139;10277.280590358752;10515.737106572244;10748.570057197625;14772.335244914004;15029.624259393602;15038.097714137186;15041.398344066334;15051.247437628075;7295.89056164158;7370.96314518424;7394;7407.518511296748;7507.399408047343;6786.321367863175;6861.55399899005;6863.10779598659;6947.791566252919;6954.582725036514;4443.400140980926;4471.7987690554;4500.074951281693;4513.616342610849;4548.385967894358;1925.740025096622;1959.8628096033142;1960.0591715976127;1961.264525802824;2006.9899650501654;961.7018724195522;963.3208587945481;1021.2606092961308;1052.5105825791045;1118.6140781430393;17395.47813565595;17774.46676599704;18149;18203.817961820478;18705.158267877978;955.8016264524553;955.9952200239094;960.6061514778908;987.8271302522173;1011.3830563356347;10057.094861462503;10248.436336001592;10285.845712314322;10301.793964120676;10337.63818266372;431251;441990;443848;445176;445339;89204.10795892088;95461;95982;96336;96531.51734241284;1056.6460235820932;1078.3853203673987;1085.3759088523973;1096.5668560918393;1103.862017247844;16510.587235319214;16520.42178523794;16802.159892005107;16826;16951.406700765416;37695;37904.620953791215;38387;38588.6141138585;39025.804870975466;54392;54417;54820;55203.723981381445;55657.44342556522;7495.362894154058;7919.0893047298;8021.157778433414;8074.555899425353;8414.579271036546;8601.956990215009;9666.468344241135;12135.08986825974;13341.19952802835;13593.52422665202;11036.392998385167;11107.555697772323;11507.194496385508;11538.365389903636;11548.94225528867;10185.388876667424;10286.588536458457;10918.454077296263;10984.835227471754;11150.609728659458;11682.824757628812;11683.299002059903;11985.28088314704;12098.153129280865;12132.332721700039;8077.555734434663;8096.83806323882;8238.299744521782;8293.170682931659;8314.6674133034;10986.285891417032;11692.649220523397;11744.823827642422;11755.764884702428;11787.174897757417 09:18:43 INFO - PROCESS | 18600 | |3;mootools.html;1475.741745194591;1521.650020495286;1647.9588010299742;1744.7557341972133;1782.5632719983605;7144.85710285794;8013.839723205532;8060.7984800379945;8333.208345207204;8342.374321925858;8125.0656174539945;8180.754577362689;8215.83568328633;8241.79395515111;8255;2261.954760904781;2296.207808306132;2299.7585253548305;2300.424893776556;2306.976930230693;2260.0959616153505;2260.5930932432157;2282.589133955887;2286.1084177170915;2289.3933107726466;2263.4454558633156;2274.442761523429;2282.3267136194863;2312.491251924574;2314.872682002489;2197.703310053146;2205.911763529473;2208;2208.7791220877943;2213.7675544067883;2227.532218234173;2231.040652519416;2246.786555277246;2255.2106762632948;2271.840971132005;8315.542645154514;8334.749957501284;8356.791080222982;8389.790255243606;8406.369522285853;5007.949920500785;5133.486651334874;5157.638965272433;5167.689938603696;5170.1727723564045;3201.183698156978;3264.9020529384156;3388.847791750792;3400.574928133983;3409.6931276185014;1155.8092914669069;1164.6797130789016;1180.557291015869;1183.9230450020807;1187.2223693480785;11160.218784685076;11207.551697932073;11260.324380537195;11314.264572802742;11326.773464530746;4308.246056940023;4441.200583894865;4469.329600559942;4679.602233810164;4692.1084993851055;8916;8923.643054277756;9017.278617710568;9026.954865225633;9059.728208153765;5073.670211436245;5076.010178015325;5082.949170508322;5094.949050509522;5113.360829896263;4044.2922488564973;4624.329472226508;4631.490536041033;4774.976125119352;4784.234522476387;3616.1863580694135;3631.4371272452813;3716.554013518395;3719.6094410087094;3745.700343972476;1085.8751243606928;1086.9673909782719;1093.1691914145306;1103.757173421846;1112.0714203639889;848.9448185868023;1026.3687831983277;1042.4214560918763;1050.5272627317738;1069.540097757956;5880.7353669085;5932.3474417814;6037.366076561898;6086.391360863879;6137.693115344304;989.9059589339001;995.7809281957958;1016.4968340671415;1029.1920842139034;1055.4775386183887;4008.659263962596;4076.7553946763287;4164.083901541656;4169.478815148106;4224.345226489899;10168.847467287997;10482.213833962483;10547.736306592396;10618.68143955667;10622.628208012682;10407.21945854064;10428.217883658755;10488.31825931312;10490.527926243338;10495.160387169008;7865.685372585147;8008.319292860056;8072.556009419538;8078.23256790604;8085.676572937016;5842.7078646066675;5927.585069045125;5954.136650185786;5993.820185394271;6152.0156774915795;9230.584623692084;9772.413655180711;9816.65641702537;9853.802923941337;9868.950655246677;9425;9425.293103017439;9541.284403669613;9612.086851749073;9614.567344469377;6599.340065993362;7057.7176912922905;7313.049303590499;7333.6333183341685;7513.023306970277;8084.63619137152;8127.187281271826;8127.552984585905;8153.306968907709;8178.836423271382;7270.127584689871;7455;7494.288042635941;7537.54774713519;7583.734569290048;7219.953106799379;7237.782866514013;7279.563226206445;7299.890501642586;7315.15875674283;6690.69891854858;6834.2482326943;6854.6229957352825;6883.27725588806;6917.584944903322;4989.401271847257;5083.87290317745;5221.869453263699;5235.476452354734;5263.23683065961;5141.203113517411;5173.22401639757;5246.055709972242;5330.680159190306;5340.359156901197 09:18:43 INFO - PROCESS | 18600 | |4;prototype.html;316.90017644441997;319.58294425774363;327.0564421643558;327.7083395777757;328.7008821972006;5367.704776237305;5411.729413529318;5435.537979271761;5578.721063946801;5633.943660563393;5449.972750136244;5479.561635069195;5506.669599824003;5508.256385387971;5537.418571050042;4193.622573968342;4207.600277973595;4219.797357753041;4252.744835309876;4259.574042595731;4161;4249.723767955073;4252.766097864616;4263.637590804769;4296.634786043174;4226.936595951048;4239.173361194568;4243.8090285937205;4265.232258193524;4275.486941567001;4273.551277115905;4278.893027674333;4279.443672322578;4289.935650965238;4306.806193721259;3721.6836568891677;3778;3789.8484060637543;3804.733668643196;3818.5608655004753;5342.679439233659;5343.385510666284;5344.770702738353;5353.223782551547;5362.597805164628;4885.8778530536665;4896.387951506062;4910.1898186799135;4927.260910863399;4931.827386041471;5553.583481238923;5713.942860571383;5774.595778295521;5820.156077368758;5834.824955251349;4128.6284234418745;4144.8134833932545;4150.91698166038;4152.397902304179;4153.1486045360625;5989.951758442256;6006.729697163638;6038.275406951194;6044.274687037584;6046.455818976269;4109.589041095866;4253.723507972034;4259.829606815692;4260.765657888845;4265.91468170641;4325.956740432618;4339.5443478434945;4347.065380943112;4357.433533640607;4364.214441400578;4877;4909.355365952374;4912.754362281871;4934.605231581465;4938.629602779806;5731.369549349568;5823.126531020296;5849.4206564227425;5876.382979787147;5892.528597712173;1553.0526378908858;1560.095144816004;1560.7034663414142;1564.5853848730096;1570.4974408189269;1037.9325343852777;1051.8264486359665;1054.2093429927554;1060.528065011078;1066.648006157966;5899.439553242435;5947.107933809876;5953.493953014043;5997.550183736237;6018.15745795589;6334.714937827809;6355.237371515448;6362.681865906686;6419.45434638061;6435.581687190318;5814.418558144152;5985.22192115031;6033.276006879202;6050.42520960508;6068.150458935753;3429.725621950288;3446.138465383654;3471.7916924984584;3472.4791281308007;3481.2515309208134;6572.835679107965;6679.833004174934;6724.899126513106;6728.259891411941;6775.1869775626255;6526.053722210253;6528.967355163194;6538.953767397289;6546.541742078009;6598.505112116611;6397.616143031433;6645.501587380869;6682.0311054896765;6723.562968407038;6733.259341472434;6395.616263024233;6428.839279018062;6443.226812782309;6456.967715161394;6475.740970361321;6216.010846730308;6339.936600633934;6357.554971151975;6395.840103997251;6403.807885763435;6590.978398348264;6598.10925525048;6604.5046621502615;6636.767713130017;6652.933470665232;3973.821178047053;4042.4946881639794;4165.604267594574;4190.287651099259;4214;5908.527317814479;5947.1563815215695;5953.196318496947;5968.671723055274;5990.31111422192;5660.943390566042;5672.319321681424;5763.971180144073;5793.826185214451;5826.970865145647;5715.31416230055;5720.685362305113;5720.713964301852;5736.4550367715;5755.625884317506;5540.63985840919;5602.4957753802355;5682.147677848356;5691.658500489983;5701.116326969326;5618.719064046863;5712.914306285326;5714.742836572281;5834.994977586462;5848.210491583582;5690.9430905690415;5716.714164291686;5750.539956803362;5758.8848223034465;5776.306843178845 09:18:43 INFO - PROCESS | 18600 | |5;yui.html;720.9351158395743;736.778966310107;750.6997201119551;772.3435080181846;781.4178437064388;14168.433262669494;14638.34127464264;14655.853441465582;14656.193909334996;14681.632959176026;13474.326283685825;13504.527341543047;13513.189208647487;13523.526676566322;13584.728305433886;650.1320736816344;759.2331744937597;801.9358451323909;801.9518828870257;806.0247101007787;788.1842293226512;788.4677842456348;791.5092642561619;796.6972550430828;800.4796882026671;854.7563944275882;855.1533981358441;855.5123579559654;856.7301300090483;861.3453775130884;854.8674955381864;856.7601071699903;858.9098144694842;859.707699382213;862.3963225741975;616.315889362807;620.2247191011236;623.18985319085;623.5105442227874;625.2840497630187;13632.318384080856;13681.31593420325;13692.931535342359;13694.452221911211;13708.24604646744;13344.532941347006;13559.796603050961;13586.456541738418;13591.592252232449;13607.183568985893;11789.23369980957;11821.645350639408;11866.52533898643;11880.40597970098;11970.521179152824;3863.265979463893;3900.4539364488996;3922.3135951208424;3926.7840268785208;3943.5464921533817;49918;49938.50061499375;50578.7471062646;50742.74628626833;51041.74479127581;10234.744131396626;10934.289271197347;11192.608258710907;11194.328340299608;11543.36511491876;18201.08994550267;19986.70019949702;20013.799862001484;20031.899840500995;20065.29771458021;7859.806633263729;7876.527408355517;7906.248906353887;7923.801904952422;7927.603619819101;4294.205571969195;4349.927501208328;4351.69538132334;4360.389545463638;4493.483249426358;3345.832708364572;3388.6950174484414;3416.641252668484;3419.9487007694906;3462.23830757233;613.1967123068794;620.2928661326092;625.5339771869986;630.5365556316104;631.333942690466;682.0008687273169;721.8989341492195;742.4468770765706;746.58191412809;749.4716225061319;7590.316871481593;7805.492642978302;7877.645505952131;7946.6424010919645;8002.159773223844;584.8859472402926;609.960352577081;753.8492301539713;759.7644730133676;777.4752042371376;4557.817687292471;4574.359589657451;4636.79134438951;4652.371929789503;4748.905021899543;63598.36401635924;64036;64314;64806.351936480976;64888.675556621914;53925;54436;55430.16854747101;55651.72174139184;56583.71708141433;51264.99999999925;51285.743571281906;51488;51873.48126518686;52236;8284.171582841667;8290.419670622998;8410.579471026547;8539.188777066169;8658.56707164652;29803.85098074496;29996.250093747833;30968.916087936814;30975.690243098183;32321.35357292888;45470.31794523151;45508.54491455043;45611.31583026191;45877.31184032309;46776.532234677215;11735.47190376418;11747.823782643438;11752.177347585586;11954.641360759191;12061.577844775391;13147.14543554666;13279.203247804777;13860.376283067488;14276.64308392257;14453.205073721047;12983.480660773463;13335.199888006751;13339.866601333862;14023.158610483404;14025.088369255966;11545.050525113722;11605.76788464243;11711.130092767246;11734.52870128253;12242.938785306016;11014.284071535325;13236.205827650372;13401.061925665499;13551.932240338736;13800.516981905585;11328.886711132784;11417.200795944203;11453.656390308304;11645;11727.706807329885;11458.82811757841;11488.368139752394;11547.711307217387;11610.129240306842;11734.589289374831 09:18:43 INFO - PROCESS | 18600 | __end_tp_report 09:18:43 INFO - PROCESS | 18600 | __start_cc_report 09:18:43 INFO - PROCESS | 18600 | _x_x_mozilla_cycle_collect,350 09:18:43 INFO - PROCESS | 18600 | __end_cc_report 09:18:43 INFO - PROCESS | 18600 | __startTimestamp1462292323809__endTimestamp 09:18:43 INFO - PROCESS | 18600 | 09:18:43 INFO - PROCESS | 18600 | ------- Summary: start ------- 09:18:43 INFO - PROCESS | 18600 | Number of tests: 6 09:18:43 INFO - PROCESS | 18600 | 09:18:43 INFO - PROCESS | 18600 | [#0] dojo.html Cycles:165 Average:5345.04 Median:5608.78 stddev:711.63 (12.7%) stddev-sans-first:691.56 09:18:43 INFO - PROCESS | 18600 | Values: 3094.4 3211.1 3221.5 3264.3 3265.3 5240.8 5311.5 5318.8 5324.4 5427.7 5261.9 5449.9 5460.2 5501.1 5560.0 4922.6 4960.7 4989.0 5006.5 5053.9 525.2 4862.5 4882.4 4929.1 4940.7 4893.7 4905.0 4921.7 4925.0 4968.4 4826.3 4942.8 4989.5 5012.5 5055.4 4841.8 4873.4 4877.7 4932.1 4996.1 5191.7 5227.9 5235.7 5236.7 5284.6 5646.1 5664.2 5691.0 5849.5 5929.9 5677.8 5736.6 5744.0 5749.1 5796.4 5340.9 5341.8 5349.1 5351.7 5352.7 5800.6 5886.5 5946.9 6032.7 6035.0 5605.0 5613.7 5622.6 5626.8 5651.9 5695.3 5696.1 5697.6 5698.2 5701.4 5619.8 5732.5 5767.8 5786.3 5812.2 5592.7 5709.1 5710.6 5731.0 5819.4 4348.7 4436.4 4437.3 4439.5 4490.0 3852.5 3940.2 3942.4 3960.0 3967.9 5436.3 5470.0 5523.2 5533.7 5539.3 5786.4 5817.5 5847.7 5854.5 5869.7 5333.1 5570.3 5604.2 5608.8 5608.9 4866.0 4899.7 4942.7 4977.7 4990.1 6055.5 6059.8 6089.8 6106.5 6117.7 5651.4 5741.9 5922.6 5927.7 5946.3 5963.9 5993.3 6030.2 6061.3 6064.8 5540.7 5583.6 5588.5 5594.1 5617.3 5538.4 5643.2 5687.1 5691.7 5729.1 5702.3 5706.6 5706.8 5723.0 5776.3 5665.1 5680.2 5699.5 5723.5 5734.1 5524.4 5647.7 5662.9 5677.3 5739.7 5569.1 5714.1 5720.1 5732.9 5753.3 5635.4 5660.2 5662.2 5666.7 5671.6 09:18:43 INFO - PROCESS | 18600 | 09:18:43 INFO - PROCESS | 18600 | [#1] ext.html Cycles:180 Average:56722.35 Median:40089.00 stddev:110250.71 (275.0%) stddev-sans-first:110479.41 09:18:43 INFO - PROCESS | 18600 | Values: 580.0 593.8 654.5 658.9 664.5 36126.5 37484.0 37581.8 37671.4 37689.2 39694.0 40102.6 40482.6 40527.4 40574.8 8252.8 8439.8 8466.9 8466.9 8475.6 8473.4 8510.8 8585.4 8750.3 8785.6 8730.1 8847.6 8901.5 8908.3 8912.0 8682.4 8798.9 8801.2 8808.2 8835.2 8602.5 8649.5 8714.7 8715.2 8717.8 41416.6 41439.6 41667.8 41759.6 41852.4 3308.1 3355.3 4015.5 4178.7 4221.3 31927.5 32172.7 32540.2 32554.8 32678.5 4316.8 4350.7 4401.5 4409.4 4496.3 286494.0 289923.0 291066.7 291924.0 292061.0 59049.4 59305.4 59697.4 59719.4 59967.7 55280.4 55925.7 56270.4 56326.7 56562.4 14108.9 14252.4 14319.0 14361.3 14393.9 10603.5 10621.8 10671.4 10693.3 10708.6 18901.4 19095.6 19103.1 19222.8 19972.4 7322.5 7498.5 7584.4 7592.8 7599.8 1008.6 1041.3 1088.0 1131.9 1158.7 31775.8 31818.4 31833.8 31949.4 32498.5 1103.7 1109.1 1158.1 1213.3 1242.8 14996.9 14997.6 15055.2 15382.8 15391.9 479799.0 490735.0 493595.0 493684.0 499089.0 56662.7 57708.7 57762.4 57768.0 57795.7 1340.6 1369.7 1404.3 1412.0 1421.6 30168.1 30370.0 30719.4 30932.4 31034.7 48229.3 49180.8 49307.8 49362.5 49378.8 437666.0 439221.0 439770.0 441236.0 442517.0 26377.7 26674.4 37921.4 39024.3 39048.6 43543.1 45273.5 46442.3 47044.8 47739.8 38711.6 38805.6 39142.4 39555.0 39930.2 38953.4 39549.8 40030.6 40075.4 40713.6 37914.4 39503.2 39509.4 39906.6 40390.6 34403.5 34867.7 35341.3 35682.3 36115.6 27255.7 27288.0 27405.3 27483.5 27617.7 09:18:43 INFO - PROCESS | 18600 | 09:18:43 INFO - PROCESS | 18600 | [#2] jquery.html Cycles:180 Average:26657.48 Median:38487.81 stddev:73010.91 (189.7%) stddev-sans-first:73189.05 09:18:43 INFO - PROCESS | 18600 | Values: 373.4 382.7 388.7 389.5 403.6 16934.7 18559.5 18770.7 18849.9 18885.6 17709.9 18443.6 18504.9 18772.5 18781.4 5566.9 5647.3 5770.2 5795.8 5811.4 5495.3 5607.0 5615.1 5691.9 5694.1 4980.8 5626.3 5627.6 5647.1 5651.7 5188.3 5215.5 5229.1 5256.2 5274.9 4992.6 5240.2 5247.5 5265.3 5276.9 12228.8 12358.9 12503.2 17208.3 22055.7 2015.9 2182.4 2279.4 2445.7 2538.0 9282.3 9425.7 9430.6 9448.9 9626.8 1885.4 1968.0 2003.9 2010.7 2058.1 57680.7 67774.3 69299.0 73966.0 78037.6 9924.6 10201.5 10277.3 10515.7 10748.6 14772.3 15029.6 15038.1 15041.4 15051.2 7295.9 7371.0 7394.0 7407.5 7507.4 6786.3 6861.6 6863.1 6947.8 6954.6 4443.4 4471.8 4500.1 4513.6 4548.4 1925.7 1959.9 1960.1 1961.3 2007.0 961.7 963.3 1021.3 1052.5 1118.6 17395.5 17774.5 18149.0 18203.8 18705.2 955.8 956.0 960.6 987.8 1011.4 10057.1 10248.4 10285.8 10301.8 10337.6 431251.0 441990.0 443848.0 445176.0 445339.0 89204.1 95461.0 95982.0 96336.0 96531.5 1056.6 1078.4 1085.4 1096.6 1103.9 16510.6 16520.4 16802.2 16826.0 16951.4 37695.0 37904.6 38387.0 38588.6 39025.8 54392.0 54417.0 54820.0 55203.7 55657.4 7495.4 7919.1 8021.2 8074.6 8414.6 8602.0 9666.5 12135.1 13341.2 13593.5 11036.4 11107.6 11507.2 11538.4 11548.9 10185.4 10286.6 10918.5 10984.8 11150.6 11682.8 11683.3 11985.3 12098.2 12132.3 8077.6 8096.8 8238.3 8293.2 8314.7 10986.3 11692.6 11744.8 11755.8 11787.2 09:18:43 INFO - PROCESS | 18600 | 09:18:43 INFO - PROCESS | 18600 | [#3] mootools.html Cycles:180 Average:5554.21 Median:5079.48 stddev:3054.82 (60.1%) stddev-sans-first:3048.01 09:18:43 INFO - PROCESS | 18600 | Values: 1475.7 1521.7 1648.0 1744.8 1782.6 7144.9 8013.8 8060.8 8333.2 8342.4 8125.1 8180.8 8215.8 8241.8 8255.0 2262.0 2296.2 2299.8 2300.4 2307.0 2260.1 2260.6 2282.6 2286.1 2289.4 2263.4 2274.4 2282.3 2312.5 2314.9 2197.7 2205.9 2208.0 2208.8 2213.8 2227.5 2231.0 2246.8 2255.2 2271.8 8315.5 8334.7 8356.8 8389.8 8406.4 5007.9 5133.5 5157.6 5167.7 5170.2 3201.2 3264.9 3388.8 3400.6 3409.7 1155.8 1164.7 1180.6 1183.9 1187.2 11160.2 11207.6 11260.3 11314.3 11326.8 4308.2 4441.2 4469.3 4679.6 4692.1 8916.0 8923.6 9017.3 9027.0 9059.7 5073.7 5076.0 5082.9 5094.9 5113.4 4044.3 4624.3 4631.5 4775.0 4784.2 3616.2 3631.4 3716.6 3719.6 3745.7 1085.9 1087.0 1093.2 1103.8 1112.1 848.9 1026.4 1042.4 1050.5 1069.5 5880.7 5932.3 6037.4 6086.4 6137.7 989.9 995.8 1016.5 1029.2 1055.5 4008.7 4076.8 4164.1 4169.5 4224.3 10168.8 10482.2 10547.7 10618.7 10622.6 10407.2 10428.2 10488.3 10490.5 10495.2 7865.7 8008.3 8072.6 8078.2 8085.7 5842.7 5927.6 5954.1 5993.8 6152.0 9230.6 9772.4 9816.7 9853.8 9869.0 9425.0 9425.3 9541.3 9612.1 9614.6 6599.3 7057.7 7313.0 7333.6 7513.0 8084.6 8127.2 8127.6 8153.3 8178.8 7270.1 7455.0 7494.3 7537.5 7583.7 7220.0 7237.8 7279.6 7299.9 7315.2 6690.7 6834.2 6854.6 6883.3 6917.6 4989.4 5083.9 5221.9 5235.5 5263.2 5141.2 5173.2 5246.1 5330.7 5340.4 09:18:43 INFO - PROCESS | 18600 | 09:18:43 INFO - PROCESS | 18600 | [#4] prototype.html Cycles:180 Average:4998.76 Median:5590.61 stddev:1519.51 (27.2%) stddev-sans-first:1482.58 09:18:43 INFO - PROCESS | 18600 | Values: 316.9 319.6 327.1 327.7 328.7 5367.7 5411.7 5435.5 5578.7 5633.9 5450.0 5479.6 5506.7 5508.3 5537.4 4193.6 4207.6 4219.8 4252.7 4259.6 4161.0 4249.7 4252.8 4263.6 4296.6 4226.9 4239.2 4243.8 4265.2 4275.5 4273.6 4278.9 4279.4 4289.9 4306.8 3721.7 3778.0 3789.8 3804.7 3818.6 5342.7 5343.4 5344.8 5353.2 5362.6 4885.9 4896.4 4910.2 4927.3 4931.8 5553.6 5713.9 5774.6 5820.2 5834.8 4128.6 4144.8 4150.9 4152.4 4153.1 5990.0 6006.7 6038.3 6044.3 6046.5 4109.6 4253.7 4259.8 4260.8 4265.9 4326.0 4339.5 4347.1 4357.4 4364.2 4877.0 4909.4 4912.8 4934.6 4938.6 5731.4 5823.1 5849.4 5876.4 5892.5 1553.1 1560.1 1560.7 1564.6 1570.5 1037.9 1051.8 1054.2 1060.5 1066.6 5899.4 5947.1 5953.5 5997.6 6018.2 6334.7 6355.2 6362.7 6419.5 6435.6 5814.4 5985.2 6033.3 6050.4 6068.2 3429.7 3446.1 3471.8 3472.5 3481.3 6572.8 6679.8 6724.9 6728.3 6775.2 6526.1 6529.0 6539.0 6546.5 6598.5 6397.6 6645.5 6682.0 6723.6 6733.3 6395.6 6428.8 6443.2 6457.0 6475.7 6216.0 6339.9 6357.6 6395.8 6403.8 6591.0 6598.1 6604.5 6636.8 6652.9 3973.8 4042.5 4165.6 4190.3 4214.0 5908.5 5947.2 5953.2 5968.7 5990.3 5660.9 5672.3 5764.0 5793.8 5827.0 5715.3 5720.7 5720.7 5736.5 5755.6 5540.6 5602.5 5682.1 5691.7 5701.1 5618.7 5712.9 5714.7 5835.0 5848.2 5690.9 5716.7 5750.5 5758.9 5776.3 09:18:43 INFO - PROCESS | 18600 | 09:18:43 INFO - PROCESS | 18600 | [#5] yui.html Cycles:180 Average:14732.19 Median:45489.43 stddev:17051.51 (37.5%) stddev-sans-first:17066.88 09:18:43 INFO - PROCESS | 18600 | Values: 720.9 736.8 750.7 772.3 781.4 14168.4 14638.3 14655.9 14656.2 14681.6 13474.3 13504.5 13513.2 13523.5 13584.7 650.1 759.2 801.9 802.0 806.0 788.2 788.5 791.5 796.7 800.5 854.8 855.2 855.5 856.7 861.3 854.9 856.8 858.9 859.7 862.4 616.3 620.2 623.2 623.5 625.3 13632.3 13681.3 13692.9 13694.5 13708.2 13344.5 13559.8 13586.5 13591.6 13607.2 11789.2 11821.6 11866.5 11880.4 11970.5 3863.3 3900.5 3922.3 3926.8 3943.5 49918.0 49938.5 50578.7 50742.7 51041.7 10234.7 10934.3 11192.6 11194.3 11543.4 18201.1 19986.7 20013.8 20031.9 20065.3 7859.8 7876.5 7906.2 7923.8 7927.6 4294.2 4349.9 4351.7 4360.4 4493.5 3345.8 3388.7 3416.6 3419.9 3462.2 613.2 620.3 625.5 630.5 631.3 682.0 721.9 742.4 746.6 749.5 7590.3 7805.5 7877.6 7946.6 8002.2 584.9 610.0 753.8 759.8 777.5 4557.8 4574.4 4636.8 4652.4 4748.9 63598.4 64036.0 64314.0 64806.4 64888.7 53925.0 54436.0 55430.2 55651.7 56583.7 51265.0 51285.7 51488.0 51873.5 52236.0 8284.2 8290.4 8410.6 8539.2 8658.6 29803.9 29996.3 30968.9 30975.7 32321.4 45470.3 45508.5 45611.3 45877.3 46776.5 11735.5 11747.8 11752.2 11954.6 12061.6 13147.1 13279.2 13860.4 14276.6 14453.2 12983.5 13335.2 13339.9 14023.2 14025.1 11545.1 11605.8 11711.1 11734.5 12242.9 11014.3 13236.2 13401.1 13551.9 13800.5 11328.9 11417.2 11453.7 11645.0 11727.7 11458.8 11488.4 11547.7 11610.1 11734.6 09:18:43 INFO - PROCESS | 18600 | -------- Summary: end -------- 09:18:43 INFO - PROCESS | 18600 | 09:18:44 INFO - TEST-INFO | 18600: exit 0 09:18:44 INFO - TEST-OK | dromaeo_css | took 1109141ms 09:18:44 INFO - TEST-START | kraken 09:18:44 INFO - operating with platform_type : linux_ 09:18:44 INFO - Initialising browser for kraken test... 09:18:44 INFO - TEST-INFO | started process 18835 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptHHZFv/profile http://localhost:55990/getInfo.html) 09:18:48 INFO - PROCESS | 18835 | 09:18:48 INFO - PROCESS | 18835 | (process:18902): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:18:49 INFO - PROCESS | 18835 | __metrics Screen width/height:1600/1200 09:18:49 INFO - PROCESS | 18835 | colorDepth:24 09:18:49 INFO - PROCESS | 18835 | Browser inner width/height: 1024/697 09:18:49 INFO - PROCESS | 18835 | __metrics 09:18:50 ERROR - PROCESS | 18835 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 09:18:50 INFO - TEST-INFO | 18835: exit 0 09:18:50 INFO - Browser initialized. 09:18:50 INFO - Running cycle 1/1 for kraken test... 09:18:50 INFO - TEST-INFO | started process 18953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptHHZFv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:18:52 INFO - PROCESS | 18953 | 09:18:52 INFO - PROCESS | 18953 | (process:19014): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 09:19:02 INFO - PROCESS | 18953 | RSS: Main: 165449728 09:19:02 INFO - PROCESS | 18953 | 09:19:05 INFO - PROCESS | 18953 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55990/tests/kraken/driver.html?testName=audio-beat-detection) 09:19:06 INFO - PROCESS | 18953 | RSS: Main: 169992192 09:19:06 INFO - PROCESS | 18953 | 09:19:08 INFO - PROCESS | 18953 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55990/tests/kraken/driver.html?testName=audio-dft) 09:19:09 INFO - PROCESS | 18953 | RSS: Main: 172146688 09:19:09 INFO - PROCESS | 18953 | 09:19:12 INFO - PROCESS | 18953 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55990/tests/kraken/driver.html?testName=audio-fft) 09:19:12 INFO - PROCESS | 18953 | RSS: Main: 164057088 09:19:12 INFO - PROCESS | 18953 | 09:19:15 INFO - PROCESS | 18953 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55990/tests/kraken/driver.html?testName=audio-oscillator) 09:19:15 INFO - PROCESS | 18953 | RSS: Main: 164569088 09:19:15 INFO - PROCESS | 18953 | 09:19:18 INFO - PROCESS | 18953 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55990/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:19:18 INFO - PROCESS | 18953 | RSS: Main: 166387712 09:19:18 INFO - PROCESS | 18953 | 09:19:21 INFO - PROCESS | 18953 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55990/tests/kraken/driver.html?testName=imaging-darkroom) 09:19:22 INFO - PROCESS | 18953 | RSS: Main: 166436864 09:19:22 INFO - PROCESS | 18953 | 09:19:25 INFO - PROCESS | 18953 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55990/tests/kraken/driver.html?testName=imaging-desaturate) 09:19:26 INFO - PROCESS | 18953 | RSS: Main: 168656896 09:19:26 INFO - PROCESS | 18953 | 09:19:29 INFO - PROCESS | 18953 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55990/tests/kraken/driver.html?testName=json-parse-financial) 09:19:30 INFO - PROCESS | 18953 | RSS: Main: 169095168 09:19:30 INFO - PROCESS | 18953 | 09:19:31 INFO - PROCESS | 18953 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55990/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:19:32 INFO - PROCESS | 18953 | RSS: Main: 168677376 09:19:32 INFO - PROCESS | 18953 | 09:19:33 INFO - PROCESS | 18953 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55990/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:19:34 INFO - PROCESS | 18953 | RSS: Main: 168914944 09:19:34 INFO - PROCESS | 18953 | 09:19:36 INFO - PROCESS | 18953 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55990/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:19:37 INFO - PROCESS | 18953 | RSS: Main: 169152512 09:19:37 INFO - PROCESS | 18953 | 09:19:40 INFO - PROCESS | 18953 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55990/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:19:40 INFO - PROCESS | 18953 | RSS: Main: 168984576 09:19:40 INFO - PROCESS | 18953 | 09:19:43 INFO - PROCESS | 18953 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55990/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:19:44 INFO - PROCESS | 18953 | RSS: Main: 169000960 09:19:44 INFO - PROCESS | 18953 | 09:19:45 INFO - PROCESS | 18953 | Cycle 1(1): loaded http://localhost:55990/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55990/tests/kraken/driver.html?testName=ai-astar) 09:19:46 INFO - PROCESS | 18953 | RSS: Main: 170749952 09:19:46 INFO - PROCESS | 18953 | 09:19:46 INFO - PROCESS | 18953 | __start_tp_report 09:19:46 INFO - PROCESS | 18953 | _x_x_mozilla_page_load 09:19:46 INFO - PROCESS | 18953 | _x_x_mozilla_page_load_details 09:19:46 INFO - PROCESS | 18953 | |i|pagename|runs| 09:19:46 INFO - PROCESS | 18953 | |0;ai-astar;114;107;112;112;113;125;114;112;113;115 09:19:46 INFO - PROCESS | 18953 | |1;audio-beat-detection;162;131;165;196;134;155;161;133;187;138 09:19:46 INFO - PROCESS | 18953 | |2;audio-dft;162;163;162;161;163;164;167;164;166;165 09:19:46 INFO - PROCESS | 18953 | |3;audio-fft;78;81;80;166;76;76;79;78;168;78 09:19:46 INFO - PROCESS | 18953 | |4;audio-oscillator;93;93;146;94;94;93;152;93;94;153 09:19:46 INFO - PROCESS | 18953 | |5;imaging-gaussian-blur;117;119;117;117;117;117;120;118;117;117 09:19:46 INFO - PROCESS | 18953 | |6;imaging-darkroom;147;147;147;147;146;149;147;146;147;147 09:19:46 INFO - PROCESS | 18953 | |7;imaging-desaturate;95;95;95;95;95;99;95;96;95;96 09:19:46 INFO - PROCESS | 18953 | |8;json-parse-financial;60;67;58;59;60;62;60;79;59;64 09:19:46 INFO - PROCESS | 18953 | |9;json-stringify-tinderbox;64;63;65;64;63;63;63;64;63;64 09:19:46 INFO - PROCESS | 18953 | |10;stanford-crypto-aes;78;79;79;78;82;81;80;81;81;81 09:19:46 INFO - PROCESS | 18953 | |11;stanford-crypto-ccm;130;127;138;125;128;135;122;122;210;128 09:19:46 INFO - PROCESS | 18953 | |12;stanford-crypto-pbkdf2;174;179;172;178;174;175;176;175;171;172 09:19:46 INFO - PROCESS | 18953 | |13;stanford-crypto-sha256-iterative;71;71;78;71;68;69;69;70;73;70 09:19:46 INFO - PROCESS | 18953 | __end_tp_report 09:19:46 INFO - PROCESS | 18953 | __start_cc_report 09:19:46 INFO - PROCESS | 18953 | _x_x_mozilla_cycle_collect,848 09:19:46 INFO - PROCESS | 18953 | __end_cc_report 09:19:46 INFO - PROCESS | 18953 | __startTimestamp1462292386080__endTimestamp 09:19:46 INFO - PROCESS | 18953 | 09:19:46 INFO - PROCESS | 18953 | ------- Summary: start ------- 09:19:46 INFO - PROCESS | 18953 | Number of tests: 14 09:19:46 INFO - PROCESS | 18953 | 09:19:46 INFO - PROCESS | 18953 | [#0] ai-astar Cycles:10 Average:113.70 Median:113.50 stddev:4.52 (4.0%) stddev-sans-first:4.80 09:19:46 INFO - PROCESS | 18953 | Values: 114.0 107.0 112.0 112.0 113.0 125.0 114.0 112.0 113.0 115.0 09:19:46 INFO - PROCESS | 18953 | 09:19:46 INFO - PROCESS | 18953 | [#1] audio-beat-detection Cycles:10 Average:156.20 Median:161.50 stddev:22.77 (14.1%) stddev-sans-first:24.05 09:19:46 INFO - PROCESS | 18953 | Values: 162.0 131.0 165.0 196.0 134.0 155.0 161.0 133.0 187.0 138.0 09:19:46 INFO - PROCESS | 18953 | 09:19:46 INFO - PROCESS | 18953 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:1.89 (1.2%) stddev-sans-first:1.90 09:19:46 INFO - PROCESS | 18953 | Values: 162.0 163.0 162.0 161.0 163.0 164.0 167.0 164.0 166.0 165.0 09:19:46 INFO - PROCESS | 18953 | 09:19:46 INFO - PROCESS | 18953 | [#3] audio-fft Cycles:10 Average:96.00 Median:78.00 stddev:37.46 (48.0%) stddev-sans-first:39.16 09:19:46 INFO - PROCESS | 18953 | Values: 78.0 81.0 80.0 166.0 76.0 76.0 79.0 78.0 168.0 78.0 09:19:46 INFO - PROCESS | 18953 | 09:19:46 INFO - PROCESS | 18953 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:93.00 stddev:27.55 (29.6%) stddev-sans-first:28.48 09:19:46 INFO - PROCESS | 18953 | Values: 93.0 93.0 146.0 94.0 94.0 93.0 152.0 93.0 94.0 153.0 09:19:46 INFO - PROCESS | 18953 | 09:19:46 INFO - PROCESS | 18953 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.00 stddev:1.07 (0.9%) stddev-sans-first:1.12 09:19:46 INFO - PROCESS | 18953 | Values: 117.0 119.0 117.0 117.0 117.0 117.0 120.0 118.0 117.0 117.0 09:19:46 INFO - PROCESS | 18953 | 09:19:46 INFO - PROCESS | 18953 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 09:19:46 INFO - PROCESS | 18953 | Values: 147.0 147.0 147.0 147.0 146.0 149.0 147.0 146.0 147.0 147.0 09:19:46 INFO - PROCESS | 18953 | 09:19:46 INFO - PROCESS | 18953 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.00 stddev:1.26 (1.3%) stddev-sans-first:1.32 09:19:46 INFO - PROCESS | 18953 | Values: 95.0 95.0 95.0 95.0 95.0 99.0 95.0 96.0 95.0 96.0 09:19:46 INFO - PROCESS | 18953 | 09:19:46 INFO - PROCESS | 18953 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:61.00 stddev:6.30 (10.3%) stddev-sans-first:6.60 09:19:46 INFO - PROCESS | 18953 | Values: 60.0 67.0 58.0 59.0 60.0 62.0 60.0 79.0 59.0 64.0 09:19:46 INFO - PROCESS | 18953 | 09:19:46 INFO - PROCESS | 18953 | [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:64.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 09:19:46 INFO - PROCESS | 18953 | Values: 64.0 63.0 65.0 64.0 63.0 63.0 63.0 64.0 63.0 64.0 09:19:46 INFO - PROCESS | 18953 | 09:19:46 INFO - PROCESS | 18953 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:81.00 stddev:1.41 (1.7%) stddev-sans-first:1.30 09:19:46 INFO - PROCESS | 18953 | Values: 78.0 79.0 79.0 78.0 82.0 81.0 80.0 81.0 81.0 81.0 09:19:46 INFO - PROCESS | 18953 | 09:19:46 INFO - PROCESS | 18953 | [#11] stanford-crypto-ccm Cycles:10 Average:136.50 Median:129.00 stddev:26.32 (20.4%) stddev-sans-first:27.82 09:19:46 INFO - PROCESS | 18953 | Values: 130.0 127.0 138.0 125.0 128.0 135.0 122.0 122.0 210.0 128.0 09:19:46 INFO - PROCESS | 18953 | 09:19:46 INFO - PROCESS | 18953 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:175.00 stddev:2.59 (1.5%) stddev-sans-first:2.74 09:19:46 INFO - PROCESS | 18953 | Values: 174.0 179.0 172.0 178.0 174.0 175.0 176.0 175.0 171.0 172.0 09:19:46 INFO - PROCESS | 18953 | 09:19:46 INFO - PROCESS | 18953 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:2.83 (4.0%) stddev-sans-first:3.00 09:19:46 INFO - PROCESS | 18953 | Values: 71.0 71.0 78.0 71.0 68.0 69.0 69.0 70.0 73.0 70.0 09:19:46 INFO - PROCESS | 18953 | -------- Summary: end -------- 09:19:46 INFO - PROCESS | 18953 | 09:19:47 INFO - TEST-INFO | 18953: exit 0 09:19:47 INFO - TEST-OK | kraken | took 62576ms 09:19:47 INFO - SUITE-END | took 1171s 09:19:47 INFO - Completed test suite (00:19:31) 09:19:47 INFO - javascript benchmark 09:19:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.3656550407163, 3211.1329940915966, 3221.5006673965536, 3264.281857991241, 3265.3142840003597, 5240.816571420001, 5311.468853114691, 5318.76065577049, 5324.3610766708, 5427.701476418795, 5261.947380526193, 5449.891002179954, 5460.153676180198, 5501.092319767244, 5560.0, 4922.5569698727195, 4960.727160006199, 4989.0, 5006.474320196382, 5053.898922021557, 525.154457193292, 4862.489438608948, 4882.43851957026, 4929.06347793918, 4940.678855874375, 4893.657443978923, 4905.043516514281, 4921.729304888229, 4925.018315565993, 4968.378952630903, 4826.300186472977, 4942.802287908479, 4989.501049895018, 5012.498750124995, 5055.368078990126, 4841.782119804582, 4873.415190177166, 4877.731724755137, 4932.136876046713, 4996.100701873697, 5191.740412979374, 5227.921581176285, 5235.738213089368, 5236.7119808410525, 5284.550813180885, 5646.096624540054, 5664.20701101846, 5691.032524470808, 5849.502792262663, 5929.881402371929, 5677.772889084473, 5736.627119237236, 5743.994800909824, 5749.137629355589, 5796.362400135981, 5340.893182136374, 5341.786328546892, 5349.117395629716, 5351.7324133793545, 5352.652077614982, 5800.59395842287, 5886.499647529922, 5946.851328716817, 6032.668203248776, 6034.969825150934, 5604.9911016016695, 5613.663180209201, 5622.550195984311, 5626.774929002794, 5651.858703532444, 5695.288088988877, 5696.11710184922, 5697.601167918288, 5698.230738850202, 5701.372848986608, 5619.80330688424, 5732.512736417451, 5767.769289228384, 5786.276715410574, 5812.244408226988, 5592.692401917852, 5709.0865461525955, 5710.628809127394, 5731.0, 5819.359870414251, 4348.717333373321, 4436.401085853433, 4437.290033594674, 4439.489458712224, 4489.977550112294, 3852.499175107218, 3940.231654827281, 3942.4086387042175, 3960.0495880988356, 3967.900802479961, 5436.320459942507, 5470.0, 5523.171524271392, 5533.695646739468, 5539.335279766373, 5786.363500014995, 5817.534597232211, 5847.678377689268, 5854.531637468992, 5869.735861886225, 5333.066713325153, 5570.3315602128005, 5604.159376093618, 5608.775648974077, 5608.887822243532, 4866.0, 4899.6570240083565, 4942.654014219042, 4977.676451030671, 4990.076835785391, 6055.455009049118, 6059.757609695563, 6089.756409743561, 6106.4809491192855, 6117.694115294306, 5651.43485651448, 5741.91387129185, 5922.585419020627, 5927.73325200367, 5946.316173640087, 5963.880722385441, 5993.310769261417, 6030.246219222598, 6061.333253342041, 6064.787732429344, 5540.667559946416, 5583.581231407579, 5588.469095435927, 5594.104943209067, 5617.297837770278, 5538.418466061005, 5643.1535269709875, 5687.146927960674, 5691.658500489983, 5729.1119876419225, 5702.258706368146, 5706.629069110494, 5706.771729130788, 5722.971385143048, 5776.306843178677, 5665.12190610456, 5680.233168522197, 5699.544036476989, 5723.513501352431, 5734.082546792493, 5524.392316845224, 5647.7176141193595, 5662.915056274242, 5677.318721753416, 5739.655620662774, 5569.10894256917, 5714.142878568248, 5720.08478643415, 5732.942670573408, 5753.280839895013, 5635.408282130317, 5660.207570940154, 5662.150677398258, 5666.688332141772, 5671.602987790815], "value": 5300.111584353765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.9913001304978, 593.8307582339035, 654.4829584628144, 658.8715200535895, 664.4916638771339, 36126.458103128476, 37484.0, 37581.812090939544, 37671.434928476025, 37689.246215075684, 39694.0, 40102.59897401025, 40482.59517404825, 40527.39208911861, 40574.797126014404, 8252.752417427457, 8439.789005274855, 8466.872996905051, 8466.915330846705, 8475.618597163142, 8473.406861519696, 8510.829783404328, 8585.441946273504, 8750.299976001905, 8785.560721963877, 8730.126987301282, 8847.646094156225, 8901.465912045265, 8908.331875109361, 8911.955440222822, 8682.392232543725, 8798.912010879938, 8801.163889430525, 8808.207261346446, 8835.204831565157, 8602.483850968962, 8649.48103113809, 8714.738557843275, 8715.215630593213, 8717.782055448664, 41416.58583414157, 41439.585604143875, 41667.7916610418, 41759.58240417617, 41852.372214416806, 3308.0902751743224, 3355.328934213143, 4015.538213105501, 4178.707490475668, 4221.324588065895, 31927.52108718371, 32172.678273217436, 32540.18649533757, 32554.837225813957, 32678.509822352684, 4316.82732690692, 4350.71720338177, 4401.5378385269405, 4409.360642706822, 4496.2805951048, 286494.0, 289922.9999999979, 291066.7146628286, 291924.0, 292061.0, 59049.40950590439, 59305.40694593085, 59697.40302597005, 59719.40280597138, 59967.70016149891, 55280.44719552834, 55925.72037139788, 56270.43729562734, 56326.71836640873, 56562.43437565654, 14108.858911410754, 14252.358643860844, 14319.0, 14361.281935903164, 14393.92803035978, 10603.469826508644, 10621.787564248827, 10671.413072281099, 10693.251472397013, 10708.571657133627, 18901.43295701131, 19095.61808763817, 19103.140358683893, 19222.8077719221, 19972.400827975183, 7322.487425880137, 7498.475106742476, 7584.4311676624475, 7592.81017974555, 7599.810004749926, 1008.5814387029301, 1041.3127335958231, 1087.9782404351868, 1131.9434028298551, 1158.7219067423757, 31775.84112079471, 31818.363632727214, 31833.789326276416, 31949.361012779613, 32498.512522312183, 1103.713034610991, 1109.0960866893456, 1158.0816342816056, 1213.3205404973244, 1242.8011518157052, 14996.850031499545, 14997.625059373384, 15055.171965542, 15382.846171538366, 15391.923040384727, 479799.0, 490735.0, 493595.0, 493684.0, 499089.0, 56662.71668641713, 57708.71145644245, 57762.422375775706, 57768.0, 57795.71102144462, 1340.604521666111, 1369.657585603599, 1404.3048690898072, 1412.032757561074, 1421.5522110535148, 30168.09495715132, 30370.0, 30719.385612288075, 30932.381352373275, 31034.689653104084, 48229.276560850914, 49180.75409622929, 49307.75346123247, 49362.506374935794, 49378.75310623424, 437666.0, 439221.0, 439770.0, 441236.0, 442517.0, 26377.736222637526, 26674.3995360279, 37921.4311785329, 39024.2926921942, 39048.6095139045, 43543.12913741644, 45273.54726452693, 46442.30336545022, 47044.7647761759, 47739.76130119327, 38711.6128838708, 38805.6119438802, 39142.412863806494, 39555.0, 39930.2013959725, 38953.41569876397, 39549.80225098856, 40030.59969400269, 40075.39886901757, 40713.59286407217, 37914.43128353022, 39503.20993580055, 39509.40735889022, 39906.60093399029, 40390.59609403869, 34403.483947741304, 34867.65132348746, 35341.29317413586, 35682.28635427225, 36115.638843611225, 27255.727442725318, 27288.0, 27405.31486712848, 27483.45033099287, 27617.74028502291], "value": 19602.86484790317, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.372733807204, 382.74164938666394, 388.7065265724378, 389.54034239597274, 403.59841957252536, 16934.661306773858, 18559.536011599685, 18770.718439223423, 18849.905750471262, 18885.62228755426, 17709.91145044273, 18443.631127377444, 18504.907475462605, 18772.53068673284, 18781.43655690328, 5566.86082847929, 5647.322321321447, 5770.2210201622875, 5795.82612521625, 5811.447912448331, 5495.313085864267, 5607.0, 5615.073512870372, 5691.886162276752, 5694.117411801178, 4980.800767969277, 5626.268585083933, 5627.634203776762, 5647.09646456567, 5651.745671444774, 5188.273641690166, 5215.452377500384, 5229.137192363255, 5256.159014557691, 5274.894502109955, 4992.600591952635, 5240.187770895517, 5247.47525247476, 5265.262863199156, 5276.947230527722, 12228.755424891542, 12358.876411235862, 12503.187292826027, 17208.311667533282, 22055.66916496254, 2015.899205039757, 2182.3562049195525, 2279.3845661671257, 2445.6698345723457, 2538.0, 9282.257419406498, 9425.670101546482, 9430.575624096931, 9448.858267126, 9626.75933101671, 1885.424945391655, 1968.0258272155374, 2003.8797672139572, 2010.7184994100837, 2058.0635810706094, 57680.71159644217, 67774.32225677778, 69299.0, 73966.0, 78037.60981195058, 9924.603015879284, 10201.540930658139, 10277.280590358752, 10515.737106572244, 10748.570057197625, 14772.335244914004, 15029.624259393602, 15038.097714137186, 15041.398344066334, 15051.247437628075, 7295.89056164158, 7370.96314518424, 7394.0, 7407.518511296748, 7507.399408047343, 6786.321367863175, 6861.55399899005, 6863.10779598659, 6947.791566252919, 6954.582725036514, 4443.400140980926, 4471.7987690554, 4500.074951281693, 4513.616342610849, 4548.385967894358, 1925.740025096622, 1959.8628096033142, 1960.0591715976127, 1961.264525802824, 2006.9899650501654, 961.7018724195522, 963.3208587945481, 1021.2606092961308, 1052.5105825791045, 1118.6140781430393, 17395.47813565595, 17774.46676599704, 18149.0, 18203.817961820478, 18705.158267877978, 955.8016264524553, 955.9952200239094, 960.6061514778908, 987.8271302522173, 1011.3830563356347, 10057.094861462503, 10248.436336001592, 10285.845712314322, 10301.793964120676, 10337.63818266372, 431251.0, 441990.0, 443848.0, 445176.0, 445339.0, 89204.10795892088, 95461.0, 95982.0, 96336.0, 96531.51734241284, 1056.6460235820932, 1078.3853203673987, 1085.3759088523973, 1096.5668560918393, 1103.862017247844, 16510.587235319214, 16520.42178523794, 16802.159892005107, 16826.0, 16951.406700765416, 37695.0, 37904.620953791215, 38387.0, 38588.6141138585, 39025.804870975466, 54392.0, 54417.0, 54820.0, 55203.723981381445, 55657.44342556522, 7495.362894154058, 7919.0893047298, 8021.157778433414, 8074.555899425353, 8414.579271036546, 8601.956990215009, 9666.468344241135, 12135.08986825974, 13341.19952802835, 13593.52422665202, 11036.392998385167, 11107.555697772323, 11507.194496385508, 11538.365389903636, 11548.94225528867, 10185.388876667424, 10286.588536458457, 10918.454077296263, 10984.835227471754, 11150.609728659458, 11682.824757628812, 11683.299002059903, 11985.28088314704, 12098.153129280865, 12132.332721700039, 8077.555734434663, 8096.83806323882, 8238.299744521782, 8293.170682931659, 8314.6674133034, 10986.285891417032, 11692.649220523397, 11744.823827642422, 11755.764884702428, 11787.174897757417], "value": 8728.57831496972, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1475.741745194591, 1521.650020495286, 1647.9588010299742, 1744.7557341972133, 1782.5632719983605, 7144.85710285794, 8013.839723205532, 8060.7984800379945, 8333.208345207204, 8342.374321925858, 8125.0656174539945, 8180.754577362689, 8215.83568328633, 8241.79395515111, 8255.0, 2261.954760904781, 2296.207808306132, 2299.7585253548305, 2300.424893776556, 2306.976930230693, 2260.0959616153505, 2260.5930932432157, 2282.589133955887, 2286.1084177170915, 2289.3933107726466, 2263.4454558633156, 2274.442761523429, 2282.3267136194863, 2312.491251924574, 2314.872682002489, 2197.703310053146, 2205.911763529473, 2208.0, 2208.7791220877943, 2213.7675544067883, 2227.532218234173, 2231.040652519416, 2246.786555277246, 2255.2106762632948, 2271.840971132005, 8315.542645154514, 8334.749957501284, 8356.791080222982, 8389.790255243606, 8406.369522285853, 5007.949920500785, 5133.486651334874, 5157.638965272433, 5167.689938603696, 5170.1727723564045, 3201.183698156978, 3264.9020529384156, 3388.847791750792, 3400.574928133983, 3409.6931276185014, 1155.8092914669069, 1164.6797130789016, 1180.557291015869, 1183.9230450020807, 1187.2223693480785, 11160.218784685076, 11207.551697932073, 11260.324380537195, 11314.264572802742, 11326.773464530746, 4308.246056940023, 4441.200583894865, 4469.329600559942, 4679.602233810164, 4692.1084993851055, 8916.0, 8923.643054277756, 9017.278617710568, 9026.954865225633, 9059.728208153765, 5073.670211436245, 5076.010178015325, 5082.949170508322, 5094.949050509522, 5113.360829896263, 4044.2922488564973, 4624.329472226508, 4631.490536041033, 4774.976125119352, 4784.234522476387, 3616.1863580694135, 3631.4371272452813, 3716.554013518395, 3719.6094410087094, 3745.700343972476, 1085.8751243606928, 1086.9673909782719, 1093.1691914145306, 1103.757173421846, 1112.0714203639889, 848.9448185868023, 1026.3687831983277, 1042.4214560918763, 1050.5272627317738, 1069.540097757956, 5880.7353669085, 5932.3474417814, 6037.366076561898, 6086.391360863879, 6137.693115344304, 989.9059589339001, 995.7809281957958, 1016.4968340671415, 1029.1920842139034, 1055.4775386183887, 4008.659263962596, 4076.7553946763287, 4164.083901541656, 4169.478815148106, 4224.345226489899, 10168.847467287997, 10482.213833962483, 10547.736306592396, 10618.68143955667, 10622.628208012682, 10407.21945854064, 10428.217883658755, 10488.31825931312, 10490.527926243338, 10495.160387169008, 7865.685372585147, 8008.319292860056, 8072.556009419538, 8078.23256790604, 8085.676572937016, 5842.7078646066675, 5927.585069045125, 5954.136650185786, 5993.820185394271, 6152.0156774915795, 9230.584623692084, 9772.413655180711, 9816.65641702537, 9853.802923941337, 9868.950655246677, 9425.0, 9425.293103017439, 9541.284403669613, 9612.086851749073, 9614.567344469377, 6599.340065993362, 7057.7176912922905, 7313.049303590499, 7333.6333183341685, 7513.023306970277, 8084.63619137152, 8127.187281271826, 8127.552984585905, 8153.306968907709, 8178.836423271382, 7270.127584689871, 7455.0, 7494.288042635941, 7537.54774713519, 7583.734569290048, 7219.953106799379, 7237.782866514013, 7279.563226206445, 7299.890501642586, 7315.15875674283, 6690.69891854858, 6834.2482326943, 6854.6229957352825, 6883.27725588806, 6917.584944903322, 4989.401271847257, 5083.87290317745, 5221.869453263699, 5235.476452354734, 5263.23683065961, 5141.203113517411, 5173.22401639757, 5246.055709972242, 5330.680159190306, 5340.359156901197], "value": 4501.546016233296, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.90017644441997, 319.58294425774363, 327.0564421643558, 327.7083395777757, 328.7008821972006, 5367.704776237305, 5411.729413529318, 5435.537979271761, 5578.721063946801, 5633.943660563393, 5449.972750136244, 5479.561635069195, 5506.669599824003, 5508.256385387971, 5537.418571050042, 4193.622573968342, 4207.600277973595, 4219.797357753041, 4252.744835309876, 4259.574042595731, 4161.0, 4249.723767955073, 4252.766097864616, 4263.637590804769, 4296.634786043174, 4226.936595951048, 4239.173361194568, 4243.8090285937205, 4265.232258193524, 4275.486941567001, 4273.551277115905, 4278.893027674333, 4279.443672322578, 4289.935650965238, 4306.806193721259, 3721.6836568891677, 3778.0, 3789.8484060637543, 3804.733668643196, 3818.5608655004753, 5342.679439233659, 5343.385510666284, 5344.770702738353, 5353.223782551547, 5362.597805164628, 4885.8778530536665, 4896.387951506062, 4910.1898186799135, 4927.260910863399, 4931.827386041471, 5553.583481238923, 5713.942860571383, 5774.595778295521, 5820.156077368758, 5834.824955251349, 4128.6284234418745, 4144.8134833932545, 4150.91698166038, 4152.397902304179, 4153.1486045360625, 5989.951758442256, 6006.729697163638, 6038.275406951194, 6044.274687037584, 6046.455818976269, 4109.589041095866, 4253.723507972034, 4259.829606815692, 4260.765657888845, 4265.91468170641, 4325.956740432618, 4339.5443478434945, 4347.065380943112, 4357.433533640607, 4364.214441400578, 4877.0, 4909.355365952374, 4912.754362281871, 4934.605231581465, 4938.629602779806, 5731.369549349568, 5823.126531020296, 5849.4206564227425, 5876.382979787147, 5892.528597712173, 1553.0526378908858, 1560.095144816004, 1560.7034663414142, 1564.5853848730096, 1570.4974408189269, 1037.9325343852777, 1051.8264486359665, 1054.2093429927554, 1060.528065011078, 1066.648006157966, 5899.439553242435, 5947.107933809876, 5953.493953014043, 5997.550183736237, 6018.15745795589, 6334.714937827809, 6355.237371515448, 6362.681865906686, 6419.45434638061, 6435.581687190318, 5814.418558144152, 5985.22192115031, 6033.276006879202, 6050.42520960508, 6068.150458935753, 3429.725621950288, 3446.138465383654, 3471.7916924984584, 3472.4791281308007, 3481.2515309208134, 6572.835679107965, 6679.833004174934, 6724.899126513106, 6728.259891411941, 6775.1869775626255, 6526.053722210253, 6528.967355163194, 6538.953767397289, 6546.541742078009, 6598.505112116611, 6397.616143031433, 6645.501587380869, 6682.0311054896765, 6723.562968407038, 6733.259341472434, 6395.616263024233, 6428.839279018062, 6443.226812782309, 6456.967715161394, 6475.740970361321, 6216.010846730308, 6339.936600633934, 6357.554971151975, 6395.840103997251, 6403.807885763435, 6590.978398348264, 6598.10925525048, 6604.5046621502615, 6636.767713130017, 6652.933470665232, 3973.821178047053, 4042.4946881639794, 4165.604267594574, 4190.287651099259, 4214.0, 5908.527317814479, 5947.1563815215695, 5953.196318496947, 5968.671723055274, 5990.31111422192, 5660.943390566042, 5672.319321681424, 5763.971180144073, 5793.826185214451, 5826.970865145647, 5715.31416230055, 5720.685362305113, 5720.713964301852, 5736.4550367715, 5755.625884317506, 5540.63985840919, 5602.4957753802355, 5682.147677848356, 5691.658500489983, 5701.116326969326, 5618.719064046863, 5712.914306285326, 5714.742836572281, 5834.994977586462, 5848.210491583582, 5690.9430905690415, 5716.714164291686, 5750.539956803362, 5758.8848223034465, 5776.306843178845], "value": 4514.714663174293, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.9351158395743, 736.778966310107, 750.6997201119551, 772.3435080181846, 781.4178437064388, 14168.433262669494, 14638.34127464264, 14655.853441465582, 14656.193909334996, 14681.632959176026, 13474.326283685825, 13504.527341543047, 13513.189208647487, 13523.526676566322, 13584.728305433886, 650.1320736816344, 759.2331744937597, 801.9358451323909, 801.9518828870257, 806.0247101007787, 788.1842293226512, 788.4677842456348, 791.5092642561619, 796.6972550430828, 800.4796882026671, 854.7563944275882, 855.1533981358441, 855.5123579559654, 856.7301300090483, 861.3453775130884, 854.8674955381864, 856.7601071699903, 858.9098144694842, 859.707699382213, 862.3963225741975, 616.315889362807, 620.2247191011236, 623.18985319085, 623.5105442227874, 625.2840497630187, 13632.318384080856, 13681.31593420325, 13692.931535342359, 13694.452221911211, 13708.24604646744, 13344.532941347006, 13559.796603050961, 13586.456541738418, 13591.592252232449, 13607.183568985893, 11789.23369980957, 11821.645350639408, 11866.52533898643, 11880.40597970098, 11970.521179152824, 3863.265979463893, 3900.4539364488996, 3922.3135951208424, 3926.7840268785208, 3943.5464921533817, 49918.0, 49938.50061499375, 50578.7471062646, 50742.74628626833, 51041.74479127581, 10234.744131396626, 10934.289271197347, 11192.608258710907, 11194.328340299608, 11543.36511491876, 18201.08994550267, 19986.70019949702, 20013.799862001484, 20031.899840500995, 20065.29771458021, 7859.806633263729, 7876.527408355517, 7906.248906353887, 7923.801904952422, 7927.603619819101, 4294.205571969195, 4349.927501208328, 4351.69538132334, 4360.389545463638, 4493.483249426358, 3345.832708364572, 3388.6950174484414, 3416.641252668484, 3419.9487007694906, 3462.23830757233, 613.1967123068794, 620.2928661326092, 625.5339771869986, 630.5365556316104, 631.333942690466, 682.0008687273169, 721.8989341492195, 742.4468770765706, 746.58191412809, 749.4716225061319, 7590.316871481593, 7805.492642978302, 7877.645505952131, 7946.6424010919645, 8002.159773223844, 584.8859472402926, 609.960352577081, 753.8492301539713, 759.7644730133676, 777.4752042371376, 4557.817687292471, 4574.359589657451, 4636.79134438951, 4652.371929789503, 4748.905021899543, 63598.36401635924, 64036.0, 64314.0, 64806.351936480976, 64888.675556621914, 53925.0, 54436.0, 55430.16854747101, 55651.72174139184, 56583.71708141433, 51264.99999999925, 51285.743571281906, 51488.0, 51873.48126518686, 52236.0, 8284.171582841667, 8290.419670622998, 8410.579471026547, 8539.188777066169, 8658.56707164652, 29803.85098074496, 29996.250093747833, 30968.916087936814, 30975.690243098183, 32321.35357292888, 45470.31794523151, 45508.54491455043, 45611.31583026191, 45877.31184032309, 46776.532234677215, 11735.47190376418, 11747.823782643438, 11752.177347585586, 11954.641360759191, 12061.577844775391, 13147.14543554666, 13279.203247804777, 13860.376283067488, 14276.64308392257, 14453.205073721047, 12983.480660773463, 13335.199888006751, 13339.866601333862, 14023.158610483404, 14025.088369255966, 11545.050525113722, 11605.76788464243, 11711.130092767246, 11734.52870128253, 12242.938785306016, 11014.284071535325, 13236.205827650372, 13401.061925665499, 13551.932240338736, 13800.516981905585, 11328.886711132784, 11417.200795944203, 11453.656390308304, 11645.0, 11727.706807329885, 11458.82811757841, 11488.368139752394, 11547.711307217387, 11610.129240306842, 11734.589289374831], "value": 6690.323312056472, "unit": "score"}], "name": "dromaeo_css", "value": 7055.127662841196, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 107.0, 112.0, 112.0, 113.0, 125.0, 114.0, 112.0, 113.0, 115.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 131.0, 165.0, 196.0, 134.0, 155.0, 161.0, 133.0, 187.0, 138.0], "value": 156.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 163.0, 164.0, 167.0, 164.0, 166.0, 165.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 80.0, 166.0, 76.0, 76.0, 79.0, 78.0, 168.0, 78.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 146.0, 94.0, 94.0, 93.0, 152.0, 93.0, 94.0, 153.0], "value": 110.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 117.0, 117.0, 117.0, 120.0, 118.0, 117.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 149.0, 147.0, 146.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 99.0, 95.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 67.0, 58.0, 59.0, 60.0, 62.0, 60.0, 79.0, 59.0, 64.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 64.0, 63.0, 63.0, 63.0, 64.0, 63.0, 64.0], "value": 63.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 78.0, 82.0, 81.0, 80.0, 81.0, 81.0, 81.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 127.0, 138.0, 125.0, 128.0, 135.0, 122.0, 122.0, 210.0, 128.0], "value": 136.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 179.0, 172.0, 178.0, 174.0, 175.0, 176.0, 175.0, 171.0, 172.0], "value": 174.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 78.0, 71.0, 68.0, 69.0, 69.0, 70.0, 73.0, 70.0], "value": 71.0, "unit": "score"}], "name": "kraken", "value": 1588.7999999999997, "alertThreshold": 2.0}]} 09:19:47 INFO - Return code: 0 09:19:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:19:47 ERROR - # TBPL SUCCESS # 09:19:47 INFO - Running post-action listener: _resource_record_post_action 09:19:47 INFO - Running post-run listener: _resource_record_post_run 09:19:48 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 359251968; Read time: 64; Write time: 365128 09:19:48 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 73977856; Read time: 0; Write time: 90756 09:19:48 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 8192; Write bytes: 285274112; Read time: 64; Write time: 274372 09:19:48 INFO - Running post-run listener: _upload_blobber_files 09:19:48 INFO - Blob upload gear active. 09:19:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:19:48 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 09:19:48 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:19:48 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:19:48 INFO - (blobuploader) - INFO - Open directory for files ... 09:19:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:19:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:19:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:49 INFO - (blobuploader) - INFO - Done attempting. 09:19:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:19:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:19:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:50 INFO - (blobuploader) - INFO - Done attempting. 09:19:50 INFO - (blobuploader) - INFO - Iteration through files over. 09:19:50 INFO - Return code: 0 09:19:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:19:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:19:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05550345d1d212e9872fdcbe795b4ff75d04ad355cf5536ebfb491b4a479ae950dbdc062b6ec83e72030d39dbe4341c4f0f140c7eb27e39270e2bab0884b6040", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/239338b7e93628b06af15f897149cca3ce6714ba1f24f44e1f01bc4aae094e87dd3f41e1bc8a199962351d6cb6ec087e91f253afb4881b6a98a971fcc5a3adbf"} 09:19:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:19:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:19:50 INFO - Contents: 09:19:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/05550345d1d212e9872fdcbe795b4ff75d04ad355cf5536ebfb491b4a479ae950dbdc062b6ec83e72030d39dbe4341c4f0f140c7eb27e39270e2bab0884b6040", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/239338b7e93628b06af15f897149cca3ce6714ba1f24f44e1f01bc4aae094e87dd3f41e1bc8a199962351d6cb6ec087e91f253afb4881b6a98a971fcc5a3adbf"} 09:19:50 INFO - Running post-run listener: copy_logs_to_upload_dir 09:19:50 INFO - Copying logs to upload dir... 09:19:50 INFO - mkdir: /builds/slave/test/build/upload/logs 09:19:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2128.083094 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 35 mins, 28 secs) (at 2016-05-03 09:19:49.607098) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-03 09:19:49.611167) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772 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/sha512/05550345d1d212e9872fdcbe795b4ff75d04ad355cf5536ebfb491b4a479ae950dbdc062b6ec83e72030d39dbe4341c4f0f140c7eb27e39270e2bab0884b6040", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/239338b7e93628b06af15f897149cca3ce6714ba1f24f44e1f01bc4aae094e87dd3f41e1bc8a199962351d6cb6ec087e91f253afb4881b6a98a971fcc5a3adbf"} build_url:https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011248 build_url: 'https://queue.taskcluster.net/v1/task/WgHVTbHkTHenwgTtRuhu3g/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/sha512/05550345d1d212e9872fdcbe795b4ff75d04ad355cf5536ebfb491b4a479ae950dbdc062b6ec83e72030d39dbe4341c4f0f140c7eb27e39270e2bab0884b6040", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/239338b7e93628b06af15f897149cca3ce6714ba1f24f44e1f01bc4aae094e87dd3f41e1bc8a199962351d6cb6ec087e91f253afb4881b6a98a971fcc5a3adbf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-03 09:19:49.635714) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 09:19:49.636052) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1462290257.742512-974541772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-03 09:19:49.718231) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-03 09:19:49.718555) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-03 09:19:49.718845) ========= ========= Total master_lag: 0.15 =========