builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1474377158.29 results: success (0) buildid: 20160920030916 builduid: b224d07f38a842c0a40c375b6d8fbf2b revision: 71b46b28322579a29a9569d494852ffe28ce418a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-20 06:12:38.295231) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-20 06:12:38.296017) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-20 06:12:38.296356) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-20 06:12:38.308329) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 06:12:38.308630) ========= 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=41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-20 06:12:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-09-20 06:12:38 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097756 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 06:12:38.419787) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 06:12:38.420153) ========= 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=41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018469 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 06:12:38.471109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-20 06:12:38.471497) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 71b46b28322579a29a9569d494852ffe28ce418a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 71b46b28322579a29a9569d494852ffe28ce418a --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=41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-20 06:12:38,798 truncating revision to first 12 chars 2016-09-20 06:12:38,798 Setting DEBUG logging. 2016-09-20 06:12:38,798 attempt 1/10 2016-09-20 06:12:38,798 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/71b46b283225?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-20 06:12:39,818 unpacking tar archive at: mozilla-beta-71b46b283225/testing/mozharness/ program finished with exit code 0 elapsedTime=1.333910 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-20 06:12:39.819074) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-20 06:12:39.819427) ========= script_repo_revision: 71b46b28322579a29a9569d494852ffe28ce418a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-20 06:12:39.819843) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-20 06:12:39.820120) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-20 06:12:39.829855) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 55 secs) (at 2016-09-20 06:12:39.830489) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:12:40 INFO - MultiFileLogger online at 20160920 06:12:40 in /builds/slave/test 06:12:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:12:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:12:40 INFO - {'append_to_log': False, 06:12:40 INFO - 'base_work_dir': '/builds/slave/test', 06:12:40 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:12:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:12:40 INFO - 'branch': 'Mozilla-Beta', 06:12:40 INFO - 'buildbot_json_path': 'buildprops.json', 06:12:40 INFO - 'config_files': ('talos/linux_config.py',), 06:12:40 INFO - 'default_actions': ('clobber', 06:12:40 INFO - 'read-buildbot-config', 06:12:40 INFO - 'download-and-extract', 06:12:40 INFO - 'populate-webroot', 06:12:40 INFO - 'create-virtualenv', 06:12:40 INFO - 'install', 06:12:40 INFO - 'run-tests'), 06:12:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:12:40 INFO - 'download_minidump_stackwalk': True, 06:12:40 INFO - 'download_symbols': 'ondemand', 06:12:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:12:40 INFO - 'tooltool.py': '/tools/tooltool.py', 06:12:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:12:40 INFO - '/tools/misc-python/virtualenv.py')}, 06:12:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:12:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:12:40 INFO - 'installer_path': 'installer.exe', 06:12:40 INFO - 'log_level': 'info', 06:12:40 INFO - 'log_name': 'talos', 06:12:40 INFO - 'log_to_console': True, 06:12:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:12:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:12:40 INFO - 'opt_config_files': (), 06:12:40 INFO - 'pip_index': False, 06:12:40 INFO - 'sps_profile': False, 06:12:40 INFO - 'sps_profile_interval': 0, 06:12:40 INFO - 'suite': 'dromaeojs', 06:12:40 INFO - 'system_bits': '32', 06:12:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:12:40 INFO - 'title': 'talos-linux64-ix-024', 06:12:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:12:40 INFO - 'use_talos_json': True, 06:12:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:12:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:12:40 INFO - 'work_dir': 'build'} 06:12:40 INFO - [mozharness: 2016-09-20 13:12:40.253510Z] Running clobber step. 06:12:40 INFO - Running pre-action listener: _resource_record_pre_action 06:12:40 INFO - Running main action method: clobber 06:12:40 INFO - rmtree: /builds/slave/test/build 06:12:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:12:40 INFO - Running post-action listener: _resource_record_post_action 06:12:40 INFO - [mozharness: 2016-09-20 13:12:40.715922Z] Finished clobber step (success) 06:12:40 INFO - [mozharness: 2016-09-20 13:12:40.716023Z] Running read-buildbot-config step. 06:12:40 INFO - Running pre-action listener: _resource_record_pre_action 06:12:40 INFO - Running main action method: read_buildbot_config 06:12:40 INFO - Using buildbot properties: 06:12:40 INFO - { 06:12:40 INFO - "project": "", 06:12:40 INFO - "product": "firefox", 06:12:40 INFO - "script_repo_revision": "production", 06:12:40 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 06:12:40 INFO - "repository": "", 06:12:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 06:12:40 INFO - "buildid": "20160920030916", 06:12:40 INFO - "pgo_build": "True", 06:12:40 INFO - "basedir": "/builds/slave/test", 06:12:40 INFO - "buildnumber": 161, 06:12:40 INFO - "slavename": "talos-linux64-ix-024", 06:12:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:12:40 INFO - "platform": "ubuntu64_hw", 06:12:40 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:12:40 INFO - "branch": "mozilla-beta", 06:12:40 INFO - "repo_path": "releases/mozilla-beta", 06:12:40 INFO - "revision": "71b46b28322579a29a9569d494852ffe28ce418a", 06:12:40 INFO - "stage_platform": "linux64-pgo", 06:12:40 INFO - "builduid": "b224d07f38a842c0a40c375b6d8fbf2b", 06:12:40 INFO - "slavebuilddir": "test" 06:12:40 INFO - } 06:12:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 06:12:40 INFO - Running post-action listener: _resource_record_post_action 06:12:40 INFO - [mozharness: 2016-09-20 13:12:40.718570Z] Finished read-buildbot-config step (success) 06:12:40 INFO - [mozharness: 2016-09-20 13:12:40.718660Z] Running download-and-extract step. 06:12:40 INFO - Running pre-action listener: _resource_record_pre_action 06:12:40 INFO - Running main action method: download_and_extract 06:12:40 INFO - mkdir: /builds/slave/test/build/tests 06:12: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')]} 06:12:40 INFO - https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:12:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:12:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:12:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:12:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:12:40 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:12:40 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:12:40 INFO - retry: Failed, sleeping 30 seconds before retrying 06:13:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #2 06:13:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:13:10 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:13:10 INFO - retry: Failed, sleeping 60 seconds before retrying 06:14:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #3 06:14:10 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:14:10 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:14:10 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json! 06:14:10 INFO - Caught exception: HTTP Error 404: Not Found 06:14:10 INFO - Caught exception: HTTP Error 404: Not Found 06:14:10 INFO - Caught exception: HTTP Error 404: Not Found 06:14:10 INFO - trying https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:14:10 INFO - Downloading https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:14:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:14:11 INFO - Downloaded 1327 bytes. 06:14:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 06:14:11 INFO - Using the following test package requirements: 06:14:11 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 06:14:11 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:14:11 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:14:11 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:14:11 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 06:14:11 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:14:11 INFO - u'jsshell-linux-x86_64.zip'], 06:14:11 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:14:11 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:14:11 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 06:14:11 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:14:11 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 06:14:11 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:14:11 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 06:14:11 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:14:11 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:14:11 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 06:14:11 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:14:11 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:14:11 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')]} 06:14:11 INFO - https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:14:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:14:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:14:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:14:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:14:11 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:14:11 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:14:11 INFO - retry: Failed, sleeping 30 seconds before retrying 06:14:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 06:14:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:14:41 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:14:41 INFO - retry: Failed, sleeping 60 seconds before retrying 06:15:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 06:15:41 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:15:41 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:15:41 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 06:15:41 INFO - Caught exception: HTTP Error 404: Not Found 06:15:41 INFO - Caught exception: HTTP Error 404: Not Found 06:15:41 INFO - Caught exception: HTTP Error 404: Not Found 06:15:41 INFO - trying https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:15:41 INFO - Downloading https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:15:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:15:42 INFO - Downloaded 21771538 bytes. 06:15:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:15:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:15:43 INFO - Return code: 0 06:15:43 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:15:43 INFO - https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:15:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:15:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:15:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:15:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:15:43 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:15:43 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:15:43 INFO - retry: Failed, sleeping 30 seconds before retrying 06:16:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #2 06:16:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:16:13 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:16:13 INFO - retry: Failed, sleeping 60 seconds before retrying 06:17:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #3 06:17:13 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:17:13 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:17:13 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip! 06:17:13 INFO - Caught exception: HTTP Error 404: Not Found 06:17:13 INFO - Caught exception: HTTP Error 404: Not Found 06:17:13 INFO - Caught exception: HTTP Error 404: Not Found 06:17:13 INFO - trying https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:17:13 INFO - Downloading https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 06:17:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:17:14 INFO - Downloaded 21771538 bytes. 06:17:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:17:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:17:16 INFO - Return code: 0 06:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:17:16 INFO - https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:17:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:17:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:17:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:17:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:17:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:17:16 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:17:16 INFO - retry: Failed, sleeping 30 seconds before retrying 06:17:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 06:17:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:17:46 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:17:46 INFO - retry: Failed, sleeping 60 seconds before retrying 06:18:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 06:18:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:18:46 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:18:46 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip! 06:18:46 INFO - Caught exception: HTTP Error 404: Not Found 06:18:46 INFO - Caught exception: HTTP Error 404: Not Found 06:18:46 INFO - Caught exception: HTTP Error 404: Not Found 06:18:46 INFO - trying https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:18:46 INFO - Downloading https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 06:18:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:18:47 INFO - Downloaded 14413740 bytes. 06:18:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:18:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:18:47 INFO - Return code: 0 06:18: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')]} 06:18:47 INFO - https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:18:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:18:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:18:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:18:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:18:47 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:18:47 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 06:18:47 INFO - retry: Failed, sleeping 30 seconds before retrying 06:19:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #2 06:19:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:19:17 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 06:19:17 INFO - retry: Failed, sleeping 60 seconds before retrying 06:20:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #3 06:20:17 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:20:17 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 06:20:17 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2! 06:20:17 INFO - Caught exception: HTTP Error 404: Not Found 06:20:17 INFO - Caught exception: HTTP Error 404: Not Found 06:20:17 INFO - Caught exception: HTTP Error 404: Not Found 06:20:17 INFO - trying https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:20:17 INFO - Downloading https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:20:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:20:18 INFO - Downloaded 56777353 bytes. 06:20:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:20:18 INFO - mkdir: /builds/slave/test/properties 06:20:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:20:18 INFO - Writing to file /builds/slave/test/properties/build_url 06:20:18 INFO - Contents: 06:20:18 INFO - build_url:https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 06:20:19 INFO - Running post-action listener: _resource_record_post_action 06:20:19 INFO - Running post-action listener: set_extra_try_arguments 06:20:19 INFO - [mozharness: 2016-09-20 13:20:19.421349Z] Finished download-and-extract step (success) 06:20:19 INFO - [mozharness: 2016-09-20 13:20:19.421589Z] Running populate-webroot step. 06:20:19 INFO - Running pre-action listener: _resource_record_pre_action 06:20:19 INFO - Running main action method: populate_webroot 06:20:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:20:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:20:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:20:19 INFO - '--tppagecycles', 06:20:19 INFO - '7'], 06:20:19 INFO - 'tests': ['tsvgm']}}, 06:20:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:20:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:20:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:20:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:20:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:20:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:20:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:19 INFO - 'talos_options': ['--disable-e10s'], 06:20:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:20:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:20:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:19 INFO - 'talos_options': ['--disable-e10s'], 06:20:19 INFO - 'tests': ['damp', 'tps']}, 06:20:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:19 INFO - 'tests': ['damp', 'tps']}, 06:20:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:20:19 INFO - 'tests': ['dromaeo_dom']}, 06:20:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:20:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:20:19 INFO - 'tests': ['basic_compositor_video']}, 06:20:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:20:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:20:19 INFO - 'tests': ['a11yr', 06:20:19 INFO - 'ts_paint', 06:20:19 INFO - 'tpaint', 06:20:19 INFO - 'sessionrestore', 06:20:19 INFO - 'sessionrestore_no_auto_restore', 06:20:19 INFO - 'tabpaint']}, 06:20:19 INFO - 'other-e10s': {'tests': ['a11yr', 06:20:19 INFO - 'ts_paint', 06:20:19 INFO - 'tpaint', 06:20:19 INFO - 'sessionrestore', 06:20:19 INFO - 'sessionrestore_no_auto_restore', 06:20:19 INFO - 'tabpaint']}, 06:20:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:20:19 INFO - 'ts_paint', 06:20:19 INFO - 'tpaint', 06:20:19 INFO - 'sessionrestore', 06:20:19 INFO - 'sessionrestore_no_auto_restore', 06:20:19 INFO - 'tabpaint']}, 06:20:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:20:19 INFO - 'ts_paint', 06:20:19 INFO - 'tpaint', 06:20:19 INFO - 'sessionrestore', 06:20:19 INFO - 'sessionrestore_no_auto_restore', 06:20:19 INFO - 'tabpaint']}, 06:20:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:20:19 INFO - 'tests': ['a11yr', 06:20:19 INFO - 'ts_paint', 06:20:19 INFO - 'tpaint', 06:20:19 INFO - 'sessionrestore', 06:20:19 INFO - 'sessionrestore_no_auto_restore', 06:20:19 INFO - 'tabpaint']}, 06:20:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:20:19 INFO - 'tests': ['a11yr', 06:20:19 INFO - 'ts_paint', 06:20:19 INFO - 'tpaint', 06:20:19 INFO - 'sessionrestore', 06:20:19 INFO - 'sessionrestore_no_auto_restore', 06:20:19 INFO - 'tabpaint']}, 06:20:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:20:19 INFO - 'tests': ['tsvgx', 06:20:19 INFO - 'tsvgr_opacity', 06:20:19 INFO - 'tart', 06:20:19 INFO - 'tscrollx', 06:20:19 INFO - 'cart']}, 06:20:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:20:19 INFO - 'tsvgr_opacity', 06:20:19 INFO - 'tart', 06:20:19 INFO - 'tscrollx', 06:20:19 INFO - 'cart']}, 06:20:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:19 INFO - 'talos_options': ['--disable-e10s'], 06:20:19 INFO - 'tests': ['tp5o']}, 06:20:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:19 INFO - 'tests': ['tp5o']}, 06:20:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:19 INFO - 'talos_options': ['--disable-e10s', 06:20:19 INFO - '--xperf_path', 06:20:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:20:19 INFO - 'tests': ['tp5n']}, 06:20:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:20:19 INFO - 'talos_options': ['--xperf_path', 06:20:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:20:19 INFO - 'tests': ['tp5n']}}, 06:20:19 INFO - 'talos.zip': {'path': '', 06:20:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:20:19 INFO - Running post-action listener: _resource_record_post_action 06:20:19 INFO - [mozharness: 2016-09-20 13:20:19.439876Z] Finished populate-webroot step (success) 06:20:19 INFO - [mozharness: 2016-09-20 13:20:19.439966Z] Running create-virtualenv step. 06:20:19 INFO - Running pre-action listener: _resource_record_pre_action 06:20:19 INFO - Running main action method: create_virtualenv 06:20:19 INFO - Creating virtualenv /builds/slave/test/build/venv 06:20:19 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 06:20:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:20:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:20:19 INFO - Using real prefix '/usr' 06:20:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:20:20 INFO - Installing distribute.............................................................................................................................................................................................done. 06:20:22 INFO - Installing pip.................done. 06:20:22 INFO - Return code: 0 06:20:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:20:22 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')]} 06:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:22 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')]} 06:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:22 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 0x11fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb3b0>, '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 0x14bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc740>, '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': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', '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 06:20:22 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 06:20:22 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 06:20:22 INFO - Using env: {'DISPLAY': ':0', 06:20:22 INFO - 'HOME': '/home/cltbld', 06:20:22 INFO - 'LANG': 'en_US.UTF-8', 06:20:22 INFO - 'LANGUAGE': 'en_US:en', 06:20:22 INFO - 'LOGNAME': 'cltbld', 06:20:22 INFO - 'MAIL': '/var/mail/cltbld', 06:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:22 INFO - 'MOZ_NO_REMOTE': '1', 06:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:20:22 INFO - 'NO_EM_RESTART': '1', 06:20:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:22 INFO - 'PWD': '/builds/slave/test', 06:20:22 INFO - 'SHELL': '/bin/bash', 06:20:22 INFO - 'SHLVL': '1', 06:20:22 INFO - 'TERM': 'linux', 06:20:22 INFO - 'TMOUT': '86400', 06:20:22 INFO - 'USER': 'cltbld', 06:20:22 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', 06:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:22 INFO - '_': '/tools/buildbot/bin/python'} 06:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:22 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 06:20:22 INFO - Cleaning up... 06:20:22 INFO - Return code: 0 06:20:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:20:22 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')]} 06:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:22 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')]} 06:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:22 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb3b0>, '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 0x14bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc740>, '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': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', '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 06:20:22 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>=3.1.1'] in /builds/slave/test/build 06:20:22 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>=3.1.1 06:20:22 INFO - Using env: {'DISPLAY': ':0', 06:20:22 INFO - 'HOME': '/home/cltbld', 06:20:22 INFO - 'LANG': 'en_US.UTF-8', 06:20:22 INFO - 'LANGUAGE': 'en_US:en', 06:20:22 INFO - 'LOGNAME': 'cltbld', 06:20:22 INFO - 'MAIL': '/var/mail/cltbld', 06:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:22 INFO - 'MOZ_NO_REMOTE': '1', 06:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:20:22 INFO - 'NO_EM_RESTART': '1', 06:20:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:22 INFO - 'PWD': '/builds/slave/test', 06:20:22 INFO - 'SHELL': '/bin/bash', 06:20:22 INFO - 'SHLVL': '1', 06:20:22 INFO - 'TERM': 'linux', 06:20:22 INFO - 'TMOUT': '86400', 06:20:22 INFO - 'USER': 'cltbld', 06:20:22 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', 06:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:22 INFO - '_': '/tools/buildbot/bin/python'} 06:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:22 INFO - Downloading/unpacking psutil>=3.1.1 06:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:20:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:20:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:20:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:20:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:20:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:20:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:20:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:20:24 INFO - Installing collected packages: psutil 06:20:24 INFO - Running setup.py install for psutil 06:20:24 INFO - building 'psutil._psutil_linux' extension 06:20:24 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 06:20:24 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 06:20:24 INFO - building 'psutil._psutil_posix' extension 06:20:24 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 06:20:24 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 06:20:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:20:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:20:24 INFO - Successfully installed psutil 06:20:24 INFO - Cleaning up... 06:20:25 INFO - Return code: 0 06:20:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:25 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb3b0>, '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 0x14bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc740>, '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': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', '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 06:20:25 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.3'] in /builds/slave/test/build 06:20:25 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.3 06:20:25 INFO - Using env: {'DISPLAY': ':0', 06:20:25 INFO - 'HOME': '/home/cltbld', 06:20:25 INFO - 'LANG': 'en_US.UTF-8', 06:20:25 INFO - 'LANGUAGE': 'en_US:en', 06:20:25 INFO - 'LOGNAME': 'cltbld', 06:20:25 INFO - 'MAIL': '/var/mail/cltbld', 06:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:25 INFO - 'MOZ_NO_REMOTE': '1', 06:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:20:25 INFO - 'NO_EM_RESTART': '1', 06:20:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:25 INFO - 'PWD': '/builds/slave/test', 06:20:25 INFO - 'SHELL': '/bin/bash', 06:20:25 INFO - 'SHLVL': '1', 06:20:25 INFO - 'TERM': 'linux', 06:20:25 INFO - 'TMOUT': '86400', 06:20:25 INFO - 'USER': 'cltbld', 06:20:25 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', 06:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:25 INFO - '_': '/tools/buildbot/bin/python'} 06:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:20:25 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 06:20:25 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 06:20:25 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 06:20:25 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 06:20:25 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 06:20:25 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 06:20:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:20:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:20:27 INFO - Installing collected packages: mozsystemmonitor 06:20:27 INFO - Running setup.py install for mozsystemmonitor 06:20:27 INFO - Successfully installed mozsystemmonitor 06:20:27 INFO - Cleaning up... 06:20:27 INFO - Return code: 0 06:20:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:20:27 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')]} 06:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:27 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')]} 06:20:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:27 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb3b0>, '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 0x14bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc740>, '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': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', '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 06:20:27 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==2.5.1'] in /builds/slave/test/build 06:20:27 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==2.5.1 06:20:27 INFO - Using env: {'DISPLAY': ':0', 06:20:27 INFO - 'HOME': '/home/cltbld', 06:20:27 INFO - 'LANG': 'en_US.UTF-8', 06:20:27 INFO - 'LANGUAGE': 'en_US:en', 06:20:27 INFO - 'LOGNAME': 'cltbld', 06:20:27 INFO - 'MAIL': '/var/mail/cltbld', 06:20:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:27 INFO - 'MOZ_NO_REMOTE': '1', 06:20:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:20:27 INFO - 'NO_EM_RESTART': '1', 06:20:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:20:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:27 INFO - 'PWD': '/builds/slave/test', 06:20:27 INFO - 'SHELL': '/bin/bash', 06:20:27 INFO - 'SHLVL': '1', 06:20:27 INFO - 'TERM': 'linux', 06:20:27 INFO - 'TMOUT': '86400', 06:20:27 INFO - 'USER': 'cltbld', 06:20:27 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', 06:20:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:27 INFO - '_': '/tools/buildbot/bin/python'} 06:20:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:27 INFO - Downloading/unpacking jsonschema==2.5.1 06:20:27 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 06:20:27 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 06:20:27 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 06:20:27 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 06:20:27 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 06:20:27 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 06:20:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:20:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:20:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:20:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:20:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:20:29 INFO - Downloading functools32-3.2.3-2.tar.gz 06:20:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:20:29 INFO - warning: no files found matching '*.txt' 06:20:29 INFO - no previously-included directories found matching 'build' 06:20:29 INFO - no previously-included directories found matching 'dist' 06:20:29 INFO - no previously-included directories found matching '.git*' 06:20:29 INFO - Installing collected packages: jsonschema, functools32 06:20:29 INFO - Running setup.py install for functools32 06:20:29 INFO - warning: no files found matching '*.txt' 06:20:29 INFO - no previously-included directories found matching 'build' 06:20:29 INFO - no previously-included directories found matching 'dist' 06:20:29 INFO - no previously-included directories found matching '.git*' 06:20:29 INFO - Successfully installed jsonschema functools32 06:20:29 INFO - Cleaning up... 06:20:29 INFO - Return code: 0 06:20:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:20: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')]} 06:20:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20: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')]} 06:20:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb3b0>, '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 0x14bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc740>, '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': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', '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 06:20:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:20:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:20:29 INFO - Using env: {'DISPLAY': ':0', 06:20:29 INFO - 'HOME': '/home/cltbld', 06:20:29 INFO - 'LANG': 'en_US.UTF-8', 06:20:29 INFO - 'LANGUAGE': 'en_US:en', 06:20:29 INFO - 'LOGNAME': 'cltbld', 06:20:29 INFO - 'MAIL': '/var/mail/cltbld', 06:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:29 INFO - 'MOZ_NO_REMOTE': '1', 06:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:20:29 INFO - 'NO_EM_RESTART': '1', 06:20:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:29 INFO - 'PWD': '/builds/slave/test', 06:20:29 INFO - 'SHELL': '/bin/bash', 06:20:29 INFO - 'SHLVL': '1', 06:20:29 INFO - 'TERM': 'linux', 06:20:29 INFO - 'TMOUT': '86400', 06:20:29 INFO - 'USER': 'cltbld', 06:20:29 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', 06:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:29 INFO - '_': '/tools/buildbot/bin/python'} 06:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:20:30 INFO - Cleaning up... 06:20:30 INFO - Return code: 0 06:20:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:20: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')]} 06:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20: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')]} 06:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:30 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 0x11fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb3b0>, '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 0x14bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc740>, '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': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', '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 06:20:30 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 06:20:30 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 06:20:30 INFO - Using env: {'DISPLAY': ':0', 06:20:30 INFO - 'HOME': '/home/cltbld', 06:20:30 INFO - 'LANG': 'en_US.UTF-8', 06:20:30 INFO - 'LANGUAGE': 'en_US:en', 06:20:30 INFO - 'LOGNAME': 'cltbld', 06:20:30 INFO - 'MAIL': '/var/mail/cltbld', 06:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:30 INFO - 'MOZ_NO_REMOTE': '1', 06:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:20:30 INFO - 'NO_EM_RESTART': '1', 06:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:30 INFO - 'PWD': '/builds/slave/test', 06:20:30 INFO - 'SHELL': '/bin/bash', 06:20:30 INFO - 'SHLVL': '1', 06:20:30 INFO - 'TERM': 'linux', 06:20:30 INFO - 'TMOUT': '86400', 06:20:30 INFO - 'USER': 'cltbld', 06:20:30 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', 06:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:30 INFO - '_': '/tools/buildbot/bin/python'} 06:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:30 INFO - Downloading/unpacking blobuploader==1.2.4 06:20:30 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 06:20:30 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 06:20:30 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 06:20:30 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 06:20:30 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 06:20:30 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 06:20:32 INFO - Downloading blobuploader-1.2.4.tar.gz 06:20:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:20:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:20:32 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 06:20:32 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 06:20:32 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 06:20:32 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 06:20:32 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 06:20:32 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 06:20:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:20:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:20:32 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 06:20:32 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 06:20:32 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 06:20:32 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 06:20:32 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 06:20:32 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 06:20:32 INFO - Downloading docopt-0.6.1.tar.gz 06:20:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:20:33 INFO - Installing collected packages: blobuploader, requests, docopt 06:20:33 INFO - Running setup.py install for blobuploader 06:20:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:20:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:20:33 INFO - Running setup.py install for requests 06:20:33 INFO - Running setup.py install for docopt 06:20:33 INFO - Successfully installed blobuploader requests docopt 06:20:33 INFO - Cleaning up... 06:20:33 INFO - Return code: 0 06:20:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:20:33 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')]} 06:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:33 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')]} 06:20:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:33 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 0x11fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb3b0>, '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 0x14bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc740>, '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': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', '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 06:20:33 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 06:20:33 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 06:20:33 INFO - Using env: {'DISPLAY': ':0', 06:20:33 INFO - 'HOME': '/home/cltbld', 06:20:33 INFO - 'LANG': 'en_US.UTF-8', 06:20:33 INFO - 'LANGUAGE': 'en_US:en', 06:20:33 INFO - 'LOGNAME': 'cltbld', 06:20:33 INFO - 'MAIL': '/var/mail/cltbld', 06:20:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:33 INFO - 'MOZ_NO_REMOTE': '1', 06:20:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:20:33 INFO - 'NO_EM_RESTART': '1', 06:20:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:20:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:33 INFO - 'PWD': '/builds/slave/test', 06:20:33 INFO - 'SHELL': '/bin/bash', 06:20:33 INFO - 'SHLVL': '1', 06:20:33 INFO - 'TERM': 'linux', 06:20:33 INFO - 'TMOUT': '86400', 06:20:33 INFO - 'USER': 'cltbld', 06:20:33 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', 06:20:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:33 INFO - '_': '/tools/buildbot/bin/python'} 06:20:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:20:33 INFO - Running setup.py (path:/tmp/pip-EOrB0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:20:33 INFO - Running setup.py (path:/tmp/pip-7BiYUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:20:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:20:33 INFO - Running setup.py (path:/tmp/pip-nY3g9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:20:34 INFO - Running setup.py (path:/tmp/pip-LbeW1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:20:34 INFO - Running setup.py (path:/tmp/pip-g8NIoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:20:34 INFO - Running setup.py (path:/tmp/pip-l1nLFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:20:34 INFO - Running setup.py (path:/tmp/pip-wGAIrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:20:34 INFO - Running setup.py (path:/tmp/pip-NgKDAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:20:34 INFO - Running setup.py (path:/tmp/pip-khHCTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:20:34 INFO - Running setup.py (path:/tmp/pip-PMH88g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:20:34 INFO - Running setup.py (path:/tmp/pip-fISGrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:20:34 INFO - Running setup.py (path:/tmp/pip-8w2VDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:20:34 INFO - Running setup.py (path:/tmp/pip-RkpLvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:20:34 INFO - Running setup.py (path:/tmp/pip-zlvQ04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:20:34 INFO - Running setup.py (path:/tmp/pip-gFa8bf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:20:34 INFO - Running setup.py (path:/tmp/pip-jDa0dV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:20:34 INFO - Running setup.py (path:/tmp/pip-UVuysC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:20:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:20:35 INFO - Running setup.py install for manifestparser 06:20:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:20:35 INFO - Running setup.py install for mozcrash 06:20:35 INFO - Running setup.py install for mozdebug 06:20:35 INFO - Running setup.py install for mozdevice 06:20:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:20:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:20:35 INFO - Running setup.py install for mozfile 06:20:35 INFO - Running setup.py install for mozhttpd 06:20:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:20:35 INFO - Running setup.py install for mozinfo 06:20:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:20:35 INFO - Running setup.py install for mozInstall 06:20:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:20:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:20:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:20:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:20:35 INFO - Running setup.py install for mozleak 06:20:35 INFO - Running setup.py install for mozlog 06:20:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:20:36 INFO - Running setup.py install for moznetwork 06:20:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:20:36 INFO - Running setup.py install for mozprocess 06:20:36 INFO - Running setup.py install for mozprofile 06:20:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:20:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:20:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:20:36 INFO - Running setup.py install for mozrunner 06:20:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:20:36 INFO - Running setup.py install for mozscreenshot 06:20:36 INFO - Running setup.py install for moztest 06:20:36 INFO - Running setup.py install for mozversion 06:20:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:20:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:20:36 INFO - Cleaning up... 06:20:36 INFO - Return code: 0 06:20:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:20:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:20:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:36 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 0x11fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb3b0>, '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 0x14bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc740>, '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': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', '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 06:20:36 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 06:20:36 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 06:20:36 INFO - Using env: {'DISPLAY': ':0', 06:20:36 INFO - 'HOME': '/home/cltbld', 06:20:36 INFO - 'LANG': 'en_US.UTF-8', 06:20:36 INFO - 'LANGUAGE': 'en_US:en', 06:20:36 INFO - 'LOGNAME': 'cltbld', 06:20:36 INFO - 'MAIL': '/var/mail/cltbld', 06:20:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:36 INFO - 'MOZ_NO_REMOTE': '1', 06:20:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:20:36 INFO - 'NO_EM_RESTART': '1', 06:20:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:20:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:36 INFO - 'PWD': '/builds/slave/test', 06:20:36 INFO - 'SHELL': '/bin/bash', 06:20:36 INFO - 'SHLVL': '1', 06:20:36 INFO - 'TERM': 'linux', 06:20:36 INFO - 'TMOUT': '86400', 06:20:36 INFO - 'USER': 'cltbld', 06:20:36 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', 06:20:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:36 INFO - '_': '/tools/buildbot/bin/python'} 06:20:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:20:37 INFO - Running setup.py (path:/tmp/pip-w_sTBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:20:37 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)) 06:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:20:37 INFO - Running setup.py (path:/tmp/pip-hZJp3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:20:37 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)) 06:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:20:37 INFO - Running setup.py (path:/tmp/pip-vSmrMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:20:37 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)) 06:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:20:37 INFO - Running setup.py (path:/tmp/pip-d2ei44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:20:37 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)) 06:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:20:37 INFO - Running setup.py (path:/tmp/pip-eZVXhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:20:37 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)) 06:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:20:37 INFO - Running setup.py (path:/tmp/pip-O12Si3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:20:37 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)) 06:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:20:37 INFO - Running setup.py (path:/tmp/pip-RyUUu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:20:37 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)) 06:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:20:37 INFO - Running setup.py (path:/tmp/pip-Rs3PgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:20:37 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)) 06:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:20:37 INFO - Running setup.py (path:/tmp/pip-u5Xb_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:20:37 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)) 06:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:20:37 INFO - Running setup.py (path:/tmp/pip-LkReeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 06:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:20:37 INFO - Running setup.py (path:/tmp/pip-ErPyH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:20:37 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)) 06:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:20:37 INFO - Running setup.py (path:/tmp/pip-Kt3LCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:20:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 06:20:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:20:37 INFO - Running setup.py (path:/tmp/pip-PZshQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:20:38 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)) 06:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:20:38 INFO - Running setup.py (path:/tmp/pip-RsxXKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 06:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:20:38 INFO - Running setup.py (path:/tmp/pip-suKc4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:20:38 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)) 06:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:20:38 INFO - Running setup.py (path:/tmp/pip-KSXPJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:20:38 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)) 06:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:20:38 INFO - Running setup.py (path:/tmp/pip-6yarEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:20:38 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)) 06:20:38 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)) 06:20:38 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)) 06:20:38 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)) 06:20:38 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)) 06:20:38 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)) 06:20:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:20: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 06:20: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 06:20: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 06:20: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 06:20: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 06:20: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 06:20:40 INFO - Downloading blessings-1.6.tar.gz 06:20:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:20:40 INFO - Installing collected packages: blessings 06:20:40 INFO - Running setup.py install for blessings 06:20:40 INFO - Successfully installed blessings 06:20:40 INFO - Cleaning up... 06:20:40 INFO - Return code: 0 06:20:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:20:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:20:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:20:40 INFO - Reading from file tmpfile_stdout 06:20:40 INFO - Current package versions: 06:20:40 INFO - argparse == 1.2.1 06:20:40 INFO - blessings == 1.6 06:20:40 INFO - blobuploader == 1.2.4 06:20:40 INFO - docopt == 0.6.1 06:20:40 INFO - functools32 == 3.2.3-2 06:20:40 INFO - jsonschema == 2.5.1 06:20:40 INFO - manifestparser == 1.1 06:20:40 INFO - mozInstall == 1.12 06:20:40 INFO - mozcrash == 0.17 06:20:40 INFO - mozdebug == 0.1 06:20:40 INFO - mozdevice == 0.48 06:20:40 INFO - mozfile == 1.2 06:20:40 INFO - mozhttpd == 0.7 06:20:40 INFO - mozinfo == 0.9 06:20:40 INFO - mozleak == 0.1 06:20:40 INFO - mozlog == 3.3 06:20:40 INFO - moznetwork == 0.27 06:20:40 INFO - mozprocess == 0.23 06:20:40 INFO - mozprofile == 0.28 06:20:40 INFO - mozrunner == 6.12 06:20:40 INFO - mozscreenshot == 0.1 06:20:40 INFO - mozsystemmonitor == 0.3 06:20:40 INFO - moztest == 0.7 06:20:40 INFO - mozversion == 1.4 06:20:40 INFO - psutil == 3.1.1 06:20:40 INFO - requests == 1.2.3 06:20:40 INFO - wsgiref == 0.1.2 06:20:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:20: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')]} 06:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20: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')]} 06:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20:40 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 0x11fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb3b0>, '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 0x14bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc740>, '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': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', '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 06:20:40 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 06:20:40 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 06:20:40 INFO - Using env: {'DISPLAY': ':0', 06:20:40 INFO - 'HOME': '/home/cltbld', 06:20:40 INFO - 'LANG': 'en_US.UTF-8', 06:20:40 INFO - 'LANGUAGE': 'en_US:en', 06:20:40 INFO - 'LOGNAME': 'cltbld', 06:20:40 INFO - 'MAIL': '/var/mail/cltbld', 06:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:40 INFO - 'MOZ_NO_REMOTE': '1', 06:20:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:20:40 INFO - 'NO_EM_RESTART': '1', 06:20:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:40 INFO - 'PWD': '/builds/slave/test', 06:20:40 INFO - 'SHELL': '/bin/bash', 06:20:40 INFO - 'SHLVL': '1', 06:20:40 INFO - 'TERM': 'linux', 06:20:40 INFO - 'TMOUT': '86400', 06:20:40 INFO - 'USER': 'cltbld', 06:20:40 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', 06:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:40 INFO - '_': '/tools/buildbot/bin/python'} 06:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:40 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)) 06:20:40 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)) 06:20:40 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)) 06:20:40 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)) 06:20:40 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)) 06:20:40 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)) 06:20:40 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)) 06:20:40 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)) 06:20:40 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)) 06:20:40 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)) 06:20:40 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)) 06:20:40 INFO - Cleaning up... 06:20:40 INFO - Return code: 0 06:20:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:20: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')]} 06:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:20:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20: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')]} 06:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:20:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:20: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11fc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x135f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bd180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb3b0>, '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 0x14bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc740>, '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': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', '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 06:20: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', 'jsonschema'] in /builds/slave/test/build 06:20: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 jsonschema 06:20:40 INFO - Using env: {'DISPLAY': ':0', 06:20:40 INFO - 'HOME': '/home/cltbld', 06:20:40 INFO - 'LANG': 'en_US.UTF-8', 06:20:40 INFO - 'LANGUAGE': 'en_US:en', 06:20:40 INFO - 'LOGNAME': 'cltbld', 06:20:40 INFO - 'MAIL': '/var/mail/cltbld', 06:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:40 INFO - 'MOZ_NO_REMOTE': '1', 06:20:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:20:40 INFO - 'NO_EM_RESTART': '1', 06:20:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:40 INFO - 'PWD': '/builds/slave/test', 06:20:40 INFO - 'SHELL': '/bin/bash', 06:20:40 INFO - 'SHLVL': '1', 06:20:40 INFO - 'TERM': 'linux', 06:20:40 INFO - 'TMOUT': '86400', 06:20:40 INFO - 'USER': 'cltbld', 06:20:40 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', 06:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:40 INFO - '_': '/tools/buildbot/bin/python'} 06:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:20:41 INFO - Cleaning up... 06:20:41 INFO - Return code: 0 06:20:41 INFO - Running post-action listener: _resource_record_post_action 06:20:41 INFO - Running post-action listener: _start_resource_monitoring 06:20:41 INFO - Starting resource monitoring. 06:20:41 INFO - [mozharness: 2016-09-20 13:20:41.189158Z] Finished create-virtualenv step (success) 06:20:41 INFO - [mozharness: 2016-09-20 13:20:41.189655Z] Running install step. 06:20:41 INFO - Running pre-action listener: _resource_record_pre_action 06:20:41 INFO - Running main action method: install 06:20:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:20:41 INFO - Reading from file tmpfile_stdout 06:20:41 INFO - Detecting whether we're running mozinstall >=1.0... 06:20:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:20:41 INFO - Reading from file tmpfile_stdout 06:20:41 INFO - Output received: 06:20:41 INFO - Usage: mozinstall [options] installer 06:20:41 INFO - Options: 06:20:41 INFO - -h, --help show this help message and exit 06:20:41 INFO - -d DEST, --destination=DEST 06:20:41 INFO - Directory to install application into. [default: 06:20:41 INFO - "/builds/slave/test"] 06:20:41 INFO - --app=APP Application being installed. [default: firefox] 06:20:41 INFO - mkdir: /builds/slave/test/build/application 06:20:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:20:55 INFO - Reading from file tmpfile_stdout 06:20:55 INFO - Output received: 06:20:55 INFO - /builds/slave/test/build/application/firefox/firefox 06:20:55 INFO - Running post-action listener: _resource_record_post_action 06:20:55 INFO - [mozharness: 2016-09-20 13:20:55.399831Z] Finished install step (success) 06:20:55 INFO - [mozharness: 2016-09-20 13:20:55.400110Z] Running run-tests step. 06:20:55 INFO - Running pre-action listener: _resource_record_pre_action 06:20:55 INFO - Running main action method: run_tests 06:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:20:55 INFO - Python 2.7.3 06:20:55 INFO - Return code: 0 06:20:55 INFO - grabbing minidump binary from tooltool 06:20:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:20:55 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bb3b0>, '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 0x14bc2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14bc740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:20:55 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 06:20:55 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 06:20:55 INFO - Calling ['/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'] with output_timeout 600 06:20:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:20:55 INFO - Return code: 0 06:20:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:20:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:20:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:20:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:20:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:20:55 INFO - Using env: {'DISPLAY': ':0', 06:20:55 INFO - 'HOME': '/home/cltbld', 06:20:55 INFO - 'LANG': 'en_US.UTF-8', 06:20:55 INFO - 'LANGUAGE': 'en_US:en', 06:20:55 INFO - 'LOGNAME': 'cltbld', 06:20:55 INFO - 'MAIL': '/var/mail/cltbld', 06:20:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:20:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:20:55 INFO - 'MOZ_NO_REMOTE': '1', 06:20:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:20:55 INFO - 'NO_EM_RESTART': '1', 06:20:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:20:55 INFO - 'PWD': '/builds/slave/test', 06:20:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:20:55 INFO - 'SHELL': '/bin/bash', 06:20:55 INFO - 'SHLVL': '1', 06:20:55 INFO - 'TERM': 'linux', 06:20:55 INFO - 'TMOUT': '86400', 06:20:55 INFO - 'USER': 'cltbld', 06:20:55 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674', 06:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:20:55 INFO - '_': '/tools/buildbot/bin/python'} 06:20:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:20:55 INFO - mozversion application_buildid: 20160920030916 06:20:55 INFO - mozversion application_changeset: 71b46b28322579a29a9569d494852ffe28ce418a 06:20:55 INFO - mozversion application_display_name: Firefox 06:20:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:20:55 INFO - mozversion application_name: Firefox 06:20:55 INFO - mozversion application_remotingname: firefox 06:20:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:20:55 INFO - mozversion application_vendor: Mozilla 06:20:55 INFO - mozversion application_version: 50.0 06:20:55 INFO - mozversion platform_buildid: 20160920030916 06:20:55 INFO - mozversion platform_changeset: 71b46b28322579a29a9569d494852ffe28ce418a 06:20:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:20:55 INFO - mozversion platform_version: 50.0 06:20:55 INFO - using testdate: 1474377655 06:20:55 INFO - actual date: 1474377655 06:20:55 INFO - starting webserver on 'localhost:45541' 06:20:55 INFO - SUITE-START | Running 2 tests 06:20:55 INFO - TEST-START | dromaeo_css 06:20:55 INFO - operating with platform_type : linux_ 06:20:55 INFO - Initialising browser for dromaeo_css test... 06:20:55 INFO - TEST-INFO | started process 1807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGMiEi6/profile http://localhost:45541/getInfo.html) 06:20:59 INFO - PROCESS | 1807 | __metrics Screen width/height:1600/1200 06:20:59 INFO - PROCESS | 1807 | colorDepth:24 06:20:59 INFO - PROCESS | 1807 | Browser inner width/height: 1024/697 06:20:59 INFO - PROCESS | 1807 | __metrics 06:21:00 INFO - PROCESS | 1807 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:21:00 INFO - PROCESS | 1807 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:21:01 INFO - TEST-INFO | 1807: exit 0 06:21:01 INFO - Browser initialized. 06:21:01 INFO - Running cycle 1/1 for dromaeo_css test... 06:21:01 INFO - TEST-INFO | started process 1894 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGMiEi6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:21:13 INFO - PROCESS | 1894 | RSS: Main: 143667200 06:21:13 INFO - PROCESS | 1894 | 06:22:04 INFO - PROCESS | 1894 | 1474377724152 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] 06:24:12 INFO - PROCESS | 1894 | Cycle 1(1): loaded http://localhost:45541/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45541/tests/dromaeo/cssquery-ext.html) 06:24:14 INFO - PROCESS | 1894 | RSS: Main: 219201536 06:24:14 INFO - PROCESS | 1894 | 06:27:16 INFO - PROCESS | 1894 | Cycle 1(1): loaded http://localhost:45541/tests/dromaeo/cssquery-ext.html (next: http://localhost:45541/tests/dromaeo/cssquery-jquery.html) 06:27:17 INFO - PROCESS | 1894 | RSS: Main: 230522880 06:27:17 INFO - PROCESS | 1894 | 06:30:18 INFO - PROCESS | 1894 | Cycle 1(1): loaded http://localhost:45541/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45541/tests/dromaeo/cssquery-mootools.html) 06:30:19 INFO - PROCESS | 1894 | RSS: Main: 219361280 06:30:19 INFO - PROCESS | 1894 | 06:33:21 INFO - PROCESS | 1894 | Cycle 1(1): loaded http://localhost:45541/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45541/tests/dromaeo/cssquery-prototype.html) 06:33:21 INFO - PROCESS | 1894 | RSS: Main: 201895936 06:33:21 INFO - PROCESS | 1894 | 06:36:24 INFO - PROCESS | 1894 | Cycle 1(1): loaded http://localhost:45541/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45541/tests/dromaeo/cssquery-yui.html) 06:36:25 INFO - PROCESS | 1894 | RSS: Main: 175464448 06:36:25 INFO - PROCESS | 1894 | 06:39:27 INFO - PROCESS | 1894 | Cycle 1(1): loaded http://localhost:45541/tests/dromaeo/cssquery-yui.html (next: http://localhost:45541/tests/dromaeo/cssquery-dojo.html) 06:39:27 INFO - PROCESS | 1894 | RSS: Main: 268619776 06:39:27 INFO - PROCESS | 1894 | 06:39:27 INFO - PROCESS | 1894 | __start_tp_report 06:39:27 INFO - PROCESS | 1894 | _x_x_mozilla_page_load 06:39:27 INFO - PROCESS | 1894 | _x_x_mozilla_page_load_details 06:39:27 INFO - PROCESS | 1894 | |i|pagename|runs| 06:39:27 INFO - PROCESS | 1894 | |0;dojo.html;3185.362927414517;3202.103411044908;3231.030690792763;3238.028591422573;3275.29581140055;5530.778768849246;5633.6338138021;5633.943660563393;5636.210930469727;5663.971680141593;5633.6338138021;5684.943150568493;5695.943040569603;5706.1726049722765;5742.712864356787;4979.327790748257;5070.645054846163;5113.616478764098;5141.254518094874;5184.844454666347;5110;5191.091558977183;5193.065248255312;5195.19474481456;5197.870053248661;5072.315237442954;5105.157648987913;5130.666506677073;5146.176611742122;5178.275041494175;5218.6868787872845;5223.112070947948;5224.477552244745;5230.21546767984;5269.183276592096;4735.5974742146955;4983.277424773424;5001.824936127255;5105;5108.565771909355;5526.198701188305;5541.418151094117;5567.8886422271735;5571.777128914839;5633.436656334375;6041.969790151065;6055;6062.636241825505;6064.3935606439445;6065.909011364833;5873.647581145145;5952.1964534787685;5972.850678733023;6011.5190784737115;6081.209442772411;5629.831105066854;5632.46491583303;5632.662040277596;5652.434756524356;5652.802151924704;6124.6325220486915;6126.019836826086;6128.142060111588;6133.601315914451;6134.9079763803575;5690.2887139107615;5738.426157384311;5757.769689212469;5776.566757493205;5841.9415805842245;5878.706064696748;5887.2052272943465;5887.264091988502;5894.32215295238;5898.380670029671;5848.64908105515;5870.442307980735;5874;5874.530037597067;5912.379200184005;5747.453991870766;5921.348651648315;5961.5230781537375;5971.970140149271;6020.57855950088;4618.861434156914;4626;4628.305754136839;4633.351330813689;4637;4069.1454794492897;4124.340105583093;4130.173965206971;4131.132462182915;4164.187983343219;5546.7781288748;5574.916376254359;5619.438056194348;5625.268715067015;5628.409017053233;5987.042073268256;5989.580729348991;5991.64050156992;5992.910106348409;6000.279966404059;5652.576056795757;5653.265075540236;5661.2923384576925;5665.773369065191;5669.773209071591;5013.323201367769;5100.846974590768;5199.844004679866;5211.270422140903;5292.603054770908;6216.191895053705;6226.097215903759;6265.185525881606;6273.37266273369;6280.748770049238;5989.580729348903;6002.579819412599;6004.219451471281;6007.729652165575;6010.308814486215;6040.788572399945;6048.032314829607;6079.574429789872;6093.329733729198;6102.4507794298725;5817.941820581909;5818.6217895836635;5822.5633077518505;5874.353821079592;5877.647341159544;5916.881662366643;5981.461668449861;5984.251968503937;5991.281046274475;5995.280566332068;5782.190493330853;5849.707514624337;5885.823425297248;5894.086416605433;5990.041593345044;5938.465538101592;5938.524918006463;5940.940590594038;5948.851278717893;5953.91069133972;5875.3243377012195;5917.142014407973;5930.199423077829;5932.377100404396;5934.643921364732;5776.075827867521;5841.970790146022;5915.526757859447;5927.466528012327;5975.133605627073;5840.853978650568;5841.620294680833;5846.590738648254;5848.064309710426;5868.413158684098 06:39:27 INFO - PROCESS | 1894 | |1;ext.html;604.5043064686955;643.3887806583746;667.6294656465662;679.6465837764359;683.3815397065657;33588.16029599261;46800.531994680045;47177.528224717746;47265.527344726586;51482.742586287015;46481.30278045832;46953.06093878121;46975.76512117443;47056.29415558761;47109.52890471103;8422.49465032097;9155.404898681598;9307.906920930805;9308.069193080672;9311;10816.837747433794;11121.388323642197;11122.721931951726;11533.884661153365;11534.711632209179;11228.831567526453;11295.661130166067;11337.37644429556;11350.035247004014;11355.602553910614;11010;11087.83368249477;11088.2238243323;11091.889081109206;11105.888941110567;11050.502727377287;11120.61077862271;11122.332660040343;11124.276922000125;11130.49912753928;44576.10847783059;44917.550824491664;44974.775126124485;45004.774976125234;45068;3882.7282090253693;3883.3980732986433;4464.933026004613;4532.252178390561;4537.115262523809;35469.82265088684;35531;35743.28513429743;35902;37471.43792843109;4181.540030596632;4265.253580623378;4281.743095414254;4300.35494675798;4307.5261721210645;399533;400591;401772.99113504536;404794;405484;64846.35153648403;65271.67364163149;65354.346456534826;65434;65498.67250663811;39341;39932;40038.39942400866;41912.58087419148;42485.57514424878;19661.410157695293;19807.405777826687;19851.702224466644;19862.801371986385;19890.801091989186;13708.17750934927;14500.057496262709;14720.558383248519;15094.698106037818;15210.771838422432;20831.583368332547;20926.162953481995;20930.686039709417;21009.474763131046;21069.47326316824;7424.517406368569;7436.3679087277105;7562;7568.167501574822;7578.886316705254;1020.8315627921459;1093.9617113400993;1101.983470247947;1105.9668209953713;1167.9532818687328;33318;35177.82411087928;35214;35243;35256.64743352534;1172.2731906218198;1256.3341429042623;1262.2048109690836;1262.7158889249845;1287.3884904670394;17587.29650813953;18648.44054678362;18738;18957.24171033171;18958;690217;694818;695431;701982;702609;65963.34036659668;66342;66532.66733666301;66575.66848663097;66708.6664566674;1377.2081053394338;1450.3111022264552;1474.675571374296;1488.2038109611522;1496.940122395092;34403.82798085993;36515.35680894313;36709.81645091758;37002.629973701;37054.258914822094;54584.18123728068;55450.72274638601;55462.72268638631;55566.72216638891;55574;318697;319215;319559;319887;560576;31062.22344441407;31251.68748312488;31259;33160.668393315755;33460.49809252814;54088.188677169084;54265.45734542604;54300.185497218365;54879.17681234705;55543.44456555383;43463;44545.331820022075;45612.31581526213;46156.30765538587;47731.28403074026;44776.55223447724;45282.77358613186;45825.770871146764;45888.08223835572;46913.06173876572;43776.56223437725;45061.32408013948;46059.53940460552;46120.769396152806;46319.07361852811;37378.8131059343;39765.40351894666;40888;40907.18185636211;41460.170796584505;29446.852765736036;30226.395472090873;30336.54495182618;30402.54396184103;30439.695603043685 06:39:27 INFO - PROCESS | 1894 | |2;jquery.html;418.43302325349134;419.67475206714795;430.60384446309394;434.7978190141584;439.5823967231131;19020.14409351579;19841.40475785725;20290.492737681565;20577.485562860937;20685.793142068575;19345.806541934577;19662.410127696156;19813.20747170115;19853.60292794147;20054;5324.174752913295;5444.646098003637;5469.371022332423;5478.205660179272;5526.917096243559;5329.893402131955;5356.517913387795;5389.649672771257;5420.566354691615;5448.42791506892;5406.729663516828;5422.349318081816;5485.177223416499;5515.779368825242;5559.249501317331;5429.592780541456;5467.535259502927;5553.916691249614;5761.884762304772;5802.361740208574;5669.0646043402785;5695.572832037614;5708.1437784332265;5717.742701578397;5727.455891690282;14302;14593.854061459355;15185.924070379688;15459.845401546065;15509.534713958486;2396.892139853711;2446.938826529351;2545.885435155404;2915.023467138511;2981.2397838551033;11197.328160310408;11313.264637798598;11440.256383335056;13609.047366684335;14858;1981.9306324278582;2079.189116244666;2117.5658989907033;2126.64910289802;2176.4232478393237;64636.676816616084;70292.29707702908;77644;88175.11824881734;94304.52847735786;11609;11842.407879605986;11883.940580297216;11896.345700986529;12085.395730213455;17281.308747650204;17300.096989331163;17333.13334333278;17346.47960561185;17355.21901514435;8865.157810008039;9015.549222538846;9017.188453039258;9019.458832470073;9058.728238152735;8678.47929124242;8715.651373944971;8767.21095101444;8861.689840855539;8904.643814247487;5175.06848767218;5186.5850731941355;5200.817971370984;5212.973935130376;5325.4940780625775;2040.3266921915733;2058.4956685611824;2136.1135128921633;2170.4682352823343;2182.4652960024896;919.3242966419676;943.1417410156724;972.9854052189223;986.452518852044;1015.3806178231273;18880.33918812835;19840.702389464168;19999.200031998556;20654.58690826175;21049.579008419747;1030.350878946274;1059.2267644619471;1103.038342051594;1114.0474893965543;1153.0544953138515;10592.947035264928;11453.14101442395;11526.904944030304;11614.187006909604;11627.76744465106;428524;430436;435803;530881;584405;92974;95847.52076239714;97634;99334.50332748434;99525;1058.4125810175274;1080.8378743188584;1104.1994553948323;1112.6773235761539;1118.6420345489366;15984.440544581348;16741;18026.459206223833;18208.817911821243;18719.25122995065;42767.572324276356;43091;43211.56788432076;43454.34818477789;44938.101237974406;60047.69976150091;60506.39493605008;60785.696071519356;61309.38690613215;61570.384296158256;8303.086660467223;8389.706360277605;8524.488530688179;8782.429142105742;9466.337356384987;12656;12759.234445933274;13939.651508712363;13949.511767088103;14175.858241417454;9729.416235025921;9763.316567840468;9776.413415195111;11273.605423810128;11362.318260904372;11889.940550297193;12001.279923204636;12006.939965300118;12169.57406490804;12332.013438924685;10779.730506737395;11154.553817847196;11322.207445479067;11442.82835757481;11498.885011150116;8615.956920215609;8860.202581767671;9091.772705682411;9110.817783644423;9376.156145946898;9038.954805225932;10978.560857565608;11256.606018789631;11309.377984210947;11444.484998174936 06:39:27 INFO - PROCESS | 1894 | |3;mootools.html;1370.9794353084712;1562.3594326326206;1589.133922012503;1736.2273788164264;1842.9907850460745;9052.637894484222;9382.85925711114;9491.383060101089;9699.07858753419;9731.124198822105;9563.665271715492;9645.324827262095;9694.466804325759;9700.272479564042;9701.029897010312;2480.9627855582135;2513.1078467144175;2515.0945659562544;2516.471540976397;2519.4583164619603;2426.9878650606724;2495.1142344467635;2498.750124987496;2502.36189771608;2505.110685706575;2423.309356833303;2440.5240978009297;2477.343503971449;2479.429731161834;2483.689538807649;2348.800351970076;2400.95198096038;2408.7350391456926;2460.138951367025;2465.839720418167;2354.587947109249;2380.2859142257425;2385.4155731845635;2403;2410.987945060281;9320.16118549327;9560.235181185559;9599.32804703671;9629.470379129145;9664.468454235015;5414.242006119146;5520.392756796749;5529.142982837627;5542.944570554324;5547.5007249347755;3594.622564630702;3622.7464077514583;3655.8903232903053;3671.7796932183887;3678.1907980244305;1228.6068458093414;1251.186728626391;1255.152771878978;1275.9855914547957;1281.51943021367;12903.290319032449;13022.804657930139;13048.804267935988;13093;13121.147125436815;4443.888902777457;4611.677182597186;4718.504557021532;4763.309320148628;4781.593564546983;10306.608607837996;10310.020548047924;10310.175185985103;10312.175025997902;10319.638812641522;5328.760205790749;5346.91979620306;5352.357717073976;5354.303940487712;5354.491323324278;4609.516000819933;4950.950490495121;5018.824341148115;5073.594112470993;5110.8466745997675;3964.742291751027;4011.8194681239415;4101.52832424269;4110.712250142461;4117.341225403921;1102.9779404412027;1105.1766434006715;1106.6569363497342;1108.257467496779;1118.983215251772;899.5682072605056;927.1840780113457;945.7446489447948;1008.9456517938771;1017.3743147964096;5939.346671866091;6132.294786099566;6141.293751218667;6315.5579109462815;6341.936580634135;464.32208974896355;1083.9349639021684;1154.861416629993;1154.8729639739622;1180.0323734537596;4506.729596224237;4648.000679853848;4648.279516674921;4694.812207511662;4695.835645752382;11333.433328333715;11670.474828632732;11684.065274778168;11690.47392867323;11718.941405292919;11342.262752921033;11608.129390295762;11765.411729413667;11780.352080635646;12075.879241207651;8972.551372431482;9144.771380715536;9160.45037297751;9193.126652967958;9208.171264586219;6148.538859585638;6273.341299163704;6337.65142917144;6355.491560675227;6403.135576697086;10391.636292729718;10658.253922225369;10689.51897164614;10700.571977120828;10787.67636970892;10929.125669946226;11016.17378696617;11055.115590752881;11061;11096.5561377544;7415.147258065176;7595.696172153052;8224.424290299861;8510.48937063778;8668.306535477273;8938.910610893809;9368.718938431857;9376;9383.296252780932;9388.295877809054;8228.424010319459;8312.584370781558;8391.95804020976;8393.118722534291;8396.916030839613;8120.472169308976;8199.42604017713;8237.382196335178;8265.669373225004;8481.40630155883;7704.537727736354;7732.729354472566;7774.105977812624;7780.416468764978;7841.764747057598;5388.973055134699;5469.234307197075;5505.064139096283;5518.33779946409;5667.801626943037;5639.7180140993605;5668.659880407189;5723.771049157987;5809.593328466966;5829.950608890441 06:39:27 INFO - PROCESS | 1894 | |4;prototype.html;337.2613975393887;339.9173631982137;343.833240878174;345.2542508182325;346.6204506065857;5523.978064058147;5556.888862222753;5558.277423934893;5581.8604534886645;5601.411851755568;5245.370555533332;5330.307060082194;5363.839084827452;5379.166229234465;5531.502164805167;4270.97864510677;4290.76400797956;4304;4306.138772245547;4311.060022989659;4304.806283717225;4311.439512863323;4321.330193819963;4324.82700691972;4342.761148136851;4082.2447847148223;4236.872893813191;4279.764612946286;4294.828206871722;4320.330348795942;4286.592773686495;4296.355546667994;4297.871063868089;4305.440292761937;4316.805743741539;3782.8486860525545;3786.110264087937;3797.3354662934153;3805.296020236265;3806.371948628473;5237.790488380499;5357.223202635635;5363.463653634644;5408.675479471205;5419.295491586108;4921.778519966574;4936.456989731127;4937.111319962405;4939.876503087416;4940;5719.570107473131;5727.656340619535;5737.856553586152;5741.110127930177;5743.913841292384;4069.97965010176;4109.712320137592;4134.3178375567995;4197.517285512175;4202;5923.407659234085;5937.614055086406;5942.465178133945;5947.910781338283;5992.280926288873;4268.615824575803;4272.295071313199;4275.87172384829;4304.74171549708;4321.833105061616;4075.959240407558;4316.3093904975685;4361.80371883266;4370.21336159488;4371.934420983688;4911.263310503453;4921.138800709861;4928.137575924199;4942.75286235694;4976.701397916137;5822.33043200029;5854.824355269348;5864.472197502245;5867.295924489089;5878.29460464747;1454.2074569359513;1507.796447479598;1508.7703521630056;1509.871660908813;1514.66677330987;952.0907533305815;956.8086382723483;967.9758006049764;971.7667759737612;975.7463059604554;4960.313493412257;4983.700977941335;5003.949960500421;5043.823466178666;5087.26234695967;5264.236685680555;5273.419923808378;5306.204069389622;5316.734163291897;5341.172118321666;4827.831025914146;4991.625628077909;5038.571721403649;5073.771680274396;5093.567046800989;2795.3151477888046;2800.8599570021415;2805.551111822099;2813.423248234107;2827.4627820714;5360.115580929181;5364.034473794754;5383.438802747238;5391.487808658171;5440.972795135999;5027;5249.806882459898;5271.551918086929;5286.444923283077;5290.65610735301;5310.389305229871;5384.384684594606;5416.350037995466;5416.674999500121;5450.991566560199;5190.273361729436;5224.555912747459;5225.58195344364;5261.684298942076;5263.999840030382;4972.477889821516;5060.949390506195;5102.540771330598;5107.974460127675;5197.740112994259;5338.946610533845;5388.272583201375;5431.533485958848;5449.6730196188355;5460.235567020541;3898.9805050974564;3901.4147877818555;3924.3524818404644;3979.184267225154;4087.2438598859308;5425.83722488326;5709.286339207599;5830.329512106162;5865.530757539302;5880.382559831156;5798.768049277982;5803;5833.912491312549;5841.510414844188;5851;5575.247341608993;5798.884022319446;5811.389804070512;5818.6217895836635;5844.415558444121;5725.828225153252;5759.56803239767;5764.827055188351;5781.132830075522;5818.33089194748;5822.388649191774;5843.152742852348;5856.326522449973;5867.501262392744;5874.295084589877;5453.336732296688;5659.54723622101;5662.915056274242;5717.17101020358;5738.254026976467 06:39:27 INFO - PROCESS | 1894 | |5;yui.html;781.1641543548405;790.8536920669673;849.4436144325465;858.6436628799047;898.991010089899;16413;16611.501654950356;17692.38076667317;17707.822921770763;17726.64546709065;16134.435294764686;16320.591985200346;16350.427735029276;16398.508044758677;16405.917970410163;734.6143274780729;749.5615065186872;749.7038669725455;752.6161657554659;874.0472884555833;883.3242569434387;901.8511945528979;901.8827552418177;903.2909166304453;904.5838914099489;946.4415994563207;960.0831206198064;960.5677445149676;960.8750862387915;962.8218779525776;949.6771097826737;950.3015283766426;950.9334346595741;951.3530799056639;952.7427594549503;699.2972063076576;704.4047779626208;704.4681265644457;704.6688056613383;704.7392464788061;15878.60303492422;15898.841011589968;15929.761053584205;15984.120873351962;16065.678686426207;16548;16641.16794160287;16980.660386792195;17199.65600687979;17634.91182544079;13590.728185436335;13626.795598065937;13663.590092297247;13970.371333290026;14021.158730476203;4056.9391459128137;4112.753234805921;4175.31107367284;4199.874003779861;4222.767747773872;85154.5742271291;85896.57051714702;86449;86575.567122164;91704.54147729285;11808.17342786014;11851.762964740657;11968.940155299168;13055.21668699881;13389.464421423034;22108.778912210993;22406.775932240795;22443.438914026952;22472.887635562045;22501.88749056277;8707.346948978726;8756.343274254456;8801.955990220136;8915.955420222857;9117;4684.203685373494;4765.880852978634;4776.95223047772;5077.695338279715;5148.382194136728;3992.121733218687;4168.166366726667;4169.082801783603;4175.373693945932;4178.519470260898;702.2941943347006;724.7499612633633;729.3326606155415;731.2322061835052;745.3440971944763;653.6306986552582;798.5887268056955;803.5982008995502;813.3493205435627;819.1071731812234;10618.84071738909;10896.891031089746;11233.438328083563;11313.547458101748;11895.04839612829;757.3184134279082;779.1312686354787;792.0970094092739;796.5220867479582;846.3567688556741;5118.488151184926;5123.5644970177955;5188.169892817131;5247.658902171346;5253.159494480865;75653.24346756573;122830;125092;129878.35060824636;133076;105639.47180264203;106465;107262;108673.45663271633;110713.44643276893;97843.51078244706;97903.51048244713;98088.50955745319;100122;103760.48119759202;9660.855087173557;9855.605775768889;9874.851877221703;9977.45124018186;10014.799704006025;53767.46232537781;54099;54892.45107549033;55247.17129243145;55633.165502516684;80411.46815700464;83802.58098709711;85034.57482712547;85046;85306;13187;13573.660658483617;13617.659558511117;13645.79531307051;13823.032387732763;12759;12965.092443528862;13416.597502074954;13605.727885442433;14113;13951.511697090553;14275.286235688382;14278.928605357321;14309.499167529086;14461.638459038608;13835.169889806644;13924;14531.346089426213;14970;14994.325255363752;11815.113866460222;12616.49534018629;12862.807057894326;14799.556013319618;14808.925955370154;11239.381833999209;11794.705132371417;11804.940975295069;12291.938540307241;12326.50693972231;10001;11083.501242443948;11577.6526704199;11766.932647958129;12047.939760301142 06:39:27 INFO - PROCESS | 1894 | __end_tp_report 06:39:27 INFO - PROCESS | 1894 | __start_cc_report 06:39:27 INFO - PROCESS | 1894 | _x_x_mozilla_cycle_collect,1018 06:39:27 INFO - PROCESS | 1894 | __end_cc_report 06:39:27 INFO - PROCESS | 1894 | __startTimestamp1474378767855__endTimestamp 06:39:27 INFO - PROCESS | 1894 | 06:39:27 INFO - PROCESS | 1894 | ------- Summary: start ------- 06:39:27 INFO - PROCESS | 1894 | Number of tests: 6 06:39:27 INFO - PROCESS | 1894 | 06:39:27 INFO - PROCESS | 1894 | [#0] dojo.html Cycles:165 Average:5568.97 Median:5817.94 stddev:622.24 (10.7%) stddev-sans-first:595.39 06:39:27 INFO - PROCESS | 1894 | Values: 3185.4 3202.1 3231.0 3238.0 3275.3 5530.8 5633.6 5633.9 5636.2 5664.0 5633.6 5684.9 5695.9 5706.2 5742.7 4979.3 5070.6 5113.6 5141.3 5184.8 5110.0 5191.1 5193.1 5195.2 5197.9 5072.3 5105.2 5130.7 5146.2 5178.3 5218.7 5223.1 5224.5 5230.2 5269.2 4735.6 4983.3 5001.8 5105.0 5108.6 5526.2 5541.4 5567.9 5571.8 5633.4 6042.0 6055.0 6062.6 6064.4 6065.9 5873.6 5952.2 5972.9 6011.5 6081.2 5629.8 5632.5 5632.7 5652.4 5652.8 6124.6 6126.0 6128.1 6133.6 6134.9 5690.3 5738.4 5757.8 5776.6 5841.9 5878.7 5887.2 5887.3 5894.3 5898.4 5848.6 5870.4 5874.0 5874.5 5912.4 5747.5 5921.3 5961.5 5972.0 6020.6 4618.9 4626.0 4628.3 4633.4 4637.0 4069.1 4124.3 4130.2 4131.1 4164.2 5546.8 5574.9 5619.4 5625.3 5628.4 5987.0 5989.6 5991.6 5992.9 6000.3 5652.6 5653.3 5661.3 5665.8 5669.8 5013.3 5100.8 5199.8 5211.3 5292.6 6216.2 6226.1 6265.2 6273.4 6280.7 5989.6 6002.6 6004.2 6007.7 6010.3 6040.8 6048.0 6079.6 6093.3 6102.5 5817.9 5818.6 5822.6 5874.4 5877.6 5916.9 5981.5 5984.3 5991.3 5995.3 5782.2 5849.7 5885.8 5894.1 5990.0 5938.5 5938.5 5940.9 5948.9 5953.9 5875.3 5917.1 5930.2 5932.4 5934.6 5776.1 5842.0 5915.5 5927.5 5975.1 5840.9 5841.6 5846.6 5848.1 5868.4 06:39:27 INFO - PROCESS | 1894 | 06:39:27 INFO - PROCESS | 1894 | [#1] ext.html Cycles:180 Average:66139.68 Median:219732.50 stddev:137122.00 (62.4%) stddev-sans-first:137418.38 06:39:27 INFO - PROCESS | 1894 | Values: 604.5 643.4 667.6 679.6 683.4 33588.2 46800.5 47177.5 47265.5 51482.7 46481.3 46953.1 46975.8 47056.3 47109.5 8422.5 9155.4 9307.9 9308.1 9311.0 10816.8 11121.4 11122.7 11533.9 11534.7 11228.8 11295.7 11337.4 11350.0 11355.6 11010.0 11087.8 11088.2 11091.9 11105.9 11050.5 11120.6 11122.3 11124.3 11130.5 44576.1 44917.6 44974.8 45004.8 45068.0 3882.7 3883.4 4464.9 4532.3 4537.1 35469.8 35531.0 35743.3 35902.0 37471.4 4181.5 4265.3 4281.7 4300.4 4307.5 399533.0 400591.0 401773.0 404794.0 405484.0 64846.4 65271.7 65354.3 65434.0 65498.7 39341.0 39932.0 40038.4 41912.6 42485.6 19661.4 19807.4 19851.7 19862.8 19890.8 13708.2 14500.1 14720.6 15094.7 15210.8 20831.6 20926.2 20930.7 21009.5 21069.5 7424.5 7436.4 7562.0 7568.2 7578.9 1020.8 1094.0 1102.0 1106.0 1168.0 33318.0 35177.8 35214.0 35243.0 35256.6 1172.3 1256.3 1262.2 1262.7 1287.4 17587.3 18648.4 18738.0 18957.2 18958.0 690217.0 694818.0 695431.0 701982.0 702609.0 65963.3 66342.0 66532.7 66575.7 66708.7 1377.2 1450.3 1474.7 1488.2 1496.9 34403.8 36515.4 36709.8 37002.6 37054.3 54584.2 55450.7 55462.7 55566.7 55574.0 318697.0 319215.0 319559.0 319887.0 560576.0 31062.2 31251.7 31259.0 33160.7 33460.5 54088.2 54265.5 54300.2 54879.2 55543.4 43463.0 44545.3 45612.3 46156.3 47731.3 44776.6 45282.8 45825.8 45888.1 46913.1 43776.6 45061.3 46059.5 46120.8 46319.1 37378.8 39765.4 40888.0 40907.2 41460.2 29446.9 30226.4 30336.5 30402.5 30439.7 06:39:27 INFO - PROCESS | 1894 | 06:39:27 INFO - PROCESS | 1894 | [#2] jquery.html Cycles:180 Average:29019.35 Median:2948.13 stddev:80355.85 (2725.7%) stddev-sans-first:80552.57 06:39:27 INFO - PROCESS | 1894 | Values: 418.4 419.7 430.6 434.8 439.6 19020.1 19841.4 20290.5 20577.5 20685.8 19345.8 19662.4 19813.2 19853.6 20054.0 5324.2 5444.6 5469.4 5478.2 5526.9 5329.9 5356.5 5389.6 5420.6 5448.4 5406.7 5422.3 5485.2 5515.8 5559.2 5429.6 5467.5 5553.9 5761.9 5802.4 5669.1 5695.6 5708.1 5717.7 5727.5 14302.0 14593.9 15185.9 15459.8 15509.5 2396.9 2446.9 2545.9 2915.0 2981.2 11197.3 11313.3 11440.3 13609.0 14858.0 1981.9 2079.2 2117.6 2126.6 2176.4 64636.7 70292.3 77644.0 88175.1 94304.5 11609.0 11842.4 11883.9 11896.3 12085.4 17281.3 17300.1 17333.1 17346.5 17355.2 8865.2 9015.5 9017.2 9019.5 9058.7 8678.5 8715.7 8767.2 8861.7 8904.6 5175.1 5186.6 5200.8 5213.0 5325.5 2040.3 2058.5 2136.1 2170.5 2182.5 919.3 943.1 973.0 986.5 1015.4 18880.3 19840.7 19999.2 20654.6 21049.6 1030.4 1059.2 1103.0 1114.0 1153.1 10592.9 11453.1 11526.9 11614.2 11627.8 428524.0 430436.0 435803.0 530881.0 584405.0 92974.0 95847.5 97634.0 99334.5 99525.0 1058.4 1080.8 1104.2 1112.7 1118.6 15984.4 16741.0 18026.5 18208.8 18719.3 42767.6 43091.0 43211.6 43454.3 44938.1 60047.7 60506.4 60785.7 61309.4 61570.4 8303.1 8389.7 8524.5 8782.4 9466.3 12656.0 12759.2 13939.7 13949.5 14175.9 9729.4 9763.3 9776.4 11273.6 11362.3 11889.9 12001.3 12006.9 12169.6 12332.0 10779.7 11154.6 11322.2 11442.8 11498.9 8616.0 8860.2 9091.8 9110.8 9376.2 9039.0 10978.6 11256.6 11309.4 11444.5 06:39:27 INFO - PROCESS | 1894 | 06:39:27 INFO - PROCESS | 1894 | [#3] mootools.html Cycles:180 Average:6185.69 Median:2556.16 stddev:3543.61 (138.6%) stddev-sans-first:3535.08 06:39:27 INFO - PROCESS | 1894 | Values: 1371.0 1562.4 1589.1 1736.2 1843.0 9052.6 9382.9 9491.4 9699.1 9731.1 9563.7 9645.3 9694.5 9700.3 9701.0 2481.0 2513.1 2515.1 2516.5 2519.5 2427.0 2495.1 2498.8 2502.4 2505.1 2423.3 2440.5 2477.3 2479.4 2483.7 2348.8 2401.0 2408.7 2460.1 2465.8 2354.6 2380.3 2385.4 2403.0 2411.0 9320.2 9560.2 9599.3 9629.5 9664.5 5414.2 5520.4 5529.1 5542.9 5547.5 3594.6 3622.7 3655.9 3671.8 3678.2 1228.6 1251.2 1255.2 1276.0 1281.5 12903.3 13022.8 13048.8 13093.0 13121.1 4443.9 4611.7 4718.5 4763.3 4781.6 10306.6 10310.0 10310.2 10312.2 10319.6 5328.8 5346.9 5352.4 5354.3 5354.5 4609.5 4951.0 5018.8 5073.6 5110.8 3964.7 4011.8 4101.5 4110.7 4117.3 1103.0 1105.2 1106.7 1108.3 1119.0 899.6 927.2 945.7 1008.9 1017.4 5939.3 6132.3 6141.3 6315.6 6341.9 464.3 1083.9 1154.9 1154.9 1180.0 4506.7 4648.0 4648.3 4694.8 4695.8 11333.4 11670.5 11684.1 11690.5 11718.9 11342.3 11608.1 11765.4 11780.4 12075.9 8972.6 9144.8 9160.5 9193.1 9208.2 6148.5 6273.3 6337.7 6355.5 6403.1 10391.6 10658.3 10689.5 10700.6 10787.7 10929.1 11016.2 11055.1 11061.0 11096.6 7415.1 7595.7 8224.4 8510.5 8668.3 8938.9 9368.7 9376.0 9383.3 9388.3 8228.4 8312.6 8392.0 8393.1 8396.9 8120.5 8199.4 8237.4 8265.7 8481.4 7704.5 7732.7 7774.1 7780.4 7841.8 5389.0 5469.2 5505.1 5518.3 5667.8 5639.7 5668.7 5723.8 5809.6 5830.0 06:39:27 INFO - PROCESS | 1894 | 06:39:27 INFO - PROCESS | 1894 | [#4] prototype.html Cycles:180 Average:4684.32 Median:5247.59 stddev:1346.10 (25.7%) stddev-sans-first:1309.74 06:39:27 INFO - PROCESS | 1894 | Values: 337.3 339.9 343.8 345.3 346.6 5524.0 5556.9 5558.3 5581.9 5601.4 5245.4 5330.3 5363.8 5379.2 5531.5 4271.0 4290.8 4304.0 4306.1 4311.1 4304.8 4311.4 4321.3 4324.8 4342.8 4082.2 4236.9 4279.8 4294.8 4320.3 4286.6 4296.4 4297.9 4305.4 4316.8 3782.8 3786.1 3797.3 3805.3 3806.4 5237.8 5357.2 5363.5 5408.7 5419.3 4921.8 4936.5 4937.1 4939.9 4940.0 5719.6 5727.7 5737.9 5741.1 5743.9 4070.0 4109.7 4134.3 4197.5 4202.0 5923.4 5937.6 5942.5 5947.9 5992.3 4268.6 4272.3 4275.9 4304.7 4321.8 4076.0 4316.3 4361.8 4370.2 4371.9 4911.3 4921.1 4928.1 4942.8 4976.7 5822.3 5854.8 5864.5 5867.3 5878.3 1454.2 1507.8 1508.8 1509.9 1514.7 952.1 956.8 968.0 971.8 975.7 4960.3 4983.7 5003.9 5043.8 5087.3 5264.2 5273.4 5306.2 5316.7 5341.2 4827.8 4991.6 5038.6 5073.8 5093.6 2795.3 2800.9 2805.6 2813.4 2827.5 5360.1 5364.0 5383.4 5391.5 5441.0 5027.0 5249.8 5271.6 5286.4 5290.7 5310.4 5384.4 5416.4 5416.7 5451.0 5190.3 5224.6 5225.6 5261.7 5264.0 4972.5 5060.9 5102.5 5108.0 5197.7 5338.9 5388.3 5431.5 5449.7 5460.2 3899.0 3901.4 3924.4 3979.2 4087.2 5425.8 5709.3 5830.3 5865.5 5880.4 5798.8 5803.0 5833.9 5841.5 5851.0 5575.2 5798.9 5811.4 5818.6 5844.4 5725.8 5759.6 5764.8 5781.1 5818.3 5822.4 5843.2 5856.3 5867.5 5874.3 5453.3 5659.5 5662.9 5717.2 5738.3 06:39:27 INFO - PROCESS | 1894 | 06:39:27 INFO - PROCESS | 1894 | [#5] yui.html Cycles:180 Average:22594.81 Median:4168.62 stddev:32823.58 (787.4%) stddev-sans-first:32874.79 06:39:27 INFO - PROCESS | 1894 | Values: 781.2 790.9 849.4 858.6 899.0 16413.0 16611.5 17692.4 17707.8 17726.6 16134.4 16320.6 16350.4 16398.5 16405.9 734.6 749.6 749.7 752.6 874.0 883.3 901.9 901.9 903.3 904.6 946.4 960.1 960.6 960.9 962.8 949.7 950.3 950.9 951.4 952.7 699.3 704.4 704.5 704.7 704.7 15878.6 15898.8 15929.8 15984.1 16065.7 16548.0 16641.2 16980.7 17199.7 17634.9 13590.7 13626.8 13663.6 13970.4 14021.2 4056.9 4112.8 4175.3 4199.9 4222.8 85154.6 85896.6 86449.0 86575.6 91704.5 11808.2 11851.8 11968.9 13055.2 13389.5 22108.8 22406.8 22443.4 22472.9 22501.9 8707.3 8756.3 8802.0 8916.0 9117.0 4684.2 4765.9 4777.0 5077.7 5148.4 3992.1 4168.2 4169.1 4175.4 4178.5 702.3 724.7 729.3 731.2 745.3 653.6 798.6 803.6 813.3 819.1 10618.8 10896.9 11233.4 11313.5 11895.0 757.3 779.1 792.1 796.5 846.4 5118.5 5123.6 5188.2 5247.7 5253.2 75653.2 122830.0 125092.0 129878.4 133076.0 105639.5 106465.0 107262.0 108673.5 110713.4 97843.5 97903.5 98088.5 100122.0 103760.5 9660.9 9855.6 9874.9 9977.5 10014.8 53767.5 54099.0 54892.5 55247.2 55633.2 80411.5 83802.6 85034.6 85046.0 85306.0 13187.0 13573.7 13617.7 13645.8 13823.0 12759.0 12965.1 13416.6 13605.7 14113.0 13951.5 14275.3 14278.9 14309.5 14461.6 13835.2 13924.0 14531.3 14970.0 14994.3 11815.1 12616.5 12862.8 14799.6 14808.9 11239.4 11794.7 11804.9 12291.9 12326.5 10001.0 11083.5 11577.7 11766.9 12047.9 06:39:27 INFO - PROCESS | 1894 | -------- Summary: end -------- 06:39:27 INFO - PROCESS | 1894 | 06:39:28 INFO - TEST-INFO | 1894: exit 0 06:39:28 INFO - TEST-OK | dromaeo_css | took 1112934ms 06:39:28 INFO - TEST-START | kraken 06:39:28 INFO - operating with platform_type : linux_ 06:39:28 INFO - Initialising browser for kraken test... 06:39:28 INFO - TEST-INFO | started process 2095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPHBszo/profile http://localhost:45541/getInfo.html) 06:39:32 INFO - PROCESS | 2095 | __metrics Screen width/height:1600/1200 06:39:32 INFO - PROCESS | 2095 | colorDepth:24 06:39:32 INFO - PROCESS | 2095 | Browser inner width/height: 1024/697 06:39:32 INFO - PROCESS | 2095 | __metrics 06:39:33 INFO - PROCESS | 2095 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:39:33 INFO - PROCESS | 2095 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:39:34 INFO - TEST-INFO | 2095: exit 0 06:39:34 INFO - Browser initialized. 06:39:34 INFO - Running cycle 1/1 for kraken test... 06:39:34 INFO - TEST-INFO | started process 2184 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPHBszo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:39:45 INFO - PROCESS | 2184 | RSS: Main: 142987264 06:39:45 INFO - PROCESS | 2184 | 06:39:48 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:45541/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45541/tests/kraken/driver.html?testName=audio-beat-detection) 06:39:49 INFO - PROCESS | 2184 | RSS: Main: 198840320 06:39:49 INFO - PROCESS | 2184 | 06:39:51 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:45541/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45541/tests/kraken/driver.html?testName=audio-dft) 06:39:52 INFO - PROCESS | 2184 | RSS: Main: 182493184 06:39:52 INFO - PROCESS | 2184 | 06:39:55 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:45541/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45541/tests/kraken/driver.html?testName=audio-fft) 06:39:55 INFO - PROCESS | 2184 | RSS: Main: 273432576 06:39:55 INFO - PROCESS | 2184 | 06:39:57 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:45541/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45541/tests/kraken/driver.html?testName=audio-oscillator) 06:39:58 INFO - PROCESS | 2184 | RSS: Main: 179662848 06:39:58 INFO - PROCESS | 2184 | 06:40:00 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:45541/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45541/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:40:01 INFO - PROCESS | 2184 | RSS: Main: 178360320 06:40:01 INFO - PROCESS | 2184 | 06:40:04 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:45541/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45541/tests/kraken/driver.html?testName=imaging-darkroom) 06:40:04 INFO - PROCESS | 2184 | RSS: Main: 215154688 06:40:04 INFO - PROCESS | 2184 | 06:40:08 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:45541/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45541/tests/kraken/driver.html?testName=imaging-desaturate) 06:40:08 INFO - PROCESS | 2184 | RSS: Main: 213757952 06:40:08 INFO - PROCESS | 2184 | 06:40:11 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:45541/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45541/tests/kraken/driver.html?testName=json-parse-financial) 06:40:12 INFO - PROCESS | 2184 | RSS: Main: 212979712 06:40:12 INFO - PROCESS | 2184 | 06:40:13 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:45541/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45541/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:40:14 INFO - PROCESS | 2184 | RSS: Main: 174968832 06:40:14 INFO - PROCESS | 2184 | 06:40:15 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:45541/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45541/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:40:16 INFO - PROCESS | 2184 | RSS: Main: 182910976 06:40:16 INFO - PROCESS | 2184 | 06:40:18 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:45541/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45541/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:40:19 INFO - PROCESS | 2184 | RSS: Main: 184303616 06:40:19 INFO - PROCESS | 2184 | 06:40:21 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:45541/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45541/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:40:22 INFO - PROCESS | 2184 | RSS: Main: 185131008 06:40:22 INFO - PROCESS | 2184 | 06:40:24 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:45541/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45541/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:40:25 INFO - PROCESS | 2184 | RSS: Main: 183050240 06:40:25 INFO - PROCESS | 2184 | 06:40:26 INFO - PROCESS | 2184 | Cycle 1(1): loaded http://localhost:45541/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45541/tests/kraken/driver.html?testName=ai-astar) 06:40:27 INFO - PROCESS | 2184 | RSS: Main: 234106880 06:40:27 INFO - PROCESS | 2184 | 06:40:27 INFO - PROCESS | 2184 | __start_tp_report 06:40:27 INFO - PROCESS | 2184 | _x_x_mozilla_page_load 06:40:27 INFO - PROCESS | 2184 | _x_x_mozilla_page_load_details 06:40:27 INFO - PROCESS | 2184 | |i|pagename|runs| 06:40:27 INFO - PROCESS | 2184 | |0;ai-astar;110;110;120;109;110;110;109;109;109;111 06:40:27 INFO - PROCESS | 2184 | |1;audio-beat-detection;150;118;149;159;116;143;149;123;170;115 06:40:27 INFO - PROCESS | 2184 | |2;audio-dft;162;161;161;162;161;162;161;161;160;159 06:40:27 INFO - PROCESS | 2184 | |3;audio-fft;74;74;73;170;75;76;74;74;176;75 06:40:27 INFO - PROCESS | 2184 | |4;audio-oscillator;83;84;156;84;84;83;141;83;84;151 06:40:27 INFO - PROCESS | 2184 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;117;117 06:40:27 INFO - PROCESS | 2184 | |6;imaging-darkroom;145;145;146;146;145;145;145;146;145;145 06:40:27 INFO - PROCESS | 2184 | |7;imaging-desaturate;94;94;94;94;96;95;94;94;94;94 06:40:27 INFO - PROCESS | 2184 | |8;json-parse-financial;50;49;49;48;49;51;49;49;51;49 06:40:27 INFO - PROCESS | 2184 | |9;json-stringify-tinderbox;59;61;61;60;60;59;60;59;60;70 06:40:27 INFO - PROCESS | 2184 | |10;stanford-crypto-aes;73;73;72;74;77;80;81;75;74;81 06:40:27 INFO - PROCESS | 2184 | |11;stanford-crypto-ccm;127;116;116;116;123;116;127;116;156;122 06:40:27 INFO - PROCESS | 2184 | |12;stanford-crypto-pbkdf2;150;152;151;155;150;151;149;151;157;151 06:40:27 INFO - PROCESS | 2184 | |13;stanford-crypto-sha256-iterative;61;66;61;61;61;60;61;61;61;60 06:40:27 INFO - PROCESS | 2184 | __end_tp_report 06:40:27 INFO - PROCESS | 2184 | __start_cc_report 06:40:27 INFO - PROCESS | 2184 | _x_x_mozilla_cycle_collect,1672 06:40:27 INFO - PROCESS | 2184 | __end_cc_report 06:40:27 INFO - PROCESS | 2184 | __startTimestamp1474378827238__endTimestamp 06:40:27 INFO - PROCESS | 2184 | 06:40:27 INFO - PROCESS | 2184 | ------- Summary: start ------- 06:40:27 INFO - PROCESS | 2184 | Number of tests: 14 06:40:27 INFO - PROCESS | 2184 | 06:40:27 INFO - PROCESS | 2184 | [#0] ai-astar Cycles:10 Average:110.70 Median:110.00 stddev:3.33 (3.0%) stddev-sans-first:3.53 06:40:27 INFO - PROCESS | 2184 | Values: 110.0 110.0 120.0 109.0 110.0 110.0 109.0 109.0 109.0 111.0 06:40:27 INFO - PROCESS | 2184 | 06:40:27 INFO - PROCESS | 2184 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:149.00 stddev:19.72 (13.2%) stddev-sans-first:20.52 06:40:27 INFO - PROCESS | 2184 | Values: 150.0 118.0 149.0 159.0 116.0 143.0 149.0 123.0 170.0 115.0 06:40:27 INFO - PROCESS | 2184 | 06:40:27 INFO - PROCESS | 2184 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 06:40:27 INFO - PROCESS | 2184 | Values: 162.0 161.0 161.0 162.0 161.0 162.0 161.0 161.0 160.0 159.0 06:40:27 INFO - PROCESS | 2184 | 06:40:27 INFO - PROCESS | 2184 | [#3] audio-fft Cycles:10 Average:94.10 Median:74.00 stddev:41.62 (56.2%) stddev-sans-first:43.50 06:40:27 INFO - PROCESS | 2184 | Values: 74.0 74.0 73.0 170.0 75.0 76.0 74.0 74.0 176.0 75.0 06:40:27 INFO - PROCESS | 2184 | 06:40:27 INFO - PROCESS | 2184 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:83.50 stddev:31.97 (38.3%) stddev-sans-first:33.06 06:40:27 INFO - PROCESS | 2184 | Values: 83.0 84.0 156.0 84.0 84.0 83.0 141.0 83.0 84.0 151.0 06:40:27 INFO - PROCESS | 2184 | 06:40:27 INFO - PROCESS | 2184 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:40:27 INFO - PROCESS | 2184 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 06:40:27 INFO - PROCESS | 2184 | 06:40:27 INFO - PROCESS | 2184 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 06:40:27 INFO - PROCESS | 2184 | Values: 145.0 145.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 06:40:27 INFO - PROCESS | 2184 | 06:40:27 INFO - PROCESS | 2184 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 06:40:27 INFO - PROCESS | 2184 | Values: 94.0 94.0 94.0 94.0 96.0 95.0 94.0 94.0 94.0 94.0 06:40:27 INFO - PROCESS | 2184 | 06:40:27 INFO - PROCESS | 2184 | [#8] json-parse-financial Cycles:10 Average:49.40 Median:49.00 stddev:0.97 (2.0%) stddev-sans-first:1.00 06:40:27 INFO - PROCESS | 2184 | Values: 50.0 49.0 49.0 48.0 49.0 51.0 49.0 49.0 51.0 49.0 06:40:27 INFO - PROCESS | 2184 | 06:40:27 INFO - PROCESS | 2184 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:60.00 stddev:3.28 (5.5%) stddev-sans-first:3.41 06:40:27 INFO - PROCESS | 2184 | Values: 59.0 61.0 61.0 60.0 60.0 59.0 60.0 59.0 60.0 70.0 06:40:27 INFO - PROCESS | 2184 | 06:40:27 INFO - PROCESS | 2184 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:76.00 stddev:3.50 (4.6%) stddev-sans-first:3.54 06:40:27 INFO - PROCESS | 2184 | Values: 73.0 73.0 72.0 74.0 77.0 80.0 81.0 75.0 74.0 81.0 06:40:27 INFO - PROCESS | 2184 | 06:40:27 INFO - PROCESS | 2184 | [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:122.50 stddev:12.31 (10.1%) stddev-sans-first:12.99 06:40:27 INFO - PROCESS | 2184 | Values: 127.0 116.0 116.0 116.0 123.0 116.0 127.0 116.0 156.0 122.0 06:40:27 INFO - PROCESS | 2184 | 06:40:27 INFO - PROCESS | 2184 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.70 Median:151.00 stddev:2.45 (1.6%) stddev-sans-first:2.52 06:40:27 INFO - PROCESS | 2184 | Values: 150.0 152.0 151.0 155.0 150.0 151.0 149.0 151.0 157.0 151.0 06:40:27 INFO - PROCESS | 2184 | 06:40:27 INFO - PROCESS | 2184 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.30 Median:61.00 stddev:1.70 (2.8%) stddev-sans-first:1.80 06:40:27 INFO - PROCESS | 2184 | Values: 61.0 66.0 61.0 61.0 61.0 60.0 61.0 61.0 61.0 60.0 06:40:27 INFO - PROCESS | 2184 | -------- Summary: end -------- 06:40:27 INFO - PROCESS | 2184 | 06:40:28 INFO - TEST-INFO | 2184: exit 0 06:40:28 INFO - TEST-OK | kraken | took 59769ms 06:40:28 INFO - SUITE-END | took 1172s 06:40:28 INFO - Completed test suite (00:19:32) 06:40:28 INFO - javascript benchmark 06:40:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3185.362927414517, 3202.103411044908, 3231.030690792763, 3238.028591422573, 3275.29581140055, 5530.778768849246, 5633.6338138021, 5633.943660563393, 5636.210930469727, 5663.971680141593, 5633.6338138021, 5684.943150568493, 5695.943040569603, 5706.1726049722765, 5742.712864356787, 4979.327790748257, 5070.645054846163, 5113.616478764098, 5141.254518094874, 5184.844454666347, 5110.0, 5191.091558977183, 5193.065248255312, 5195.19474481456, 5197.870053248661, 5072.315237442954, 5105.157648987913, 5130.666506677073, 5146.176611742122, 5178.275041494175, 5218.6868787872845, 5223.112070947948, 5224.477552244745, 5230.21546767984, 5269.183276592096, 4735.5974742146955, 4983.277424773424, 5001.824936127255, 5105.0, 5108.565771909355, 5526.198701188305, 5541.418151094117, 5567.8886422271735, 5571.777128914839, 5633.436656334375, 6041.969790151065, 6055.0, 6062.636241825505, 6064.3935606439445, 6065.909011364833, 5873.647581145145, 5952.1964534787685, 5972.850678733023, 6011.5190784737115, 6081.209442772411, 5629.831105066854, 5632.46491583303, 5632.662040277596, 5652.434756524356, 5652.802151924704, 6124.6325220486915, 6126.019836826086, 6128.142060111588, 6133.601315914451, 6134.9079763803575, 5690.2887139107615, 5738.426157384311, 5757.769689212469, 5776.566757493205, 5841.9415805842245, 5878.706064696748, 5887.2052272943465, 5887.264091988502, 5894.32215295238, 5898.380670029671, 5848.64908105515, 5870.442307980735, 5874.0, 5874.530037597067, 5912.379200184005, 5747.453991870766, 5921.348651648315, 5961.5230781537375, 5971.970140149271, 6020.57855950088, 4618.861434156914, 4626.0, 4628.305754136839, 4633.351330813689, 4637.0, 4069.1454794492897, 4124.340105583093, 4130.173965206971, 4131.132462182915, 4164.187983343219, 5546.7781288748, 5574.916376254359, 5619.438056194348, 5625.268715067015, 5628.409017053233, 5987.042073268256, 5989.580729348991, 5991.64050156992, 5992.910106348409, 6000.279966404059, 5652.576056795757, 5653.265075540236, 5661.2923384576925, 5665.773369065191, 5669.773209071591, 5013.323201367769, 5100.846974590768, 5199.844004679866, 5211.270422140903, 5292.603054770908, 6216.191895053705, 6226.097215903759, 6265.185525881606, 6273.37266273369, 6280.748770049238, 5989.580729348903, 6002.579819412599, 6004.219451471281, 6007.729652165575, 6010.308814486215, 6040.788572399945, 6048.032314829607, 6079.574429789872, 6093.329733729198, 6102.4507794298725, 5817.941820581909, 5818.6217895836635, 5822.5633077518505, 5874.353821079592, 5877.647341159544, 5916.881662366643, 5981.461668449861, 5984.251968503937, 5991.281046274475, 5995.280566332068, 5782.190493330853, 5849.707514624337, 5885.823425297248, 5894.086416605433, 5990.041593345044, 5938.465538101592, 5938.524918006463, 5940.940590594038, 5948.851278717893, 5953.91069133972, 5875.3243377012195, 5917.142014407973, 5930.199423077829, 5932.377100404396, 5934.643921364732, 5776.075827867521, 5841.970790146022, 5915.526757859447, 5927.466528012327, 5975.133605627073, 5840.853978650568, 5841.620294680833, 5846.590738648254, 5848.064309710426, 5868.413158684098], "value": 5527.270595497431, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.5043064686955, 643.3887806583746, 667.6294656465662, 679.6465837764359, 683.3815397065657, 33588.16029599261, 46800.531994680045, 47177.528224717746, 47265.527344726586, 51482.742586287015, 46481.30278045832, 46953.06093878121, 46975.76512117443, 47056.29415558761, 47109.52890471103, 8422.49465032097, 9155.404898681598, 9307.906920930805, 9308.069193080672, 9311.0, 10816.837747433794, 11121.388323642197, 11122.721931951726, 11533.884661153365, 11534.711632209179, 11228.831567526453, 11295.661130166067, 11337.37644429556, 11350.035247004014, 11355.602553910614, 11010.0, 11087.83368249477, 11088.2238243323, 11091.889081109206, 11105.888941110567, 11050.502727377287, 11120.61077862271, 11122.332660040343, 11124.276922000125, 11130.49912753928, 44576.10847783059, 44917.550824491664, 44974.775126124485, 45004.774976125234, 45068.0, 3882.7282090253693, 3883.3980732986433, 4464.933026004613, 4532.252178390561, 4537.115262523809, 35469.82265088684, 35531.0, 35743.28513429743, 35902.0, 37471.43792843109, 4181.540030596632, 4265.253580623378, 4281.743095414254, 4300.35494675798, 4307.5261721210645, 399533.0, 400591.0, 401772.99113504536, 404794.0, 405484.0, 64846.35153648403, 65271.67364163149, 65354.346456534826, 65434.0, 65498.67250663811, 39341.0, 39932.0, 40038.39942400866, 41912.58087419148, 42485.57514424878, 19661.410157695293, 19807.405777826687, 19851.702224466644, 19862.801371986385, 19890.801091989186, 13708.17750934927, 14500.057496262709, 14720.558383248519, 15094.698106037818, 15210.771838422432, 20831.583368332547, 20926.162953481995, 20930.686039709417, 21009.474763131046, 21069.47326316824, 7424.517406368569, 7436.3679087277105, 7562.0, 7568.167501574822, 7578.886316705254, 1020.8315627921459, 1093.9617113400993, 1101.983470247947, 1105.9668209953713, 1167.9532818687328, 33318.0, 35177.82411087928, 35214.0, 35243.0, 35256.64743352534, 1172.2731906218198, 1256.3341429042623, 1262.2048109690836, 1262.7158889249845, 1287.3884904670394, 17587.29650813953, 18648.44054678362, 18738.0, 18957.24171033171, 18958.0, 690217.0, 694818.0, 695431.0, 701982.0, 702609.0, 65963.34036659668, 66342.0, 66532.66733666301, 66575.66848663097, 66708.6664566674, 1377.2081053394338, 1450.3111022264552, 1474.675571374296, 1488.2038109611522, 1496.940122395092, 34403.82798085993, 36515.35680894313, 36709.81645091758, 37002.629973701, 37054.258914822094, 54584.18123728068, 55450.72274638601, 55462.72268638631, 55566.72216638891, 55574.0, 318697.0, 319215.0, 319559.0, 319887.0, 560576.0, 31062.22344441407, 31251.68748312488, 31259.0, 33160.668393315755, 33460.49809252814, 54088.188677169084, 54265.45734542604, 54300.185497218365, 54879.17681234705, 55543.44456555383, 43463.0, 44545.331820022075, 45612.31581526213, 46156.30765538587, 47731.28403074026, 44776.55223447724, 45282.77358613186, 45825.770871146764, 45888.08223835572, 46913.06173876572, 43776.56223437725, 45061.32408013948, 46059.53940460552, 46120.769396152806, 46319.07361852811, 37378.8131059343, 39765.40351894666, 40888.0, 40907.18185636211, 41460.170796584505, 29446.852765736036, 30226.395472090873, 30336.54495182618, 30402.54396184103, 30439.695603043685], "value": 22107.934017074913, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.43302325349134, 419.67475206714795, 430.60384446309394, 434.7978190141584, 439.5823967231131, 19020.14409351579, 19841.40475785725, 20290.492737681565, 20577.485562860937, 20685.793142068575, 19345.806541934577, 19662.410127696156, 19813.20747170115, 19853.60292794147, 20054.0, 5324.174752913295, 5444.646098003637, 5469.371022332423, 5478.205660179272, 5526.917096243559, 5329.893402131955, 5356.517913387795, 5389.649672771257, 5420.566354691615, 5448.42791506892, 5406.729663516828, 5422.349318081816, 5485.177223416499, 5515.779368825242, 5559.249501317331, 5429.592780541456, 5467.535259502927, 5553.916691249614, 5761.884762304772, 5802.361740208574, 5669.0646043402785, 5695.572832037614, 5708.1437784332265, 5717.742701578397, 5727.455891690282, 14302.0, 14593.854061459355, 15185.924070379688, 15459.845401546065, 15509.534713958486, 2396.892139853711, 2446.938826529351, 2545.885435155404, 2915.023467138511, 2981.2397838551033, 11197.328160310408, 11313.264637798598, 11440.256383335056, 13609.047366684335, 14858.0, 1981.9306324278582, 2079.189116244666, 2117.5658989907033, 2126.64910289802, 2176.4232478393237, 64636.676816616084, 70292.29707702908, 77644.0, 88175.11824881734, 94304.52847735786, 11609.0, 11842.407879605986, 11883.940580297216, 11896.345700986529, 12085.395730213455, 17281.308747650204, 17300.096989331163, 17333.13334333278, 17346.47960561185, 17355.21901514435, 8865.157810008039, 9015.549222538846, 9017.188453039258, 9019.458832470073, 9058.728238152735, 8678.47929124242, 8715.651373944971, 8767.21095101444, 8861.689840855539, 8904.643814247487, 5175.06848767218, 5186.5850731941355, 5200.817971370984, 5212.973935130376, 5325.4940780625775, 2040.3266921915733, 2058.4956685611824, 2136.1135128921633, 2170.4682352823343, 2182.4652960024896, 919.3242966419676, 943.1417410156724, 972.9854052189223, 986.452518852044, 1015.3806178231273, 18880.33918812835, 19840.702389464168, 19999.200031998556, 20654.58690826175, 21049.579008419747, 1030.350878946274, 1059.2267644619471, 1103.038342051594, 1114.0474893965543, 1153.0544953138515, 10592.947035264928, 11453.14101442395, 11526.904944030304, 11614.187006909604, 11627.76744465106, 428524.0, 430436.0, 435803.0, 530881.0, 584405.0, 92974.0, 95847.52076239714, 97634.0, 99334.50332748434, 99525.0, 1058.4125810175274, 1080.8378743188584, 1104.1994553948323, 1112.6773235761539, 1118.6420345489366, 15984.440544581348, 16741.0, 18026.459206223833, 18208.817911821243, 18719.25122995065, 42767.572324276356, 43091.0, 43211.56788432076, 43454.34818477789, 44938.101237974406, 60047.69976150091, 60506.39493605008, 60785.696071519356, 61309.38690613215, 61570.384296158256, 8303.086660467223, 8389.706360277605, 8524.488530688179, 8782.429142105742, 9466.337356384987, 12656.0, 12759.234445933274, 13939.651508712363, 13949.511767088103, 14175.858241417454, 9729.416235025921, 9763.316567840468, 9776.413415195111, 11273.605423810128, 11362.318260904372, 11889.940550297193, 12001.279923204636, 12006.939965300118, 12169.57406490804, 12332.013438924685, 10779.730506737395, 11154.553817847196, 11322.207445479067, 11442.82835757481, 11498.885011150116, 8615.956920215609, 8860.202581767671, 9091.772705682411, 9110.817783644423, 9376.156145946898, 9038.954805225932, 10978.560857565608, 11256.606018789631, 11309.377984210947, 11444.484998174936], "value": 9428.083447864037, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.9794353084712, 1562.3594326326206, 1589.133922012503, 1736.2273788164264, 1842.9907850460745, 9052.637894484222, 9382.85925711114, 9491.383060101089, 9699.07858753419, 9731.124198822105, 9563.665271715492, 9645.324827262095, 9694.466804325759, 9700.272479564042, 9701.029897010312, 2480.9627855582135, 2513.1078467144175, 2515.0945659562544, 2516.471540976397, 2519.4583164619603, 2426.9878650606724, 2495.1142344467635, 2498.750124987496, 2502.36189771608, 2505.110685706575, 2423.309356833303, 2440.5240978009297, 2477.343503971449, 2479.429731161834, 2483.689538807649, 2348.800351970076, 2400.95198096038, 2408.7350391456926, 2460.138951367025, 2465.839720418167, 2354.587947109249, 2380.2859142257425, 2385.4155731845635, 2403.0, 2410.987945060281, 9320.16118549327, 9560.235181185559, 9599.32804703671, 9629.470379129145, 9664.468454235015, 5414.242006119146, 5520.392756796749, 5529.142982837627, 5542.944570554324, 5547.5007249347755, 3594.622564630702, 3622.7464077514583, 3655.8903232903053, 3671.7796932183887, 3678.1907980244305, 1228.6068458093414, 1251.186728626391, 1255.152771878978, 1275.9855914547957, 1281.51943021367, 12903.290319032449, 13022.804657930139, 13048.804267935988, 13093.0, 13121.147125436815, 4443.888902777457, 4611.677182597186, 4718.504557021532, 4763.309320148628, 4781.593564546983, 10306.608607837996, 10310.020548047924, 10310.175185985103, 10312.175025997902, 10319.638812641522, 5328.760205790749, 5346.91979620306, 5352.357717073976, 5354.303940487712, 5354.491323324278, 4609.516000819933, 4950.950490495121, 5018.824341148115, 5073.594112470993, 5110.8466745997675, 3964.742291751027, 4011.8194681239415, 4101.52832424269, 4110.712250142461, 4117.341225403921, 1102.9779404412027, 1105.1766434006715, 1106.6569363497342, 1108.257467496779, 1118.983215251772, 899.5682072605056, 927.1840780113457, 945.7446489447948, 1008.9456517938771, 1017.3743147964096, 5939.346671866091, 6132.294786099566, 6141.293751218667, 6315.5579109462815, 6341.936580634135, 464.32208974896355, 1083.9349639021684, 1154.861416629993, 1154.8729639739622, 1180.0323734537596, 4506.729596224237, 4648.000679853848, 4648.279516674921, 4694.812207511662, 4695.835645752382, 11333.433328333715, 11670.474828632732, 11684.065274778168, 11690.47392867323, 11718.941405292919, 11342.262752921033, 11608.129390295762, 11765.411729413667, 11780.352080635646, 12075.879241207651, 8972.551372431482, 9144.771380715536, 9160.45037297751, 9193.126652967958, 9208.171264586219, 6148.538859585638, 6273.341299163704, 6337.65142917144, 6355.491560675227, 6403.135576697086, 10391.636292729718, 10658.253922225369, 10689.51897164614, 10700.571977120828, 10787.67636970892, 10929.125669946226, 11016.17378696617, 11055.115590752881, 11061.0, 11096.5561377544, 7415.147258065176, 7595.696172153052, 8224.424290299861, 8510.48937063778, 8668.306535477273, 8938.910610893809, 9368.718938431857, 9376.0, 9383.296252780932, 9388.295877809054, 8228.424010319459, 8312.584370781558, 8391.95804020976, 8393.118722534291, 8396.916030839613, 8120.472169308976, 8199.42604017713, 8237.382196335178, 8265.669373225004, 8481.40630155883, 7704.537727736354, 7732.729354472566, 7774.105977812624, 7780.416468764978, 7841.764747057598, 5388.973055134699, 5469.234307197075, 5505.064139096283, 5518.33779946409, 5667.801626943037, 5639.7180140993605, 5668.659880407189, 5723.771049157987, 5809.593328466966, 5829.950608890441], "value": 4912.3255072914735, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.2613975393887, 339.9173631982137, 343.833240878174, 345.2542508182325, 346.6204506065857, 5523.978064058147, 5556.888862222753, 5558.277423934893, 5581.8604534886645, 5601.411851755568, 5245.370555533332, 5330.307060082194, 5363.839084827452, 5379.166229234465, 5531.502164805167, 4270.97864510677, 4290.76400797956, 4304.0, 4306.138772245547, 4311.060022989659, 4304.806283717225, 4311.439512863323, 4321.330193819963, 4324.82700691972, 4342.761148136851, 4082.2447847148223, 4236.872893813191, 4279.764612946286, 4294.828206871722, 4320.330348795942, 4286.592773686495, 4296.355546667994, 4297.871063868089, 4305.440292761937, 4316.805743741539, 3782.8486860525545, 3786.110264087937, 3797.3354662934153, 3805.296020236265, 3806.371948628473, 5237.790488380499, 5357.223202635635, 5363.463653634644, 5408.675479471205, 5419.295491586108, 4921.778519966574, 4936.456989731127, 4937.111319962405, 4939.876503087416, 4940.0, 5719.570107473131, 5727.656340619535, 5737.856553586152, 5741.110127930177, 5743.913841292384, 4069.97965010176, 4109.712320137592, 4134.3178375567995, 4197.517285512175, 4202.0, 5923.407659234085, 5937.614055086406, 5942.465178133945, 5947.910781338283, 5992.280926288873, 4268.615824575803, 4272.295071313199, 4275.87172384829, 4304.74171549708, 4321.833105061616, 4075.959240407558, 4316.3093904975685, 4361.80371883266, 4370.21336159488, 4371.934420983688, 4911.263310503453, 4921.138800709861, 4928.137575924199, 4942.75286235694, 4976.701397916137, 5822.33043200029, 5854.824355269348, 5864.472197502245, 5867.295924489089, 5878.29460464747, 1454.2074569359513, 1507.796447479598, 1508.7703521630056, 1509.871660908813, 1514.66677330987, 952.0907533305815, 956.8086382723483, 967.9758006049764, 971.7667759737612, 975.7463059604554, 4960.313493412257, 4983.700977941335, 5003.949960500421, 5043.823466178666, 5087.26234695967, 5264.236685680555, 5273.419923808378, 5306.204069389622, 5316.734163291897, 5341.172118321666, 4827.831025914146, 4991.625628077909, 5038.571721403649, 5073.771680274396, 5093.567046800989, 2795.3151477888046, 2800.8599570021415, 2805.551111822099, 2813.423248234107, 2827.4627820714, 5360.115580929181, 5364.034473794754, 5383.438802747238, 5391.487808658171, 5440.972795135999, 5027.0, 5249.806882459898, 5271.551918086929, 5286.444923283077, 5290.65610735301, 5310.389305229871, 5384.384684594606, 5416.350037995466, 5416.674999500121, 5450.991566560199, 5190.273361729436, 5224.555912747459, 5225.58195344364, 5261.684298942076, 5263.999840030382, 4972.477889821516, 5060.949390506195, 5102.540771330598, 5107.974460127675, 5197.740112994259, 5338.946610533845, 5388.272583201375, 5431.533485958848, 5449.6730196188355, 5460.235567020541, 3898.9805050974564, 3901.4147877818555, 3924.3524818404644, 3979.184267225154, 4087.2438598859308, 5425.83722488326, 5709.286339207599, 5830.329512106162, 5865.530757539302, 5880.382559831156, 5798.768049277982, 5803.0, 5833.912491312549, 5841.510414844188, 5851.0, 5575.247341608993, 5798.884022319446, 5811.389804070512, 5818.6217895836635, 5844.415558444121, 5725.828225153252, 5759.56803239767, 5764.827055188351, 5781.132830075522, 5818.33089194748, 5822.388649191774, 5843.152742852348, 5856.326522449973, 5867.501262392744, 5874.295084589877, 5453.336732296688, 5659.54723622101, 5662.915056274242, 5717.17101020358, 5738.254026976467], "value": 4259.365652412815, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.1641543548405, 790.8536920669673, 849.4436144325465, 858.6436628799047, 898.991010089899, 16413.0, 16611.501654950356, 17692.38076667317, 17707.822921770763, 17726.64546709065, 16134.435294764686, 16320.591985200346, 16350.427735029276, 16398.508044758677, 16405.917970410163, 734.6143274780729, 749.5615065186872, 749.7038669725455, 752.6161657554659, 874.0472884555833, 883.3242569434387, 901.8511945528979, 901.8827552418177, 903.2909166304453, 904.5838914099489, 946.4415994563207, 960.0831206198064, 960.5677445149676, 960.8750862387915, 962.8218779525776, 949.6771097826737, 950.3015283766426, 950.9334346595741, 951.3530799056639, 952.7427594549503, 699.2972063076576, 704.4047779626208, 704.4681265644457, 704.6688056613383, 704.7392464788061, 15878.60303492422, 15898.841011589968, 15929.761053584205, 15984.120873351962, 16065.678686426207, 16548.0, 16641.16794160287, 16980.660386792195, 17199.65600687979, 17634.91182544079, 13590.728185436335, 13626.795598065937, 13663.590092297247, 13970.371333290026, 14021.158730476203, 4056.9391459128137, 4112.753234805921, 4175.31107367284, 4199.874003779861, 4222.767747773872, 85154.5742271291, 85896.57051714702, 86449.0, 86575.567122164, 91704.54147729285, 11808.17342786014, 11851.762964740657, 11968.940155299168, 13055.21668699881, 13389.464421423034, 22108.778912210993, 22406.775932240795, 22443.438914026952, 22472.887635562045, 22501.88749056277, 8707.346948978726, 8756.343274254456, 8801.955990220136, 8915.955420222857, 9117.0, 4684.203685373494, 4765.880852978634, 4776.95223047772, 5077.695338279715, 5148.382194136728, 3992.121733218687, 4168.166366726667, 4169.082801783603, 4175.373693945932, 4178.519470260898, 702.2941943347006, 724.7499612633633, 729.3326606155415, 731.2322061835052, 745.3440971944763, 653.6306986552582, 798.5887268056955, 803.5982008995502, 813.3493205435627, 819.1071731812234, 10618.84071738909, 10896.891031089746, 11233.438328083563, 11313.547458101748, 11895.04839612829, 757.3184134279082, 779.1312686354787, 792.0970094092739, 796.5220867479582, 846.3567688556741, 5118.488151184926, 5123.5644970177955, 5188.169892817131, 5247.658902171346, 5253.159494480865, 75653.24346756573, 122830.0, 125092.0, 129878.35060824636, 133076.0, 105639.47180264203, 106465.0, 107262.0, 108673.45663271633, 110713.44643276893, 97843.51078244706, 97903.51048244713, 98088.50955745319, 100122.0, 103760.48119759202, 9660.855087173557, 9855.605775768889, 9874.851877221703, 9977.45124018186, 10014.799704006025, 53767.46232537781, 54099.0, 54892.45107549033, 55247.17129243145, 55633.165502516684, 80411.46815700464, 83802.58098709711, 85034.57482712547, 85046.0, 85306.0, 13187.0, 13573.660658483617, 13617.659558511117, 13645.79531307051, 13823.032387732763, 12759.0, 12965.092443528862, 13416.597502074954, 13605.727885442433, 14113.0, 13951.511697090553, 14275.286235688382, 14278.928605357321, 14309.499167529086, 14461.638459038608, 13835.169889806644, 13924.0, 14531.346089426213, 14970.0, 14994.325255363752, 11815.113866460222, 12616.49534018629, 12862.807057894326, 14799.556013319618, 14808.925955370154, 11239.381833999209, 11794.705132371417, 11804.940975295069, 12291.938540307241, 12326.50693972231, 10001.0, 11083.501242443948, 11577.6526704199, 11766.932647958129, 12047.939760301142], "value": 8175.882625680817, "unit": "score"}], "name": "dromaeo_css", "value": 7628.676517354197, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 120.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 111.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 118.0, 149.0, 159.0, 116.0, 143.0, 149.0, 123.0, 170.0, 115.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 160.0, 159.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 170.0, 75.0, 76.0, 74.0, 74.0, 176.0, 75.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 156.0, 84.0, 84.0, 83.0, 141.0, 83.0, 84.0, 151.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 96.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 48.0, 49.0, 51.0, 49.0, 49.0, 51.0, 49.0], "value": 49.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 61.0, 60.0, 60.0, 59.0, 60.0, 59.0, 60.0, 70.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 72.0, 74.0, 77.0, 80.0, 81.0, 75.0, 74.0, 81.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 116.0, 116.0, 116.0, 123.0, 116.0, 127.0, 116.0, 156.0, 122.0], "value": 123.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 151.0, 155.0, 150.0, 151.0, 149.0, 151.0, 157.0, 151.0], "value": 151.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 66.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 60.0], "value": 61.3, "unit": "score"}], "name": "kraken", "value": 1487.4999999999998, "alertThreshold": 2.0}]} 06:40:28 INFO - Return code: 0 06:40:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:40:28 INFO - # TBPL SUCCESS # 06:40:28 INFO - Running post-action listener: _resource_record_post_action 06:40:28 INFO - [mozharness: 2016-09-20 13:40:28.528115Z] Finished run-tests step (success) 06:40:28 INFO - Running post-run listener: _resource_record_post_run 06:40:28 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290447360; Read time: 20; Write time: 154212 06:40:28 INFO - TinderboxPrint: CPU usage
13.0% 06:40:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 06:40:28 INFO - TinderboxPrint: I/O write bytes / time
290,447,360 / 154,212 06:40:28 INFO - TinderboxPrint: CPU idle
8,244.8 (87.0%) 06:40:28 INFO - TinderboxPrint: CPU user
1,187.1 (12.5%) 06:40:28 INFO - TinderboxPrint: Swap in / out
0 / 0 06:40:28 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 70074368; Read time: 0; Write time: 52048 06:40:28 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 219799552; Read time: 0; Write time: 102156 06:40:29 INFO - Running post-run listener: _upload_blobber_files 06:40:29 INFO - Blob upload gear active. 06:40:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:40:29 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 06:40:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:40:29 INFO - (blobuploader) - INFO - Open directory for files ... 06:40:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:40:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:40:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:40:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:40:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:40:33 INFO - (blobuploader) - INFO - Done attempting. 06:40:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:40:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:40:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:40:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:40:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:40:34 INFO - (blobuploader) - INFO - Done attempting. 06:40:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:40:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:40:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:40:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:40:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:40:35 INFO - (blobuploader) - INFO - Done attempting. 06:40:35 INFO - (blobuploader) - INFO - Iteration through files over. 06:40:35 INFO - Return code: 0 06:40:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:40:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:40:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e1e0d63c99f1e2941e22e3f47df2dcc329aa7cafd9469ee59c2266dc64fb9c37c542fa811937406d4b71f8d9f6a72c6e7db90f47dce940e2a013b48cb2ec32e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dfd513fddac297736872f6481f61bac718b52d74f119d0f8202a8fd9894c874f7bedc654761101199aca5b224a7b330184ac7cd4b9bc576038093bdb6c8c5040", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/de52e66305bca1ef551671fa038367b090353985addddd53891d538f2f8536157a746a92791e407cf9c3a69b07c6a95d508002c952e25ad7f0c7f5030aa9ea31"} 06:40:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:40:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:40:35 INFO - Contents: 06:40:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e1e0d63c99f1e2941e22e3f47df2dcc329aa7cafd9469ee59c2266dc64fb9c37c542fa811937406d4b71f8d9f6a72c6e7db90f47dce940e2a013b48cb2ec32e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dfd513fddac297736872f6481f61bac718b52d74f119d0f8202a8fd9894c874f7bedc654761101199aca5b224a7b330184ac7cd4b9bc576038093bdb6c8c5040", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/de52e66305bca1ef551671fa038367b090353985addddd53891d538f2f8536157a746a92791e407cf9c3a69b07c6a95d508002c952e25ad7f0c7f5030aa9ea31"} 06:40:35 INFO - Running post-run listener: copy_logs_to_upload_dir 06:40:35 INFO - Copying logs to upload dir... 06:40:35 INFO - mkdir: /builds/slave/test/build/upload/logs 06:40:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1675.173743 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 55 secs) (at 2016-09-20 06:40:35.022916) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-20 06:40:35.026462) ========= 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=41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e1e0d63c99f1e2941e22e3f47df2dcc329aa7cafd9469ee59c2266dc64fb9c37c542fa811937406d4b71f8d9f6a72c6e7db90f47dce940e2a013b48cb2ec32e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dfd513fddac297736872f6481f61bac718b52d74f119d0f8202a8fd9894c874f7bedc654761101199aca5b224a7b330184ac7cd4b9bc576038093bdb6c8c5040", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/de52e66305bca1ef551671fa038367b090353985addddd53891d538f2f8536157a746a92791e407cf9c3a69b07c6a95d508002c952e25ad7f0c7f5030aa9ea31"} build_url:https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/M42KM2cFRROVJR6SHLzzNA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e1e0d63c99f1e2941e22e3f47df2dcc329aa7cafd9469ee59c2266dc64fb9c37c542fa811937406d4b71f8d9f6a72c6e7db90f47dce940e2a013b48cb2ec32e4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dfd513fddac297736872f6481f61bac718b52d74f119d0f8202a8fd9894c874f7bedc654761101199aca5b224a7b330184ac7cd4b9bc576038093bdb6c8c5040", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/de52e66305bca1ef551671fa038367b090353985addddd53891d538f2f8536157a746a92791e407cf9c3a69b07c6a95d508002c952e25ad7f0c7f5030aa9ea31"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-20 06:40:35.051782) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 06:40:35.052126) ========= 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=41a7e32711b8e08598a63237000001d6-1474377157.861200-628985674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 06:40:35.136420) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-20 06:40:35.136927) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-20 06:40:35.137432) ========= ========= Total master_lag: 0.17 =========