builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1477355233.35 results: success (0) buildid: 20161024154922 builduid: e383cf7212a842c4aa78236149b1114f revision: 0c671ce41082a2bba72b4e2340c391f9a5d83b6b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 17:27:13.354349) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 17:27:13.354803) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 17:27:13.355082) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 17:27:13.369771) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:27:13.370051) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-24 17:27:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-10-24 17:27:13 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101125 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:27:13.484886) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:27:13.485204) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018371 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:27:13.536888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:27:13.537749) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0c671ce41082a2bba72b4e2340c391f9a5d83b6b --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 0c671ce41082a2bba72b4e2340c391f9a5d83b6b --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=934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-24 17:27:13,812 truncating revision to first 12 chars 2016-10-24 17:27:13,812 Setting DEBUG logging. 2016-10-24 17:27:13,813 attempt 1/10 2016-10-24 17:27:13,813 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0c671ce41082?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 17:27:14,370 unpacking tar archive at: mozilla-beta-0c671ce41082/testing/mozharness/ program finished with exit code 0 elapsedTime=0.933725 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:27:14.487011) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 17:27:14.487351) ========= script_repo_revision: 0c671ce41082a2bba72b4e2340c391f9a5d83b6b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 17:27:14.487755) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 17:27:14.488026) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 17:27:14.498221) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 54 secs) (at 2016-10-24 17:27:14.498613) ========= /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=934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:27:14 INFO - MultiFileLogger online at 20161024 17:27:14 in /builds/slave/test 17:27:14 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 17:27:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:27:14 INFO - {'append_to_log': False, 17:27:14 INFO - 'base_work_dir': '/builds/slave/test', 17:27:14 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:27:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:27:14 INFO - 'branch': 'Mozilla-Beta', 17:27:14 INFO - 'buildbot_json_path': 'buildprops.json', 17:27:14 INFO - 'config_files': ('talos/linux_config.py',), 17:27:14 INFO - 'default_actions': ('clobber', 17:27:14 INFO - 'read-buildbot-config', 17:27:14 INFO - 'download-and-extract', 17:27:14 INFO - 'populate-webroot', 17:27:14 INFO - 'create-virtualenv', 17:27:14 INFO - 'install', 17:27:14 INFO - 'run-tests'), 17:27:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:27:14 INFO - 'download_minidump_stackwalk': True, 17:27:14 INFO - 'download_symbols': 'ondemand', 17:27:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:27:14 INFO - 'tooltool.py': '/tools/tooltool.py', 17:27:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:27:14 INFO - '/tools/misc-python/virtualenv.py')}, 17:27:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:27:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:27:14 INFO - 'installer_path': 'installer.exe', 17:27:14 INFO - 'log_level': 'info', 17:27:14 INFO - 'log_name': 'talos', 17:27:14 INFO - 'log_to_console': True, 17:27:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:27:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:27:14 INFO - 'opt_config_files': (), 17:27:14 INFO - 'pip_index': False, 17:27:14 INFO - 'sps_profile': False, 17:27:14 INFO - 'sps_profile_interval': 0, 17:27:14 INFO - 'suite': 'dromaeojs-e10s', 17:27:14 INFO - 'system_bits': '32', 17:27:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:27:14 INFO - 'title': 'talos-linux64-ix-057', 17:27:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:27:14 INFO - 'use_talos_json': True, 17:27:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:27:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:27:14 INFO - 'work_dir': 'build'} 17:27:14 INFO - [mozharness: 2016-10-25 00:27:14.874617Z] Running clobber step. 17:27:14 INFO - Running pre-action listener: _resource_record_pre_action 17:27:14 INFO - Running main action method: clobber 17:27:14 INFO - rmtree: /builds/slave/test/build 17:27:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:27:15 INFO - Running post-action listener: _resource_record_post_action 17:27:15 INFO - [mozharness: 2016-10-25 00:27:15.328937Z] Finished clobber step (success) 17:27:15 INFO - [mozharness: 2016-10-25 00:27:15.329038Z] Running read-buildbot-config step. 17:27:15 INFO - Running pre-action listener: _resource_record_pre_action 17:27:15 INFO - Running main action method: read_buildbot_config 17:27:15 INFO - Using buildbot properties: 17:27:15 INFO - { 17:27:15 INFO - "project": "", 17:27:15 INFO - "product": "firefox", 17:27:15 INFO - "script_repo_revision": "production", 17:27:15 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 17:27:15 INFO - "repository": "", 17:27:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 17:27:15 INFO - "buildid": "20161024154922", 17:27:15 INFO - "pgo_build": "True", 17:27:15 INFO - "basedir": "/builds/slave/test", 17:27:15 INFO - "buildnumber": 299, 17:27:15 INFO - "slavename": "talos-linux64-ix-057", 17:27:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:27:15 INFO - "platform": "ubuntu64_hw", 17:27:15 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 17:27:15 INFO - "branch": "mozilla-beta", 17:27:15 INFO - "repo_path": "releases/mozilla-beta", 17:27:15 INFO - "revision": "0c671ce41082a2bba72b4e2340c391f9a5d83b6b", 17:27:15 INFO - "stage_platform": "linux64-pgo", 17:27:15 INFO - "builduid": "e383cf7212a842c4aa78236149b1114f", 17:27:15 INFO - "slavebuilddir": "test" 17:27:15 INFO - } 17:27:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 17:27:15 INFO - Running post-action listener: _resource_record_post_action 17:27:15 INFO - [mozharness: 2016-10-25 00:27:15.331563Z] Finished read-buildbot-config step (success) 17:27:15 INFO - [mozharness: 2016-10-25 00:27:15.331653Z] Running download-and-extract step. 17:27:15 INFO - Running pre-action listener: _resource_record_pre_action 17:27:15 INFO - Running main action method: download_and_extract 17:27:15 INFO - mkdir: /builds/slave/test/build/tests 17:27:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:27:15 INFO - https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:27:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:27:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:27:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:27:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:27:15 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:27:15 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:27:15 INFO - retry: Failed, sleeping 30 seconds before retrying 17:27:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:27:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:27:45 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:27:45 INFO - retry: Failed, sleeping 60 seconds before retrying 17:28:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:28:45 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:28:45 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:28:45 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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! 17:28:45 INFO - Caught exception: HTTP Error 404: Not Found 17:28:45 INFO - Caught exception: HTTP Error 404: Not Found 17:28:45 INFO - Caught exception: HTTP Error 404: Not Found 17:28:45 INFO - trying https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:28:45 INFO - Downloading https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:28:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:28:46 INFO - Downloaded 1327 bytes. 17:28:46 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 17:28:46 INFO - Using the following test package requirements: 17:28:46 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 17:28:46 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:28:46 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 17:28:46 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:28:46 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 17:28:46 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:28:46 INFO - u'jsshell-linux-x86_64.zip'], 17:28:46 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:28:46 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 17:28:46 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 17:28:46 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:28:46 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 17:28:46 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:28:46 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 17:28:46 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:28:46 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 17:28:46 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 17:28:46 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 17:28:46 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:28:46 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')]} 17:28:46 INFO - https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:28:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:28:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:28:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:28:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:28:46 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:28:46 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:28:46 INFO - retry: Failed, sleeping 30 seconds before retrying 17:29:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:29:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:29:16 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:29:16 INFO - retry: Failed, sleeping 60 seconds before retrying 17:30:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:30:16 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:30:16 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:30:16 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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! 17:30:16 INFO - Caught exception: HTTP Error 404: Not Found 17:30:16 INFO - Caught exception: HTTP Error 404: Not Found 17:30:16 INFO - Caught exception: HTTP Error 404: Not Found 17:30:16 INFO - trying https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:30:16 INFO - Downloading https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:30:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:30:17 INFO - Downloaded 21773202 bytes. 17:30:17 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'] 17:30:17 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 17:30:18 INFO - Return code: 0 17:30:18 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 17:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:30:18 INFO - https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:30:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:30:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:30:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:30:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:30:18 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:30:18 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:30:18 INFO - retry: Failed, sleeping 30 seconds before retrying 17:30:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:30:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:30:48 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:30:48 INFO - retry: Failed, sleeping 60 seconds before retrying 17:31:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:31:48 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:31:48 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:31:48 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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! 17:31:48 INFO - Caught exception: HTTP Error 404: Not Found 17:31:48 INFO - Caught exception: HTTP Error 404: Not Found 17:31:48 INFO - Caught exception: HTTP Error 404: Not Found 17:31:48 INFO - trying https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 17:31:48 INFO - Downloading https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:31:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:31:49 INFO - Downloaded 21773202 bytes. 17:31:49 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'] 17:31:49 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 17:31:50 INFO - Return code: 0 17:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:31:50 INFO - https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:31:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:31:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:31:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:31:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:31:50 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:31:50 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:31:50 INFO - retry: Failed, sleeping 30 seconds before retrying 17:32:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:32:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:32:20 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:32:20 INFO - retry: Failed, sleeping 60 seconds before retrying 17:33:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:33:20 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:33:20 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:33:20 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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! 17:33:20 INFO - Caught exception: HTTP Error 404: Not Found 17:33:20 INFO - Caught exception: HTTP Error 404: Not Found 17:33:20 INFO - Caught exception: HTTP Error 404: Not Found 17:33:20 INFO - trying https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 17:33:20 INFO - Downloading https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:33:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:33:21 INFO - Downloaded 14413762 bytes. 17:33:21 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'] 17:33:21 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 17:33:21 INFO - Return code: 0 17:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:33:21 INFO - https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:33:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:33:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:33:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:33:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:33:21 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:33:21 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 17:33:21 INFO - retry: Failed, sleeping 30 seconds before retrying 17:33:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:33:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:33:51 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 17:33:51 INFO - retry: Failed, sleeping 60 seconds before retrying 17:34:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:34:51 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:34:51 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 17:34:51 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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! 17:34:51 INFO - Caught exception: HTTP Error 404: Not Found 17:34:51 INFO - Caught exception: HTTP Error 404: Not Found 17:34:51 INFO - Caught exception: HTTP Error 404: Not Found 17:34:51 INFO - trying https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:34:51 INFO - Downloading https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:34:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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 17:34:53 INFO - Downloaded 56796336 bytes. 17:34:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:34:53 INFO - mkdir: /builds/slave/test/properties 17:34:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:34:53 INFO - Writing to file /builds/slave/test/properties/build_url 17:34:53 INFO - Contents: 17:34:53 INFO - build_url:https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 17:34:53 INFO - Running post-action listener: _resource_record_post_action 17:34:53 INFO - Running post-action listener: set_extra_try_arguments 17:34:53 INFO - [mozharness: 2016-10-25 00:34:53.997438Z] Finished download-and-extract step (success) 17:34:53 INFO - [mozharness: 2016-10-25 00:34:53.997671Z] Running populate-webroot step. 17:34:53 INFO - Running pre-action listener: _resource_record_pre_action 17:34:53 INFO - Running main action method: populate_webroot 17:34:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:34:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:34:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:34:54 INFO - '--tppagecycles', 17:34:54 INFO - '7'], 17:34:54 INFO - 'tests': ['tsvgm']}}, 17:34:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:34:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:34:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:34:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:34:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:34:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:34:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:54 INFO - 'talos_options': ['--disable-e10s'], 17:34:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:54 INFO - 'talos_options': ['--disable-e10s'], 17:34:54 INFO - 'tests': ['damp', 'tps']}, 17:34:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:54 INFO - 'tests': ['damp', 'tps']}, 17:34:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:34:54 INFO - 'tests': ['dromaeo_dom']}, 17:34:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:34:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:34:54 INFO - 'tests': ['basic_compositor_video']}, 17:34:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:34:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:34:54 INFO - 'tests': ['a11yr', 17:34:54 INFO - 'ts_paint', 17:34:54 INFO - 'tpaint', 17:34:54 INFO - 'sessionrestore', 17:34:54 INFO - 'sessionrestore_no_auto_restore', 17:34:54 INFO - 'tabpaint']}, 17:34:54 INFO - 'other-e10s': {'tests': ['a11yr', 17:34:54 INFO - 'ts_paint', 17:34:54 INFO - 'tpaint', 17:34:54 INFO - 'sessionrestore', 17:34:54 INFO - 'sessionrestore_no_auto_restore', 17:34:54 INFO - 'tabpaint']}, 17:34:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:34:54 INFO - 'ts_paint', 17:34:54 INFO - 'tpaint', 17:34:54 INFO - 'sessionrestore', 17:34:54 INFO - 'sessionrestore_no_auto_restore', 17:34:54 INFO - 'tabpaint']}, 17:34:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:34:54 INFO - 'ts_paint', 17:34:54 INFO - 'tpaint', 17:34:54 INFO - 'sessionrestore', 17:34:54 INFO - 'sessionrestore_no_auto_restore', 17:34:54 INFO - 'tabpaint']}, 17:34:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:34:54 INFO - 'tests': ['a11yr', 17:34:54 INFO - 'ts_paint', 17:34:54 INFO - 'tpaint', 17:34:54 INFO - 'sessionrestore', 17:34:54 INFO - 'sessionrestore_no_auto_restore', 17:34:54 INFO - 'tabpaint']}, 17:34:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:34:54 INFO - 'tests': ['a11yr', 17:34:54 INFO - 'ts_paint', 17:34:54 INFO - 'tpaint', 17:34:54 INFO - 'sessionrestore', 17:34:54 INFO - 'sessionrestore_no_auto_restore', 17:34:54 INFO - 'tabpaint']}, 17:34:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:34:54 INFO - 'tests': ['tsvgx', 17:34:54 INFO - 'tsvgr_opacity', 17:34:54 INFO - 'tart', 17:34:54 INFO - 'tscrollx', 17:34:54 INFO - 'cart']}, 17:34:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:34:54 INFO - 'tsvgr_opacity', 17:34:54 INFO - 'tart', 17:34:54 INFO - 'tscrollx', 17:34:54 INFO - 'cart']}, 17:34:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:54 INFO - 'talos_options': ['--disable-e10s'], 17:34:54 INFO - 'tests': ['tp5o']}, 17:34:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:54 INFO - 'tests': ['tp5o']}, 17:34:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:54 INFO - 'talos_options': ['--disable-e10s', 17:34:54 INFO - '--xperf_path', 17:34:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:54 INFO - 'tests': ['tp5n']}, 17:34:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:54 INFO - 'talos_options': ['--xperf_path', 17:34:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:54 INFO - 'tests': ['tp5n']}}, 17:34:54 INFO - 'talos.zip': {'path': '', 17:34:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:34:54 INFO - Running post-action listener: _resource_record_post_action 17:34:54 INFO - [mozharness: 2016-10-25 00:34:54.016279Z] Finished populate-webroot step (success) 17:34:54 INFO - [mozharness: 2016-10-25 00:34:54.016368Z] Running create-virtualenv step. 17:34:54 INFO - Running pre-action listener: _resource_record_pre_action 17:34:54 INFO - Running main action method: create_virtualenv 17:34:54 INFO - Creating virtualenv /builds/slave/test/build/venv 17:34:54 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 17:34:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:34:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:34:54 INFO - Using real prefix '/usr' 17:34:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:34:54 INFO - Installing distribute.............................................................................................................................................................................................done. 17:34:56 INFO - Installing pip.................done. 17:34:56 INFO - Return code: 0 17:34:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:34:56 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')]} 17:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:56 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')]} 17:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:56 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 0x2379030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2637570>, '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 0x2638470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2638900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', '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 17:34:56 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 17:34:56 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 17:34:56 INFO - Using env: {'DISPLAY': ':0', 17:34:56 INFO - 'HOME': '/home/cltbld', 17:34:56 INFO - 'LANG': 'en_US.UTF-8', 17:34:56 INFO - 'LANGUAGE': 'en_US:en', 17:34:56 INFO - 'LOGNAME': 'cltbld', 17:34:56 INFO - 'MAIL': '/var/mail/cltbld', 17:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:56 INFO - 'MOZ_NO_REMOTE': '1', 17:34:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:56 INFO - 'NO_EM_RESTART': '1', 17:34:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:56 INFO - 'PWD': '/builds/slave/test', 17:34:56 INFO - 'SHELL': '/bin/bash', 17:34:56 INFO - 'SHLVL': '1', 17:34:56 INFO - 'TERM': 'linux', 17:34:56 INFO - 'TMOUT': '86400', 17:34:56 INFO - 'USER': 'cltbld', 17:34:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', 17:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:56 INFO - '_': '/tools/buildbot/bin/python'} 17:34:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:56 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 17:34:56 INFO - Cleaning up... 17:34:56 INFO - Return code: 0 17:34:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:34:56 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')]} 17:34:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:56 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')]} 17:34:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:56 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 0x2379030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2637570>, '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 0x2638470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2638900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', '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 17:34:56 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 17:34:56 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 17:34:56 INFO - Using env: {'DISPLAY': ':0', 17:34:56 INFO - 'HOME': '/home/cltbld', 17:34:56 INFO - 'LANG': 'en_US.UTF-8', 17:34:56 INFO - 'LANGUAGE': 'en_US:en', 17:34:56 INFO - 'LOGNAME': 'cltbld', 17:34:56 INFO - 'MAIL': '/var/mail/cltbld', 17:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:56 INFO - 'MOZ_NO_REMOTE': '1', 17:34:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:56 INFO - 'NO_EM_RESTART': '1', 17:34:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:56 INFO - 'PWD': '/builds/slave/test', 17:34:56 INFO - 'SHELL': '/bin/bash', 17:34:56 INFO - 'SHLVL': '1', 17:34:56 INFO - 'TERM': 'linux', 17:34:56 INFO - 'TMOUT': '86400', 17:34:56 INFO - 'USER': 'cltbld', 17:34:56 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', 17:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:56 INFO - '_': '/tools/buildbot/bin/python'} 17:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:57 INFO - Downloading/unpacking psutil>=3.1.1 17:34:57 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 17:34:57 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 17:34:57 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 17:34:57 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 17:34:57 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 17:34:57 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 17:34:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:34:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:59 INFO - Installing collected packages: psutil 17:34:59 INFO - Running setup.py install for psutil 17:34:59 INFO - building 'psutil._psutil_linux' extension 17:34:59 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 17:34:59 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 17:34:59 INFO - building 'psutil._psutil_posix' extension 17:34:59 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 17:34:59 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 17:34:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:34:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:34:59 INFO - Successfully installed psutil 17:34:59 INFO - Cleaning up... 17:34:59 INFO - Return code: 0 17:34:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:34: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')]} 17:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:34:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34: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')]} 17:34:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:34:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:34:59 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 0x2379030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2637570>, '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 0x2638470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2638900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', '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 17:34:59 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 17:34:59 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 17:34:59 INFO - Using env: {'DISPLAY': ':0', 17:34:59 INFO - 'HOME': '/home/cltbld', 17:34:59 INFO - 'LANG': 'en_US.UTF-8', 17:34:59 INFO - 'LANGUAGE': 'en_US:en', 17:34:59 INFO - 'LOGNAME': 'cltbld', 17:34:59 INFO - 'MAIL': '/var/mail/cltbld', 17:34:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:34:59 INFO - 'MOZ_NO_REMOTE': '1', 17:34:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:34:59 INFO - 'NO_EM_RESTART': '1', 17:34:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:34:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:34:59 INFO - 'PWD': '/builds/slave/test', 17:34:59 INFO - 'SHELL': '/bin/bash', 17:34:59 INFO - 'SHLVL': '1', 17:34:59 INFO - 'TERM': 'linux', 17:34:59 INFO - 'TMOUT': '86400', 17:34:59 INFO - 'USER': 'cltbld', 17:34:59 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', 17:34:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:34:59 INFO - '_': '/tools/buildbot/bin/python'} 17:34:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:34:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:34:59 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 17:34:59 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 17:34:59 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 17:34:59 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 17:34:59 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 17:34:59 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 17:35:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:35:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:35:01 INFO - Installing collected packages: mozsystemmonitor 17:35:01 INFO - Running setup.py install for mozsystemmonitor 17:35:01 INFO - Successfully installed mozsystemmonitor 17:35:01 INFO - Cleaning up... 17:35:01 INFO - Return code: 0 17:35:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2379030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2637570>, '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 0x2638470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2638900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', '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 17:35:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:35:01 INFO - Using env: {'DISPLAY': ':0', 17:35:01 INFO - 'HOME': '/home/cltbld', 17:35:01 INFO - 'LANG': 'en_US.UTF-8', 17:35:01 INFO - 'LANGUAGE': 'en_US:en', 17:35:01 INFO - 'LOGNAME': 'cltbld', 17:35:01 INFO - 'MAIL': '/var/mail/cltbld', 17:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:01 INFO - 'MOZ_NO_REMOTE': '1', 17:35:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:01 INFO - 'NO_EM_RESTART': '1', 17:35:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:01 INFO - 'PWD': '/builds/slave/test', 17:35:01 INFO - 'SHELL': '/bin/bash', 17:35:01 INFO - 'SHLVL': '1', 17:35:01 INFO - 'TERM': 'linux', 17:35:01 INFO - 'TMOUT': '86400', 17:35:01 INFO - 'USER': 'cltbld', 17:35:01 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', 17:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:01 INFO - '_': '/tools/buildbot/bin/python'} 17:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:02 INFO - Downloading/unpacking jsonschema==2.5.1 17:35:02 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 17:35:02 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 17:35:02 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 17:35:02 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 17:35:02 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 17:35:02 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 17:35:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:35:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:04 INFO - Downloading functools32-3.2.3-2.tar.gz 17:35:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:35:04 INFO - warning: no files found matching '*.txt' 17:35:04 INFO - no previously-included directories found matching 'build' 17:35:04 INFO - no previously-included directories found matching 'dist' 17:35:04 INFO - no previously-included directories found matching '.git*' 17:35:04 INFO - Installing collected packages: jsonschema, functools32 17:35:04 INFO - Running setup.py install for functools32 17:35:04 INFO - warning: no files found matching '*.txt' 17:35:04 INFO - no previously-included directories found matching 'build' 17:35:04 INFO - no previously-included directories found matching 'dist' 17:35:04 INFO - no previously-included directories found matching '.git*' 17:35:04 INFO - Successfully installed jsonschema functools32 17:35:04 INFO - Cleaning up... 17:35:04 INFO - Return code: 0 17:35:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:35:04 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')]} 17:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:04 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')]} 17:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:04 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 0x2379030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2637570>, '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 0x2638470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2638900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', '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 17:35:04 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 17:35:04 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 17:35:04 INFO - Using env: {'DISPLAY': ':0', 17:35:04 INFO - 'HOME': '/home/cltbld', 17:35:04 INFO - 'LANG': 'en_US.UTF-8', 17:35:04 INFO - 'LANGUAGE': 'en_US:en', 17:35:04 INFO - 'LOGNAME': 'cltbld', 17:35:04 INFO - 'MAIL': '/var/mail/cltbld', 17:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:04 INFO - 'MOZ_NO_REMOTE': '1', 17:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:04 INFO - 'NO_EM_RESTART': '1', 17:35:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:04 INFO - 'PWD': '/builds/slave/test', 17:35:04 INFO - 'SHELL': '/bin/bash', 17:35:04 INFO - 'SHLVL': '1', 17:35:04 INFO - 'TERM': 'linux', 17:35:04 INFO - 'TMOUT': '86400', 17:35:04 INFO - 'USER': 'cltbld', 17:35:04 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', 17:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:04 INFO - '_': '/tools/buildbot/bin/python'} 17:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:35:04 INFO - Cleaning up... 17:35:04 INFO - Return code: 0 17:35:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:35:04 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')]} 17:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:04 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')]} 17:35:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:04 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 0x2379030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2637570>, '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 0x2638470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2638900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', '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 17:35:04 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 17:35:04 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 17:35:04 INFO - Using env: {'DISPLAY': ':0', 17:35:04 INFO - 'HOME': '/home/cltbld', 17:35:04 INFO - 'LANG': 'en_US.UTF-8', 17:35:04 INFO - 'LANGUAGE': 'en_US:en', 17:35:04 INFO - 'LOGNAME': 'cltbld', 17:35:04 INFO - 'MAIL': '/var/mail/cltbld', 17:35:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:04 INFO - 'MOZ_NO_REMOTE': '1', 17:35:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:04 INFO - 'NO_EM_RESTART': '1', 17:35:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:04 INFO - 'PWD': '/builds/slave/test', 17:35:04 INFO - 'SHELL': '/bin/bash', 17:35:04 INFO - 'SHLVL': '1', 17:35:04 INFO - 'TERM': 'linux', 17:35:04 INFO - 'TMOUT': '86400', 17:35:04 INFO - 'USER': 'cltbld', 17:35:04 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', 17:35:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:04 INFO - '_': '/tools/buildbot/bin/python'} 17:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:04 INFO - Downloading/unpacking blobuploader==1.2.4 17:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:06 INFO - Downloading blobuploader-1.2.4.tar.gz 17:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:35:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:35:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:35:07 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 17:35:07 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 17:35:07 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 17:35:07 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 17:35:07 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 17:35:07 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 17:35:07 INFO - Downloading docopt-0.6.1.tar.gz 17:35:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:35:07 INFO - Installing collected packages: blobuploader, requests, docopt 17:35:07 INFO - Running setup.py install for blobuploader 17:35:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:35:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:35:07 INFO - Running setup.py install for requests 17:35:08 INFO - Running setup.py install for docopt 17:35:08 INFO - Successfully installed blobuploader requests docopt 17:35:08 INFO - Cleaning up... 17:35:08 INFO - Return code: 0 17:35:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35: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')]} 17:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35: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')]} 17:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:08 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 0x2379030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2637570>, '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 0x2638470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2638900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', '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 17:35:08 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 17:35:08 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 17:35:08 INFO - Using env: {'DISPLAY': ':0', 17:35:08 INFO - 'HOME': '/home/cltbld', 17:35:08 INFO - 'LANG': 'en_US.UTF-8', 17:35:08 INFO - 'LANGUAGE': 'en_US:en', 17:35:08 INFO - 'LOGNAME': 'cltbld', 17:35:08 INFO - 'MAIL': '/var/mail/cltbld', 17:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:08 INFO - 'MOZ_NO_REMOTE': '1', 17:35:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:08 INFO - 'NO_EM_RESTART': '1', 17:35:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:08 INFO - 'PWD': '/builds/slave/test', 17:35:08 INFO - 'SHELL': '/bin/bash', 17:35:08 INFO - 'SHLVL': '1', 17:35:08 INFO - 'TERM': 'linux', 17:35:08 INFO - 'TMOUT': '86400', 17:35:08 INFO - 'USER': 'cltbld', 17:35:08 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', 17:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:08 INFO - '_': '/tools/buildbot/bin/python'} 17:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:08 INFO - Running setup.py (path:/tmp/pip-wocypn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:08 INFO - Running setup.py (path:/tmp/pip-B7jfvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:08 INFO - Running setup.py (path:/tmp/pip-DgWzDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:08 INFO - Running setup.py (path:/tmp/pip-oCOAJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:08 INFO - Running setup.py (path:/tmp/pip-heBs_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:08 INFO - Running setup.py (path:/tmp/pip-wnzDNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:08 INFO - Running setup.py (path:/tmp/pip-eCNYpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:09 INFO - Running setup.py (path:/tmp/pip-r2zjtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:09 INFO - Running setup.py (path:/tmp/pip-5nDANr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:09 INFO - Running setup.py (path:/tmp/pip-y4966i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:09 INFO - Running setup.py (path:/tmp/pip-zKHBGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:09 INFO - Running setup.py (path:/tmp/pip-_sTBXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:09 INFO - Running setup.py (path:/tmp/pip-pIzYwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:09 INFO - Running setup.py (path:/tmp/pip-36wivE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:09 INFO - Running setup.py (path:/tmp/pip-fLW148-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:09 INFO - Running setup.py (path:/tmp/pip-oXCy__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:09 INFO - Running setup.py (path:/tmp/pip-rGDdpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:35:09 INFO - Running setup.py install for manifestparser 17:35:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:35:09 INFO - Running setup.py install for mozcrash 17:35:09 INFO - Running setup.py install for mozdebug 17:35:10 INFO - Running setup.py install for mozdevice 17:35:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:35:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:35:10 INFO - Running setup.py install for mozfile 17:35:10 INFO - Running setup.py install for mozhttpd 17:35:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:35:10 INFO - Running setup.py install for mozinfo 17:35:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:35:10 INFO - Running setup.py install for mozInstall 17:35:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:35:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:35:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:35:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:35:10 INFO - Running setup.py install for mozleak 17:35:10 INFO - Running setup.py install for mozlog 17:35:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:35:10 INFO - Running setup.py install for moznetwork 17:35:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:35:10 INFO - Running setup.py install for mozprocess 17:35:10 INFO - Running setup.py install for mozprofile 17:35:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:35:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:35:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:35:11 INFO - Running setup.py install for mozrunner 17:35:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:35:11 INFO - Running setup.py install for mozscreenshot 17:35:11 INFO - Running setup.py install for moztest 17:35:11 INFO - Running setup.py install for mozversion 17:35:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:35:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:35:11 INFO - Cleaning up... 17:35:11 INFO - Return code: 0 17:35:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:11 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 0x2379030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2637570>, '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 0x2638470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2638900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', '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 17:35:11 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 17:35:11 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 17:35:11 INFO - Using env: {'DISPLAY': ':0', 17:35:11 INFO - 'HOME': '/home/cltbld', 17:35:11 INFO - 'LANG': 'en_US.UTF-8', 17:35:11 INFO - 'LANGUAGE': 'en_US:en', 17:35:11 INFO - 'LOGNAME': 'cltbld', 17:35:11 INFO - 'MAIL': '/var/mail/cltbld', 17:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:11 INFO - 'MOZ_NO_REMOTE': '1', 17:35:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:11 INFO - 'NO_EM_RESTART': '1', 17:35:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:11 INFO - 'PWD': '/builds/slave/test', 17:35:11 INFO - 'SHELL': '/bin/bash', 17:35:11 INFO - 'SHLVL': '1', 17:35:11 INFO - 'TERM': 'linux', 17:35:11 INFO - 'TMOUT': '86400', 17:35:11 INFO - 'USER': 'cltbld', 17:35:11 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', 17:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:11 INFO - '_': '/tools/buildbot/bin/python'} 17:35:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:11 INFO - Running setup.py (path:/tmp/pip-yBeFrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:11 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)) 17:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:11 INFO - Running setup.py (path:/tmp/pip-cdq8iM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:11 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)) 17:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:11 INFO - Running setup.py (path:/tmp/pip-lDev7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:11 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)) 17:35:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:12 INFO - Running setup.py (path:/tmp/pip-_eyQ3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:12 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)) 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:12 INFO - Running setup.py (path:/tmp/pip-Zy15Bu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:12 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)) 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:12 INFO - Running setup.py (path:/tmp/pip-TQmRso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:12 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)) 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:12 INFO - Running setup.py (path:/tmp/pip-MzMRLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:12 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)) 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:12 INFO - Running setup.py (path:/tmp/pip-OkjkVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:12 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)) 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:12 INFO - Running setup.py (path:/tmp/pip-BsgHMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:12 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)) 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:12 INFO - Running setup.py (path:/tmp/pip-GEM0WP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:12 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)) 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:12 INFO - Running setup.py (path:/tmp/pip-5TWT3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:12 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)) 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:12 INFO - Running setup.py (path:/tmp/pip-ZO_ZOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:12 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)) 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:12 INFO - Running setup.py (path:/tmp/pip-Y55lph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:12 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)) 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:12 INFO - Running setup.py (path:/tmp/pip-avfSxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:12 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)) 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:12 INFO - Running setup.py (path:/tmp/pip-4uWbYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:12 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)) 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:12 INFO - Running setup.py (path:/tmp/pip-iZVCgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:12 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)) 17:35:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:12 INFO - Running setup.py (path:/tmp/pip-8TQRRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:13 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)) 17:35:13 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)) 17:35:13 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)) 17:35:13 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)) 17:35:13 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)) 17:35:13 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)) 17:35:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:35: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 17:35: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 17:35: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 17:35: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 17:35: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 17:35: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 17:35:14 INFO - Downloading blessings-1.6.tar.gz 17:35:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:35:15 INFO - Installing collected packages: blessings 17:35:15 INFO - Running setup.py install for blessings 17:35:15 INFO - Successfully installed blessings 17:35:15 INFO - Cleaning up... 17:35:15 INFO - Return code: 0 17:35:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:35:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:15 INFO - Reading from file tmpfile_stdout 17:35:15 INFO - Current package versions: 17:35:15 INFO - argparse == 1.2.1 17:35:15 INFO - blessings == 1.6 17:35:15 INFO - blobuploader == 1.2.4 17:35:15 INFO - docopt == 0.6.1 17:35:15 INFO - functools32 == 3.2.3-2 17:35:15 INFO - jsonschema == 2.5.1 17:35:15 INFO - manifestparser == 1.1 17:35:15 INFO - mozInstall == 1.12 17:35:15 INFO - mozcrash == 0.17 17:35:15 INFO - mozdebug == 0.1 17:35:15 INFO - mozdevice == 0.48 17:35:15 INFO - mozfile == 1.2 17:35:15 INFO - mozhttpd == 0.7 17:35:15 INFO - mozinfo == 0.9 17:35:15 INFO - mozleak == 0.1 17:35:15 INFO - mozlog == 3.3 17:35:15 INFO - moznetwork == 0.27 17:35:15 INFO - mozprocess == 0.23 17:35:15 INFO - mozprofile == 0.28 17:35:15 INFO - mozrunner == 6.12 17:35:15 INFO - mozscreenshot == 0.1 17:35:15 INFO - mozsystemmonitor == 0.3 17:35:15 INFO - moztest == 0.7 17:35:15 INFO - mozversion == 1.4 17:35:15 INFO - psutil == 3.1.1 17:35:15 INFO - requests == 1.2.3 17:35:15 INFO - wsgiref == 0.1.2 17:35:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:15 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 0x2379030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2637570>, '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 0x2638470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2638900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', '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 17:35:15 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 17:35:15 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 17:35:15 INFO - Using env: {'DISPLAY': ':0', 17:35:15 INFO - 'HOME': '/home/cltbld', 17:35:15 INFO - 'LANG': 'en_US.UTF-8', 17:35:15 INFO - 'LANGUAGE': 'en_US:en', 17:35:15 INFO - 'LOGNAME': 'cltbld', 17:35:15 INFO - 'MAIL': '/var/mail/cltbld', 17:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:15 INFO - 'MOZ_NO_REMOTE': '1', 17:35:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:15 INFO - 'NO_EM_RESTART': '1', 17:35:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:15 INFO - 'PWD': '/builds/slave/test', 17:35:15 INFO - 'SHELL': '/bin/bash', 17:35:15 INFO - 'SHLVL': '1', 17:35:15 INFO - 'TERM': 'linux', 17:35:15 INFO - 'TMOUT': '86400', 17:35:15 INFO - 'USER': 'cltbld', 17:35:15 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', 17:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:15 INFO - '_': '/tools/buildbot/bin/python'} 17:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:15 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)) 17:35:15 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)) 17:35:15 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)) 17:35:15 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)) 17:35:15 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)) 17:35:15 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)) 17:35:15 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)) 17:35:15 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)) 17:35:15 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)) 17:35:15 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)) 17:35:15 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)) 17:35:15 INFO - Cleaning up... 17:35:15 INFO - Return code: 0 17:35:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2379030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a8400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2637570>, '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 0x2638470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2638900>, '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': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', '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 17:35:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:35:15 INFO - Using env: {'DISPLAY': ':0', 17:35:15 INFO - 'HOME': '/home/cltbld', 17:35:15 INFO - 'LANG': 'en_US.UTF-8', 17:35:15 INFO - 'LANGUAGE': 'en_US:en', 17:35:15 INFO - 'LOGNAME': 'cltbld', 17:35:15 INFO - 'MAIL': '/var/mail/cltbld', 17:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:15 INFO - 'MOZ_NO_REMOTE': '1', 17:35:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:15 INFO - 'NO_EM_RESTART': '1', 17:35:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:15 INFO - 'PWD': '/builds/slave/test', 17:35:15 INFO - 'SHELL': '/bin/bash', 17:35:15 INFO - 'SHLVL': '1', 17:35:15 INFO - 'TERM': 'linux', 17:35:15 INFO - 'TMOUT': '86400', 17:35:15 INFO - 'USER': 'cltbld', 17:35:15 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', 17:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:15 INFO - '_': '/tools/buildbot/bin/python'} 17:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:35:15 INFO - Cleaning up... 17:35:15 INFO - Return code: 0 17:35:15 INFO - Running post-action listener: _resource_record_post_action 17:35:15 INFO - Running post-action listener: _start_resource_monitoring 17:35:15 INFO - Starting resource monitoring. 17:35:15 INFO - [mozharness: 2016-10-25 00:35:15.880239Z] Finished create-virtualenv step (success) 17:35:15 INFO - [mozharness: 2016-10-25 00:35:15.880673Z] Running install step. 17:35:15 INFO - Running pre-action listener: _resource_record_pre_action 17:35:15 INFO - Running main action method: install 17:35:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:16 INFO - Reading from file tmpfile_stdout 17:35:16 INFO - Detecting whether we're running mozinstall >=1.0... 17:35:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:35:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:35:16 INFO - Reading from file tmpfile_stdout 17:35:16 INFO - Output received: 17:35:16 INFO - Usage: mozinstall [options] installer 17:35:16 INFO - Options: 17:35:16 INFO - -h, --help show this help message and exit 17:35:16 INFO - -d DEST, --destination=DEST 17:35:16 INFO - Directory to install application into. [default: 17:35:16 INFO - "/builds/slave/test"] 17:35:16 INFO - --app=APP Application being installed. [default: firefox] 17:35:16 INFO - mkdir: /builds/slave/test/build/application 17:35:16 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'] 17:35:16 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 17:35:30 INFO - Reading from file tmpfile_stdout 17:35:30 INFO - Output received: 17:35:30 INFO - /builds/slave/test/build/application/firefox/firefox 17:35:30 INFO - Running post-action listener: _resource_record_post_action 17:35:30 INFO - [mozharness: 2016-10-25 00:35:30.094073Z] Finished install step (success) 17:35:30 INFO - [mozharness: 2016-10-25 00:35:30.094354Z] Running run-tests step. 17:35:30 INFO - Running pre-action listener: _resource_record_pre_action 17:35:30 INFO - Running main action method: run_tests 17:35:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:35:30 INFO - Python 2.7.3 17:35:30 INFO - Return code: 0 17:35:30 INFO - grabbing minidump binary from tooltool 17:35: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')]} 17:35:30 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 0x2637570>, '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 0x2638470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2638900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:35:30 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 17:35:30 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 17:35:30 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 17:35:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:35:30 INFO - Return code: 0 17:35:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:35:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:35:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:35:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:35:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:35:30 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/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 17:35:30 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/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 17:35:30 INFO - Using env: {'DISPLAY': ':0', 17:35:30 INFO - 'HOME': '/home/cltbld', 17:35:30 INFO - 'LANG': 'en_US.UTF-8', 17:35:30 INFO - 'LANGUAGE': 'en_US:en', 17:35:30 INFO - 'LOGNAME': 'cltbld', 17:35:30 INFO - 'MAIL': '/var/mail/cltbld', 17:35:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:35:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:30 INFO - 'MOZ_NO_REMOTE': '1', 17:35:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:35:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:35:30 INFO - 'NO_EM_RESTART': '1', 17:35:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:30 INFO - 'PWD': '/builds/slave/test', 17:35:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:35:30 INFO - 'SHELL': '/bin/bash', 17:35:30 INFO - 'SHLVL': '1', 17:35:30 INFO - 'TERM': 'linux', 17:35:30 INFO - 'TMOUT': '86400', 17:35:30 INFO - 'USER': 'cltbld', 17:35:30 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562', 17:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:30 INFO - '_': '/tools/buildbot/bin/python'} 17:35:30 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/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 17:35:30 INFO - mozversion application_buildid: 20161024154922 17:35:30 INFO - mozversion application_changeset: 0c671ce41082a2bba72b4e2340c391f9a5d83b6b 17:35:30 INFO - mozversion application_display_name: Firefox 17:35:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:35:30 INFO - mozversion application_name: Firefox 17:35:30 INFO - mozversion application_remotingname: firefox 17:35:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:35:30 INFO - mozversion application_vendor: Mozilla 17:35:30 INFO - mozversion application_version: 50.0 17:35:30 INFO - mozversion platform_buildid: 20161024154922 17:35:30 INFO - mozversion platform_changeset: 0c671ce41082a2bba72b4e2340c391f9a5d83b6b 17:35:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:35:30 INFO - mozversion platform_version: 50.0 17:35:30 INFO - using testdate: 1477355730 17:35:30 INFO - actual date: 1477355730 17:35:30 INFO - starting webserver on 'localhost:41168' 17:35:30 INFO - SUITE-START | Running 2 tests 17:35:30 INFO - TEST-START | dromaeo_css 17:35:30 INFO - operating with platform_type : linux_ 17:35:30 INFO - Initialising browser for dromaeo_css test... 17:35:30 INFO - TEST-INFO | started process 7664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfDQZco/profile http://localhost:41168/getInfo.html) 17:35:34 INFO - PROCESS | 7664 | __metrics Screen width/height:1600/1200 17:35:34 INFO - PROCESS | 7664 | colorDepth:24 17:35:34 INFO - PROCESS | 7664 | Browser inner width/height: 1024/697 17:35:34 INFO - PROCESS | 7664 | __metrics 17:35:35 ERROR - PROCESS | 7664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:35:36 INFO - TEST-INFO | 7664: exit 0 17:35:36 INFO - Browser initialized. 17:35:36 INFO - Running cycle 1/1 for dromaeo_css test... 17:35:36 INFO - TEST-INFO | started process 7791 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfDQZco/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:35:48 INFO - PROCESS | 7791 | RSS: Main: 150360064 17:35:48 INFO - PROCESS | 7791 | 17:36:37 INFO - PROCESS | 7791 | 1477355797789 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] 17:38:46 INFO - PROCESS | 7791 | Cycle 1(1): loaded http://localhost:41168/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41168/tests/dromaeo/cssquery-ext.html) 17:38:47 INFO - PROCESS | 7791 | RSS: Main: 158236672 17:38:47 INFO - PROCESS | 7791 | 17:41:49 INFO - PROCESS | 7791 | Cycle 1(1): loaded http://localhost:41168/tests/dromaeo/cssquery-ext.html (next: http://localhost:41168/tests/dromaeo/cssquery-jquery.html) 17:41:49 INFO - PROCESS | 7791 | RSS: Main: 155619328 17:41:49 INFO - PROCESS | 7791 | 17:44:51 INFO - PROCESS | 7791 | Cycle 1(1): loaded http://localhost:41168/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41168/tests/dromaeo/cssquery-mootools.html) 17:44:52 INFO - PROCESS | 7791 | RSS: Main: 155254784 17:44:52 INFO - PROCESS | 7791 | 17:47:54 INFO - PROCESS | 7791 | Cycle 1(1): loaded http://localhost:41168/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41168/tests/dromaeo/cssquery-prototype.html) 17:47:54 INFO - PROCESS | 7791 | RSS: Main: 156962816 17:47:54 INFO - PROCESS | 7791 | 17:50:57 INFO - PROCESS | 7791 | Cycle 1(1): loaded http://localhost:41168/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41168/tests/dromaeo/cssquery-yui.html) 17:50:57 INFO - PROCESS | 7791 | RSS: Main: 157827072 17:50:57 INFO - PROCESS | 7791 | 17:54:00 INFO - PROCESS | 7791 | Cycle 1(1): loaded http://localhost:41168/tests/dromaeo/cssquery-yui.html (next: http://localhost:41168/tests/dromaeo/cssquery-dojo.html) 17:54:00 INFO - PROCESS | 7791 | RSS: Main: 157745152 17:54:00 INFO - PROCESS | 7791 | 17:54:00 INFO - PROCESS | 7791 | __start_tp_report 17:54:00 INFO - PROCESS | 7791 | _x_x_mozilla_page_load 17:54:00 INFO - PROCESS | 7791 | _x_x_mozilla_page_load_details 17:54:00 INFO - PROCESS | 7791 | |i|pagename|runs| 17:54:00 INFO - PROCESS | 7791 | |0;dojo.html;3311.2384151645106;3312.205070783012;3315.336932613478;3317.6848199421047;3343.2811945431727;5691.032524470839;5696.943030569693;5729.226554415152;5760.510356619692;5777;5611.3266408031095;5689.886202275952;5728.283964504437;5733.397993210715;5737.942620573793;5160.974195129038;5190.818321358754;5225.738713064351;5260.132078207092;5276.182191760283;5232.6075544334135;5270.92093618596;5278.551323137538;5280;5307.2569840222395;5128.846134615949;5150.536451719345;5270.262163297141;5277.182036784305;5285.603579731516;5192.896142077157;5269.578433725293;5270.710110943896;5286.233496143038;5305.602079844027;5195.896082078375;5238.92141617876;5241.187615919539;5246.186841039645;5258.710770907637;5530.695811730353;5549.861253468655;5642.322921249435;5687.26065611472;5788.131780232957;6020.909686354708;6069.757209711606;6077.24034495688;6091.9390806091815;6116.174316467264;6105.481034112061;6111.449969502766;6111.755529778803;6113.633182009094;6115.327313995457;5502.119660854284;5577.8047768327915;5709.314882214119;5715.1713001614535;5734.168545560912;6114.936124487593;6201.441870231701;6207.937920620826;6212.88168129741;6233.594816337014;5959.493443057302;5959.910601340984;5982.970085149546;5989.131575921554;6000.309964354068;5936.5250779937505;6001.969990150109;6024.638521688713;6072.453479186895;6084.148219249309;6005.879882402415;6092.634441933498;6109.908351374733;6125.234345706786;6126.816195514141;6049.758009679652;6070.453659170696;6070.817875463743;6078.179445774852;6087.54343424245;4512.548745125461;4600.332951721982;4654.115718013634;4656.41794775653;4665.113628410591;4137.007118291588;4174.123434078817;4185.707000509996;4209.621134097946;4219.409282700424;5881.441263080001;5899.734511946973;5902.586818922634;5929.37741537141;5932.169496270526;5913;6012.518998480111;6186.133941248228;6193.535484838655;6195.504359651217;5866.178734977107;5873.647581145059;5939.4357536034;5945.227120474397;5968.283805943228;5115.309433226541;5124.282600435942;5124.692518448905;5125.79496820123;5151.0470562945975;6115.938840611626;6173.351798061139;6262.530310226751;6335.208098987627;6399.840003999937;6090.839842874775;6137.3049617043;6142.140100386039;6151.138840562415;6174.567780255339;6323.652199129092;6336.746530138743;6360.554761166674;6371.904421433589;6373.649449280334;5769.942300577109;5941.524678025661;5977.252843394575;5999.100134979788;6032.33644299118;6138.9095594588325;6157.168782214523;6162.568620196544;6162.753489860355;6164.198654174928;6015.428534289235;6018.488428483628;6023.939760602513;6031.819045428644;6048.637081775108;5751.424857514216;5933.851653708692;5980.491658209101;6009.06859436788;6032.426919442646;5923.200367950271;5964.135200396005;5966.940330596639;5979.222701048836;5979.790707325223;5961.850953726192;5986.9401305986385;6046.90929636047;6054.697265136638;6070.726817293321;5694.772209111589;5760.337561180518;5864.794732184353;5893.116032595145;5896.852578685567 17:54:00 INFO - PROCESS | 7791 | |1;ext.html;593.7001814083887;631.5831551176225;663.4360793325674;674.1404708996032;711.0365454808731;41936.370954435704;47630.04739905204;47927.28109078367;47972.52027479724;48026.27960580585;47028.52971470293;47071.52928470714;47285.29072063922;47791.0441791164;48161.75919120408;8914.06402327756;9147.72556823293;9148.542572871364;9159.404638698497;9170;9107.726768196932;9147.725568232963;9176;9242.537873106352;9250.583723732449;9135.95432022839;9204.631814727403;9310.674126405576;9312.068793120701;9331.486768227745;9210.171084602385;9265.351425400224;9300.674476393327;9303.953480232556;9310;9097.727068187965;9098.86351704725;9181.816363672757;9181.862272065924;9195.632174713004;44872;44982.550174498494;45205.77397112994;45254.32118518225;45369;3839.424086387064;3968.9801550992347;4486.147631949919;4509.457001171197;4636.605888499482;35183.4722479163;35252;35339.82330088359;36083.4587481188;36820.63179368199;4637.489876113625;4656.972967571106;4667.113248482778;4670.089332580148;4746.881327966794;407604;408151;410316;411674;413022;38977.41533876994;65303.673481632286;65658.34341656523;65702.67148664226;65811.67094164499;38531.42202866959;41364.586354136074;41460.37809432861;41483.1703365931;41490.585094149275;16372.345106195857;16454.670906581803;16459.25933333003;16472.25874835635;16477.670446591;14798.408063677332;14811.629709257139;14920.40318387274;14951.102933824006;14981.775273370908;9421.811563768686;9438.339316247797;9454.621815127455;9488.810223795486;9553;3537.8054207018345;3599.3748033776474;3646.08847788053;3654.926901461956;3657.4148136298063;1054.8628678271775;1070.4166229404993;1133.4502766158407;1149.1438878035917;1177.8586569611703;35101;35316.47025294622;35545;35571.110722231635;35696;1142.2461175624214;1146.4095990564865;1163.6567212672282;1223.2660403757852;1229.6434034130002;18264.817351826576;18663.677886165216;18684;18695.81304186968;19003.80996190048;593877;595269;602141;602151;605345;66676.99984500237;66730;67110;67487.66256168688;67554.32445675578;1464.2166440954038;1467.581739204343;1468.3979568377129;1493.1787516865681;1500.7523758579712;33771.3245735079;33809;33828.15429614279;33837.492437612964;33934.32131357408;56994.43005569891;57689.42310576841;57889.4211057884;58386.416135838095;58496.4150358508;474610;474818;476269;476584;478605;31504.369912602077;31863.522047169776;31876;32290.515642265855;32295;53246;54036.729816350664;54751.452485474634;59752.701236493536;59799.40200598112;45704.542954571356;47734.522654774395;47789.28316075192;48416.75791621019;49029.2645610309;47225.527744723484;47850.282245765644;48348.5165148344;48468.75765621149;48625;45752.1699132031;46829;46899.53100468952;47402;49576;41265;41276.58723412848;41799;42006;42595.787021064694;31577;31722.20694482564;31743;31987.520187197675;32085.67914320827 17:54:00 INFO - PROCESS | 7791 | |2;jquery.html;418.4706346471712;429.96411989230984;436.7750608436655;442.1334184997405;442.21065398264085;19083.522911927208;20260.29088981884;20764.584708305843;21711.240106596273;21864.23475178369;20291.18835246592;20301.39095827124;20770.584588308226;20774.792252077474;20790.272340468087;5842.766289348431;6031.577789554733;6067.7269522871575;6098.115773212881;6110.572259941806;5955.047192449209;5972;5973.313068997056;5993.640381577097;6013.037913933749;5905.055191169414;5923.911141332884;5939.762409503614;5942.554308426864;5944.613600116;5900.911486327708;5989.3112292086535;6010.75956961721;6016.729247183844;6045.244344456943;5091.949080509185;5124.282600435942;5213.244079608436;5227.529522342969;5237.240600113;24596.754032459805;24770.25689229326;24807.751922480726;24948.50102997948;25091.62362564563;2533.366658335416;2582.535143674138;2658.56133737933;2808.8033837631374;3026.500627396477;15503.844961550352;15885.523434296989;15993.760093598605;16055.678886422324;16260.349586016546;2031.5530583271805;2047.682609195577;2067.1421360135528;2109.4726318420394;2118.2691971269887;83286;84526.15473845245;84712.15287847104;85593.14406855914;86034;11675.12436567261;11846.526138954345;11875.228110172811;11953.760924781629;11971.940140299243;16899;16994;17015.65968680644;17018.48944531666;17051.829481705023;8911.866322005175;8933.28533717301;9067.183953444222;9071;9324.720258392259;8775.473471591726;8903.955480222687;8977;9146.359754817233;9176.174144327042;5076.771545280471;5152.92270615941;5167.354080739908;5217.295665085165;5271.341082364705;2079.8336133109315;2166;2179.5863376662387;2202.9008694608783;2217.4899773051966;930.7197366452084;1043.1967385113421;1072.2387105155271;1113.1206346985953;1161.96514104577;20973.26593569248;21053.684194737092;21168.78831211699;21301.89349053276;21765.78234217669;999.4652860719481;1020.505055048301;1021.1167340250778;1029.6807989523122;1029.7837454134565;11123.555057797597;11893.04855611549;11937.224080434919;12003.639890803115;12056.27662340245;516914;525978;548701;558727;562701;100949.49525252474;102126.48936755417;103692.48153759183;104519;106591.46704266428;1037.9377237365632;1072.420892717939;1137.6473293278943;1141.149843366697;1142.6857614156174;17941.910290448985;18872.52818679489;19055.71416428727;19296.614067718285;19378.127984240462;32243.838780805945;32632.34735305328;35983;44896.55103448924;44921.775391122836;61026.69486652538;62937;64851;65498.34501655113;66027.66986165039;9319.114684105;9352.953235234052;9356.532173391439;9480.194183494481;9639.469829159463;10952.945235273774;13207.471701131846;13214.801777973145;13263.867361326264;13429.328533573478;11630.534778609099;11728.179027467995;11903.226290291102;11965.401729913643;12020.579279725167;12006.819897701367;12445.75108497843;12591.433385497492;12634.115611907078;12876.935615321863;11039.337639741641;12034.518619255481;12352.25886446816;12574.05694572929;12843.165194262718;9369;9402.57688404037;9579.568919398504;9609.855852162083;9713.320067595201;10578.523966421375;11847.644570662549;11960.880391196324;11985.22096063753;12023.75952480928 17:54:00 INFO - PROCESS | 7791 | |3;mootools.html;1518.0891465120926;1520.4526370506617;1674.271691814061;1784.883982541134;1812.6284111757084;8677.349198810083;8807.999999999984;9329.207017403529;9417.38786978846;9443.386179898302;9335.719928402143;9477.431354118758;9519.143277105059;9519.952400238006;9574.2340612751;2400.9039638414442;2437.7805997460223;2444.4622183119686;2444.535538247736;2449.2407353720405;2418.1657328221736;2425.3451568076607;2451.534208500388;2455.1038870812204;2461.040194324215;2377.7741114594087;2390.880455977203;2397.5085107552995;2405.3625789165885;2411.3489357873364;2311.410590299471;2320.791128798416;2323.082382458936;2326.209088909779;2353.1293421434007;2128.4253251621976;2132.9786702132933;2140.871547707143;2142.9571408571896;2143.1320315272183;9245.861312080324;9396.718098457057;9502.4298542087;9506.334556581041;9524;5213.165893457029;5464.9453505464835;5514.172874068881;5547.750351234205;5551.8889622207325;3311.3211791582908;3356.194513316811;3389.949115774118;3446.4485682290715;3467.8266086695817;1087.211771465689;1109.4230999880099;1120.714217874445;1135.1543100390263;1139.1740987783874;12501.56244531437;12541.372931353488;12543.310117943509;12555.121141520098;12585.622431327167;4468.865934021985;4510.932336014962;4671.5328467153695;4694.976525117421;4728.527147285244;10095.394276343442;10100.848487272697;10110.292279540361;10120.544575494121;10128.493575321205;5450.645708028966;5466.562674985991;5472.5621950243885;5486.31421072366;5487.42382049887;5035.068512325159;5110.080185566634;5162.251473536317;5192.81825136126;5256.211568264791;3895.6299151580556;4000.9199816003515;4028.2144981728866;4061.6953728470485;4064.8577299794365;1204.3015051270243;1206.173770966873;1210.9212901161397;1212.2605210821391;1216.4343580235234;968.801395713877;1048;1066.1311031509294;1073.897979691928;1086.9347839129678;6252.155958945576;6344.777932772331;6356.459700925473;6428.4214420702365;6495.967520162369;419.62443612966223;419.7418587568623;419.8866306097337;426.86340371080956;430.79752516317905;4266.573342665709;4304.89237769052;4327.636794409751;4373.169097871394;4396.824127034883;11104.111671066295;11350.716232094264;11475.483603237708;11477.36874471912;11532.423378831025;10560.788784224425;10984.505697243643;11010.39442830652;11417.972382485616;11528.135389845795;8264.752057438167;8276.875846862302;8401.915980840113;8482.703105391281;8511.787205319917;6334.778282760081;6342.302346741947;6509.1863517060365;6540.117084193573;6633.834154145992;10171.389716617026;10528.42093684824;10631;10740.624078157227;10743.24797264184;10635.521401537104;10873.836892446461;10947.616833411112;10948;11046.447677615926;8017.959910200411;8170.877436838333;8308.459950103224;8314.87527687073;8538.316934645089;9226.07739226072;9265.583048762957;9291.48896810682;9317.72046838596;9322.487263200317;8191.631376587949;8274.710385136492;8328.583570821556;8331.416800823885;8447.915520844714;7964.20357964199;8018.799530011796;8031.638576263966;8084.231997960184;8230.09468958402;7323.340899319087;7332.193458719643;7383.150937642025;7421.369183619453;7429.368503677248;5679.545636349165;5723.828285151452;5781.68200748946;5820.76716931318;5946.375630558729;5641.971790141023;5651.463111004448;5710.314762228559;5761.654300741969;5770.769169233184 17:54:00 INFO - PROCESS | 7791 | |4;prototype.html;340.6202084675586;340.62361090994466;341.27308832187435;357.29077780605496;363.647262155709;5860.5311575074;5900.734466948987;5902.232709747726;5912.852178695534;5914.172015917769;5752.252207213067;5820.883582328351;5829.329627092886;5835.270591176103;5840.883182336351;4162.542120366765;4543.341215523764;4565.840195593155;4567.474740404846;4580.427446569179;4528.7056341337875;4537.277633419954;4566.018306064196;4570.54294570542;4595.988882445857;4475.955240447603;4573.908521829578;4596.402467679214;4604.723716577016;4605.585497305242;4530.954690453103;4531.886702832423;4541.477730061019;4559.156556037144;4573.794179261941;4055.675545956346;4067.3085575452246;4074.8183026922156;4084.509858816961;4104.384342348641;5644.673501727091;5690.630109042899;5713;5719.857003574903;5726.026575482178;4957.760559860035;5138.383393992707;5142.614303927183;5168.198929165947;5169.39748677911;6051.364606716319;6090.48230900374;6092.939070609325;6093.055576385667;6096.786612468587;4166.958330416687;4379.605835474823;4382.583654552813;4393.384926110315;4396.505188236015;6228.346023667495;6249.125262421256;6264.3422440643535;6310.6213627182515;6326.912119000719;4459.52835564263;4468.575485328954;4491.685582009228;4495.43807024122;4519.485972199284;4407.647388208936;4536.79584418702;4566.1552612766745;4568.70303430276;4598.609118224988;5150.845474635767;5162.845114646567;5172.224166374998;5173.482651734872;5204.21936709489;6079.422454866781;6093.268807743099;6156.384361563897;6170.352113028157;6187.257529096537;1477.4385733421232;1548.6283292010062;1551.6663917257845;1572.5439622509573;1576.9369225231092;963.9084286992725;1008.6822650864954;1009.7374682582581;1045.2839804733783;1081.1080858291941;5841.88316233673;5842.240508733922;5855.414458554111;5883.17635531026;5895.7052147393315;6185.226846644169;6192.721327540272;6241.157443745036;6261.686915654199;6274.560780745395;5739;5835.795747148914;5839.5036421904615;5877;5890.911636325459;3292.7859689120132;3332.333533293351;3339.4489909164718;3342.331533693271;3343.966560334414;6145.508359331243;6417.2299324081405;6461.483081353481;6489.474973381251;6497.122888410004;6361.872762544724;6398.424141827258;6401.199850018747;6410.967945160244;6427.075680565425;6250.749970001149;6431.807045788634;6466.450351720063;6483.082612824248;6486;6270.686465676789;6281.654509002049;6285.528585356208;6297.4017468340435;6325.146105275913;6265.2746055464195;6270.090836828543;6279.591826531261;6288.874222515616;6312.400321969406;6257;6466.967665161644;6508.349165083454;6530.346965303432;6588.934110659024;4443.822247110079;4497.977510112429;4498.685092043525;4501;4526.2531682273375;6224.62652240867;6326;6397.808065758035;6432.774852880127;6435.935640643534;6157.722902469489;6165.969170154121;6179.81460556184;6184.474319682878;6208.565400421927;5952.702364881825;6186.319504854552;6188.412100850412;6237.8148151851;6257.624542527463;5972.432618901197;6114.065248680748;6117.357677443804;6123.295820980644;6154.122992487334;6216.720247588779;6223.471004964629;6233.407826256498;6240.781572644935;6275.462511684666;5971.134185543159;6060.333363330118;6061.666433384648;6076.513878889767;6080.270367555921 17:54:00 INFO - PROCESS | 7791 | |5;yui.html;738.0589748071209;765.6745882999727;782.3193821375404;782.7964729170413;802.5987006496752;15997.120158391299;17166.656666866656;17383.73924391135;17421.91289043556;17477.65044699107;14625.268736563155;15391.84608153918;15406.69186616267;15770.132642704675;15945.681086378265;857.7898414888346;882.7087061269798;884.456059523395;889.3374436045123;890.6882591093098;874.9650013999433;879.1911441473827;879.8944126704804;880.4409200157882;880.9119088091172;920.249996253055;920.7099763574486;921.4885738415177;922.4419226368051;923.2475532441039;914.2548822709471;914.8673442350855;914.9542522873863;916.2120576304372;916.5508900638706;666.1007639686433;672.1933679584519;672.7342699633617;673.4275865514322;673.5958424945043;16130.112843793586;16287.83712162875;16335.673286534202;16338.101404422752;16359.918200408922;14210.857891421058;14786.482473113389;15419.383224670999;15653.530394088082;15871.28579213938;12924.741505169844;13113.934430327883;13431;13583.660408489768;13791.172529648153;4135.58644135587;4141;4152.418661387408;4155.854545090938;4243.27864263076;69839;72519.99999999948;92407;93445;93479;12356.545684586497;12573.308468034345;12699.238045717286;12812.871871281355;12865.871341286655;20428.387148385573;20583.279585214746;20664;20740;20817.271395501084;8648.654053837901;8758.86861697075;8862.335324850534;8989.280857531381;9054.094590540893;4611;4775.06886157196;4843.636727245471;4953.900921981613;5054.69671819692;3634.9091272717865;3762.2663580602066;3775.905602359963;3778.3765678663262;3779.8866034019024;672.559473544829;675.1425689374466;678.3250665587772;679.17819438479;684.9931500685029;614.7141579165709;722.0829546475946;741.1698897235132;755.8186035351476;756.7578374919973;10117.392956422638;10402.27184097106;11002.559897604006;11168.776624467628;11313.321200727984;628.2335550628226;677.6916502991127;701.8841891088016;807.8625345076316;844.1853611265159;5227.555657769056;5271.604629652791;5908.172855800191;6027.9095813562835;6068.6358818471035;130409;132708;133754.3312283452;134459;136735;69515;70874.64562677154;71274.28725712677;78245.60877195692;103829.48085259525;60822;101987;106269.99999999846;106606.46696766622;108434.45782771036;10839.783204335712;10856.254592165691;11082.113430925345;11415.315081095161;11580.826287605523;41649.79175104105;47597.76201119111;57596.71201643965;58122;59162.70418647879;76122;79794;88327.55836220778;88569;90708.5464572673;14121.435142594592;14194.503192388216;14585.854141458449;14651.340689669203;14694.485693000694;16252.366306772692;16529.66940661204;16669.249883755503;16697.248623811716;16800.831991679926;15446.613834654223;15582.454614088452;16264.593385165466;16746.665066698843;16807.159642018094;14518.927405362905;15544;15653.295601697722;16706.49880503587;16728.163591820605;14167.220802855942;14247.643808904446;14903.478378256708;15071.342152363011;15088.471903483325;12430.067744918986;12457.377131143588;12788.265166685893;12840;13461.663458413617;12209.206401583868;12722.745545088861;12766.17019893704;12992.415341309475;13056.608301750963 17:54:00 INFO - PROCESS | 7791 | __end_tp_report 17:54:00 INFO - PROCESS | 7791 | __start_cc_report 17:54:00 INFO - PROCESS | 7791 | _x_x_mozilla_cycle_collect,361 17:54:00 INFO - PROCESS | 7791 | __end_cc_report 17:54:00 INFO - PROCESS | 7791 | __startTimestamp1477356840609__endTimestamp 17:54:00 INFO - PROCESS | 7791 | 17:54:00 INFO - PROCESS | 7791 | ------- Summary: start ------- 17:54:00 INFO - PROCESS | 7791 | Number of tests: 6 17:54:00 INFO - PROCESS | 7791 | 17:54:00 INFO - PROCESS | 7791 | [#0] dojo.html Cycles:165 Average:5675.55 Median:5936.53 stddev:639.58 (10.8%) stddev-sans-first:614.06 17:54:00 INFO - PROCESS | 7791 | Values: 3311.2 3312.2 3315.3 3317.7 3343.3 5691.0 5696.9 5729.2 5760.5 5777.0 5611.3 5689.9 5728.3 5733.4 5737.9 5161.0 5190.8 5225.7 5260.1 5276.2 5232.6 5270.9 5278.6 5280.0 5307.3 5128.8 5150.5 5270.3 5277.2 5285.6 5192.9 5269.6 5270.7 5286.2 5305.6 5195.9 5238.9 5241.2 5246.2 5258.7 5530.7 5549.9 5642.3 5687.3 5788.1 6020.9 6069.8 6077.2 6091.9 6116.2 6105.5 6111.4 6111.8 6113.6 6115.3 5502.1 5577.8 5709.3 5715.2 5734.2 6114.9 6201.4 6207.9 6212.9 6233.6 5959.5 5959.9 5983.0 5989.1 6000.3 5936.5 6002.0 6024.6 6072.5 6084.1 6005.9 6092.6 6109.9 6125.2 6126.8 6049.8 6070.5 6070.8 6078.2 6087.5 4512.5 4600.3 4654.1 4656.4 4665.1 4137.0 4174.1 4185.7 4209.6 4219.4 5881.4 5899.7 5902.6 5929.4 5932.2 5913.0 6012.5 6186.1 6193.5 6195.5 5866.2 5873.6 5939.4 5945.2 5968.3 5115.3 5124.3 5124.7 5125.8 5151.0 6115.9 6173.4 6262.5 6335.2 6399.8 6090.8 6137.3 6142.1 6151.1 6174.6 6323.7 6336.7 6360.6 6371.9 6373.6 5769.9 5941.5 5977.3 5999.1 6032.3 6138.9 6157.2 6162.6 6162.8 6164.2 6015.4 6018.5 6023.9 6031.8 6048.6 5751.4 5933.9 5980.5 6009.1 6032.4 5923.2 5964.1 5966.9 5979.2 5979.8 5961.9 5986.9 6046.9 6054.7 6070.7 5694.8 5760.3 5864.8 5893.1 5896.9 17:54:00 INFO - PROCESS | 7791 | 17:54:00 INFO - PROCESS | 7791 | [#1] ext.html Cycles:180 Average:66223.95 Median:4662.04 stddev:133230.09 (2857.8%) stddev-sans-first:133512.71 17:54:00 INFO - PROCESS | 7791 | Values: 593.7 631.6 663.4 674.1 711.0 41936.4 47630.0 47927.3 47972.5 48026.3 47028.5 47071.5 47285.3 47791.0 48161.8 8914.1 9147.7 9148.5 9159.4 9170.0 9107.7 9147.7 9176.0 9242.5 9250.6 9136.0 9204.6 9310.7 9312.1 9331.5 9210.2 9265.4 9300.7 9304.0 9310.0 9097.7 9098.9 9181.8 9181.9 9195.6 44872.0 44982.6 45205.8 45254.3 45369.0 3839.4 3969.0 4486.1 4509.5 4636.6 35183.5 35252.0 35339.8 36083.5 36820.6 4637.5 4657.0 4667.1 4670.1 4746.9 407604.0 408151.0 410316.0 411674.0 413022.0 38977.4 65303.7 65658.3 65702.7 65811.7 38531.4 41364.6 41460.4 41483.2 41490.6 16372.3 16454.7 16459.3 16472.3 16477.7 14798.4 14811.6 14920.4 14951.1 14981.8 9421.8 9438.3 9454.6 9488.8 9553.0 3537.8 3599.4 3646.1 3654.9 3657.4 1054.9 1070.4 1133.5 1149.1 1177.9 35101.0 35316.5 35545.0 35571.1 35696.0 1142.2 1146.4 1163.7 1223.3 1229.6 18264.8 18663.7 18684.0 18695.8 19003.8 593877.0 595269.0 602141.0 602151.0 605345.0 66677.0 66730.0 67110.0 67487.7 67554.3 1464.2 1467.6 1468.4 1493.2 1500.8 33771.3 33809.0 33828.2 33837.5 33934.3 56994.4 57689.4 57889.4 58386.4 58496.4 474610.0 474818.0 476269.0 476584.0 478605.0 31504.4 31863.5 31876.0 32290.5 32295.0 53246.0 54036.7 54751.5 59752.7 59799.4 45704.5 47734.5 47789.3 48416.8 49029.3 47225.5 47850.3 48348.5 48468.8 48625.0 45752.2 46829.0 46899.5 47402.0 49576.0 41265.0 41276.6 41799.0 42006.0 42595.8 31577.0 31722.2 31743.0 31987.5 32085.7 17:54:00 INFO - PROCESS | 7791 | 17:54:00 INFO - PROCESS | 7791 | [#2] jquery.html Cycles:180 Average:31640.83 Median:12033.57 stddev:89480.38 (743.6%) stddev-sans-first:89700.68 17:54:00 INFO - PROCESS | 7791 | Values: 418.5 430.0 436.8 442.1 442.2 19083.5 20260.3 20764.6 21711.2 21864.2 20291.2 20301.4 20770.6 20774.8 20790.3 5842.8 6031.6 6067.7 6098.1 6110.6 5955.0 5972.0 5973.3 5993.6 6013.0 5905.1 5923.9 5939.8 5942.6 5944.6 5900.9 5989.3 6010.8 6016.7 6045.2 5091.9 5124.3 5213.2 5227.5 5237.2 24596.8 24770.3 24807.8 24948.5 25091.6 2533.4 2582.5 2658.6 2808.8 3026.5 15503.8 15885.5 15993.8 16055.7 16260.3 2031.6 2047.7 2067.1 2109.5 2118.3 83286.0 84526.2 84712.2 85593.1 86034.0 11675.1 11846.5 11875.2 11953.8 11971.9 16899.0 16994.0 17015.7 17018.5 17051.8 8911.9 8933.3 9067.2 9071.0 9324.7 8775.5 8904.0 8977.0 9146.4 9176.2 5076.8 5152.9 5167.4 5217.3 5271.3 2079.8 2166.0 2179.6 2202.9 2217.5 930.7 1043.2 1072.2 1113.1 1162.0 20973.3 21053.7 21168.8 21301.9 21765.8 999.5 1020.5 1021.1 1029.7 1029.8 11123.6 11893.0 11937.2 12003.6 12056.3 516914.0 525978.0 548701.0 558727.0 562701.0 100949.5 102126.5 103692.5 104519.0 106591.5 1037.9 1072.4 1137.6 1141.1 1142.7 17941.9 18872.5 19055.7 19296.6 19378.1 32243.8 32632.3 35983.0 44896.6 44921.8 61026.7 62937.0 64851.0 65498.3 66027.7 9319.1 9353.0 9356.5 9480.2 9639.5 10952.9 13207.5 13214.8 13263.9 13429.3 11630.5 11728.2 11903.2 11965.4 12020.6 12006.8 12445.8 12591.4 12634.1 12876.9 11039.3 12034.5 12352.3 12574.1 12843.2 9369.0 9402.6 9579.6 9609.9 9713.3 10578.5 11847.6 11960.9 11985.2 12023.8 17:54:00 INFO - PROCESS | 7791 | 17:54:00 INFO - PROCESS | 7791 | [#3] mootools.html Cycles:180 Average:6064.91 Median:4316.26 stddev:3473.72 (80.5%) stddev-sans-first:3466.66 17:54:00 INFO - PROCESS | 7791 | Values: 1518.1 1520.5 1674.3 1784.9 1812.6 8677.3 8808.0 9329.2 9417.4 9443.4 9335.7 9477.4 9519.1 9520.0 9574.2 2400.9 2437.8 2444.5 2444.5 2449.2 2418.2 2425.3 2451.5 2455.1 2461.0 2377.8 2390.9 2397.5 2405.4 2411.3 2311.4 2320.8 2323.1 2326.2 2353.1 2128.4 2133.0 2140.9 2143.0 2143.1 9245.9 9396.7 9502.4 9506.3 9524.0 5213.2 5464.9 5514.2 5547.8 5551.9 3311.3 3356.2 3389.9 3446.4 3467.8 1087.2 1109.4 1120.7 1135.2 1139.2 12501.6 12541.4 12543.3 12555.1 12585.6 4468.9 4510.9 4671.5 4695.0 4728.5 10095.4 10100.8 10110.3 10120.5 10128.5 5450.6 5466.6 5472.6 5486.3 5487.4 5035.1 5110.1 5162.3 5192.8 5256.2 3895.6 4000.9 4028.2 4061.7 4064.9 1204.3 1206.2 1210.9 1212.3 1216.4 968.8 1048.0 1066.1 1073.9 1086.9 6252.2 6344.8 6356.5 6428.4 6496.0 419.6 419.7 419.9 426.9 430.8 4266.6 4304.9 4327.6 4373.2 4396.8 11104.1 11350.7 11475.5 11477.4 11532.4 10560.8 10984.5 11010.4 11418.0 11528.1 8264.8 8276.9 8401.9 8482.7 8511.8 6334.8 6342.3 6509.2 6540.1 6633.8 10171.4 10528.4 10631.0 10740.6 10743.2 10635.5 10873.8 10947.6 10948.0 11046.4 8018.0 8170.9 8308.5 8314.9 8538.3 9226.1 9265.6 9291.5 9317.7 9322.5 8191.6 8274.7 8328.6 8331.4 8447.9 7964.2 8018.8 8031.6 8084.2 8230.1 7323.3 7332.2 7383.2 7421.4 7429.4 5679.5 5723.8 5781.7 5820.8 5946.4 5642.0 5651.5 5710.3 5761.7 5770.8 17:54:00 INFO - PROCESS | 7791 | 17:54:00 INFO - PROCESS | 7791 | [#4] prototype.html Cycles:180 Average:5162.18 Median:5868.77 stddev:1524.17 (26.0%) stddev-sans-first:1484.86 17:54:00 INFO - PROCESS | 7791 | Values: 340.6 340.6 341.3 357.3 363.6 5860.5 5900.7 5902.2 5912.9 5914.2 5752.3 5820.9 5829.3 5835.3 5840.9 4162.5 4543.3 4565.8 4567.5 4580.4 4528.7 4537.3 4566.0 4570.5 4596.0 4476.0 4573.9 4596.4 4604.7 4605.6 4531.0 4531.9 4541.5 4559.2 4573.8 4055.7 4067.3 4074.8 4084.5 4104.4 5644.7 5690.6 5713.0 5719.9 5726.0 4957.8 5138.4 5142.6 5168.2 5169.4 6051.4 6090.5 6092.9 6093.1 6096.8 4167.0 4379.6 4382.6 4393.4 4396.5 6228.3 6249.1 6264.3 6310.6 6326.9 4459.5 4468.6 4491.7 4495.4 4519.5 4407.6 4536.8 4566.2 4568.7 4598.6 5150.8 5162.8 5172.2 5173.5 5204.2 6079.4 6093.3 6156.4 6170.4 6187.3 1477.4 1548.6 1551.7 1572.5 1576.9 963.9 1008.7 1009.7 1045.3 1081.1 5841.9 5842.2 5855.4 5883.2 5895.7 6185.2 6192.7 6241.2 6261.7 6274.6 5739.0 5835.8 5839.5 5877.0 5890.9 3292.8 3332.3 3339.4 3342.3 3344.0 6145.5 6417.2 6461.5 6489.5 6497.1 6361.9 6398.4 6401.2 6411.0 6427.1 6250.7 6431.8 6466.5 6483.1 6486.0 6270.7 6281.7 6285.5 6297.4 6325.1 6265.3 6270.1 6279.6 6288.9 6312.4 6257.0 6467.0 6508.3 6530.3 6588.9 4443.8 4498.0 4498.7 4501.0 4526.3 6224.6 6326.0 6397.8 6432.8 6435.9 6157.7 6166.0 6179.8 6184.5 6208.6 5952.7 6186.3 6188.4 6237.8 6257.6 5972.4 6114.1 6117.4 6123.3 6154.1 6216.7 6223.5 6233.4 6240.8 6275.5 5971.1 6060.3 6061.7 6076.5 6080.3 17:54:00 INFO - PROCESS | 7791 | 17:54:00 INFO - PROCESS | 7791 | [#5] yui.html Cycles:180 Average:22262.65 Median:3698.59 stddev:32194.64 (870.5%) stddev-sans-first:32244.39 17:54:00 INFO - PROCESS | 7791 | Values: 738.1 765.7 782.3 782.8 802.6 15997.1 17166.7 17383.7 17421.9 17477.7 14625.3 15391.8 15406.7 15770.1 15945.7 857.8 882.7 884.5 889.3 890.7 875.0 879.2 879.9 880.4 880.9 920.2 920.7 921.5 922.4 923.2 914.3 914.9 915.0 916.2 916.6 666.1 672.2 672.7 673.4 673.6 16130.1 16287.8 16335.7 16338.1 16359.9 14210.9 14786.5 15419.4 15653.5 15871.3 12924.7 13113.9 13431.0 13583.7 13791.2 4135.6 4141.0 4152.4 4155.9 4243.3 69839.0 72520.0 92407.0 93445.0 93479.0 12356.5 12573.3 12699.2 12812.9 12865.9 20428.4 20583.3 20664.0 20740.0 20817.3 8648.7 8758.9 8862.3 8989.3 9054.1 4611.0 4775.1 4843.6 4953.9 5054.7 3634.9 3762.3 3775.9 3778.4 3779.9 672.6 675.1 678.3 679.2 685.0 614.7 722.1 741.2 755.8 756.8 10117.4 10402.3 11002.6 11168.8 11313.3 628.2 677.7 701.9 807.9 844.2 5227.6 5271.6 5908.2 6027.9 6068.6 130409.0 132708.0 133754.3 134459.0 136735.0 69515.0 70874.6 71274.3 78245.6 103829.5 60822.0 101987.0 106270.0 106606.5 108434.5 10839.8 10856.3 11082.1 11415.3 11580.8 41649.8 47597.8 57596.7 58122.0 59162.7 76122.0 79794.0 88327.6 88569.0 90708.5 14121.4 14194.5 14585.9 14651.3 14694.5 16252.4 16529.7 16669.2 16697.2 16800.8 15446.6 15582.5 16264.6 16746.7 16807.2 14518.9 15544.0 15653.3 16706.5 16728.2 14167.2 14247.6 14903.5 15071.3 15088.5 12430.1 12457.4 12788.3 12840.0 13461.7 12209.2 12722.7 12766.2 12992.4 13056.6 17:54:00 INFO - PROCESS | 7791 | -------- Summary: end -------- 17:54:00 INFO - PROCESS | 7791 | 17:54:01 INFO - TEST-INFO | 7791: exit 0 17:54:01 INFO - TEST-OK | dromaeo_css | took 1110957ms 17:54:01 INFO - TEST-START | kraken 17:54:01 INFO - operating with platform_type : linux_ 17:54:01 INFO - Initialising browser for kraken test... 17:54:01 INFO - TEST-INFO | started process 8038 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxmgb4a/profile http://localhost:41168/getInfo.html) 17:54:05 INFO - PROCESS | 8038 | __metrics Screen width/height:1600/1200 17:54:05 INFO - PROCESS | 8038 | colorDepth:24 17:54:05 INFO - PROCESS | 8038 | Browser inner width/height: 1024/697 17:54:05 INFO - PROCESS | 8038 | __metrics 17:54:06 ERROR - PROCESS | 8038 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 17:54:07 INFO - TEST-INFO | 8038: exit 0 17:54:07 INFO - Browser initialized. 17:54:07 INFO - Running cycle 1/1 for kraken test... 17:54:07 INFO - TEST-INFO | started process 8161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxmgb4a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:54:19 INFO - PROCESS | 8161 | RSS: Main: 150032384 17:54:19 INFO - PROCESS | 8161 | 17:54:21 INFO - PROCESS | 8161 | Cycle 1(1): loaded http://localhost:41168/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41168/tests/kraken/driver.html?testName=audio-beat-detection) 17:54:22 INFO - PROCESS | 8161 | RSS: Main: 156725248 17:54:22 INFO - PROCESS | 8161 | 17:54:24 INFO - PROCESS | 8161 | Cycle 1(1): loaded http://localhost:41168/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41168/tests/kraken/driver.html?testName=audio-dft) 17:54:25 INFO - PROCESS | 8161 | RSS: Main: 155353088 17:54:25 INFO - PROCESS | 8161 | 17:54:28 INFO - PROCESS | 8161 | Cycle 1(1): loaded http://localhost:41168/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41168/tests/kraken/driver.html?testName=audio-fft) 17:54:29 INFO - PROCESS | 8161 | RSS: Main: 156090368 17:54:29 INFO - PROCESS | 8161 | 17:54:31 INFO - PROCESS | 8161 | Cycle 1(1): loaded http://localhost:41168/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41168/tests/kraken/driver.html?testName=audio-oscillator) 17:54:31 INFO - PROCESS | 8161 | RSS: Main: 155566080 17:54:31 INFO - PROCESS | 8161 | 17:54:33 INFO - PROCESS | 8161 | Cycle 1(1): loaded http://localhost:41168/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41168/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:54:34 INFO - PROCESS | 8161 | RSS: Main: 156512256 17:54:34 INFO - PROCESS | 8161 | 17:54:37 INFO - PROCESS | 8161 | Cycle 1(1): loaded http://localhost:41168/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41168/tests/kraken/driver.html?testName=imaging-darkroom) 17:54:38 INFO - PROCESS | 8161 | RSS: Main: 155787264 17:54:38 INFO - PROCESS | 8161 | 17:54:41 INFO - PROCESS | 8161 | Cycle 1(1): loaded http://localhost:41168/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41168/tests/kraken/driver.html?testName=imaging-desaturate) 17:54:42 INFO - PROCESS | 8161 | RSS: Main: 156618752 17:54:42 INFO - PROCESS | 8161 | 17:54:45 INFO - PROCESS | 8161 | Cycle 1(1): loaded http://localhost:41168/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41168/tests/kraken/driver.html?testName=json-parse-financial) 17:54:45 INFO - PROCESS | 8161 | RSS: Main: 156893184 17:54:45 INFO - PROCESS | 8161 | 17:54:47 INFO - PROCESS | 8161 | Cycle 1(1): loaded http://localhost:41168/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41168/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:54:47 INFO - PROCESS | 8161 | RSS: Main: 156381184 17:54:47 INFO - PROCESS | 8161 | 17:54:49 INFO - PROCESS | 8161 | Cycle 1(1): loaded http://localhost:41168/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41168/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:54:50 INFO - PROCESS | 8161 | RSS: Main: 156082176 17:54:50 INFO - PROCESS | 8161 | 17:54:52 INFO - PROCESS | 8161 | Cycle 1(1): loaded http://localhost:41168/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41168/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:54:52 INFO - PROCESS | 8161 | RSS: Main: 156516352 17:54:52 INFO - PROCESS | 8161 | 17:54:55 INFO - PROCESS | 8161 | Cycle 1(1): loaded http://localhost:41168/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41168/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:54:56 INFO - PROCESS | 8161 | RSS: Main: 156839936 17:54:56 INFO - PROCESS | 8161 | 17:54:58 INFO - PROCESS | 8161 | Cycle 1(1): loaded http://localhost:41168/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41168/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:54:59 INFO - PROCESS | 8161 | RSS: Main: 157220864 17:54:59 INFO - PROCESS | 8161 | 17:55:00 INFO - PROCESS | 8161 | Cycle 1(1): loaded http://localhost:41168/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41168/tests/kraken/driver.html?testName=ai-astar) 17:55:01 INFO - PROCESS | 8161 | RSS: Main: 159207424 17:55:01 INFO - PROCESS | 8161 | 17:55:01 INFO - PROCESS | 8161 | __start_tp_report 17:55:01 INFO - PROCESS | 8161 | _x_x_mozilla_page_load 17:55:01 INFO - PROCESS | 8161 | _x_x_mozilla_page_load_details 17:55:01 INFO - PROCESS | 8161 | |i|pagename|runs| 17:55:01 INFO - PROCESS | 8161 | |0;ai-astar;99;111;104;110;113;111;109;111;109;109 17:55:01 INFO - PROCESS | 8161 | |1;audio-beat-detection;147;116;144;175;117;153;147;122;170;120 17:55:01 INFO - PROCESS | 8161 | |2;audio-dft;161;161;164;163;162;161;161;163;162;161 17:55:01 INFO - PROCESS | 8161 | |3;audio-fft;82;75;76;174;75;75;75;77;168;76 17:55:01 INFO - PROCESS | 8161 | |4;audio-oscillator;85;84;147;84;85;85;142;84;84;145 17:55:01 INFO - PROCESS | 8161 | |5;imaging-gaussian-blur;117;118;118;117;118;117;118;118;118;117 17:55:01 INFO - PROCESS | 8161 | |6;imaging-darkroom;147;148;147;148;147;147;146;147;147;147 17:55:01 INFO - PROCESS | 8161 | |7;imaging-desaturate;96;96;96;97;96;96;95;95;95;96 17:55:01 INFO - PROCESS | 8161 | |8;json-parse-financial;50;50;50;49;50;58;50;56;50;51 17:55:01 INFO - PROCESS | 8161 | |9;json-stringify-tinderbox;63;62;61;62;61;62;61;62;65;62 17:55:01 INFO - PROCESS | 8161 | |10;stanford-crypto-aes;74;72;83;75;75;76;73;75;77;79 17:55:01 INFO - PROCESS | 8161 | |11;stanford-crypto-ccm;125;129;131;120;120;135;119;120;149;119 17:55:01 INFO - PROCESS | 8161 | |12;stanford-crypto-pbkdf2;161;157;157;151;154;152;159;154;154;154 17:55:01 INFO - PROCESS | 8161 | |13;stanford-crypto-sha256-iterative;62;62;61;61;63;66;61;63;60;59 17:55:01 INFO - PROCESS | 8161 | __end_tp_report 17:55:01 INFO - PROCESS | 8161 | __start_cc_report 17:55:01 INFO - PROCESS | 8161 | _x_x_mozilla_cycle_collect,858 17:55:01 INFO - PROCESS | 8161 | __end_cc_report 17:55:01 INFO - PROCESS | 8161 | __startTimestamp1477356901240__endTimestamp 17:55:01 INFO - PROCESS | 8161 | 17:55:01 INFO - PROCESS | 8161 | ------- Summary: start ------- 17:55:01 INFO - PROCESS | 8161 | Number of tests: 14 17:55:01 INFO - PROCESS | 8161 | 17:55:01 INFO - PROCESS | 8161 | [#0] ai-astar Cycles:10 Average:108.60 Median:111.00 stddev:4.12 (3.7%) stddev-sans-first:2.50 17:55:01 INFO - PROCESS | 8161 | Values: 99.0 111.0 104.0 110.0 113.0 111.0 109.0 111.0 109.0 109.0 17:55:01 INFO - PROCESS | 8161 | 17:55:01 INFO - PROCESS | 8161 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:147.00 stddev:21.67 (14.7%) stddev-sans-first:22.88 17:55:01 INFO - PROCESS | 8161 | Values: 147.0 116.0 144.0 175.0 117.0 153.0 147.0 122.0 170.0 120.0 17:55:01 INFO - PROCESS | 8161 | 17:55:01 INFO - PROCESS | 8161 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 17:55:01 INFO - PROCESS | 8161 | Values: 161.0 161.0 164.0 163.0 162.0 161.0 161.0 163.0 162.0 161.0 17:55:01 INFO - PROCESS | 8161 | 17:55:01 INFO - PROCESS | 8161 | [#3] audio-fft Cycles:10 Average:95.30 Median:75.50 stddev:39.98 (53.0%) stddev-sans-first:42.11 17:55:01 INFO - PROCESS | 8161 | Values: 82.0 75.0 76.0 174.0 75.0 75.0 75.0 77.0 168.0 76.0 17:55:01 INFO - PROCESS | 8161 | 17:55:01 INFO - PROCESS | 8161 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:84.00 stddev:29.13 (34.7%) stddev-sans-first:30.20 17:55:01 INFO - PROCESS | 8161 | Values: 85.0 84.0 147.0 84.0 85.0 85.0 142.0 84.0 84.0 145.0 17:55:01 INFO - PROCESS | 8161 | 17:55:01 INFO - PROCESS | 8161 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 17:55:01 INFO - PROCESS | 8161 | Values: 117.0 118.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 117.0 17:55:01 INFO - PROCESS | 8161 | 17:55:01 INFO - PROCESS | 8161 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 17:55:01 INFO - PROCESS | 8161 | Values: 147.0 148.0 147.0 148.0 147.0 147.0 146.0 147.0 147.0 147.0 17:55:01 INFO - PROCESS | 8161 | 17:55:01 INFO - PROCESS | 8161 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 17:55:01 INFO - PROCESS | 8161 | Values: 96.0 96.0 96.0 97.0 96.0 96.0 95.0 95.0 95.0 96.0 17:55:01 INFO - PROCESS | 8161 | 17:55:01 INFO - PROCESS | 8161 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:50.00 stddev:3.03 (6.1%) stddev-sans-first:3.17 17:55:01 INFO - PROCESS | 8161 | Values: 50.0 50.0 50.0 49.0 50.0 58.0 50.0 56.0 50.0 51.0 17:55:01 INFO - PROCESS | 8161 | 17:55:01 INFO - PROCESS | 8161 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:1.20 (1.9%) stddev-sans-first:1.22 17:55:01 INFO - PROCESS | 8161 | Values: 63.0 62.0 61.0 62.0 61.0 62.0 61.0 62.0 65.0 62.0 17:55:01 INFO - PROCESS | 8161 | 17:55:01 INFO - PROCESS | 8161 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:75.50 stddev:3.18 (4.2%) stddev-sans-first:3.30 17:55:01 INFO - PROCESS | 8161 | Values: 74.0 72.0 83.0 75.0 75.0 76.0 73.0 75.0 77.0 79.0 17:55:01 INFO - PROCESS | 8161 | 17:55:01 INFO - PROCESS | 8161 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:127.00 stddev:9.70 (7.6%) stddev-sans-first:10.26 17:55:01 INFO - PROCESS | 8161 | Values: 125.0 129.0 131.0 120.0 120.0 135.0 119.0 120.0 149.0 119.0 17:55:01 INFO - PROCESS | 8161 | 17:55:01 INFO - PROCESS | 8161 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.30 Median:155.50 stddev:3.13 (2.0%) stddev-sans-first:2.55 17:55:01 INFO - PROCESS | 8161 | Values: 161.0 157.0 157.0 151.0 154.0 152.0 159.0 154.0 154.0 154.0 17:55:01 INFO - PROCESS | 8161 | 17:55:01 INFO - PROCESS | 8161 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.80 Median:62.00 stddev:1.93 (3.1%) stddev-sans-first:2.05 17:55:01 INFO - PROCESS | 8161 | Values: 62.0 62.0 61.0 61.0 63.0 66.0 61.0 63.0 60.0 59.0 17:55:01 INFO - PROCESS | 8161 | -------- Summary: end -------- 17:55:01 INFO - PROCESS | 8161 | 17:55:02 INFO - TEST-INFO | 8161: exit 0 17:55:02 INFO - TEST-OK | kraken | took 60888ms 17:55:02 INFO - SUITE-END | took 1171s 17:55:02 INFO - Completed test suite (00:19:32) 17:55:02 INFO - javascript benchmark 17:55:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7718.159582832743, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3311.2384151645106, 3312.205070783012, 3315.336932613478, 3317.6848199421047, 3343.2811945431727, 5691.032524470839, 5696.943030569693, 5729.226554415152, 5760.510356619692, 5777.0, 5611.3266408031095, 5689.886202275952, 5728.283964504437, 5733.397993210715, 5737.942620573793, 5160.974195129038, 5190.818321358754, 5225.738713064351, 5260.132078207092, 5276.182191760283, 5232.6075544334135, 5270.92093618596, 5278.551323137538, 5280.0, 5307.2569840222395, 5128.846134615949, 5150.536451719345, 5270.262163297141, 5277.182036784305, 5285.603579731516, 5192.896142077157, 5269.578433725293, 5270.710110943896, 5286.233496143038, 5305.602079844027, 5195.896082078375, 5238.92141617876, 5241.187615919539, 5246.186841039645, 5258.710770907637, 5530.695811730353, 5549.861253468655, 5642.322921249435, 5687.26065611472, 5788.131780232957, 6020.909686354708, 6069.757209711606, 6077.24034495688, 6091.9390806091815, 6116.174316467264, 6105.481034112061, 6111.449969502766, 6111.755529778803, 6113.633182009094, 6115.327313995457, 5502.119660854284, 5577.8047768327915, 5709.314882214119, 5715.1713001614535, 5734.168545560912, 6114.936124487593, 6201.441870231701, 6207.937920620826, 6212.88168129741, 6233.594816337014, 5959.493443057302, 5959.910601340984, 5982.970085149546, 5989.131575921554, 6000.309964354068, 5936.5250779937505, 6001.969990150109, 6024.638521688713, 6072.453479186895, 6084.148219249309, 6005.879882402415, 6092.634441933498, 6109.908351374733, 6125.234345706786, 6126.816195514141, 6049.758009679652, 6070.453659170696, 6070.817875463743, 6078.179445774852, 6087.54343424245, 4512.548745125461, 4600.332951721982, 4654.115718013634, 4656.41794775653, 4665.113628410591, 4137.007118291588, 4174.123434078817, 4185.707000509996, 4209.621134097946, 4219.409282700424, 5881.441263080001, 5899.734511946973, 5902.586818922634, 5929.37741537141, 5932.169496270526, 5913.0, 6012.518998480111, 6186.133941248228, 6193.535484838655, 6195.504359651217, 5866.178734977107, 5873.647581145059, 5939.4357536034, 5945.227120474397, 5968.283805943228, 5115.309433226541, 5124.282600435942, 5124.692518448905, 5125.79496820123, 5151.0470562945975, 6115.938840611626, 6173.351798061139, 6262.530310226751, 6335.208098987627, 6399.840003999937, 6090.839842874775, 6137.3049617043, 6142.140100386039, 6151.138840562415, 6174.567780255339, 6323.652199129092, 6336.746530138743, 6360.554761166674, 6371.904421433589, 6373.649449280334, 5769.942300577109, 5941.524678025661, 5977.252843394575, 5999.100134979788, 6032.33644299118, 6138.9095594588325, 6157.168782214523, 6162.568620196544, 6162.753489860355, 6164.198654174928, 6015.428534289235, 6018.488428483628, 6023.939760602513, 6031.819045428644, 6048.637081775108, 5751.424857514216, 5933.851653708692, 5980.491658209101, 6009.06859436788, 6032.426919442646, 5923.200367950271, 5964.135200396005, 5966.940330596639, 5979.222701048836, 5979.790707325223, 5961.850953726192, 5986.9401305986385, 6046.90929636047, 6054.697265136638, 6070.726817293321, 5694.772209111589, 5760.337561180518, 5864.794732184353, 5893.116032595145, 5896.852578685567], "value": 5632.649147202761, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.7001814083887, 631.5831551176225, 663.4360793325674, 674.1404708996032, 711.0365454808731, 41936.370954435704, 47630.04739905204, 47927.28109078367, 47972.52027479724, 48026.27960580585, 47028.52971470293, 47071.52928470714, 47285.29072063922, 47791.0441791164, 48161.75919120408, 8914.06402327756, 9147.72556823293, 9148.542572871364, 9159.404638698497, 9170.0, 9107.726768196932, 9147.725568232963, 9176.0, 9242.537873106352, 9250.583723732449, 9135.95432022839, 9204.631814727403, 9310.674126405576, 9312.068793120701, 9331.486768227745, 9210.171084602385, 9265.351425400224, 9300.674476393327, 9303.953480232556, 9310.0, 9097.727068187965, 9098.86351704725, 9181.816363672757, 9181.862272065924, 9195.632174713004, 44872.0, 44982.550174498494, 45205.77397112994, 45254.32118518225, 45369.0, 3839.424086387064, 3968.9801550992347, 4486.147631949919, 4509.457001171197, 4636.605888499482, 35183.4722479163, 35252.0, 35339.82330088359, 36083.4587481188, 36820.63179368199, 4637.489876113625, 4656.972967571106, 4667.113248482778, 4670.089332580148, 4746.881327966794, 407604.0, 408151.0, 410316.0, 411674.0, 413022.0, 38977.41533876994, 65303.673481632286, 65658.34341656523, 65702.67148664226, 65811.67094164499, 38531.42202866959, 41364.586354136074, 41460.37809432861, 41483.1703365931, 41490.585094149275, 16372.345106195857, 16454.670906581803, 16459.25933333003, 16472.25874835635, 16477.670446591, 14798.408063677332, 14811.629709257139, 14920.40318387274, 14951.102933824006, 14981.775273370908, 9421.811563768686, 9438.339316247797, 9454.621815127455, 9488.810223795486, 9553.0, 3537.8054207018345, 3599.3748033776474, 3646.08847788053, 3654.926901461956, 3657.4148136298063, 1054.8628678271775, 1070.4166229404993, 1133.4502766158407, 1149.1438878035917, 1177.8586569611703, 35101.0, 35316.47025294622, 35545.0, 35571.110722231635, 35696.0, 1142.2461175624214, 1146.4095990564865, 1163.6567212672282, 1223.2660403757852, 1229.6434034130002, 18264.817351826576, 18663.677886165216, 18684.0, 18695.81304186968, 19003.80996190048, 593877.0, 595269.0, 602141.0, 602151.0, 605345.0, 66676.99984500237, 66730.0, 67110.0, 67487.66256168688, 67554.32445675578, 1464.2166440954038, 1467.581739204343, 1468.3979568377129, 1493.1787516865681, 1500.7523758579712, 33771.3245735079, 33809.0, 33828.15429614279, 33837.492437612964, 33934.32131357408, 56994.43005569891, 57689.42310576841, 57889.4211057884, 58386.416135838095, 58496.4150358508, 474610.0, 474818.0, 476269.0, 476584.0, 478605.0, 31504.369912602077, 31863.522047169776, 31876.0, 32290.515642265855, 32295.0, 53246.0, 54036.729816350664, 54751.452485474634, 59752.701236493536, 59799.40200598112, 45704.542954571356, 47734.522654774395, 47789.28316075192, 48416.75791621019, 49029.2645610309, 47225.527744723484, 47850.282245765644, 48348.5165148344, 48468.75765621149, 48625.0, 45752.1699132031, 46829.0, 46899.53100468952, 47402.0, 49576.0, 41265.0, 41276.58723412848, 41799.0, 42006.0, 42595.787021064694, 31577.0, 31722.20694482564, 31743.0, 31987.520187197675, 32085.67914320827], "value": 20893.327308991997, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.4706346471712, 429.96411989230984, 436.7750608436655, 442.1334184997405, 442.21065398264085, 19083.522911927208, 20260.29088981884, 20764.584708305843, 21711.240106596273, 21864.23475178369, 20291.18835246592, 20301.39095827124, 20770.584588308226, 20774.792252077474, 20790.272340468087, 5842.766289348431, 6031.577789554733, 6067.7269522871575, 6098.115773212881, 6110.572259941806, 5955.047192449209, 5972.0, 5973.313068997056, 5993.640381577097, 6013.037913933749, 5905.055191169414, 5923.911141332884, 5939.762409503614, 5942.554308426864, 5944.613600116, 5900.911486327708, 5989.3112292086535, 6010.75956961721, 6016.729247183844, 6045.244344456943, 5091.949080509185, 5124.282600435942, 5213.244079608436, 5227.529522342969, 5237.240600113, 24596.754032459805, 24770.25689229326, 24807.751922480726, 24948.50102997948, 25091.62362564563, 2533.366658335416, 2582.535143674138, 2658.56133737933, 2808.8033837631374, 3026.500627396477, 15503.844961550352, 15885.523434296989, 15993.760093598605, 16055.678886422324, 16260.349586016546, 2031.5530583271805, 2047.682609195577, 2067.1421360135528, 2109.4726318420394, 2118.2691971269887, 83286.0, 84526.15473845245, 84712.15287847104, 85593.14406855914, 86034.0, 11675.12436567261, 11846.526138954345, 11875.228110172811, 11953.760924781629, 11971.940140299243, 16899.0, 16994.0, 17015.65968680644, 17018.48944531666, 17051.829481705023, 8911.866322005175, 8933.28533717301, 9067.183953444222, 9071.0, 9324.720258392259, 8775.473471591726, 8903.955480222687, 8977.0, 9146.359754817233, 9176.174144327042, 5076.771545280471, 5152.92270615941, 5167.354080739908, 5217.295665085165, 5271.341082364705, 2079.8336133109315, 2166.0, 2179.5863376662387, 2202.9008694608783, 2217.4899773051966, 930.7197366452084, 1043.1967385113421, 1072.2387105155271, 1113.1206346985953, 1161.96514104577, 20973.26593569248, 21053.684194737092, 21168.78831211699, 21301.89349053276, 21765.78234217669, 999.4652860719481, 1020.505055048301, 1021.1167340250778, 1029.6807989523122, 1029.7837454134565, 11123.555057797597, 11893.04855611549, 11937.224080434919, 12003.639890803115, 12056.27662340245, 516914.0, 525978.0, 548701.0, 558727.0, 562701.0, 100949.49525252474, 102126.48936755417, 103692.48153759183, 104519.0, 106591.46704266428, 1037.9377237365632, 1072.420892717939, 1137.6473293278943, 1141.149843366697, 1142.6857614156174, 17941.910290448985, 18872.52818679489, 19055.71416428727, 19296.614067718285, 19378.127984240462, 32243.838780805945, 32632.34735305328, 35983.0, 44896.55103448924, 44921.775391122836, 61026.69486652538, 62937.0, 64851.0, 65498.34501655113, 66027.66986165039, 9319.114684105, 9352.953235234052, 9356.532173391439, 9480.194183494481, 9639.469829159463, 10952.945235273774, 13207.471701131846, 13214.801777973145, 13263.867361326264, 13429.328533573478, 11630.534778609099, 11728.179027467995, 11903.226290291102, 11965.401729913643, 12020.579279725167, 12006.819897701367, 12445.75108497843, 12591.433385497492, 12634.115611907078, 12876.935615321863, 11039.337639741641, 12034.518619255481, 12352.25886446816, 12574.05694572929, 12843.165194262718, 9369.0, 9402.57688404037, 9579.568919398504, 9609.855852162083, 9713.320067595201, 10578.523966421375, 11847.644570662549, 11960.880391196324, 11985.22096063753, 12023.75952480928], "value": 9945.750917383464, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.0891465120926, 1520.4526370506617, 1674.271691814061, 1784.883982541134, 1812.6284111757084, 8677.349198810083, 8807.999999999984, 9329.207017403529, 9417.38786978846, 9443.386179898302, 9335.719928402143, 9477.431354118758, 9519.143277105059, 9519.952400238006, 9574.2340612751, 2400.9039638414442, 2437.7805997460223, 2444.4622183119686, 2444.535538247736, 2449.2407353720405, 2418.1657328221736, 2425.3451568076607, 2451.534208500388, 2455.1038870812204, 2461.040194324215, 2377.7741114594087, 2390.880455977203, 2397.5085107552995, 2405.3625789165885, 2411.3489357873364, 2311.410590299471, 2320.791128798416, 2323.082382458936, 2326.209088909779, 2353.1293421434007, 2128.4253251621976, 2132.9786702132933, 2140.871547707143, 2142.9571408571896, 2143.1320315272183, 9245.861312080324, 9396.718098457057, 9502.4298542087, 9506.334556581041, 9524.0, 5213.165893457029, 5464.9453505464835, 5514.172874068881, 5547.750351234205, 5551.8889622207325, 3311.3211791582908, 3356.194513316811, 3389.949115774118, 3446.4485682290715, 3467.8266086695817, 1087.211771465689, 1109.4230999880099, 1120.714217874445, 1135.1543100390263, 1139.1740987783874, 12501.56244531437, 12541.372931353488, 12543.310117943509, 12555.121141520098, 12585.622431327167, 4468.865934021985, 4510.932336014962, 4671.5328467153695, 4694.976525117421, 4728.527147285244, 10095.394276343442, 10100.848487272697, 10110.292279540361, 10120.544575494121, 10128.493575321205, 5450.645708028966, 5466.562674985991, 5472.5621950243885, 5486.31421072366, 5487.42382049887, 5035.068512325159, 5110.080185566634, 5162.251473536317, 5192.81825136126, 5256.211568264791, 3895.6299151580556, 4000.9199816003515, 4028.2144981728866, 4061.6953728470485, 4064.8577299794365, 1204.3015051270243, 1206.173770966873, 1210.9212901161397, 1212.2605210821391, 1216.4343580235234, 968.801395713877, 1048.0, 1066.1311031509294, 1073.897979691928, 1086.9347839129678, 6252.155958945576, 6344.777932772331, 6356.459700925473, 6428.4214420702365, 6495.967520162369, 419.62443612966223, 419.7418587568623, 419.8866306097337, 426.86340371080956, 430.79752516317905, 4266.573342665709, 4304.89237769052, 4327.636794409751, 4373.169097871394, 4396.824127034883, 11104.111671066295, 11350.716232094264, 11475.483603237708, 11477.36874471912, 11532.423378831025, 10560.788784224425, 10984.505697243643, 11010.39442830652, 11417.972382485616, 11528.135389845795, 8264.752057438167, 8276.875846862302, 8401.915980840113, 8482.703105391281, 8511.787205319917, 6334.778282760081, 6342.302346741947, 6509.1863517060365, 6540.117084193573, 6633.834154145992, 10171.389716617026, 10528.42093684824, 10631.0, 10740.624078157227, 10743.24797264184, 10635.521401537104, 10873.836892446461, 10947.616833411112, 10948.0, 11046.447677615926, 8017.959910200411, 8170.877436838333, 8308.459950103224, 8314.87527687073, 8538.316934645089, 9226.07739226072, 9265.583048762957, 9291.48896810682, 9317.72046838596, 9322.487263200317, 8191.631376587949, 8274.710385136492, 8328.583570821556, 8331.416800823885, 8447.915520844714, 7964.20357964199, 8018.799530011796, 8031.638576263966, 8084.231997960184, 8230.09468958402, 7323.340899319087, 7332.193458719643, 7383.150937642025, 7421.369183619453, 7429.368503677248, 5679.545636349165, 5723.828285151452, 5781.68200748946, 5820.76716931318, 5946.375630558729, 5641.971790141023, 5651.463111004448, 5710.314762228559, 5761.654300741969, 5770.769169233184], "value": 4728.6092508211705, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.6202084675586, 340.62361090994466, 341.27308832187435, 357.29077780605496, 363.647262155709, 5860.5311575074, 5900.734466948987, 5902.232709747726, 5912.852178695534, 5914.172015917769, 5752.252207213067, 5820.883582328351, 5829.329627092886, 5835.270591176103, 5840.883182336351, 4162.542120366765, 4543.341215523764, 4565.840195593155, 4567.474740404846, 4580.427446569179, 4528.7056341337875, 4537.277633419954, 4566.018306064196, 4570.54294570542, 4595.988882445857, 4475.955240447603, 4573.908521829578, 4596.402467679214, 4604.723716577016, 4605.585497305242, 4530.954690453103, 4531.886702832423, 4541.477730061019, 4559.156556037144, 4573.794179261941, 4055.675545956346, 4067.3085575452246, 4074.8183026922156, 4084.509858816961, 4104.384342348641, 5644.673501727091, 5690.630109042899, 5713.0, 5719.857003574903, 5726.026575482178, 4957.760559860035, 5138.383393992707, 5142.614303927183, 5168.198929165947, 5169.39748677911, 6051.364606716319, 6090.48230900374, 6092.939070609325, 6093.055576385667, 6096.786612468587, 4166.958330416687, 4379.605835474823, 4382.583654552813, 4393.384926110315, 4396.505188236015, 6228.346023667495, 6249.125262421256, 6264.3422440643535, 6310.6213627182515, 6326.912119000719, 4459.52835564263, 4468.575485328954, 4491.685582009228, 4495.43807024122, 4519.485972199284, 4407.647388208936, 4536.79584418702, 4566.1552612766745, 4568.70303430276, 4598.609118224988, 5150.845474635767, 5162.845114646567, 5172.224166374998, 5173.482651734872, 5204.21936709489, 6079.422454866781, 6093.268807743099, 6156.384361563897, 6170.352113028157, 6187.257529096537, 1477.4385733421232, 1548.6283292010062, 1551.6663917257845, 1572.5439622509573, 1576.9369225231092, 963.9084286992725, 1008.6822650864954, 1009.7374682582581, 1045.2839804733783, 1081.1080858291941, 5841.88316233673, 5842.240508733922, 5855.414458554111, 5883.17635531026, 5895.7052147393315, 6185.226846644169, 6192.721327540272, 6241.157443745036, 6261.686915654199, 6274.560780745395, 5739.0, 5835.795747148914, 5839.5036421904615, 5877.0, 5890.911636325459, 3292.7859689120132, 3332.333533293351, 3339.4489909164718, 3342.331533693271, 3343.966560334414, 6145.508359331243, 6417.2299324081405, 6461.483081353481, 6489.474973381251, 6497.122888410004, 6361.872762544724, 6398.424141827258, 6401.199850018747, 6410.967945160244, 6427.075680565425, 6250.749970001149, 6431.807045788634, 6466.450351720063, 6483.082612824248, 6486.0, 6270.686465676789, 6281.654509002049, 6285.528585356208, 6297.4017468340435, 6325.146105275913, 6265.2746055464195, 6270.090836828543, 6279.591826531261, 6288.874222515616, 6312.400321969406, 6257.0, 6466.967665161644, 6508.349165083454, 6530.346965303432, 6588.934110659024, 4443.822247110079, 4497.977510112429, 4498.685092043525, 4501.0, 4526.2531682273375, 6224.62652240867, 6326.0, 6397.808065758035, 6432.774852880127, 6435.935640643534, 6157.722902469489, 6165.969170154121, 6179.81460556184, 6184.474319682878, 6208.565400421927, 5952.702364881825, 6186.319504854552, 6188.412100850412, 6237.8148151851, 6257.624542527463, 5972.432618901197, 6114.065248680748, 6117.357677443804, 6123.295820980644, 6154.122992487334, 6216.720247588779, 6223.471004964629, 6233.407826256498, 6240.781572644935, 6275.462511684666, 5971.134185543159, 6060.333363330118, 6061.666433384648, 6076.513878889767, 6080.270367555921], "value": 4668.220842423289, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.0589748071209, 765.6745882999727, 782.3193821375404, 782.7964729170413, 802.5987006496752, 15997.120158391299, 17166.656666866656, 17383.73924391135, 17421.91289043556, 17477.65044699107, 14625.268736563155, 15391.84608153918, 15406.69186616267, 15770.132642704675, 15945.681086378265, 857.7898414888346, 882.7087061269798, 884.456059523395, 889.3374436045123, 890.6882591093098, 874.9650013999433, 879.1911441473827, 879.8944126704804, 880.4409200157882, 880.9119088091172, 920.249996253055, 920.7099763574486, 921.4885738415177, 922.4419226368051, 923.2475532441039, 914.2548822709471, 914.8673442350855, 914.9542522873863, 916.2120576304372, 916.5508900638706, 666.1007639686433, 672.1933679584519, 672.7342699633617, 673.4275865514322, 673.5958424945043, 16130.112843793586, 16287.83712162875, 16335.673286534202, 16338.101404422752, 16359.918200408922, 14210.857891421058, 14786.482473113389, 15419.383224670999, 15653.530394088082, 15871.28579213938, 12924.741505169844, 13113.934430327883, 13431.0, 13583.660408489768, 13791.172529648153, 4135.58644135587, 4141.0, 4152.418661387408, 4155.854545090938, 4243.27864263076, 69839.0, 72519.99999999948, 92407.0, 93445.0, 93479.0, 12356.545684586497, 12573.308468034345, 12699.238045717286, 12812.871871281355, 12865.871341286655, 20428.387148385573, 20583.279585214746, 20664.0, 20740.0, 20817.271395501084, 8648.654053837901, 8758.86861697075, 8862.335324850534, 8989.280857531381, 9054.094590540893, 4611.0, 4775.06886157196, 4843.636727245471, 4953.900921981613, 5054.69671819692, 3634.9091272717865, 3762.2663580602066, 3775.905602359963, 3778.3765678663262, 3779.8866034019024, 672.559473544829, 675.1425689374466, 678.3250665587772, 679.17819438479, 684.9931500685029, 614.7141579165709, 722.0829546475946, 741.1698897235132, 755.8186035351476, 756.7578374919973, 10117.392956422638, 10402.27184097106, 11002.559897604006, 11168.776624467628, 11313.321200727984, 628.2335550628226, 677.6916502991127, 701.8841891088016, 807.8625345076316, 844.1853611265159, 5227.555657769056, 5271.604629652791, 5908.172855800191, 6027.9095813562835, 6068.6358818471035, 130409.0, 132708.0, 133754.3312283452, 134459.0, 136735.0, 69515.0, 70874.64562677154, 71274.28725712677, 78245.60877195692, 103829.48085259525, 60822.0, 101987.0, 106269.99999999846, 106606.46696766622, 108434.45782771036, 10839.783204335712, 10856.254592165691, 11082.113430925345, 11415.315081095161, 11580.826287605523, 41649.79175104105, 47597.76201119111, 57596.71201643965, 58122.0, 59162.70418647879, 76122.0, 79794.0, 88327.55836220778, 88569.0, 90708.5464572673, 14121.435142594592, 14194.503192388216, 14585.854141458449, 14651.340689669203, 14694.485693000694, 16252.366306772692, 16529.66940661204, 16669.249883755503, 16697.248623811716, 16800.831991679926, 15446.613834654223, 15582.454614088452, 16264.593385165466, 16746.665066698843, 16807.159642018094, 14518.927405362905, 15544.0, 15653.295601697722, 16706.49880503587, 16728.163591820605, 14167.220802855942, 14247.643808904446, 14903.478378256708, 15071.342152363011, 15088.471903483325, 12430.067744918986, 12457.377131143588, 12788.265166685893, 12840.0, 13461.663458413617, 12209.206401583868, 12722.745545088861, 12766.17019893704, 12992.415341309475, 13056.608301750963], "value": 8180.840457602384, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1503.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 111.0, 104.0, 110.0, 113.0, 111.0, 109.0, 111.0, 109.0, 109.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 144.0, 175.0, 117.0, 153.0, 147.0, 122.0, 170.0, 120.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 164.0, 163.0, 162.0, 161.0, 161.0, 163.0, 162.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 75.0, 76.0, 174.0, 75.0, 75.0, 75.0, 77.0, 168.0, 76.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 147.0, 84.0, 85.0, 85.0, 142.0, 84.0, 84.0, 145.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 49.0, 50.0, 58.0, 50.0, 56.0, 50.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 62.0, 61.0, 62.0, 61.0, 62.0, 65.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 83.0, 75.0, 75.0, 76.0, 73.0, 75.0, 77.0, 79.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 129.0, 131.0, 120.0, 120.0, 135.0, 119.0, 120.0, 149.0, 119.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 157.0, 157.0, 151.0, 154.0, 152.0, 159.0, 154.0, 154.0, 154.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 63.0, 66.0, 61.0, 63.0, 60.0, 59.0], "value": 61.8, "unit": "score"}]}]} 17:55:02 INFO - Return code: 0 17:55:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:55:02 ERROR - # TBPL SUCCESS # 17:55:02 INFO - Running post-action listener: _resource_record_post_action 17:55:02 INFO - [mozharness: 2016-10-25 00:55:02.541500Z] Finished run-tests step (success) 17:55:02 INFO - Running post-run listener: _resource_record_post_run 17:55:02 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288223232; Read time: 104; Write time: 172184 17:55:02 INFO - TinderboxPrint: CPU usage
13.1% 17:55:02 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 104 17:55:02 INFO - TinderboxPrint: I/O write bytes / time
288,223,232 / 172,184 17:55:02 INFO - TinderboxPrint: CPU idle
8,219.3 (86.8%) 17:55:02 INFO - TinderboxPrint: CPU user
1,193.7 (12.6%) 17:55:02 INFO - TinderboxPrint: Swap in / out
0 / 0 17:55:02 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 71323648; Read time: 0; Write time: 34368 17:55:02 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 216330240; Read time: 96; Write time: 137752 17:55:03 INFO - Running post-run listener: _upload_blobber_files 17:55:03 INFO - Blob upload gear active. 17:55:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:55:03 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 17:55:03 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'] 17:55:03 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 17:55:03 INFO - (blobuploader) - INFO - Open directory for files ... 17:55:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:55:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:55:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:07 INFO - (blobuploader) - INFO - Done attempting. 17:55:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:55:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:55:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:08 INFO - (blobuploader) - INFO - Done attempting. 17:55:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:55:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:55:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:09 INFO - (blobuploader) - INFO - Done attempting. 17:55:09 INFO - (blobuploader) - INFO - Iteration through files over. 17:55:09 INFO - Return code: 0 17:55:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:55:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:55:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8bb5f0b004941a3f9250113518376668777bcb7ae4b7e5c19d0f36ecabd132a6318aaa92689d8e90b57ad7cf587dda910388b369f1e6040d3c4568bb67bf45d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb144bb6461d44cdcffea1b9c5625a85c7111b896136ccfa16b7f2afe6a576b5b54d53a4396b65041199402b917a0df4117a0f05676ba0131c948c90a514f704", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5561c35927c8a3d3f565f747f285cd8bc2c0ac42ed959bb4b796174b89c52ae4606aa53576407ed98f7435f1bfbcf2f1676ace476f60c6bb0003a87d97438b01"} 17:55:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:55:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:55:09 INFO - Contents: 17:55:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8bb5f0b004941a3f9250113518376668777bcb7ae4b7e5c19d0f36ecabd132a6318aaa92689d8e90b57ad7cf587dda910388b369f1e6040d3c4568bb67bf45d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb144bb6461d44cdcffea1b9c5625a85c7111b896136ccfa16b7f2afe6a576b5b54d53a4396b65041199402b917a0df4117a0f05676ba0131c948c90a514f704", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5561c35927c8a3d3f565f747f285cd8bc2c0ac42ed959bb4b796174b89c52ae4606aa53576407ed98f7435f1bfbcf2f1676ace476f60c6bb0003a87d97438b01"} 17:55:09 INFO - Running post-run listener: copy_logs_to_upload_dir 17:55:09 INFO - Copying logs to upload dir... 17:55:09 INFO - mkdir: /builds/slave/test/build/upload/logs 17:55:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1674.781186 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 54 secs) (at 2016-10-24 17:55:09.287910) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 17:55:09.291847) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562 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/8bb5f0b004941a3f9250113518376668777bcb7ae4b7e5c19d0f36ecabd132a6318aaa92689d8e90b57ad7cf587dda910388b369f1e6040d3c4568bb67bf45d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb144bb6461d44cdcffea1b9c5625a85c7111b896136ccfa16b7f2afe6a576b5b54d53a4396b65041199402b917a0df4117a0f05676ba0131c948c90a514f704", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5561c35927c8a3d3f565f747f285cd8bc2c0ac42ed959bb4b796174b89c52ae4606aa53576407ed98f7435f1bfbcf2f1676ace476f60c6bb0003a87d97438b01"} build_url:https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/K_jLoE7vQ6-qeVRkHivzDg/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/8bb5f0b004941a3f9250113518376668777bcb7ae4b7e5c19d0f36ecabd132a6318aaa92689d8e90b57ad7cf587dda910388b369f1e6040d3c4568bb67bf45d8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb144bb6461d44cdcffea1b9c5625a85c7111b896136ccfa16b7f2afe6a576b5b54d53a4396b65041199402b917a0df4117a0f05676ba0131c948c90a514f704", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5561c35927c8a3d3f565f747f285cd8bc2c0ac42ed959bb4b796174b89c52ae4606aa53576407ed98f7435f1bfbcf2f1676ace476f60c6bb0003a87d97438b01"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 17:55:09.321017) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:55:09.321390) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1477355232.881415-1156413562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 17:55:09.405640) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 17:55:09.406002) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 17:55:09.406377) ========= ========= Total master_lag: 0.17 =========