builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1476913642.57 results: success (0) buildid: 20161019120023 builduid: 1e2814078e4e497eae85f50656771125 revision: 0c46713f5b17e943e39866326bd040f639364b8e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 14:47:22.570287) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 14:47:22.570797) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 14:47:22.571075) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 14:47:22.585947) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:47:22.586419) ========= 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=8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-19 14:47:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-10-19 14:47:22 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.072380 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:47:22.672799) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:47:22.673115) ========= 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=8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018195 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 14:47:22.722658) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 14:47:22.723006) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0c46713f5b17e943e39866326bd040f639364b8e --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 0c46713f5b17e943e39866326bd040f639364b8e --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=8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-19 14:47:22,754 truncating revision to first 12 chars 2016-10-19 14:47:22,754 Setting DEBUG logging. 2016-10-19 14:47:22,754 attempt 1/10 2016-10-19 14:47:22,754 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0c46713f5b17?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 14:47:23,395 unpacking tar archive at: mozilla-beta-0c46713f5b17/testing/mozharness/ program finished with exit code 0 elapsedTime=0.992007 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 14:47:23.729112) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 14:47:23.729442) ========= script_repo_revision: 0c46713f5b17e943e39866326bd040f639364b8e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 14:47:23.729855) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 14:47:23.730122) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 14:47:23.739971) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-10-19 14:47:23.740398) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:47:23 INFO - MultiFileLogger online at 20161019 14:47:23 in /builds/slave/test 14:47:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:47:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:47:23 INFO - {'append_to_log': False, 14:47:23 INFO - 'base_work_dir': '/builds/slave/test', 14:47:23 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:47:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:47:23 INFO - 'branch': 'Mozilla-Beta', 14:47:23 INFO - 'buildbot_json_path': 'buildprops.json', 14:47:23 INFO - 'config_files': ('talos/linux_config.py',), 14:47:23 INFO - 'default_actions': ('clobber', 14:47:23 INFO - 'read-buildbot-config', 14:47:23 INFO - 'download-and-extract', 14:47:23 INFO - 'populate-webroot', 14:47:23 INFO - 'create-virtualenv', 14:47:23 INFO - 'install', 14:47:23 INFO - 'run-tests'), 14:47:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:47:23 INFO - 'download_minidump_stackwalk': True, 14:47:23 INFO - 'download_symbols': 'ondemand', 14:47:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:47:23 INFO - 'tooltool.py': '/tools/tooltool.py', 14:47:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:47:23 INFO - '/tools/misc-python/virtualenv.py')}, 14:47:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:47:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:47:23 INFO - 'installer_path': 'installer.exe', 14:47:23 INFO - 'log_level': 'info', 14:47:23 INFO - 'log_name': 'talos', 14:47:23 INFO - 'log_to_console': True, 14:47:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:47:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:47:23 INFO - 'opt_config_files': (), 14:47:23 INFO - 'pip_index': False, 14:47:23 INFO - 'sps_profile': False, 14:47:23 INFO - 'sps_profile_interval': 0, 14:47:23 INFO - 'suite': 'dromaeojs-e10s', 14:47:23 INFO - 'system_bits': '32', 14:47:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:47:23 INFO - 'title': 'talos-linux64-ix-001', 14:47:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:47:23 INFO - 'use_talos_json': True, 14:47:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:47:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:47:23 INFO - 'work_dir': 'build'} 14:47:23 INFO - [mozharness: 2016-10-19 21:47:23.865418Z] Running clobber step. 14:47:23 INFO - Running pre-action listener: _resource_record_pre_action 14:47:23 INFO - Running main action method: clobber 14:47:23 INFO - rmtree: /builds/slave/test/build 14:47:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:47:24 INFO - Running post-action listener: _resource_record_post_action 14:47:24 INFO - [mozharness: 2016-10-19 21:47:24.314611Z] Finished clobber step (success) 14:47:24 INFO - [mozharness: 2016-10-19 21:47:24.314709Z] Running read-buildbot-config step. 14:47:24 INFO - Running pre-action listener: _resource_record_pre_action 14:47:24 INFO - Running main action method: read_buildbot_config 14:47:24 INFO - Using buildbot properties: 14:47:24 INFO - { 14:47:24 INFO - "project": "", 14:47:24 INFO - "product": "firefox", 14:47:24 INFO - "script_repo_revision": "production", 14:47:24 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 14:47:24 INFO - "repository": "", 14:47:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 14:47:24 INFO - "buildid": "20161019120023", 14:47:24 INFO - "pgo_build": "True", 14:47:24 INFO - "basedir": "/builds/slave/test", 14:47:24 INFO - "buildnumber": 291, 14:47:24 INFO - "slavename": "talos-linux64-ix-001", 14:47:24 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:47:24 INFO - "platform": "ubuntu64_hw", 14:47:24 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:47:24 INFO - "branch": "mozilla-beta", 14:47:24 INFO - "repo_path": "releases/mozilla-beta", 14:47:24 INFO - "revision": "0c46713f5b17e943e39866326bd040f639364b8e", 14:47:24 INFO - "stage_platform": "linux64-pgo", 14:47:24 INFO - "builduid": "1e2814078e4e497eae85f50656771125", 14:47:24 INFO - "slavebuilddir": "test" 14:47:24 INFO - } 14:47:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 14:47:24 INFO - Running post-action listener: _resource_record_post_action 14:47:24 INFO - [mozharness: 2016-10-19 21:47:24.317187Z] Finished read-buildbot-config step (success) 14:47:24 INFO - [mozharness: 2016-10-19 21:47:24.317276Z] Running download-and-extract step. 14:47:24 INFO - Running pre-action listener: _resource_record_pre_action 14:47:24 INFO - Running main action method: download_and_extract 14:47:24 INFO - mkdir: /builds/slave/test/build/tests 14:47:24 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')]} 14:47:24 INFO - https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:47:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 14:47:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 14:47:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:47:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:47:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 14:47:24 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:47:24 INFO - retry: Failed, sleeping 30 seconds before retrying 14:47:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:47:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 14:47:54 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:47:54 INFO - retry: Failed, sleeping 60 seconds before retrying 14:48:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:48:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 14:48:54 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:48:54 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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! 14:48:54 INFO - Caught exception: HTTP Error 404: Not Found 14:48:54 INFO - Caught exception: HTTP Error 404: Not Found 14:48:54 INFO - Caught exception: HTTP Error 404: Not Found 14:48:54 INFO - trying https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 14:48:54 INFO - Downloading https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:48:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:48:54 INFO - Downloaded 1327 bytes. 14:48:54 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 14:48:54 INFO - Using the following test package requirements: 14:48:54 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 14:48:54 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 14:48:54 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:48:54 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 14:48:54 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 14:48:54 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 14:48:54 INFO - u'jsshell-linux-x86_64.zip'], 14:48:54 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 14:48:54 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:48:54 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 14:48:54 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 14:48:54 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 14:48:54 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 14:48:54 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 14:48:54 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 14:48:54 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:48:54 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 14:48:54 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:48:54 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:48:54 INFO - https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:48:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:48:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:48:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:48:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:48:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:48:55 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:48:55 INFO - retry: Failed, sleeping 30 seconds before retrying 14:49:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:49:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:49:25 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:49:25 INFO - retry: Failed, sleeping 60 seconds before retrying 14:50:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:50:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:50:25 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:50:25 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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! 14:50:25 INFO - Caught exception: HTTP Error 404: Not Found 14:50:25 INFO - Caught exception: HTTP Error 404: Not Found 14:50:25 INFO - Caught exception: HTTP Error 404: Not Found 14:50:25 INFO - trying https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:50:25 INFO - Downloading https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:50:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:50:25 INFO - Downloaded 21774985 bytes. 14:50:25 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'] 14:50:25 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 14:50:27 INFO - Return code: 0 14:50:27 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 14:50: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')]} 14:50:27 INFO - https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:50:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:50:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:50:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:50:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:50:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:50:27 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:50:27 INFO - retry: Failed, sleeping 30 seconds before retrying 14:50:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:50:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:50:57 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:50:57 INFO - retry: Failed, sleeping 60 seconds before retrying 14:51:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:51:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:51:57 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:51:57 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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! 14:51:57 INFO - Caught exception: HTTP Error 404: Not Found 14:51:57 INFO - Caught exception: HTTP Error 404: Not Found 14:51:57 INFO - Caught exception: HTTP Error 404: Not Found 14:51:57 INFO - trying https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 14:51:57 INFO - Downloading https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:51:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:51:58 INFO - Downloaded 21774985 bytes. 14:51:58 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'] 14:51:58 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 14:51:59 INFO - Return code: 0 14:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:59 INFO - https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:51:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 14:51:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 14:51:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:51:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:51:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 14:51:59 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:51:59 INFO - retry: Failed, sleeping 30 seconds before retrying 14:52:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:52:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 14:52:29 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:52:29 INFO - retry: Failed, sleeping 60 seconds before retrying 14:53:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:53:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 14:53:29 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:53:29 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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! 14:53:29 INFO - Caught exception: HTTP Error 404: Not Found 14:53:29 INFO - Caught exception: HTTP Error 404: Not Found 14:53:29 INFO - Caught exception: HTTP Error 404: Not Found 14:53:29 INFO - trying https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 14:53:29 INFO - Downloading https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:53:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:53:30 INFO - Downloaded 14413762 bytes. 14:53:30 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'] 14:53:30 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 14:53:30 INFO - Return code: 0 14:53: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')]} 14:53:30 INFO - https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:53:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 14:53:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 14:53:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:53:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:53:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 14:53:30 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:53:30 INFO - retry: Failed, sleeping 30 seconds before retrying 14:54:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:54:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 14:54:00 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:54:00 INFO - retry: Failed, sleeping 60 seconds before retrying 14:55:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:55:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 14:55:00 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:55:00 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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! 14:55:00 INFO - Caught exception: HTTP Error 404: Not Found 14:55:00 INFO - Caught exception: HTTP Error 404: Not Found 14:55:00 INFO - Caught exception: HTTP Error 404: Not Found 14:55:00 INFO - trying https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 14:55:00 INFO - Downloading https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:55:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/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 14:55:01 INFO - Downloaded 56802534 bytes. 14:55:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 14:55:01 INFO - mkdir: /builds/slave/test/properties 14:55:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:55:01 INFO - Writing to file /builds/slave/test/properties/build_url 14:55:01 INFO - Contents: 14:55:01 INFO - build_url:https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 14:55:02 INFO - Running post-action listener: _resource_record_post_action 14:55:02 INFO - Running post-action listener: set_extra_try_arguments 14:55:02 INFO - [mozharness: 2016-10-19 21:55:02.456011Z] Finished download-and-extract step (success) 14:55:02 INFO - [mozharness: 2016-10-19 21:55:02.456243Z] Running populate-webroot step. 14:55:02 INFO - Running pre-action listener: _resource_record_pre_action 14:55:02 INFO - Running main action method: populate_webroot 14:55:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:55:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:55:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:55:02 INFO - '--tppagecycles', 14:55:02 INFO - '7'], 14:55:02 INFO - 'tests': ['tsvgm']}}, 14:55:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:55:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:55:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:55:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:55:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:55:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:55:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:02 INFO - 'talos_options': ['--disable-e10s'], 14:55:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:55:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:55:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:02 INFO - 'talos_options': ['--disable-e10s'], 14:55:02 INFO - 'tests': ['damp', 'tps']}, 14:55:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:02 INFO - 'tests': ['damp', 'tps']}, 14:55:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:55:02 INFO - 'tests': ['dromaeo_dom']}, 14:55:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:55:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:55:02 INFO - 'tests': ['basic_compositor_video']}, 14:55:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:55:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:55:02 INFO - 'tests': ['a11yr', 14:55:02 INFO - 'ts_paint', 14:55:02 INFO - 'tpaint', 14:55:02 INFO - 'sessionrestore', 14:55:02 INFO - 'sessionrestore_no_auto_restore', 14:55:02 INFO - 'tabpaint']}, 14:55:02 INFO - 'other-e10s': {'tests': ['a11yr', 14:55:02 INFO - 'ts_paint', 14:55:02 INFO - 'tpaint', 14:55:02 INFO - 'sessionrestore', 14:55:02 INFO - 'sessionrestore_no_auto_restore', 14:55:02 INFO - 'tabpaint']}, 14:55:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:55:02 INFO - 'ts_paint', 14:55:02 INFO - 'tpaint', 14:55:02 INFO - 'sessionrestore', 14:55:02 INFO - 'sessionrestore_no_auto_restore', 14:55:02 INFO - 'tabpaint']}, 14:55:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:55:02 INFO - 'ts_paint', 14:55:02 INFO - 'tpaint', 14:55:02 INFO - 'sessionrestore', 14:55:02 INFO - 'sessionrestore_no_auto_restore', 14:55:02 INFO - 'tabpaint']}, 14:55:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:55:02 INFO - 'tests': ['a11yr', 14:55:02 INFO - 'ts_paint', 14:55:02 INFO - 'tpaint', 14:55:02 INFO - 'sessionrestore', 14:55:02 INFO - 'sessionrestore_no_auto_restore', 14:55:02 INFO - 'tabpaint']}, 14:55:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:55:02 INFO - 'tests': ['a11yr', 14:55:02 INFO - 'ts_paint', 14:55:02 INFO - 'tpaint', 14:55:02 INFO - 'sessionrestore', 14:55:02 INFO - 'sessionrestore_no_auto_restore', 14:55:02 INFO - 'tabpaint']}, 14:55:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:55:02 INFO - 'tests': ['tsvgx', 14:55:02 INFO - 'tsvgr_opacity', 14:55:02 INFO - 'tart', 14:55:02 INFO - 'tscrollx', 14:55:02 INFO - 'cart']}, 14:55:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:55:02 INFO - 'tsvgr_opacity', 14:55:02 INFO - 'tart', 14:55:02 INFO - 'tscrollx', 14:55:02 INFO - 'cart']}, 14:55:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:02 INFO - 'talos_options': ['--disable-e10s'], 14:55:02 INFO - 'tests': ['tp5o']}, 14:55:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:02 INFO - 'tests': ['tp5o']}, 14:55:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:02 INFO - 'talos_options': ['--disable-e10s', 14:55:02 INFO - '--xperf_path', 14:55:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:55:02 INFO - 'tests': ['tp5n']}, 14:55:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:02 INFO - 'talos_options': ['--xperf_path', 14:55:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:55:02 INFO - 'tests': ['tp5n']}}, 14:55:02 INFO - 'talos.zip': {'path': '', 14:55:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:55:02 INFO - Running post-action listener: _resource_record_post_action 14:55:02 INFO - [mozharness: 2016-10-19 21:55:02.477654Z] Finished populate-webroot step (success) 14:55:02 INFO - [mozharness: 2016-10-19 21:55:02.477743Z] Running create-virtualenv step. 14:55:02 INFO - Running pre-action listener: _resource_record_pre_action 14:55:02 INFO - Running main action method: create_virtualenv 14:55:02 INFO - Creating virtualenv /builds/slave/test/build/venv 14:55:02 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 14:55:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:55:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:55:02 INFO - Using real prefix '/usr' 14:55:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:55:03 INFO - Installing distribute.............................................................................................................................................................................................done. 14:55:05 INFO - Installing pip.................done. 14:55:05 INFO - Return code: 0 14:55:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:55:05 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')]} 14:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:05 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')]} 14:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:05 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 0xb1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd570>, '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 0xdde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdde900>, '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': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', '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 14:55:05 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 14:55:05 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 14:55:05 INFO - Using env: {'DISPLAY': ':0', 14:55:05 INFO - 'HOME': '/home/cltbld', 14:55:05 INFO - 'LANG': 'en_US.UTF-8', 14:55:05 INFO - 'LANGUAGE': 'en_US:en', 14:55:05 INFO - 'LOGNAME': 'cltbld', 14:55:05 INFO - 'MAIL': '/var/mail/cltbld', 14:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:05 INFO - 'MOZ_NO_REMOTE': '1', 14:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:05 INFO - 'NO_EM_RESTART': '1', 14:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:05 INFO - 'PWD': '/builds/slave/test', 14:55:05 INFO - 'SHELL': '/bin/bash', 14:55:05 INFO - 'SHLVL': '1', 14:55:05 INFO - 'TERM': 'linux', 14:55:05 INFO - 'TMOUT': '86400', 14:55:05 INFO - 'USER': 'cltbld', 14:55:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', 14:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:05 INFO - '_': '/tools/buildbot/bin/python'} 14:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:05 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 14:55:05 INFO - Cleaning up... 14:55:05 INFO - Return code: 0 14:55:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:55:05 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')]} 14:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:05 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')]} 14:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:05 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 0xb1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd570>, '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 0xdde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdde900>, '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': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', '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 14:55:05 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 14:55:05 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 14:55:05 INFO - Using env: {'DISPLAY': ':0', 14:55:05 INFO - 'HOME': '/home/cltbld', 14:55:05 INFO - 'LANG': 'en_US.UTF-8', 14:55:05 INFO - 'LANGUAGE': 'en_US:en', 14:55:05 INFO - 'LOGNAME': 'cltbld', 14:55:05 INFO - 'MAIL': '/var/mail/cltbld', 14:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:05 INFO - 'MOZ_NO_REMOTE': '1', 14:55:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:05 INFO - 'NO_EM_RESTART': '1', 14:55:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:05 INFO - 'PWD': '/builds/slave/test', 14:55:05 INFO - 'SHELL': '/bin/bash', 14:55:05 INFO - 'SHLVL': '1', 14:55:05 INFO - 'TERM': 'linux', 14:55:05 INFO - 'TMOUT': '86400', 14:55:05 INFO - 'USER': 'cltbld', 14:55:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', 14:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:05 INFO - '_': '/tools/buildbot/bin/python'} 14:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:05 INFO - Downloading/unpacking psutil>=3.1.1 14:55:05 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 14:55:05 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 14:55:05 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 14:55:05 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 14:55:05 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 14:55:05 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 14:55:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:55:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:55:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:55:07 INFO - Installing collected packages: psutil 14:55:07 INFO - Running setup.py install for psutil 14:55:07 INFO - building 'psutil._psutil_linux' extension 14:55:07 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 14:55:07 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 14:55:07 INFO - building 'psutil._psutil_posix' extension 14:55:07 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 14:55:07 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 14:55:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:55:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:55:07 INFO - Successfully installed psutil 14:55:07 INFO - Cleaning up... 14:55:08 INFO - Return code: 0 14:55:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:55:08 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')]} 14:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:08 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')]} 14:55:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:08 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 0xb1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd570>, '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 0xdde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdde900>, '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': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', '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 14:55:08 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 14:55:08 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 14:55:08 INFO - Using env: {'DISPLAY': ':0', 14:55:08 INFO - 'HOME': '/home/cltbld', 14:55:08 INFO - 'LANG': 'en_US.UTF-8', 14:55:08 INFO - 'LANGUAGE': 'en_US:en', 14:55:08 INFO - 'LOGNAME': 'cltbld', 14:55:08 INFO - 'MAIL': '/var/mail/cltbld', 14:55:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:08 INFO - 'MOZ_NO_REMOTE': '1', 14:55:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:08 INFO - 'NO_EM_RESTART': '1', 14:55:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:08 INFO - 'PWD': '/builds/slave/test', 14:55:08 INFO - 'SHELL': '/bin/bash', 14:55:08 INFO - 'SHLVL': '1', 14:55:08 INFO - 'TERM': 'linux', 14:55:08 INFO - 'TMOUT': '86400', 14:55:08 INFO - 'USER': 'cltbld', 14:55:08 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', 14:55:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:08 INFO - '_': '/tools/buildbot/bin/python'} 14:55:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:55:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:55:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:55:10 INFO - Installing collected packages: mozsystemmonitor 14:55:10 INFO - Running setup.py install for mozsystemmonitor 14:55:10 INFO - Successfully installed mozsystemmonitor 14:55:10 INFO - Cleaning up... 14:55:10 INFO - Return code: 0 14:55:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd570>, '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 0xdde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdde900>, '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': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', '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 14:55:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:55:10 INFO - Using env: {'DISPLAY': ':0', 14:55:10 INFO - 'HOME': '/home/cltbld', 14:55:10 INFO - 'LANG': 'en_US.UTF-8', 14:55:10 INFO - 'LANGUAGE': 'en_US:en', 14:55:10 INFO - 'LOGNAME': 'cltbld', 14:55:10 INFO - 'MAIL': '/var/mail/cltbld', 14:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:10 INFO - 'MOZ_NO_REMOTE': '1', 14:55:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:10 INFO - 'NO_EM_RESTART': '1', 14:55:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:10 INFO - 'PWD': '/builds/slave/test', 14:55:10 INFO - 'SHELL': '/bin/bash', 14:55:10 INFO - 'SHLVL': '1', 14:55:10 INFO - 'TERM': 'linux', 14:55:10 INFO - 'TMOUT': '86400', 14:55:10 INFO - 'USER': 'cltbld', 14:55:10 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', 14:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:10 INFO - '_': '/tools/buildbot/bin/python'} 14:55:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:10 INFO - Downloading/unpacking jsonschema==2.5.1 14:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:55:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:12 INFO - Downloading functools32-3.2.3-2.tar.gz 14:55:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:55:12 INFO - warning: no files found matching '*.txt' 14:55:12 INFO - no previously-included directories found matching 'build' 14:55:12 INFO - no previously-included directories found matching 'dist' 14:55:12 INFO - no previously-included directories found matching '.git*' 14:55:12 INFO - Installing collected packages: jsonschema, functools32 14:55:12 INFO - Running setup.py install for functools32 14:55:12 INFO - warning: no files found matching '*.txt' 14:55:12 INFO - no previously-included directories found matching 'build' 14:55:12 INFO - no previously-included directories found matching 'dist' 14:55:12 INFO - no previously-included directories found matching '.git*' 14:55:12 INFO - Successfully installed jsonschema functools32 14:55:12 INFO - Cleaning up... 14:55:12 INFO - Return code: 0 14:55:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd570>, '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 0xdde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdde900>, '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': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', '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 14:55:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:55:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:55:12 INFO - Using env: {'DISPLAY': ':0', 14:55:12 INFO - 'HOME': '/home/cltbld', 14:55:12 INFO - 'LANG': 'en_US.UTF-8', 14:55:12 INFO - 'LANGUAGE': 'en_US:en', 14:55:12 INFO - 'LOGNAME': 'cltbld', 14:55:12 INFO - 'MAIL': '/var/mail/cltbld', 14:55:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:12 INFO - 'MOZ_NO_REMOTE': '1', 14:55:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:12 INFO - 'NO_EM_RESTART': '1', 14:55:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:12 INFO - 'PWD': '/builds/slave/test', 14:55:12 INFO - 'SHELL': '/bin/bash', 14:55:12 INFO - 'SHLVL': '1', 14:55:12 INFO - 'TERM': 'linux', 14:55:12 INFO - 'TMOUT': '86400', 14:55:12 INFO - 'USER': 'cltbld', 14:55:12 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', 14:55:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:12 INFO - '_': '/tools/buildbot/bin/python'} 14:55:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:55:13 INFO - Cleaning up... 14:55:13 INFO - Return code: 0 14:55:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd570>, '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 0xdde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdde900>, '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': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', '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 14:55:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:55:13 INFO - Using env: {'DISPLAY': ':0', 14:55:13 INFO - 'HOME': '/home/cltbld', 14:55:13 INFO - 'LANG': 'en_US.UTF-8', 14:55:13 INFO - 'LANGUAGE': 'en_US:en', 14:55:13 INFO - 'LOGNAME': 'cltbld', 14:55:13 INFO - 'MAIL': '/var/mail/cltbld', 14:55:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:13 INFO - 'MOZ_NO_REMOTE': '1', 14:55:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:13 INFO - 'NO_EM_RESTART': '1', 14:55:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:13 INFO - 'PWD': '/builds/slave/test', 14:55:13 INFO - 'SHELL': '/bin/bash', 14:55:13 INFO - 'SHLVL': '1', 14:55:13 INFO - 'TERM': 'linux', 14:55:13 INFO - 'TMOUT': '86400', 14:55:13 INFO - 'USER': 'cltbld', 14:55:13 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', 14:55:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:13 INFO - '_': '/tools/buildbot/bin/python'} 14:55:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:13 INFO - Downloading/unpacking blobuploader==1.2.4 14:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:15 INFO - Downloading blobuploader-1.2.4.tar.gz 14:55:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:55:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:55:15 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 14:55:15 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 14:55:15 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 14:55:15 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 14:55:15 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 14:55:15 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 14:55:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:55:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:55:15 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 14:55:15 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 14:55:15 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 14:55:15 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 14:55:15 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 14:55:15 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 14:55:16 INFO - Downloading docopt-0.6.1.tar.gz 14:55:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:55:16 INFO - Installing collected packages: blobuploader, requests, docopt 14:55:16 INFO - Running setup.py install for blobuploader 14:55:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:55:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:55:16 INFO - Running setup.py install for requests 14:55:16 INFO - Running setup.py install for docopt 14:55:16 INFO - Successfully installed blobuploader requests docopt 14:55:16 INFO - Cleaning up... 14:55:16 INFO - Return code: 0 14:55:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:55: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')]} 14:55:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55: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')]} 14:55:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:16 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 0xb1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd570>, '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 0xdde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdde900>, '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': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', '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 14:55:16 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 14:55:16 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 14:55:16 INFO - Using env: {'DISPLAY': ':0', 14:55:16 INFO - 'HOME': '/home/cltbld', 14:55:16 INFO - 'LANG': 'en_US.UTF-8', 14:55:16 INFO - 'LANGUAGE': 'en_US:en', 14:55:16 INFO - 'LOGNAME': 'cltbld', 14:55:16 INFO - 'MAIL': '/var/mail/cltbld', 14:55:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:16 INFO - 'MOZ_NO_REMOTE': '1', 14:55:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:16 INFO - 'NO_EM_RESTART': '1', 14:55:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:16 INFO - 'PWD': '/builds/slave/test', 14:55:16 INFO - 'SHELL': '/bin/bash', 14:55:16 INFO - 'SHLVL': '1', 14:55:16 INFO - 'TERM': 'linux', 14:55:16 INFO - 'TMOUT': '86400', 14:55:16 INFO - 'USER': 'cltbld', 14:55:16 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', 14:55:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:16 INFO - '_': '/tools/buildbot/bin/python'} 14:55:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:55:16 INFO - Running setup.py (path:/tmp/pip-YrpJdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:55:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:55:16 INFO - Running setup.py (path:/tmp/pip-jNjzP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:55:17 INFO - Running setup.py (path:/tmp/pip-9Q2eqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:55:17 INFO - Running setup.py (path:/tmp/pip-fiTR7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:55:17 INFO - Running setup.py (path:/tmp/pip-LOLByn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:55:17 INFO - Running setup.py (path:/tmp/pip-5FvvW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:55:17 INFO - Running setup.py (path:/tmp/pip-otVJPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:55:17 INFO - Running setup.py (path:/tmp/pip-XvZFLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:55:17 INFO - Running setup.py (path:/tmp/pip-f4zr4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:55:17 INFO - Running setup.py (path:/tmp/pip-30znbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:55:17 INFO - Running setup.py (path:/tmp/pip-fk28Fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:55:17 INFO - Running setup.py (path:/tmp/pip-REknlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:55:17 INFO - Running setup.py (path:/tmp/pip-_zOCe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:55:17 INFO - Running setup.py (path:/tmp/pip-NaoxgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:55:17 INFO - Running setup.py (path:/tmp/pip-Q9BPHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:55:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:55:17 INFO - Running setup.py (path:/tmp/pip-p99eyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:55:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:55:18 INFO - Running setup.py (path:/tmp/pip-M5sb9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:55:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:55:18 INFO - Running setup.py install for manifestparser 14:55:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:55:18 INFO - Running setup.py install for mozcrash 14:55:18 INFO - Running setup.py install for mozdebug 14:55:18 INFO - Running setup.py install for mozdevice 14:55:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:55:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:55:18 INFO - Running setup.py install for mozfile 14:55:18 INFO - Running setup.py install for mozhttpd 14:55:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:55:18 INFO - Running setup.py install for mozinfo 14:55:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:55:18 INFO - Running setup.py install for mozInstall 14:55:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:55:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:55:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:55:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:55:18 INFO - Running setup.py install for mozleak 14:55:18 INFO - Running setup.py install for mozlog 14:55:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:55:19 INFO - Running setup.py install for moznetwork 14:55:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:55:19 INFO - Running setup.py install for mozprocess 14:55:19 INFO - Running setup.py install for mozprofile 14:55:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:55:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:55:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:55:19 INFO - Running setup.py install for mozrunner 14:55:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:55:19 INFO - Running setup.py install for mozscreenshot 14:55:19 INFO - Running setup.py install for moztest 14:55:19 INFO - Running setup.py install for mozversion 14:55:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:55:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:55:19 INFO - Cleaning up... 14:55:19 INFO - Return code: 0 14:55:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:19 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 0xb1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd570>, '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 0xdde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdde900>, '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': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', '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 14:55:19 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 14:55:19 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 14:55:19 INFO - Using env: {'DISPLAY': ':0', 14:55:19 INFO - 'HOME': '/home/cltbld', 14:55:19 INFO - 'LANG': 'en_US.UTF-8', 14:55:19 INFO - 'LANGUAGE': 'en_US:en', 14:55:19 INFO - 'LOGNAME': 'cltbld', 14:55:19 INFO - 'MAIL': '/var/mail/cltbld', 14:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:19 INFO - 'MOZ_NO_REMOTE': '1', 14:55:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:19 INFO - 'NO_EM_RESTART': '1', 14:55:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:19 INFO - 'PWD': '/builds/slave/test', 14:55:19 INFO - 'SHELL': '/bin/bash', 14:55:19 INFO - 'SHLVL': '1', 14:55:19 INFO - 'TERM': 'linux', 14:55:19 INFO - 'TMOUT': '86400', 14:55:19 INFO - 'USER': 'cltbld', 14:55:19 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', 14:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:19 INFO - '_': '/tools/buildbot/bin/python'} 14:55:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:55:20 INFO - Running setup.py (path:/tmp/pip-gZuPoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:55:20 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)) 14:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:55:20 INFO - Running setup.py (path:/tmp/pip-PQrYpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:55:20 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)) 14:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:55:20 INFO - Running setup.py (path:/tmp/pip-mdgcQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:55:20 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)) 14:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:55:20 INFO - Running setup.py (path:/tmp/pip-R4mTGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:55:20 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)) 14:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:55:20 INFO - Running setup.py (path:/tmp/pip-Rax4tG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:55:20 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)) 14:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:55:20 INFO - Running setup.py (path:/tmp/pip-64PCIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:55:20 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)) 14:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:55:20 INFO - Running setup.py (path:/tmp/pip-UiXJUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:55:20 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)) 14:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:55:20 INFO - Running setup.py (path:/tmp/pip-d8K5On-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:55:20 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)) 14:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:55:20 INFO - Running setup.py (path:/tmp/pip-DQkPlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:55:20 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)) 14:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:55:20 INFO - Running setup.py (path:/tmp/pip-_NBG17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:55:20 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)) 14:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:55:20 INFO - Running setup.py (path:/tmp/pip-tHkt_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:55:20 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)) 14:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:55:20 INFO - Running setup.py (path:/tmp/pip-atQyaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:55:20 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)) 14:55:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:55:20 INFO - Running setup.py (path:/tmp/pip-z1LApT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:55:21 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)) 14:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:55:21 INFO - Running setup.py (path:/tmp/pip-KvRuu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:55:21 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)) 14:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:55:21 INFO - Running setup.py (path:/tmp/pip-DuMdA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:55:21 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)) 14:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:55:21 INFO - Running setup.py (path:/tmp/pip-uPT2uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:55:21 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)) 14:55:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:55:21 INFO - Running setup.py (path:/tmp/pip-B7cUCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:55:21 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)) 14:55:21 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)) 14:55:21 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)) 14:55:21 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)) 14:55:21 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)) 14:55:21 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)) 14:55:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:23 INFO - Downloading blessings-1.6.tar.gz 14:55:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:55:23 INFO - Installing collected packages: blessings 14:55:23 INFO - Running setup.py install for blessings 14:55:23 INFO - Successfully installed blessings 14:55:23 INFO - Cleaning up... 14:55:23 INFO - Return code: 0 14:55:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:55:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:55:23 INFO - Reading from file tmpfile_stdout 14:55:23 INFO - Current package versions: 14:55:23 INFO - argparse == 1.2.1 14:55:23 INFO - blessings == 1.6 14:55:23 INFO - blobuploader == 1.2.4 14:55:23 INFO - docopt == 0.6.1 14:55:23 INFO - functools32 == 3.2.3-2 14:55:23 INFO - jsonschema == 2.5.1 14:55:23 INFO - manifestparser == 1.1 14:55:23 INFO - mozInstall == 1.12 14:55:23 INFO - mozcrash == 0.17 14:55:23 INFO - mozdebug == 0.1 14:55:23 INFO - mozdevice == 0.48 14:55:23 INFO - mozfile == 1.2 14:55:23 INFO - mozhttpd == 0.7 14:55:23 INFO - mozinfo == 0.9 14:55:23 INFO - mozleak == 0.1 14:55:23 INFO - mozlog == 3.3 14:55:23 INFO - moznetwork == 0.27 14:55:23 INFO - mozprocess == 0.23 14:55:23 INFO - mozprofile == 0.28 14:55:23 INFO - mozrunner == 6.12 14:55:23 INFO - mozscreenshot == 0.1 14:55:23 INFO - mozsystemmonitor == 0.3 14:55:23 INFO - moztest == 0.7 14:55:23 INFO - mozversion == 1.4 14:55:23 INFO - psutil == 3.1.1 14:55:23 INFO - requests == 1.2.3 14:55:23 INFO - wsgiref == 0.1.2 14:55:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:23 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 0xb1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd570>, '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 0xdde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdde900>, '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': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', '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 14:55:23 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 14:55:23 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 14:55:23 INFO - Using env: {'DISPLAY': ':0', 14:55:23 INFO - 'HOME': '/home/cltbld', 14:55:23 INFO - 'LANG': 'en_US.UTF-8', 14:55:23 INFO - 'LANGUAGE': 'en_US:en', 14:55:23 INFO - 'LOGNAME': 'cltbld', 14:55:23 INFO - 'MAIL': '/var/mail/cltbld', 14:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:23 INFO - 'MOZ_NO_REMOTE': '1', 14:55:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:23 INFO - 'NO_EM_RESTART': '1', 14:55:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:23 INFO - 'PWD': '/builds/slave/test', 14:55:23 INFO - 'SHELL': '/bin/bash', 14:55:23 INFO - 'SHLVL': '1', 14:55:23 INFO - 'TERM': 'linux', 14:55:23 INFO - 'TMOUT': '86400', 14:55:23 INFO - 'USER': 'cltbld', 14:55:23 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', 14:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:23 INFO - '_': '/tools/buildbot/bin/python'} 14:55:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:23 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)) 14:55:23 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)) 14:55:23 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)) 14:55:23 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)) 14:55:23 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)) 14:55:23 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)) 14:55:23 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)) 14:55:23 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)) 14:55:23 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)) 14:55:23 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)) 14:55:23 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)) 14:55:23 INFO - Cleaning up... 14:55:23 INFO - Return code: 0 14:55:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:23 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 0xb1f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc828a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd4e400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xddd570>, '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 0xdde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdde900>, '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': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', '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 14:55:23 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 14:55:23 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 14:55:23 INFO - Using env: {'DISPLAY': ':0', 14:55:23 INFO - 'HOME': '/home/cltbld', 14:55:23 INFO - 'LANG': 'en_US.UTF-8', 14:55:23 INFO - 'LANGUAGE': 'en_US:en', 14:55:23 INFO - 'LOGNAME': 'cltbld', 14:55:23 INFO - 'MAIL': '/var/mail/cltbld', 14:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:23 INFO - 'MOZ_NO_REMOTE': '1', 14:55:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:23 INFO - 'NO_EM_RESTART': '1', 14:55:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:23 INFO - 'PWD': '/builds/slave/test', 14:55:23 INFO - 'SHELL': '/bin/bash', 14:55:23 INFO - 'SHLVL': '1', 14:55:23 INFO - 'TERM': 'linux', 14:55:23 INFO - 'TMOUT': '86400', 14:55:23 INFO - 'USER': 'cltbld', 14:55:23 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', 14:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:23 INFO - '_': '/tools/buildbot/bin/python'} 14:55:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:55:24 INFO - Cleaning up... 14:55:24 INFO - Return code: 0 14:55:24 INFO - Running post-action listener: _resource_record_post_action 14:55:24 INFO - Running post-action listener: _start_resource_monitoring 14:55:24 INFO - Starting resource monitoring. 14:55:24 INFO - [mozharness: 2016-10-19 21:55:24.191987Z] Finished create-virtualenv step (success) 14:55:24 INFO - [mozharness: 2016-10-19 21:55:24.192411Z] Running install step. 14:55:24 INFO - Running pre-action listener: _resource_record_pre_action 14:55:24 INFO - Running main action method: install 14:55:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:55:24 INFO - Reading from file tmpfile_stdout 14:55:24 INFO - Detecting whether we're running mozinstall >=1.0... 14:55:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:55:24 INFO - Reading from file tmpfile_stdout 14:55:24 INFO - Output received: 14:55:24 INFO - Usage: mozinstall [options] installer 14:55:24 INFO - Options: 14:55:24 INFO - -h, --help show this help message and exit 14:55:24 INFO - -d DEST, --destination=DEST 14:55:24 INFO - Directory to install application into. [default: 14:55:24 INFO - "/builds/slave/test"] 14:55:24 INFO - --app=APP Application being installed. [default: firefox] 14:55:24 INFO - mkdir: /builds/slave/test/build/application 14:55:24 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'] 14:55:24 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 14:55:37 INFO - Reading from file tmpfile_stdout 14:55:37 INFO - Output received: 14:55:37 INFO - /builds/slave/test/build/application/firefox/firefox 14:55:37 INFO - Running post-action listener: _resource_record_post_action 14:55:37 INFO - [mozharness: 2016-10-19 21:55:37.963106Z] Finished install step (success) 14:55:37 INFO - [mozharness: 2016-10-19 21:55:37.963446Z] Running run-tests step. 14:55:37 INFO - Running pre-action listener: _resource_record_pre_action 14:55:37 INFO - Running main action method: run_tests 14:55:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:55:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:55:37 INFO - Python 2.7.3 14:55:37 INFO - Return code: 0 14:55:37 INFO - grabbing minidump binary from tooltool 14:55:37 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')]} 14:55:37 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 0xddd570>, '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 0xdde470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdde900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:55:37 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 14:55:37 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 14:55:37 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 14:55:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:55:38 INFO - Return code: 0 14:55:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:55:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:55:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:55:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:55:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:55:38 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:55:38 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:55:38 INFO - Using env: {'DISPLAY': ':0', 14:55:38 INFO - 'HOME': '/home/cltbld', 14:55:38 INFO - 'LANG': 'en_US.UTF-8', 14:55:38 INFO - 'LANGUAGE': 'en_US:en', 14:55:38 INFO - 'LOGNAME': 'cltbld', 14:55:38 INFO - 'MAIL': '/var/mail/cltbld', 14:55:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:55:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:38 INFO - 'MOZ_NO_REMOTE': '1', 14:55:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:55:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:38 INFO - 'NO_EM_RESTART': '1', 14:55:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:38 INFO - 'PWD': '/builds/slave/test', 14:55:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:55:38 INFO - 'SHELL': '/bin/bash', 14:55:38 INFO - 'SHLVL': '1', 14:55:38 INFO - 'TERM': 'linux', 14:55:38 INFO - 'TMOUT': '86400', 14:55:38 INFO - 'USER': 'cltbld', 14:55:38 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008', 14:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:38 INFO - '_': '/tools/buildbot/bin/python'} 14:55:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:55:38 INFO - mozversion application_buildid: 20161019120023 14:55:38 INFO - mozversion application_changeset: 0c46713f5b17e943e39866326bd040f639364b8e 14:55:38 INFO - mozversion application_display_name: Firefox 14:55:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:55:38 INFO - mozversion application_name: Firefox 14:55:38 INFO - mozversion application_remotingname: firefox 14:55:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:55:38 INFO - mozversion application_vendor: Mozilla 14:55:38 INFO - mozversion application_version: 50.0 14:55:38 INFO - mozversion platform_buildid: 20161019120023 14:55:38 INFO - mozversion platform_changeset: 0c46713f5b17e943e39866326bd040f639364b8e 14:55:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:55:38 INFO - mozversion platform_version: 50.0 14:55:38 INFO - using testdate: 1476914138 14:55:38 INFO - actual date: 1476914138 14:55:38 INFO - starting webserver on 'localhost:50278' 14:55:38 INFO - SUITE-START | Running 2 tests 14:55:38 INFO - TEST-START | dromaeo_css 14:55:38 INFO - operating with platform_type : linux_ 14:55:38 INFO - Initialising browser for dromaeo_css test... 14:55:38 INFO - TEST-INFO | started process 7202 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHV3DoV/profile http://localhost:50278/getInfo.html) 14:55:42 INFO - PROCESS | 7202 | __metrics Screen width/height:1600/1200 14:55:42 INFO - PROCESS | 7202 | colorDepth:24 14:55:42 INFO - PROCESS | 7202 | Browser inner width/height: 1024/697 14:55:42 INFO - PROCESS | 7202 | __metrics 14:55:43 ERROR - PROCESS | 7202 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 14:55:44 INFO - TEST-INFO | 7202: exit 0 14:55:44 INFO - Browser initialized. 14:55:44 INFO - Running cycle 1/1 for dromaeo_css test... 14:55:44 INFO - TEST-INFO | started process 7324 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHV3DoV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:55:56 INFO - PROCESS | 7324 | RSS: Main: 150544384 14:55:56 INFO - PROCESS | 7324 | 14:56:45 INFO - PROCESS | 7324 | 1476914205613 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] 14:58:53 INFO - PROCESS | 7324 | Cycle 1(1): loaded http://localhost:50278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50278/tests/dromaeo/cssquery-ext.html) 14:58:55 INFO - PROCESS | 7324 | RSS: Main: 158662656 14:58:55 INFO - PROCESS | 7324 | 15:01:57 INFO - PROCESS | 7324 | Cycle 1(1): loaded http://localhost:50278/tests/dromaeo/cssquery-ext.html (next: http://localhost:50278/tests/dromaeo/cssquery-jquery.html) 15:01:57 INFO - PROCESS | 7324 | RSS: Main: 155652096 15:01:57 INFO - PROCESS | 7324 | 15:04:59 INFO - PROCESS | 7324 | Cycle 1(1): loaded http://localhost:50278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50278/tests/dromaeo/cssquery-mootools.html) 15:05:00 INFO - PROCESS | 7324 | RSS: Main: 155226112 15:05:00 INFO - PROCESS | 7324 | 15:08:01 INFO - PROCESS | 7324 | Cycle 1(1): loaded http://localhost:50278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50278/tests/dromaeo/cssquery-prototype.html) 15:08:02 INFO - PROCESS | 7324 | RSS: Main: 156749824 15:08:02 INFO - PROCESS | 7324 | 15:11:04 INFO - PROCESS | 7324 | Cycle 1(1): loaded http://localhost:50278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50278/tests/dromaeo/cssquery-yui.html) 15:11:05 INFO - PROCESS | 7324 | RSS: Main: 157925376 15:11:05 INFO - PROCESS | 7324 | 15:14:07 INFO - PROCESS | 7324 | Cycle 1(1): loaded http://localhost:50278/tests/dromaeo/cssquery-yui.html (next: http://localhost:50278/tests/dromaeo/cssquery-dojo.html) 15:14:08 INFO - PROCESS | 7324 | RSS: Main: 157646848 15:14:08 INFO - PROCESS | 7324 | 15:14:08 INFO - PROCESS | 7324 | __start_tp_report 15:14:08 INFO - PROCESS | 7324 | _x_x_mozilla_page_load 15:14:08 INFO - PROCESS | 7324 | _x_x_mozilla_page_load_details 15:14:08 INFO - PROCESS | 7324 | |i|pagename|runs| 15:14:08 INFO - PROCESS | 7324 | |0;dojo.html;3276.7378609711227;3285.260816316329;3295.604527456705;3305.7851239669435;3324.335132973406;5624.521915637176;5646.124850648151;5705.343885453174;5721.828345149642;5752.165935939286;5647.8588035299035;5762.798302059428;5768.538516918647;5774.855628609287;5794.362620111784;5256.106461901467;5279.208118782175;5291.629585928987;5320.414754377015;5337.626366154371;5286.524212820846;5291.947080529203;5292.92060619091;5318.946810531903;5332.520073193412;5144.09978253806;5182.818601348954;5289;5289.523942845143;5323.467653234684;5162.2772811806;5175.948240517584;5191.428942816287;5284.128118860383;5304.549113325372;5138.177891537373;5186.429492755794;5219.973900130513;5223.007628550601;5230.529252367267;5624.353199382042;5624.606277560572;5704.857378565527;5725.770969161229;5728.398518155617;5985.521158307369;6018.458338749533;6113.654458598753;6113.908291375633;6124.625058545688;5998.820035398945;6006.699665016732;6021.157038014681;6122.816315510542;6123.295820980599;5715.2855893013375;5725.312962444492;5725.5133313667975;5726.026575482178;5735.684537350444;6199.752009919643;6217.782377616762;6242.750289988349;6255.46828519581;6335.081413195061;6008.459238668541;6069.878602427927;6072.544559157993;6075.48358389533;6094.6647934363145;6090.056041313604;6097.969510152421;6155.6614386209185;6172.5679202456295;6178.66017369049;6172.382761723792;6176.197094377702;6176.444120029129;6184.907226391608;6202.534809889276;6133.570650054453;6142.201513803177;6161.075838624242;6162.969185154136;6180.103884936659;4538.478075021349;4606.585407313358;4640.6751527393435;4734.834280800155;4751.40607424072;4152.792360381969;4157.563455837154;4172.040430700895;4181.916361672749;4205.453291072202;5828.067509198508;5880.970595146997;5885.440883116097;5891.293044834647;5896.764129434775;5955.106733989849;6078.817635470943;6082.239720034996;6178.764247150588;6185.350538193425;5821.7380217890295;5845.152452894392;5859.882802343929;5895.380984996599;5896.852578685567;5257.132573125392;5299.364076310867;5309.920351194735;5314.62797604164;5316.1494160934835;6177.505799536027;6425;6434.581752186093;6437.452816510649;6443.097966284724;6034.456898879122;6065.545084118797;6067.514598832171;6138.296437970319;6138.940218748475;6374.394432528902;6376.330485298977;6379.170707807955;6380.3619638035825;6380.680965951591;5896.793612223723;6016.7292471838;6019.578629496068;6028.246469191351;6043.395660433922;6131.233595800525;6142.40669208518;6152.907706384497;6249.281332646804;6258;6083.026715725463;6090.330063692902;6098.512119030378;6103.11504831788;6105.969470152799;5892.911606325994;6030.3668114847305;6039.486643635164;6078.057901025348;6096.29892562361;5891.528677705687;5926.140709597171;5947.464728174312;5996.4603185713495;6030.065339872327;6044.637321760709;6050.878982420239;6052.909206361996;6089.269287685506;6096.939030609815;5783.681897495678;5921.437463440966;5930.555208359477;5943.257092863392;5956.344802071682 15:14:08 INFO - PROCESS | 7324 | |1;ext.html;604.3956043956044;634.09324665728;665.3280187011119;670.2359310386161;718.9568625882445;41123.383149252746;46405.07189856201;46684;46725.76637116814;46765.29852052218;46881;47485;47585.52414475854;47775.28337074938;47817.52182478174;8958.10418958104;9084.8637270441;9099.863502047474;9105.95447022764;9117.589708463134;9221.538923053855;9357.76605584859;9360.906390936105;9375.156235938764;9376.8593471098;9348.532573371338;9388.671396501124;9398.483083430408;9403.905960940405;9416.10546998034;9355.532223388838;9390.15488606022;9390.85913711295;9441.19749821266;9445.149936505748;9228.40015398997;9293.907060929372;9316.394434361744;9317.860232096524;9348;44695.55304446979;44923.32615010777;45121.097578048255;45193.09613807738;45250.321245181345;3960.0693836948294;4002.1795531915886;4017.4576432181866;4139.77231252281;4697.859064228079;35902;36018.45972310418;36064;36227.456588151195;36965.26069478622;4847.951520484785;4850.975745121252;4854.951450485485;4914.4839791821705;4945.159322915113;271498;272088;272120;272498;273816.63091684616;65267.34732652707;65498.34501655018;65563.67218163879;65614.3596410084;65665.34334656592;41222.1755564887;41858;42039.36940945888;43800.342994854465;70424.64787676028;17318.826811731975;17422.825771742373;17425;17445.127743613022;17506.912465437592;13833.723325533634;13853;13917.791233131511;14013.229272390117;14028.509002184874;21487.46281342979;21491.247806326704;21556.56886862254;21669.566608667737;21698.13207471715;7509.249075092556;7630.7710768677025;7780.844383112306;7810.828375743684;7871.960640196762;1016.5120742043713;1063.1136464498923;1076.7523469601879;1146.5471138900089;1170.9824352634716;34017;34625;34835;34913.650863491544;34942.12644683853;1129.2321221569412;1189.649053529211;1203.1277323940074;1242.577523641966;1249.3940438887132;17946.91026544859;17957.37149199798;18204.817951820576;18210.908945455187;18257.360992365204;546443;613749;622731;623595;914664;67620;68273.65863170652;68420.31579684239;68565.65717171383;68575;1414.8231471066117;1461.5688371930305;1465.3625672832352;1471.146734893759;1471.4555614422732;33630.495542566394;35867.28265434729;35887.64112358843;36003.63996360003;36116;59092.704536477046;59562;59904.101438477584;59977.700111499165;60027;502512;504531;507976;508209;508684;31841;32719.18202044968;32721.181970449976;33020.50469242915;33025.83487082549;54138;54566;54883;55028.449715502335;55327.44672553384;44750.77624611856;44939.55060449484;44976.32535512035;46734.76632616951;49522.50477495179;46493.3026004617;46711.29933051075;47099.52900471089;47627.28559071686;47811;45473.545264546934;45690.77154614206;46460.070798584515;46655.53344466512;46885;39493.60506394899;40655.7967210162;40738.59261407348;41129.737864417744;41142.79428602838;30391.848040759654;30558;30750;31129.377412451173;31330.686693133688 15:14:08 INFO - PROCESS | 7324 | |2;jquery.html;412.21473093756407;421.78699756622905;425.09666957714876;429.3002406078092;441.2240731057493;19518.31685890994;20158.49603759905;20603;20753.792462075377;20775.065122069504;19508.804911950876;19903.203871845108;20129;20268.29060982866;20299;5207.9739601302035;5425.7287135643255;5432.320959880015;5434.701091439969;5439.048166570854;5346.117890548055;5361.571074314065;5657.915131273014;6080.057591073369;6106.755729770804;5868.647881127146;6040.758369665208;6047.969760151193;6079.756809727605;6087.634741915477;5297.44376840432;5362.785488580452;5364.141737322048;5511.145772405283;6051.27384713835;5191.247269145991;5253.816116435906;5257.290265814105;5266.078436273637;5266.183741520071;12860.935695321557;13687.794683079761;13721.862781372258;13760.105593136414;13875.37560809766;2511.598144296922;2542.9618555721677;2624.9500199919994;2639.4853003664293;2955.596091856351;9566.665166719202;9989;10278.872973335798;10429.217808664305;14552.417903283857;2022.2517668462615;2028.3205126282712;2053.3224036068063;2071.6996035574907;2097.811196992278;65878.67060664666;83851;84291.57854210751;87494.56252718695;88118;11818.763624727457;11994.400279986141;12124.151309408257;12279.079069069856;12319.876801231872;17017.48947531576;17142.57143571396;17206;17251.65496690059;17292.481225563253;8751.868721969175;8838.911610883937;8923.15230053144;8982.730518084469;9093.454392736458;8257.628406721711;8331.875021874677;8345.332373410112;8525;8540.145985401534;5064.974675126601;5101.362329708786;5252.264682944391;5271.576674297918;5333.306670132858;1923.249932526316;2030.147338117994;2080.9791902080788;2088.3839267416147;2116.322776711468;951.4338968313842;975.380633297861;1040.6357774778767;1066.983995240072;1071.839224116373;20135.19459221644;20411.183552658025;20498.897505512676;20536.281230156874;20661.58676826455;1048.1614708233535;1060.3637817309552;1061.4970597029924;1070;1074.5862842805577;10912.836307455394;11621.24461909973;11636.12729045308;11697.23967942081;11742.295462272292;385896;386991;392182;486312;538986;61911.38088619056;63541.36458635354;63609.68195159087;99759.50120249353;99878;1061.135174832509;1083.090204228452;1105.7180418993266;1109.9278546894427;1115.8437818705224;18237.54406139857;18623.72064419062;18834.811651883854;18985.620287593894;19221.23115075437;44508;45119.548804511534;45210.09579808451;45230.095398091195;45426.54573454223;60164;61816.38183618106;63918.68040659767;64364.356356435834;64792;5507.779688812403;5514.91727624078;8593.785155370915;8810.955945220232;8900.73297801067;12807.871921280668;14153.504627337994;14387;14432.639184020483;14532.491362802251;11799.410029498318;12561.811572826233;12809.743805124031;13013.089083764424;13094.934525327313;12305.384730763604;12734.872651273368;12820.679483013;12841.35793210317;12947.287899165636;13032.804507932198;13175.275359854917;13305.135166214164;13318.866811331764;13611.047226694433;7878.527288362717;8555.272801811916;8591.699290525052;8658.740237792876;9789.363691360324;9542.666006689733;12400.19398739079;12684.682882928;12726.68183295388;12821.487140514648 15:14:08 INFO - PROCESS | 7324 | |3;mootools.html;1512.954611361659;1529;1677.8573821225195;1808.6925222712155;1814.510082277785;9198.494082825442;9317.767055823608;9694.03059694032;9817.50912454377;9862.30963832532;9614.519274036287;9740.853887191697;9748;9749.7562560936;9754.365966212192;2568.422105026368;2596.6883973923154;2611.347163209198;2615;2618.3323252570567;2518.0431436054273;2559.897604095834;2565.243253240289;2571.3700143464785;2574.2277316804884;2559.4113353928606;2559.539282929072;2559.6928368595795;2569.678790151231;2570.6915170179605;2472.443700167466;2503.636972638966;2507.536105820429;2511.460036092249;2514.635377870208;2469.715982661999;2471.147454128323;2471.6045432730857;2535.2521006303186;2554.6551215585846;9524.476153811538;9597.616095356178;9598.90401095987;9672.177864881423;9902.108810207115;5549.112142057292;5730.971345143247;5736.741846616912;5738.225339579145;5749.885002299972;3431.571053618298;3528.523649307336;3546.29074185164;3573.0888623400865;3579.4451859961746;1221.2062159596244;1289.5679947217693;1302.1991475242753;1317.657409073638;1328.0968941120034;12989.675258118528;13096.017798665043;13105.737885242337;13115.213087214797;13165.407556659877;4701.976490117528;4741.193997020515;4867.26990951353;4885.8045678173185;4942.5304596063315;10502.264841461178;10507.422091785025;10516.789664206673;10519.684409467729;10527.315724477885;5578.665280083208;5579.163125531121;5601.579881508822;5632.549396048306;5636.830895073154;4623.12160689468;5156.252343410185;5213.244079608511;5250.238715386247;5268.81559145428;4059.7564146151326;4087.7547347159266;4121.670266378683;4174.165166966558;4209.684273679486;1178.9410529473491;1182.3260741377505;1199.5981346249105;1227.9324637145044;1227.9815802762967;971.621067783565;1040.3341861208833;1044.4151275285865;1089.2974031749477;1090.3512410115968;6434.871302574016;6463.353664633593;6491.9350806492275;6518.315576864456;6547.476201903932;496.4985364781597;506.5846006274819;516.9224616307584;519.1330478101579;521.0360832459919;4441.666874984389;4569.657275704336;4585.220512512881;4647;4647.18674232008;11220.831687524693;11340.20618556693;11702.941485292518;11812;11851.288922664668;12053.457594408274;12058.879411205951;12060.517579296906;12073.87926120745;12092.455839487244;8744;8896.777580560538;8933.240674542736;8940.061293564213;8962.596683149273;6248.218972628421;6336.176297081534;6459.644719540471;6486.643234622141;6549.803505894831;10457.058864702214;10666.679999600025;10847.240693151403;10864.293820901616;10928.508217130408;10871.456427178768;10906.61826836057;11110.888911109148;11112.166587505808;11194.83207751868;8167.550784706898;8336.291415229773;8398.118197589165;8451.619677114668;8538.743837684879;9338.673146439842;9389;9390.295727820305;9403.294752893697;9428.575714092745;8282.71010514629;8552.57237138153;8577.785555361166;8583.613737381707;8590.35572332065;8400.003985294245;8449.619767110371;8485.872711909204;8527.74416767498;8530.360222983178;7763.805904852424;7791.844163116819;7844.294013538809;7847.136814950465;7885.842283154419;5459.481349271813;5631.070873306023;5640.464155905182;5673.404292549223;5816.621919575214;5541.251930989265;5627.943720562906;5636.549076073822;5647.068233741386;5671.461211185096 15:14:08 INFO - PROCESS | 7324 | |4;prototype.html;353.5174486825484;358.5052627374223;361.2341835309145;361.96199399063096;365.5138665574786;5604.719764011804;5611.438856114387;5697.9515958961965;5756.625819321746;5803.274590676166;5668.093105103184;5683.857903552403;5684.459976302255;5698.7435565399555;5703.914441283384;4527.954720452794;4529.456465224162;4537.977310113445;4538.387317712116;4539.774260949542;4445.933311000337;4454.710443821141;4480.238359478896;4492.326151077348;4551.476580193271;4433.822647094113;4435.290353543433;4435.356873253377;4442.067165895166;4463.174312752135;4465.307877279027;4466.3747075409465;4472.776361181945;4510.616597589209;4511.819527218908;3764.5670747864074;3894.2990261752875;4007.158496715693;4018.618231268025;4025.9194816103513;5527.364353099365;5538.363088244863;5554.750181209236;5557.360903496109;5641.12562552805;5108.514691104339;5110.437851836295;5114.954018392636;5120.359955005624;5130.846074617767;5743.942560574383;5962.552808539377;5970.761169553212;5975.655477517567;5992.801439712031;4279.40088387626;4284.186004659105;4296.9570304297185;4300.484216733214;4306.590873866978;6305.558610897239;6330.436173349801;6339.58792678479;6347.682615869188;6375.45808606269;4349.717268377545;4412.514623391425;4431.158079964861;4436.423264975532;4445.82216711328;4480.238359478896;4494.5505449454795;4506.684532082722;4512.413386259831;4513.345564893072;5171.4052883918075;5194.142966410575;5195.142801437796;5197.168453047494;5199.7920083197005;5876.823695289148;6006.789762358297;6048.697565121726;6050.727717252734;6054.455099041019;1533.8082739657543;1560.0717573044021;1560.305663979541;1561.625209949604;1564.1006421307566;952.9618815247312;986.8421052631544;989.7723523589615;1005.6429967361628;1007.8639383683109;5185.61461727602;5190.506901844319;5195.454477279907;5212.296339994128;5219.895602087937;5396.246219978522;5459.344878614592;5464.879699661639;5508.7521061552325;5526.364468086222;4961.627877909171;5044.200468739885;5170.681476223539;5181.715005674649;5186.170212765939;2897.2177512072044;2905.6513218413925;2906;2923.386088921308;2928.765698744138;5651.219865742278;5699.487046165865;5702.800401985911;5714.771409143587;5734.562810805474;5321.973390133102;5491.670499770026;5503.789600955272;5532.225488431623;5546.86132846674;5606.355269144019;5620.227625711009;5657.46254105851;5657.660540367591;5686.516646085046;5073.797048118182;5415.1335786274;5427.891442171055;5443.700596467074;5460;5319.946800531945;5337.466253374631;5339.065663508793;5354.491323324278;5355.25026496283;5623.606347555632;5626.35296940857;5637.267155269788;5643.633163844337;5668.866226754583;3805.8858234253016;3962.7424217425773;3983.980080099581;4005.419214213981;4017.5178978522763;5370.436104209002;5400.729963501731;5421.83734487966;5974.2830860297045;6183.659898705614;6033.758649653964;6089.391060893875;6099.237595300588;6103.389661033861;6145.170401995852;6053.182820319201;6086.665233412028;6109.908351374644;6115;6127.234095738033;5849.151872978479;6029.51763858899;6068.605540639845;6094.238220222473;6120.969395152996;6134.754609815736;6137.447629713347;6137.877242455215;6163.322034576104;6202.379762023942;5871.823845284648;5889.086047034816;5931.436513531207;5962.433568810956;6007 15:14:08 INFO - PROCESS | 7324 | |5;yui.html;839.8572242718737;848.2069265237;886.2998231397197;907.446457660827;917.1104029091779;16287.18564071796;17527.561810954732;17585.73621395677;17632.294708211655;17694.734578981308;15925.840741592581;16070.357185712586;16253;16254.43109491168;16415.917920410382;845.932325413967;870.8084221471266;872.650939624149;872.9214370706635;875.6147295190096;845.9492430454162;873.2315562305195;876.0669886570813;880.4365206267994;881.3962435731545;925.7084018534174;926.2358554192784;931.3852857114306;936.9437833729997;938.2259635800492;919.5402298850574;921.944683319003;924.6347692661394;926.3978414030901;929.930255230857;678.3284548297199;680.3400701319712;681.2982627893277;681.3459079283894;683.3849535418113;15646.9217653911;15861;15881.36474541017;15888.602784930354;15893.443729469413;16017.679646407123;16202.675946481122;16275.430359937345;16463.176841157896;16536.6692666146;13675.179489230679;13735.793963090562;13851.930740346335;13903.235322057282;14009.369578368998;4136.710430269883;4202.789860506993;4214.494260688706;4263.744175349458;4326.82692692295;68281;70696.6465167676;93263;93470;93648.53175734146;12348.135630505778;12478.563250286197;12658.177218480769;12662.873371266354;12886.871131288568;22589.661155082686;22695.432614184778;22832.31503054911;22842.31473055811;22984;9538.093881081286;9579.616815327448;9584.424934503813;9703.854442183372;9735.756606084904;5214.556762675215;5218.112920803396;5256.316678831804;5274.973625131926;5398.406175320712;3922.843086276574;4052.0275133967634;4067.7966101694797;4070.816813243411;4075.898102547401;674.3223060823841;678.8947713104477;684.7089986755708;685.4036987820627;697.3479796390391;684.6277647949878;753;754.2118486181844;778.360584216633;818.5620692929373;10289.279750417549;10441.425721585385;10491.16070714341;10969.122470202365;11041.33751974884;647.3579395239153;710.8187412209853;725.2167658928345;737.2038198745342;751.5115175136096;4843.6367272454;5105.7191854448365;5116.462771409023;5135.204043373283;5192.1173400522;128971.35514322556;129710.35144824216;131644;131741;133224;113001;113198;114323.42838285922;114376;116752;57040.71479642658;78298.6085069571;83247;83649.66114831873;103101.48449257706;10329.535170917177;10397.688069357931;11103.833442498531;11327.546898123983;11472.483738231633;47779.28331074967;56972.430275696715;58774;59404.40595594161;60599;49169.75415122901;76034;76286.23713762792;77501.2249877494;79834;14505;15169.165695886832;15239;15255.542333730005;15369.846301536842;15898.205089745697;15931.522054338388;16120;16306.755398668793;16312.592185195464;15190.240487975336;15519.146446945526;16060.43788467398;16112.194390280205;16618.3352665892;14903.254837257877;14926.477573284883;16257;16295.755563666791;16302;14621.92689036548;15632;15685.607859803597;16165;16176.433824816075;12381.75236495283;12944.935275323563;13261.535846245335;13604.979626528248;13717.314134293047;11282.323060616389;11845.170838041598;12285.69285767863;12999.350032498149;13030.739385212053 15:14:08 INFO - PROCESS | 7324 | __end_tp_report 15:14:08 INFO - PROCESS | 7324 | __start_cc_report 15:14:08 INFO - PROCESS | 7324 | _x_x_mozilla_cycle_collect,352 15:14:08 INFO - PROCESS | 7324 | __end_cc_report 15:14:08 INFO - PROCESS | 7324 | __startTimestamp1476915248128__endTimestamp 15:14:08 INFO - PROCESS | 7324 | 15:14:08 INFO - PROCESS | 7324 | ------- Summary: start ------- 15:14:08 INFO - PROCESS | 7324 | Number of tests: 6 15:14:08 INFO - PROCESS | 7324 | 15:14:08 INFO - PROCESS | 7324 | [#0] dojo.html Cycles:165 Average:5708.82 Median:5943.26 stddev:650.86 (11.0%) stddev-sans-first:624.26 15:14:08 INFO - PROCESS | 7324 | Values: 3276.7 3285.3 3295.6 3305.8 3324.3 5624.5 5646.1 5705.3 5721.8 5752.2 5647.9 5762.8 5768.5 5774.9 5794.4 5256.1 5279.2 5291.6 5320.4 5337.6 5286.5 5291.9 5292.9 5318.9 5332.5 5144.1 5182.8 5289.0 5289.5 5323.5 5162.3 5175.9 5191.4 5284.1 5304.5 5138.2 5186.4 5220.0 5223.0 5230.5 5624.4 5624.6 5704.9 5725.8 5728.4 5985.5 6018.5 6113.7 6113.9 6124.6 5998.8 6006.7 6021.2 6122.8 6123.3 5715.3 5725.3 5725.5 5726.0 5735.7 6199.8 6217.8 6242.8 6255.5 6335.1 6008.5 6069.9 6072.5 6075.5 6094.7 6090.1 6098.0 6155.7 6172.6 6178.7 6172.4 6176.2 6176.4 6184.9 6202.5 6133.6 6142.2 6161.1 6163.0 6180.1 4538.5 4606.6 4640.7 4734.8 4751.4 4152.8 4157.6 4172.0 4181.9 4205.5 5828.1 5881.0 5885.4 5891.3 5896.8 5955.1 6078.8 6082.2 6178.8 6185.4 5821.7 5845.2 5859.9 5895.4 5896.9 5257.1 5299.4 5309.9 5314.6 5316.1 6177.5 6425.0 6434.6 6437.5 6443.1 6034.5 6065.5 6067.5 6138.3 6138.9 6374.4 6376.3 6379.2 6380.4 6380.7 5896.8 6016.7 6019.6 6028.2 6043.4 6131.2 6142.4 6152.9 6249.3 6258.0 6083.0 6090.3 6098.5 6103.1 6106.0 5892.9 6030.4 6039.5 6078.1 6096.3 5891.5 5926.1 5947.5 5996.5 6030.1 6044.6 6050.9 6052.9 6089.3 6096.9 5783.7 5921.4 5930.6 5943.3 5956.3 15:14:08 INFO - PROCESS | 7324 | 15:14:08 INFO - PROCESS | 7324 | [#1] ext.html Cycles:180 Average:65725.79 Median:46476.69 stddev:137100.06 (295.0%) stddev-sans-first:137397.48 15:14:08 INFO - PROCESS | 7324 | Values: 604.4 634.1 665.3 670.2 719.0 41123.4 46405.1 46684.0 46725.8 46765.3 46881.0 47485.0 47585.5 47775.3 47817.5 8958.1 9084.9 9099.9 9106.0 9117.6 9221.5 9357.8 9360.9 9375.2 9376.9 9348.5 9388.7 9398.5 9403.9 9416.1 9355.5 9390.2 9390.9 9441.2 9445.1 9228.4 9293.9 9316.4 9317.9 9348.0 44695.6 44923.3 45121.1 45193.1 45250.3 3960.1 4002.2 4017.5 4139.8 4697.9 35902.0 36018.5 36064.0 36227.5 36965.3 4848.0 4851.0 4855.0 4914.5 4945.2 271498.0 272088.0 272120.0 272498.0 273816.6 65267.3 65498.3 65563.7 65614.4 65665.3 41222.2 41858.0 42039.4 43800.3 70424.6 17318.8 17422.8 17425.0 17445.1 17506.9 13833.7 13853.0 13917.8 14013.2 14028.5 21487.5 21491.2 21556.6 21669.6 21698.1 7509.2 7630.8 7780.8 7810.8 7872.0 1016.5 1063.1 1076.8 1146.5 1171.0 34017.0 34625.0 34835.0 34913.7 34942.1 1129.2 1189.6 1203.1 1242.6 1249.4 17946.9 17957.4 18204.8 18210.9 18257.4 546443.0 613749.0 622731.0 623595.0 914664.0 67620.0 68273.7 68420.3 68565.7 68575.0 1414.8 1461.6 1465.4 1471.1 1471.5 33630.5 35867.3 35887.6 36003.6 36116.0 59092.7 59562.0 59904.1 59977.7 60027.0 502512.0 504531.0 507976.0 508209.0 508684.0 31841.0 32719.2 32721.2 33020.5 33025.8 54138.0 54566.0 54883.0 55028.4 55327.4 44750.8 44939.6 44976.3 46734.8 49522.5 46493.3 46711.3 47099.5 47627.3 47811.0 45473.5 45690.8 46460.1 46655.5 46885.0 39493.6 40655.8 40738.6 41129.7 41142.8 30391.8 30558.0 30750.0 31129.4 31330.7 15:14:08 INFO - PROCESS | 7324 | 15:14:08 INFO - PROCESS | 7324 | [#2] jquery.html Cycles:180 Average:27570.11 Median:2527.28 stddev:73135.95 (2893.9%) stddev-sans-first:73312.68 15:14:08 INFO - PROCESS | 7324 | Values: 412.2 421.8 425.1 429.3 441.2 19518.3 20158.5 20603.0 20753.8 20775.1 19508.8 19903.2 20129.0 20268.3 20299.0 5208.0 5425.7 5432.3 5434.7 5439.0 5346.1 5361.6 5657.9 6080.1 6106.8 5868.6 6040.8 6048.0 6079.8 6087.6 5297.4 5362.8 5364.1 5511.1 6051.3 5191.2 5253.8 5257.3 5266.1 5266.2 12860.9 13687.8 13721.9 13760.1 13875.4 2511.6 2543.0 2625.0 2639.5 2955.6 9566.7 9989.0 10278.9 10429.2 14552.4 2022.3 2028.3 2053.3 2071.7 2097.8 65878.7 83851.0 84291.6 87494.6 88118.0 11818.8 11994.4 12124.2 12279.1 12319.9 17017.5 17142.6 17206.0 17251.7 17292.5 8751.9 8838.9 8923.2 8982.7 9093.5 8257.6 8331.9 8345.3 8525.0 8540.1 5065.0 5101.4 5252.3 5271.6 5333.3 1923.2 2030.1 2081.0 2088.4 2116.3 951.4 975.4 1040.6 1067.0 1071.8 20135.2 20411.2 20498.9 20536.3 20661.6 1048.2 1060.4 1061.5 1070.0 1074.6 10912.8 11621.2 11636.1 11697.2 11742.3 385896.0 386991.0 392182.0 486312.0 538986.0 61911.4 63541.4 63609.7 99759.5 99878.0 1061.1 1083.1 1105.7 1109.9 1115.8 18237.5 18623.7 18834.8 18985.6 19221.2 44508.0 45119.5 45210.1 45230.1 45426.5 60164.0 61816.4 63918.7 64364.4 64792.0 5507.8 5514.9 8593.8 8811.0 8900.7 12807.9 14153.5 14387.0 14432.6 14532.5 11799.4 12561.8 12809.7 13013.1 13094.9 12305.4 12734.9 12820.7 12841.4 12947.3 13032.8 13175.3 13305.1 13318.9 13611.0 7878.5 8555.3 8591.7 8658.7 9789.4 9542.7 12400.2 12684.7 12726.7 12821.5 15:14:08 INFO - PROCESS | 7324 | 15:14:08 INFO - PROCESS | 7324 | [#3] mootools.html Cycles:180 Average:6266.72 Median:4721.59 stddev:3580.33 (75.8%) stddev-sans-first:3572.55 15:14:08 INFO - PROCESS | 7324 | Values: 1513.0 1529.0 1677.9 1808.7 1814.5 9198.5 9317.8 9694.0 9817.5 9862.3 9614.5 9740.9 9748.0 9749.8 9754.4 2568.4 2596.7 2611.3 2615.0 2618.3 2518.0 2559.9 2565.2 2571.4 2574.2 2559.4 2559.5 2559.7 2569.7 2570.7 2472.4 2503.6 2507.5 2511.5 2514.6 2469.7 2471.1 2471.6 2535.3 2554.7 9524.5 9597.6 9598.9 9672.2 9902.1 5549.1 5731.0 5736.7 5738.2 5749.9 3431.6 3528.5 3546.3 3573.1 3579.4 1221.2 1289.6 1302.2 1317.7 1328.1 12989.7 13096.0 13105.7 13115.2 13165.4 4702.0 4741.2 4867.3 4885.8 4942.5 10502.3 10507.4 10516.8 10519.7 10527.3 5578.7 5579.2 5601.6 5632.5 5636.8 4623.1 5156.3 5213.2 5250.2 5268.8 4059.8 4087.8 4121.7 4174.2 4209.7 1178.9 1182.3 1199.6 1227.9 1228.0 971.6 1040.3 1044.4 1089.3 1090.4 6434.9 6463.4 6491.9 6518.3 6547.5 496.5 506.6 516.9 519.1 521.0 4441.7 4569.7 4585.2 4647.0 4647.2 11220.8 11340.2 11702.9 11812.0 11851.3 12053.5 12058.9 12060.5 12073.9 12092.5 8744.0 8896.8 8933.2 8940.1 8962.6 6248.2 6336.2 6459.6 6486.6 6549.8 10457.1 10666.7 10847.2 10864.3 10928.5 10871.5 10906.6 11110.9 11112.2 11194.8 8167.6 8336.3 8398.1 8451.6 8538.7 9338.7 9389.0 9390.3 9403.3 9428.6 8282.7 8552.6 8577.8 8583.6 8590.4 8400.0 8449.6 8485.9 8527.7 8530.4 7763.8 7791.8 7844.3 7847.1 7885.8 5459.5 5631.1 5640.5 5673.4 5816.6 5541.3 5627.9 5636.5 5647.1 5671.5 15:14:08 INFO - PROCESS | 7324 | 15:14:08 INFO - PROCESS | 7324 | [#4] prototype.html Cycles:180 Average:4870.47 Median:5398.49 stddev:1408.25 (26.1%) stddev-sans-first:1370.78 15:14:08 INFO - PROCESS | 7324 | Values: 353.5 358.5 361.2 362.0 365.5 5604.7 5611.4 5698.0 5756.6 5803.3 5668.1 5683.9 5684.5 5698.7 5703.9 4528.0 4529.5 4538.0 4538.4 4539.8 4445.9 4454.7 4480.2 4492.3 4551.5 4433.8 4435.3 4435.4 4442.1 4463.2 4465.3 4466.4 4472.8 4510.6 4511.8 3764.6 3894.3 4007.2 4018.6 4025.9 5527.4 5538.4 5554.8 5557.4 5641.1 5108.5 5110.4 5115.0 5120.4 5130.8 5743.9 5962.6 5970.8 5975.7 5992.8 4279.4 4284.2 4297.0 4300.5 4306.6 6305.6 6330.4 6339.6 6347.7 6375.5 4349.7 4412.5 4431.2 4436.4 4445.8 4480.2 4494.6 4506.7 4512.4 4513.3 5171.4 5194.1 5195.1 5197.2 5199.8 5876.8 6006.8 6048.7 6050.7 6054.5 1533.8 1560.1 1560.3 1561.6 1564.1 953.0 986.8 989.8 1005.6 1007.9 5185.6 5190.5 5195.5 5212.3 5219.9 5396.2 5459.3 5464.9 5508.8 5526.4 4961.6 5044.2 5170.7 5181.7 5186.2 2897.2 2905.7 2906.0 2923.4 2928.8 5651.2 5699.5 5702.8 5714.8 5734.6 5322.0 5491.7 5503.8 5532.2 5546.9 5606.4 5620.2 5657.5 5657.7 5686.5 5073.8 5415.1 5427.9 5443.7 5460.0 5319.9 5337.5 5339.1 5354.5 5355.3 5623.6 5626.4 5637.3 5643.6 5668.9 3805.9 3962.7 3984.0 4005.4 4017.5 5370.4 5400.7 5421.8 5974.3 6183.7 6033.8 6089.4 6099.2 6103.4 6145.2 6053.2 6086.7 6109.9 6115.0 6127.2 5849.2 6029.5 6068.6 6094.2 6121.0 6134.8 6137.4 6137.9 6163.3 6202.4 5871.8 5889.1 5931.4 5962.4 6007.0 15:14:08 INFO - PROCESS | 7324 | 15:14:08 INFO - PROCESS | 7324 | [#5] yui.html Cycles:180 Average:22633.57 Median:13453.42 stddev:32672.60 (242.9%) stddev-sans-first:32723.27 15:14:08 INFO - PROCESS | 7324 | Values: 839.9 848.2 886.3 907.4 917.1 16287.2 17527.6 17585.7 17632.3 17694.7 15925.8 16070.4 16253.0 16254.4 16415.9 845.9 870.8 872.7 872.9 875.6 845.9 873.2 876.1 880.4 881.4 925.7 926.2 931.4 936.9 938.2 919.5 921.9 924.6 926.4 929.9 678.3 680.3 681.3 681.3 683.4 15646.9 15861.0 15881.4 15888.6 15893.4 16017.7 16202.7 16275.4 16463.2 16536.7 13675.2 13735.8 13851.9 13903.2 14009.4 4136.7 4202.8 4214.5 4263.7 4326.8 68281.0 70696.6 93263.0 93470.0 93648.5 12348.1 12478.6 12658.2 12662.9 12886.9 22589.7 22695.4 22832.3 22842.3 22984.0 9538.1 9579.6 9584.4 9703.9 9735.8 5214.6 5218.1 5256.3 5275.0 5398.4 3922.8 4052.0 4067.8 4070.8 4075.9 674.3 678.9 684.7 685.4 697.3 684.6 753.0 754.2 778.4 818.6 10289.3 10441.4 10491.2 10969.1 11041.3 647.4 710.8 725.2 737.2 751.5 4843.6 5105.7 5116.5 5135.2 5192.1 128971.4 129710.4 131644.0 131741.0 133224.0 113001.0 113198.0 114323.4 114376.0 116752.0 57040.7 78298.6 83247.0 83649.7 103101.5 10329.5 10397.7 11103.8 11327.5 11472.5 47779.3 56972.4 58774.0 59404.4 60599.0 49169.8 76034.0 76286.2 77501.2 79834.0 14505.0 15169.2 15239.0 15255.5 15369.8 15898.2 15931.5 16120.0 16306.8 16312.6 15190.2 15519.1 16060.4 16112.2 16618.3 14903.3 14926.5 16257.0 16295.8 16302.0 14621.9 15632.0 15685.6 16165.0 16176.4 12381.8 12944.9 13261.5 13605.0 13717.3 11282.3 11845.2 12285.7 12999.4 13030.7 15:14:08 INFO - PROCESS | 7324 | -------- Summary: end -------- 15:14:08 INFO - PROCESS | 7324 | 15:14:08 INFO - TEST-INFO | 7324: exit 0 15:14:08 INFO - TEST-OK | dromaeo_css | took 1110504ms 15:14:08 INFO - TEST-START | kraken 15:14:08 INFO - operating with platform_type : linux_ 15:14:08 INFO - Initialising browser for kraken test... 15:14:08 INFO - TEST-INFO | started process 7560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqTVb2I/profile http://localhost:50278/getInfo.html) 15:14:13 INFO - PROCESS | 7560 | __metrics Screen width/height:1600/1200 15:14:13 INFO - PROCESS | 7560 | colorDepth:24 15:14:13 INFO - PROCESS | 7560 | Browser inner width/height: 1024/697 15:14:13 INFO - PROCESS | 7560 | __metrics 15:14:13 ERROR - PROCESS | 7560 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 15:14:14 INFO - TEST-INFO | 7560: exit 0 15:14:14 INFO - Browser initialized. 15:14:14 INFO - Running cycle 1/1 for kraken test... 15:14:14 INFO - TEST-INFO | started process 7684 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqTVb2I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:14:26 INFO - PROCESS | 7684 | RSS: Main: 150216704 15:14:26 INFO - PROCESS | 7684 | 15:14:28 INFO - PROCESS | 7684 | Cycle 1(1): loaded http://localhost:50278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50278/tests/kraken/driver.html?testName=audio-beat-detection) 15:14:29 INFO - PROCESS | 7684 | RSS: Main: 156585984 15:14:29 INFO - PROCESS | 7684 | 15:14:32 INFO - PROCESS | 7684 | Cycle 1(1): loaded http://localhost:50278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50278/tests/kraken/driver.html?testName=audio-dft) 15:14:32 INFO - PROCESS | 7684 | RSS: Main: 155250688 15:14:32 INFO - PROCESS | 7684 | 15:14:35 INFO - PROCESS | 7684 | Cycle 1(1): loaded http://localhost:50278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50278/tests/kraken/driver.html?testName=audio-fft) 15:14:36 INFO - PROCESS | 7684 | RSS: Main: 155832320 15:14:36 INFO - PROCESS | 7684 | 15:14:38 INFO - PROCESS | 7684 | Cycle 1(1): loaded http://localhost:50278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50278/tests/kraken/driver.html?testName=audio-oscillator) 15:14:38 INFO - PROCESS | 7684 | RSS: Main: 156090368 15:14:38 INFO - PROCESS | 7684 | 15:14:41 INFO - PROCESS | 7684 | Cycle 1(1): loaded http://localhost:50278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:14:41 INFO - PROCESS | 7684 | RSS: Main: 155459584 15:14:41 INFO - PROCESS | 7684 | 15:14:44 INFO - PROCESS | 7684 | Cycle 1(1): loaded http://localhost:50278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50278/tests/kraken/driver.html?testName=imaging-darkroom) 15:14:45 INFO - PROCESS | 7684 | RSS: Main: 155725824 15:14:45 INFO - PROCESS | 7684 | 15:14:48 INFO - PROCESS | 7684 | Cycle 1(1): loaded http://localhost:50278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50278/tests/kraken/driver.html?testName=imaging-desaturate) 15:14:49 INFO - PROCESS | 7684 | RSS: Main: 156782592 15:14:49 INFO - PROCESS | 7684 | 15:14:52 INFO - PROCESS | 7684 | Cycle 1(1): loaded http://localhost:50278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50278/tests/kraken/driver.html?testName=json-parse-financial) 15:14:52 INFO - PROCESS | 7684 | RSS: Main: 156364800 15:14:52 INFO - PROCESS | 7684 | 15:14:54 INFO - PROCESS | 7684 | Cycle 1(1): loaded http://localhost:50278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:14:55 INFO - PROCESS | 7684 | RSS: Main: 155418624 15:14:55 INFO - PROCESS | 7684 | 15:14:56 INFO - PROCESS | 7684 | Cycle 1(1): loaded http://localhost:50278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50278/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:14:57 INFO - PROCESS | 7684 | RSS: Main: 155705344 15:14:57 INFO - PROCESS | 7684 | 15:14:59 INFO - PROCESS | 7684 | Cycle 1(1): loaded http://localhost:50278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:15:00 INFO - PROCESS | 7684 | RSS: Main: 156610560 15:15:00 INFO - PROCESS | 7684 | 15:15:02 INFO - PROCESS | 7684 | Cycle 1(1): loaded http://localhost:50278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:15:03 INFO - PROCESS | 7684 | RSS: Main: 156397568 15:15:03 INFO - PROCESS | 7684 | 15:15:05 INFO - PROCESS | 7684 | Cycle 1(1): loaded http://localhost:50278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:15:06 INFO - PROCESS | 7684 | RSS: Main: 156663808 15:15:06 INFO - PROCESS | 7684 | 15:15:08 INFO - PROCESS | 7684 | Cycle 1(1): loaded http://localhost:50278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50278/tests/kraken/driver.html?testName=ai-astar) 15:15:08 INFO - PROCESS | 7684 | RSS: Main: 158494720 15:15:08 INFO - PROCESS | 7684 | 15:15:08 INFO - PROCESS | 7684 | __start_tp_report 15:15:08 INFO - PROCESS | 7684 | _x_x_mozilla_page_load 15:15:08 INFO - PROCESS | 7684 | _x_x_mozilla_page_load_details 15:15:08 INFO - PROCESS | 7684 | |i|pagename|runs| 15:15:08 INFO - PROCESS | 7684 | |0;ai-astar;101;111;104;110;112;112;111;110;113;112 15:15:08 INFO - PROCESS | 7684 | |1;audio-beat-detection;146;123;144;181;119;146;140;117;173;120 15:15:08 INFO - PROCESS | 7684 | |2;audio-dft;163;161;162;167;163;162;162;160;160;162 15:15:08 INFO - PROCESS | 7684 | |3;audio-fft;75;77;75;173;78;74;77;75;169;76 15:15:08 INFO - PROCESS | 7684 | |4;audio-oscillator;85;83;147;85;85;84;144;84;84;146 15:15:08 INFO - PROCESS | 7684 | |5;imaging-gaussian-blur;117;117;117;117;117;118;118;118;118;117 15:15:08 INFO - PROCESS | 7684 | |6;imaging-darkroom;147;147;148;145;148;146;146;146;146;147 15:15:08 INFO - PROCESS | 7684 | |7;imaging-desaturate;95;95;95;98;96;96;95;96;96;95 15:15:08 INFO - PROCESS | 7684 | |8;json-parse-financial;52;54;67;55;51;55;51;51;51;50 15:15:08 INFO - PROCESS | 7684 | |9;json-stringify-tinderbox;64;60;60;61;60;59;60;60;64;60 15:15:08 INFO - PROCESS | 7684 | |10;stanford-crypto-aes;74;73;72;83;81;77;75;73;78;73 15:15:08 INFO - PROCESS | 7684 | |11;stanford-crypto-ccm;119;118;127;119;127;129;128;117;154;124 15:15:08 INFO - PROCESS | 7684 | |12;stanford-crypto-pbkdf2;151;154;157;153;165;154;154;158;150;156 15:15:08 INFO - PROCESS | 7684 | |13;stanford-crypto-sha256-iterative;62;65;62;62;63;61;62;63;60;61 15:15:08 INFO - PROCESS | 7684 | __end_tp_report 15:15:08 INFO - PROCESS | 7684 | __start_cc_report 15:15:08 INFO - PROCESS | 7684 | _x_x_mozilla_cycle_collect,901 15:15:08 INFO - PROCESS | 7684 | __end_cc_report 15:15:08 INFO - PROCESS | 7684 | __startTimestamp1476915308447__endTimestamp 15:15:08 INFO - PROCESS | 7684 | 15:15:08 INFO - PROCESS | 7684 | ------- Summary: start ------- 15:15:08 INFO - PROCESS | 7684 | Number of tests: 14 15:15:08 INFO - PROCESS | 7684 | 15:15:08 INFO - PROCESS | 7684 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.50 stddev:3.92 (3.5%) stddev-sans-first:2.65 15:15:08 INFO - PROCESS | 7684 | Values: 101.0 111.0 104.0 110.0 112.0 112.0 111.0 110.0 113.0 112.0 15:15:08 INFO - PROCESS | 7684 | 15:15:08 INFO - PROCESS | 7684 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:145.00 stddev:22.38 (15.4%) stddev-sans-first:23.66 15:15:08 INFO - PROCESS | 7684 | Values: 146.0 123.0 144.0 181.0 119.0 146.0 140.0 117.0 173.0 120.0 15:15:08 INFO - PROCESS | 7684 | 15:15:08 INFO - PROCESS | 7684 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.99 (1.2%) stddev-sans-first:2.09 15:15:08 INFO - PROCESS | 7684 | Values: 163.0 161.0 162.0 167.0 163.0 162.0 162.0 160.0 160.0 162.0 15:15:08 INFO - PROCESS | 7684 | 15:15:08 INFO - PROCESS | 7684 | [#3] audio-fft Cycles:10 Average:94.90 Median:75.50 stddev:40.14 (53.2%) stddev-sans-first:41.92 15:15:08 INFO - PROCESS | 7684 | Values: 75.0 77.0 75.0 173.0 78.0 74.0 77.0 75.0 169.0 76.0 15:15:08 INFO - PROCESS | 7684 | 15:15:08 INFO - PROCESS | 7684 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:84.00 stddev:29.66 (35.3%) stddev-sans-first:30.77 15:15:08 INFO - PROCESS | 7684 | Values: 85.0 83.0 147.0 85.0 85.0 84.0 144.0 84.0 84.0 146.0 15:15:08 INFO - PROCESS | 7684 | 15:15:08 INFO - PROCESS | 7684 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 15:15:08 INFO - PROCESS | 7684 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 117.0 15:15:08 INFO - PROCESS | 7684 | 15:15:08 INFO - PROCESS | 7684 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 15:15:08 INFO - PROCESS | 7684 | Values: 147.0 147.0 148.0 145.0 148.0 146.0 146.0 146.0 146.0 147.0 15:15:08 INFO - PROCESS | 7684 | 15:15:08 INFO - PROCESS | 7684 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.95 (1.0%) stddev-sans-first:0.97 15:15:08 INFO - PROCESS | 7684 | Values: 95.0 95.0 95.0 98.0 96.0 96.0 95.0 96.0 96.0 95.0 15:15:08 INFO - PROCESS | 7684 | 15:15:08 INFO - PROCESS | 7684 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.00 stddev:5.01 (9.5%) stddev-sans-first:5.28 15:15:08 INFO - PROCESS | 7684 | Values: 52.0 54.0 67.0 55.0 51.0 55.0 51.0 51.0 51.0 50.0 15:15:08 INFO - PROCESS | 7684 | 15:15:08 INFO - PROCESS | 7684 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:60.00 stddev:1.75 (2.9%) stddev-sans-first:1.42 15:15:08 INFO - PROCESS | 7684 | Values: 64.0 60.0 60.0 61.0 60.0 59.0 60.0 60.0 64.0 60.0 15:15:08 INFO - PROCESS | 7684 | 15:15:08 INFO - PROCESS | 7684 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:76.00 stddev:3.75 (4.9%) stddev-sans-first:3.92 15:15:08 INFO - PROCESS | 7684 | Values: 74.0 73.0 72.0 83.0 81.0 77.0 75.0 73.0 78.0 73.0 15:15:08 INFO - PROCESS | 7684 | 15:15:08 INFO - PROCESS | 7684 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:127.00 stddev:10.78 (8.5%) stddev-sans-first:11.11 15:15:08 INFO - PROCESS | 7684 | Values: 119.0 118.0 127.0 119.0 127.0 129.0 128.0 117.0 154.0 124.0 15:15:08 INFO - PROCESS | 7684 | 15:15:08 INFO - PROCESS | 7684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:155.00 stddev:4.24 (2.7%) stddev-sans-first:4.21 15:15:08 INFO - PROCESS | 7684 | Values: 151.0 154.0 157.0 153.0 165.0 154.0 154.0 158.0 150.0 156.0 15:15:08 INFO - PROCESS | 7684 | 15:15:08 INFO - PROCESS | 7684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.37 (2.2%) stddev-sans-first:1.45 15:15:08 INFO - PROCESS | 7684 | Values: 62.0 65.0 62.0 62.0 63.0 61.0 62.0 63.0 60.0 61.0 15:15:08 INFO - PROCESS | 7684 | -------- Summary: end -------- 15:15:08 INFO - PROCESS | 7684 | 15:15:09 INFO - TEST-INFO | 7684: exit 0 15:15:09 INFO - TEST-OK | kraken | took 60548ms 15:15:09 INFO - SUITE-END | took 1171s 15:15:09 INFO - Completed test suite (00:19:31) 15:15:09 INFO - javascript benchmark 15:15:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7718.758841317381, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3276.7378609711227, 3285.260816316329, 3295.604527456705, 3305.7851239669435, 3324.335132973406, 5624.521915637176, 5646.124850648151, 5705.343885453174, 5721.828345149642, 5752.165935939286, 5647.8588035299035, 5762.798302059428, 5768.538516918647, 5774.855628609287, 5794.362620111784, 5256.106461901467, 5279.208118782175, 5291.629585928987, 5320.414754377015, 5337.626366154371, 5286.524212820846, 5291.947080529203, 5292.92060619091, 5318.946810531903, 5332.520073193412, 5144.09978253806, 5182.818601348954, 5289.0, 5289.523942845143, 5323.467653234684, 5162.2772811806, 5175.948240517584, 5191.428942816287, 5284.128118860383, 5304.549113325372, 5138.177891537373, 5186.429492755794, 5219.973900130513, 5223.007628550601, 5230.529252367267, 5624.353199382042, 5624.606277560572, 5704.857378565527, 5725.770969161229, 5728.398518155617, 5985.521158307369, 6018.458338749533, 6113.654458598753, 6113.908291375633, 6124.625058545688, 5998.820035398945, 6006.699665016732, 6021.157038014681, 6122.816315510542, 6123.295820980599, 5715.2855893013375, 5725.312962444492, 5725.5133313667975, 5726.026575482178, 5735.684537350444, 6199.752009919643, 6217.782377616762, 6242.750289988349, 6255.46828519581, 6335.081413195061, 6008.459238668541, 6069.878602427927, 6072.544559157993, 6075.48358389533, 6094.6647934363145, 6090.056041313604, 6097.969510152421, 6155.6614386209185, 6172.5679202456295, 6178.66017369049, 6172.382761723792, 6176.197094377702, 6176.444120029129, 6184.907226391608, 6202.534809889276, 6133.570650054453, 6142.201513803177, 6161.075838624242, 6162.969185154136, 6180.103884936659, 4538.478075021349, 4606.585407313358, 4640.6751527393435, 4734.834280800155, 4751.40607424072, 4152.792360381969, 4157.563455837154, 4172.040430700895, 4181.916361672749, 4205.453291072202, 5828.067509198508, 5880.970595146997, 5885.440883116097, 5891.293044834647, 5896.764129434775, 5955.106733989849, 6078.817635470943, 6082.239720034996, 6178.764247150588, 6185.350538193425, 5821.7380217890295, 5845.152452894392, 5859.882802343929, 5895.380984996599, 5896.852578685567, 5257.132573125392, 5299.364076310867, 5309.920351194735, 5314.62797604164, 5316.1494160934835, 6177.505799536027, 6425.0, 6434.581752186093, 6437.452816510649, 6443.097966284724, 6034.456898879122, 6065.545084118797, 6067.514598832171, 6138.296437970319, 6138.940218748475, 6374.394432528902, 6376.330485298977, 6379.170707807955, 6380.3619638035825, 6380.680965951591, 5896.793612223723, 6016.7292471838, 6019.578629496068, 6028.246469191351, 6043.395660433922, 6131.233595800525, 6142.40669208518, 6152.907706384497, 6249.281332646804, 6258.0, 6083.026715725463, 6090.330063692902, 6098.512119030378, 6103.11504831788, 6105.969470152799, 5892.911606325994, 6030.3668114847305, 6039.486643635164, 6078.057901025348, 6096.29892562361, 5891.528677705687, 5926.140709597171, 5947.464728174312, 5996.4603185713495, 6030.065339872327, 6044.637321760709, 6050.878982420239, 6052.909206361996, 6089.269287685506, 6096.939030609815, 5783.681897495678, 5921.437463440966, 5930.555208359477, 5943.257092863392, 5956.344802071682], "value": 5664.33209321074, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.3956043956044, 634.09324665728, 665.3280187011119, 670.2359310386161, 718.9568625882445, 41123.383149252746, 46405.07189856201, 46684.0, 46725.76637116814, 46765.29852052218, 46881.0, 47485.0, 47585.52414475854, 47775.28337074938, 47817.52182478174, 8958.10418958104, 9084.8637270441, 9099.863502047474, 9105.95447022764, 9117.589708463134, 9221.538923053855, 9357.76605584859, 9360.906390936105, 9375.156235938764, 9376.8593471098, 9348.532573371338, 9388.671396501124, 9398.483083430408, 9403.905960940405, 9416.10546998034, 9355.532223388838, 9390.15488606022, 9390.85913711295, 9441.19749821266, 9445.149936505748, 9228.40015398997, 9293.907060929372, 9316.394434361744, 9317.860232096524, 9348.0, 44695.55304446979, 44923.32615010777, 45121.097578048255, 45193.09613807738, 45250.321245181345, 3960.0693836948294, 4002.1795531915886, 4017.4576432181866, 4139.77231252281, 4697.859064228079, 35902.0, 36018.45972310418, 36064.0, 36227.456588151195, 36965.26069478622, 4847.951520484785, 4850.975745121252, 4854.951450485485, 4914.4839791821705, 4945.159322915113, 271498.0, 272088.0, 272120.0, 272498.0, 273816.63091684616, 65267.34732652707, 65498.34501655018, 65563.67218163879, 65614.3596410084, 65665.34334656592, 41222.1755564887, 41858.0, 42039.36940945888, 43800.342994854465, 70424.64787676028, 17318.826811731975, 17422.825771742373, 17425.0, 17445.127743613022, 17506.912465437592, 13833.723325533634, 13853.0, 13917.791233131511, 14013.229272390117, 14028.509002184874, 21487.46281342979, 21491.247806326704, 21556.56886862254, 21669.566608667737, 21698.13207471715, 7509.249075092556, 7630.7710768677025, 7780.844383112306, 7810.828375743684, 7871.960640196762, 1016.5120742043713, 1063.1136464498923, 1076.7523469601879, 1146.5471138900089, 1170.9824352634716, 34017.0, 34625.0, 34835.0, 34913.650863491544, 34942.12644683853, 1129.2321221569412, 1189.649053529211, 1203.1277323940074, 1242.577523641966, 1249.3940438887132, 17946.91026544859, 17957.37149199798, 18204.817951820576, 18210.908945455187, 18257.360992365204, 546443.0, 613749.0, 622731.0, 623595.0, 914664.0, 67620.0, 68273.65863170652, 68420.31579684239, 68565.65717171383, 68575.0, 1414.8231471066117, 1461.5688371930305, 1465.3625672832352, 1471.146734893759, 1471.4555614422732, 33630.495542566394, 35867.28265434729, 35887.64112358843, 36003.63996360003, 36116.0, 59092.704536477046, 59562.0, 59904.101438477584, 59977.700111499165, 60027.0, 502512.0, 504531.0, 507976.0, 508209.0, 508684.0, 31841.0, 32719.18202044968, 32721.181970449976, 33020.50469242915, 33025.83487082549, 54138.0, 54566.0, 54883.0, 55028.449715502335, 55327.44672553384, 44750.77624611856, 44939.55060449484, 44976.32535512035, 46734.76632616951, 49522.50477495179, 46493.3026004617, 46711.29933051075, 47099.52900471089, 47627.28559071686, 47811.0, 45473.545264546934, 45690.77154614206, 46460.070798584515, 46655.53344466512, 46885.0, 39493.60506394899, 40655.7967210162, 40738.59261407348, 41129.737864417744, 41142.79428602838, 30391.848040759654, 30558.0, 30750.0, 31129.377412451173, 31330.686693133688], "value": 21792.943882748106, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.21473093756407, 421.78699756622905, 425.09666957714876, 429.3002406078092, 441.2240731057493, 19518.31685890994, 20158.49603759905, 20603.0, 20753.792462075377, 20775.065122069504, 19508.804911950876, 19903.203871845108, 20129.0, 20268.29060982866, 20299.0, 5207.9739601302035, 5425.7287135643255, 5432.320959880015, 5434.701091439969, 5439.048166570854, 5346.117890548055, 5361.571074314065, 5657.915131273014, 6080.057591073369, 6106.755729770804, 5868.647881127146, 6040.758369665208, 6047.969760151193, 6079.756809727605, 6087.634741915477, 5297.44376840432, 5362.785488580452, 5364.141737322048, 5511.145772405283, 6051.27384713835, 5191.247269145991, 5253.816116435906, 5257.290265814105, 5266.078436273637, 5266.183741520071, 12860.935695321557, 13687.794683079761, 13721.862781372258, 13760.105593136414, 13875.37560809766, 2511.598144296922, 2542.9618555721677, 2624.9500199919994, 2639.4853003664293, 2955.596091856351, 9566.665166719202, 9989.0, 10278.872973335798, 10429.217808664305, 14552.417903283857, 2022.2517668462615, 2028.3205126282712, 2053.3224036068063, 2071.6996035574907, 2097.811196992278, 65878.67060664666, 83851.0, 84291.57854210751, 87494.56252718695, 88118.0, 11818.763624727457, 11994.400279986141, 12124.151309408257, 12279.079069069856, 12319.876801231872, 17017.48947531576, 17142.57143571396, 17206.0, 17251.65496690059, 17292.481225563253, 8751.868721969175, 8838.911610883937, 8923.15230053144, 8982.730518084469, 9093.454392736458, 8257.628406721711, 8331.875021874677, 8345.332373410112, 8525.0, 8540.145985401534, 5064.974675126601, 5101.362329708786, 5252.264682944391, 5271.576674297918, 5333.306670132858, 1923.249932526316, 2030.147338117994, 2080.9791902080788, 2088.3839267416147, 2116.322776711468, 951.4338968313842, 975.380633297861, 1040.6357774778767, 1066.983995240072, 1071.839224116373, 20135.19459221644, 20411.183552658025, 20498.897505512676, 20536.281230156874, 20661.58676826455, 1048.1614708233535, 1060.3637817309552, 1061.4970597029924, 1070.0, 1074.5862842805577, 10912.836307455394, 11621.24461909973, 11636.12729045308, 11697.23967942081, 11742.295462272292, 385896.0, 386991.0, 392182.0, 486312.0, 538986.0, 61911.38088619056, 63541.36458635354, 63609.68195159087, 99759.50120249353, 99878.0, 1061.135174832509, 1083.090204228452, 1105.7180418993266, 1109.9278546894427, 1115.8437818705224, 18237.54406139857, 18623.72064419062, 18834.811651883854, 18985.620287593894, 19221.23115075437, 44508.0, 45119.548804511534, 45210.09579808451, 45230.095398091195, 45426.54573454223, 60164.0, 61816.38183618106, 63918.68040659767, 64364.356356435834, 64792.0, 5507.779688812403, 5514.91727624078, 8593.785155370915, 8810.955945220232, 8900.73297801067, 12807.871921280668, 14153.504627337994, 14387.0, 14432.639184020483, 14532.491362802251, 11799.410029498318, 12561.811572826233, 12809.743805124031, 13013.089083764424, 13094.934525327313, 12305.384730763604, 12734.872651273368, 12820.679483013, 12841.35793210317, 12947.287899165636, 13032.804507932198, 13175.275359854917, 13305.135166214164, 13318.866811331764, 13611.047226694433, 7878.527288362717, 8555.272801811916, 8591.699290525052, 8658.740237792876, 9789.363691360324, 9542.666006689733, 12400.19398739079, 12684.682882928, 12726.68183295388, 12821.487140514648], "value": 9436.575344164654, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1512.954611361659, 1529.0, 1677.8573821225195, 1808.6925222712155, 1814.510082277785, 9198.494082825442, 9317.767055823608, 9694.03059694032, 9817.50912454377, 9862.30963832532, 9614.519274036287, 9740.853887191697, 9748.0, 9749.7562560936, 9754.365966212192, 2568.422105026368, 2596.6883973923154, 2611.347163209198, 2615.0, 2618.3323252570567, 2518.0431436054273, 2559.897604095834, 2565.243253240289, 2571.3700143464785, 2574.2277316804884, 2559.4113353928606, 2559.539282929072, 2559.6928368595795, 2569.678790151231, 2570.6915170179605, 2472.443700167466, 2503.636972638966, 2507.536105820429, 2511.460036092249, 2514.635377870208, 2469.715982661999, 2471.147454128323, 2471.6045432730857, 2535.2521006303186, 2554.6551215585846, 9524.476153811538, 9597.616095356178, 9598.90401095987, 9672.177864881423, 9902.108810207115, 5549.112142057292, 5730.971345143247, 5736.741846616912, 5738.225339579145, 5749.885002299972, 3431.571053618298, 3528.523649307336, 3546.29074185164, 3573.0888623400865, 3579.4451859961746, 1221.2062159596244, 1289.5679947217693, 1302.1991475242753, 1317.657409073638, 1328.0968941120034, 12989.675258118528, 13096.017798665043, 13105.737885242337, 13115.213087214797, 13165.407556659877, 4701.976490117528, 4741.193997020515, 4867.26990951353, 4885.8045678173185, 4942.5304596063315, 10502.264841461178, 10507.422091785025, 10516.789664206673, 10519.684409467729, 10527.315724477885, 5578.665280083208, 5579.163125531121, 5601.579881508822, 5632.549396048306, 5636.830895073154, 4623.12160689468, 5156.252343410185, 5213.244079608511, 5250.238715386247, 5268.81559145428, 4059.7564146151326, 4087.7547347159266, 4121.670266378683, 4174.165166966558, 4209.684273679486, 1178.9410529473491, 1182.3260741377505, 1199.5981346249105, 1227.9324637145044, 1227.9815802762967, 971.621067783565, 1040.3341861208833, 1044.4151275285865, 1089.2974031749477, 1090.3512410115968, 6434.871302574016, 6463.353664633593, 6491.9350806492275, 6518.315576864456, 6547.476201903932, 496.4985364781597, 506.5846006274819, 516.9224616307584, 519.1330478101579, 521.0360832459919, 4441.666874984389, 4569.657275704336, 4585.220512512881, 4647.0, 4647.18674232008, 11220.831687524693, 11340.20618556693, 11702.941485292518, 11812.0, 11851.288922664668, 12053.457594408274, 12058.879411205951, 12060.517579296906, 12073.87926120745, 12092.455839487244, 8744.0, 8896.777580560538, 8933.240674542736, 8940.061293564213, 8962.596683149273, 6248.218972628421, 6336.176297081534, 6459.644719540471, 6486.643234622141, 6549.803505894831, 10457.058864702214, 10666.679999600025, 10847.240693151403, 10864.293820901616, 10928.508217130408, 10871.456427178768, 10906.61826836057, 11110.888911109148, 11112.166587505808, 11194.83207751868, 8167.550784706898, 8336.291415229773, 8398.118197589165, 8451.619677114668, 8538.743837684879, 9338.673146439842, 9389.0, 9390.295727820305, 9403.294752893697, 9428.575714092745, 8282.71010514629, 8552.57237138153, 8577.785555361166, 8583.613737381707, 8590.35572332065, 8400.003985294245, 8449.619767110371, 8485.872711909204, 8527.74416767498, 8530.360222983178, 7763.805904852424, 7791.844163116819, 7844.294013538809, 7847.136814950465, 7885.842283154419, 5459.481349271813, 5631.070873306023, 5640.464155905182, 5673.404292549223, 5816.621919575214, 5541.251930989265, 5627.943720562906, 5636.549076073822, 5647.068233741386, 5671.461211185096], "value": 4924.56284920249, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.5174486825484, 358.5052627374223, 361.2341835309145, 361.96199399063096, 365.5138665574786, 5604.719764011804, 5611.438856114387, 5697.9515958961965, 5756.625819321746, 5803.274590676166, 5668.093105103184, 5683.857903552403, 5684.459976302255, 5698.7435565399555, 5703.914441283384, 4527.954720452794, 4529.456465224162, 4537.977310113445, 4538.387317712116, 4539.774260949542, 4445.933311000337, 4454.710443821141, 4480.238359478896, 4492.326151077348, 4551.476580193271, 4433.822647094113, 4435.290353543433, 4435.356873253377, 4442.067165895166, 4463.174312752135, 4465.307877279027, 4466.3747075409465, 4472.776361181945, 4510.616597589209, 4511.819527218908, 3764.5670747864074, 3894.2990261752875, 4007.158496715693, 4018.618231268025, 4025.9194816103513, 5527.364353099365, 5538.363088244863, 5554.750181209236, 5557.360903496109, 5641.12562552805, 5108.514691104339, 5110.437851836295, 5114.954018392636, 5120.359955005624, 5130.846074617767, 5743.942560574383, 5962.552808539377, 5970.761169553212, 5975.655477517567, 5992.801439712031, 4279.40088387626, 4284.186004659105, 4296.9570304297185, 4300.484216733214, 4306.590873866978, 6305.558610897239, 6330.436173349801, 6339.58792678479, 6347.682615869188, 6375.45808606269, 4349.717268377545, 4412.514623391425, 4431.158079964861, 4436.423264975532, 4445.82216711328, 4480.238359478896, 4494.5505449454795, 4506.684532082722, 4512.413386259831, 4513.345564893072, 5171.4052883918075, 5194.142966410575, 5195.142801437796, 5197.168453047494, 5199.7920083197005, 5876.823695289148, 6006.789762358297, 6048.697565121726, 6050.727717252734, 6054.455099041019, 1533.8082739657543, 1560.0717573044021, 1560.305663979541, 1561.625209949604, 1564.1006421307566, 952.9618815247312, 986.8421052631544, 989.7723523589615, 1005.6429967361628, 1007.8639383683109, 5185.61461727602, 5190.506901844319, 5195.454477279907, 5212.296339994128, 5219.895602087937, 5396.246219978522, 5459.344878614592, 5464.879699661639, 5508.7521061552325, 5526.364468086222, 4961.627877909171, 5044.200468739885, 5170.681476223539, 5181.715005674649, 5186.170212765939, 2897.2177512072044, 2905.6513218413925, 2906.0, 2923.386088921308, 2928.765698744138, 5651.219865742278, 5699.487046165865, 5702.800401985911, 5714.771409143587, 5734.562810805474, 5321.973390133102, 5491.670499770026, 5503.789600955272, 5532.225488431623, 5546.86132846674, 5606.355269144019, 5620.227625711009, 5657.46254105851, 5657.660540367591, 5686.516646085046, 5073.797048118182, 5415.1335786274, 5427.891442171055, 5443.700596467074, 5460.0, 5319.946800531945, 5337.466253374631, 5339.065663508793, 5354.491323324278, 5355.25026496283, 5623.606347555632, 5626.35296940857, 5637.267155269788, 5643.633163844337, 5668.866226754583, 3805.8858234253016, 3962.7424217425773, 3983.980080099581, 4005.419214213981, 4017.5178978522763, 5370.436104209002, 5400.729963501731, 5421.83734487966, 5974.2830860297045, 6183.659898705614, 6033.758649653964, 6089.391060893875, 6099.237595300588, 6103.389661033861, 6145.170401995852, 6053.182820319201, 6086.665233412028, 6109.908351374644, 6115.0, 6127.234095738033, 5849.151872978479, 6029.51763858899, 6068.605540639845, 6094.238220222473, 6120.969395152996, 6134.754609815736, 6137.447629713347, 6137.877242455215, 6163.322034576104, 6202.379762023942, 5871.823845284648, 5889.086047034816, 5931.436513531207, 5962.433568810956, 6007.0], "value": 4426.567651916595, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [839.8572242718737, 848.2069265237, 886.2998231397197, 907.446457660827, 917.1104029091779, 16287.18564071796, 17527.561810954732, 17585.73621395677, 17632.294708211655, 17694.734578981308, 15925.840741592581, 16070.357185712586, 16253.0, 16254.43109491168, 16415.917920410382, 845.932325413967, 870.8084221471266, 872.650939624149, 872.9214370706635, 875.6147295190096, 845.9492430454162, 873.2315562305195, 876.0669886570813, 880.4365206267994, 881.3962435731545, 925.7084018534174, 926.2358554192784, 931.3852857114306, 936.9437833729997, 938.2259635800492, 919.5402298850574, 921.944683319003, 924.6347692661394, 926.3978414030901, 929.930255230857, 678.3284548297199, 680.3400701319712, 681.2982627893277, 681.3459079283894, 683.3849535418113, 15646.9217653911, 15861.0, 15881.36474541017, 15888.602784930354, 15893.443729469413, 16017.679646407123, 16202.675946481122, 16275.430359937345, 16463.176841157896, 16536.6692666146, 13675.179489230679, 13735.793963090562, 13851.930740346335, 13903.235322057282, 14009.369578368998, 4136.710430269883, 4202.789860506993, 4214.494260688706, 4263.744175349458, 4326.82692692295, 68281.0, 70696.6465167676, 93263.0, 93470.0, 93648.53175734146, 12348.135630505778, 12478.563250286197, 12658.177218480769, 12662.873371266354, 12886.871131288568, 22589.661155082686, 22695.432614184778, 22832.31503054911, 22842.31473055811, 22984.0, 9538.093881081286, 9579.616815327448, 9584.424934503813, 9703.854442183372, 9735.756606084904, 5214.556762675215, 5218.112920803396, 5256.316678831804, 5274.973625131926, 5398.406175320712, 3922.843086276574, 4052.0275133967634, 4067.7966101694797, 4070.816813243411, 4075.898102547401, 674.3223060823841, 678.8947713104477, 684.7089986755708, 685.4036987820627, 697.3479796390391, 684.6277647949878, 753.0, 754.2118486181844, 778.360584216633, 818.5620692929373, 10289.279750417549, 10441.425721585385, 10491.16070714341, 10969.122470202365, 11041.33751974884, 647.3579395239153, 710.8187412209853, 725.2167658928345, 737.2038198745342, 751.5115175136096, 4843.6367272454, 5105.7191854448365, 5116.462771409023, 5135.204043373283, 5192.1173400522, 128971.35514322556, 129710.35144824216, 131644.0, 131741.0, 133224.0, 113001.0, 113198.0, 114323.42838285922, 114376.0, 116752.0, 57040.71479642658, 78298.6085069571, 83247.0, 83649.66114831873, 103101.48449257706, 10329.535170917177, 10397.688069357931, 11103.833442498531, 11327.546898123983, 11472.483738231633, 47779.28331074967, 56972.430275696715, 58774.0, 59404.40595594161, 60599.0, 49169.75415122901, 76034.0, 76286.23713762792, 77501.2249877494, 79834.0, 14505.0, 15169.165695886832, 15239.0, 15255.542333730005, 15369.846301536842, 15898.205089745697, 15931.522054338388, 16120.0, 16306.755398668793, 16312.592185195464, 15190.240487975336, 15519.146446945526, 16060.43788467398, 16112.194390280205, 16618.3352665892, 14903.254837257877, 14926.477573284883, 16257.0, 16295.755563666791, 16302.0, 14621.92689036548, 15632.0, 15685.607859803597, 16165.0, 16176.433824816075, 12381.75236495283, 12944.935275323563, 13261.535846245335, 13604.979626528248, 13717.314134293047, 11282.323060616389, 11845.170838041598, 12285.69285767863, 12999.350032498149, 13030.739385212053], "value": 8327.747537224377, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1503.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 104.0, 110.0, 112.0, 112.0, 111.0, 110.0, 113.0, 112.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 123.0, 144.0, 181.0, 119.0, 146.0, 140.0, 117.0, 173.0, 120.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 167.0, 163.0, 162.0, 162.0, 160.0, 160.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 173.0, 78.0, 74.0, 77.0, 75.0, 169.0, 76.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 147.0, 85.0, 85.0, 84.0, 144.0, 84.0, 84.0, 146.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 145.0, 148.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 98.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 54.0, 67.0, 55.0, 51.0, 55.0, 51.0, 51.0, 51.0, 50.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 60.0, 60.0, 61.0, 60.0, 59.0, 60.0, 60.0, 64.0, 60.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 83.0, 81.0, 77.0, 75.0, 73.0, 78.0, 73.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 127.0, 119.0, 127.0, 129.0, 128.0, 117.0, 154.0, 124.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 154.0, 157.0, 153.0, 165.0, 154.0, 154.0, 158.0, 150.0, 156.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 62.0, 62.0, 63.0, 61.0, 62.0, 63.0, 60.0, 61.0], "value": 62.1, "unit": "score"}]}]} 15:15:09 INFO - Return code: 0 15:15:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:15:09 ERROR - # TBPL SUCCESS # 15:15:09 INFO - Running post-action listener: _resource_record_post_action 15:15:09 INFO - [mozharness: 2016-10-19 22:15:09.742449Z] Finished run-tests step (success) 15:15:09 INFO - Running post-run listener: _resource_record_post_run 15:15:09 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 2215936; Write bytes: 290332672; Read time: 168; Write time: 160932 15:15:09 INFO - TinderboxPrint: CPU usage
13.2% 15:15:09 INFO - TinderboxPrint: I/O read bytes / time
2,215,936 / 168 15:15:09 INFO - TinderboxPrint: I/O write bytes / time
290,332,672 / 160,932 15:15:09 INFO - TinderboxPrint: CPU idle
8,202.9 (86.7%) 15:15:09 INFO - TinderboxPrint: CPU user
1,199.7 (12.7%) 15:15:09 INFO - TinderboxPrint: Swap in / out
0 / 0 15:15:09 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 139264; Write bytes: 70111232; Read time: 72; Write time: 49024 15:15:09 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 344064; Write bytes: 220221440; Read time: 68; Write time: 111908 15:15:10 INFO - Running post-run listener: _upload_blobber_files 15:15:10 INFO - Blob upload gear active. 15:15:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:15:10 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 15:15:10 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'] 15:15:10 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 15:15:10 INFO - (blobuploader) - INFO - Open directory for files ... 15:15:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:15:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:15:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:15:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:15:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:15:15 INFO - (blobuploader) - INFO - Done attempting. 15:15:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:15:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:15:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:15:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:15:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:15:16 INFO - (blobuploader) - INFO - Done attempting. 15:15:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:15:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:15:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:15:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:15:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:15:17 INFO - (blobuploader) - INFO - Done attempting. 15:15:17 INFO - (blobuploader) - INFO - Iteration through files over. 15:15:17 INFO - Return code: 0 15:15:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:15:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:15:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1ef2a82510b4b6d4f3aa73f2265ff29782dcb3954f9f53f7385a96390ebeb071a3cafbd5edc4672195b3a2b43f0346bb6eb962640460d9808ddfb2ec98c19244", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30cb2e201ecbd5c080e6124a43ab7709e489f4b66370d2657f13d2e5a447be5405c0ee646a6b246012da27630c76487b226a49c3855582de75c95fc1960400c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f758a1642c1b3c863516445f24c3973e7693ca488ea994514131d5a4b22f6e534be86b9b1e7abb0ecc4192c8e90c0acb433d9eee59b1b9266405467acc5d9cb9"} 15:15:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:15:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:15:17 INFO - Contents: 15:15:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1ef2a82510b4b6d4f3aa73f2265ff29782dcb3954f9f53f7385a96390ebeb071a3cafbd5edc4672195b3a2b43f0346bb6eb962640460d9808ddfb2ec98c19244", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30cb2e201ecbd5c080e6124a43ab7709e489f4b66370d2657f13d2e5a447be5405c0ee646a6b246012da27630c76487b226a49c3855582de75c95fc1960400c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f758a1642c1b3c863516445f24c3973e7693ca488ea994514131d5a4b22f6e534be86b9b1e7abb0ecc4192c8e90c0acb433d9eee59b1b9266405467acc5d9cb9"} 15:15:17 INFO - Running post-run listener: copy_logs_to_upload_dir 15:15:17 INFO - Copying logs to upload dir... 15:15:17 INFO - mkdir: /builds/slave/test/build/upload/logs 15:15:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1673.660913 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-10-19 15:15:17.453733) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 15:15:17.457123) ========= 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=8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1ef2a82510b4b6d4f3aa73f2265ff29782dcb3954f9f53f7385a96390ebeb071a3cafbd5edc4672195b3a2b43f0346bb6eb962640460d9808ddfb2ec98c19244", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30cb2e201ecbd5c080e6124a43ab7709e489f4b66370d2657f13d2e5a447be5405c0ee646a6b246012da27630c76487b226a49c3855582de75c95fc1960400c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f758a1642c1b3c863516445f24c3973e7693ca488ea994514131d5a4b22f6e534be86b9b1e7abb0ecc4192c8e90c0acb433d9eee59b1b9266405467acc5d9cb9"} build_url:https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/LNqn3yMKRLKMizX-Z0SDqA/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1ef2a82510b4b6d4f3aa73f2265ff29782dcb3954f9f53f7385a96390ebeb071a3cafbd5edc4672195b3a2b43f0346bb6eb962640460d9808ddfb2ec98c19244", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/30cb2e201ecbd5c080e6124a43ab7709e489f4b66370d2657f13d2e5a447be5405c0ee646a6b246012da27630c76487b226a49c3855582de75c95fc1960400c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f758a1642c1b3c863516445f24c3973e7693ca488ea994514131d5a4b22f6e534be86b9b1e7abb0ecc4192c8e90c0acb433d9eee59b1b9266405467acc5d9cb9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 15:15:17.484998) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:15:17.485553) ========= 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=8887e36bb8e381bfd44124ac000001a8-1476913641.825180-986605008 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004556 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 15:15:17.569222) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 15:15:17.569546) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 15:15:17.569882) ========= ========= Total master_lag: 0.21 =========