builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1474522257.63 results: success (0) buildid: 20160921193259 builduid: c04abccae78643b497132fcf53730cfc revision: a00bd4772feb80835569ff24a8f1434175953935 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 22:30:57.631251) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 22:30:57.631739) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 22:30:57.632036) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 22:30:57.650375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 22:30:57.650691) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-21 22:30:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-09-21 22:30:58 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125217 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 22:30:57.791900) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 22:30:57.792634) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021320 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 22:30:57.843210) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 22:30:57.843520) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a00bd4772feb80835569ff24a8f1434175953935 --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 a00bd4772feb80835569ff24a8f1434175953935 --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=9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-21 22:30:58,133 truncating revision to first 12 chars 2016-09-21 22:30:58,133 Setting DEBUG logging. 2016-09-21 22:30:58,133 attempt 1/10 2016-09-21 22:30:58,133 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a00bd4772feb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-21 22:30:58,442 unpacking tar archive at: mozilla-beta-a00bd4772feb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.673812 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 22:30:58.530849) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 22:30:58.531164) ========= script_repo_revision: a00bd4772feb80835569ff24a8f1434175953935 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 22:30:58.531561) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 22:30:58.531842) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 22:30:58.541458) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-09-21 22:30:58.541837) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:30:58 INFO - MultiFileLogger online at 20160921 22:30:58 in /builds/slave/test 22:30:58 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 22:30:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:30:58 INFO - {'append_to_log': False, 22:30:58 INFO - 'base_work_dir': '/builds/slave/test', 22:30:58 INFO - 'blob_upload_branch': 'Mozilla-Beta', 22:30:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:30:58 INFO - 'branch': 'Mozilla-Beta', 22:30:58 INFO - 'buildbot_json_path': 'buildprops.json', 22:30:58 INFO - 'config_files': ('talos/linux_config.py',), 22:30:58 INFO - 'default_actions': ('clobber', 22:30:58 INFO - 'read-buildbot-config', 22:30:58 INFO - 'download-and-extract', 22:30:58 INFO - 'populate-webroot', 22:30:58 INFO - 'create-virtualenv', 22:30:58 INFO - 'install', 22:30:58 INFO - 'run-tests'), 22:30:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:30:58 INFO - 'download_minidump_stackwalk': True, 22:30:58 INFO - 'download_symbols': 'ondemand', 22:30:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:30:58 INFO - 'tooltool.py': '/tools/tooltool.py', 22:30:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:30:58 INFO - '/tools/misc-python/virtualenv.py')}, 22:30:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:30:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:30:58 INFO - 'installer_path': 'installer.exe', 22:30:58 INFO - 'log_level': 'info', 22:30:58 INFO - 'log_name': 'talos', 22:30:58 INFO - 'log_to_console': True, 22:30:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:30:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:30:58 INFO - 'opt_config_files': (), 22:30:58 INFO - 'pip_index': False, 22:30:58 INFO - 'sps_profile': False, 22:30:58 INFO - 'sps_profile_interval': 0, 22:30:58 INFO - 'suite': 'dromaeojs-e10s', 22:30:58 INFO - 'system_bits': '32', 22:30:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:30:58 INFO - 'title': 'talos-linux64-ix-013', 22:30:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:30:58 INFO - 'use_talos_json': True, 22:30:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:30:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:30:58 INFO - 'work_dir': 'build'} 22:30:58 INFO - [mozharness: 2016-09-22 05:30:58.927141Z] Running clobber step. 22:30:58 INFO - Running pre-action listener: _resource_record_pre_action 22:30:58 INFO - Running main action method: clobber 22:30:58 INFO - rmtree: /builds/slave/test/build 22:30:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:30:59 INFO - Running post-action listener: _resource_record_post_action 22:30:59 INFO - [mozharness: 2016-09-22 05:30:59.383507Z] Finished clobber step (success) 22:30:59 INFO - [mozharness: 2016-09-22 05:30:59.383931Z] Running read-buildbot-config step. 22:30:59 INFO - Running pre-action listener: _resource_record_pre_action 22:30:59 INFO - Running main action method: read_buildbot_config 22:30:59 INFO - Using buildbot properties: 22:30:59 INFO - { 22:30:59 INFO - "project": "", 22:30:59 INFO - "product": "firefox", 22:30:59 INFO - "script_repo_revision": "production", 22:30:59 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 22:30:59 INFO - "repository": "", 22:30:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 22:30:59 INFO - "buildid": "20160921193259", 22:30:59 INFO - "pgo_build": "True", 22:30:59 INFO - "basedir": "/builds/slave/test", 22:30:59 INFO - "buildnumber": 126, 22:30:59 INFO - "slavename": "talos-linux64-ix-013", 22:30:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:30:59 INFO - "platform": "ubuntu64_hw", 22:30:59 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 22:30:59 INFO - "branch": "mozilla-beta", 22:30:59 INFO - "repo_path": "releases/mozilla-beta", 22:30:59 INFO - "revision": "a00bd4772feb80835569ff24a8f1434175953935", 22:30:59 INFO - "stage_platform": "linux64-pgo", 22:30:59 INFO - "builduid": "c04abccae78643b497132fcf53730cfc", 22:30:59 INFO - "slavebuilddir": "test" 22:30:59 INFO - } 22:30:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2. 22:30:59 INFO - Running post-action listener: _resource_record_post_action 22:30:59 INFO - [mozharness: 2016-09-22 05:30:59.386395Z] Finished read-buildbot-config step (success) 22:30:59 INFO - [mozharness: 2016-09-22 05:30:59.386484Z] Running download-and-extract step. 22:30:59 INFO - Running pre-action listener: _resource_record_pre_action 22:30:59 INFO - Running main action method: download_and_extract 22:30:59 INFO - mkdir: /builds/slave/test/build/tests 22:30: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')]} 22:30:59 INFO - https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:30:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 22:30:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 22:30:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:30:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:30:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 22:30:59 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 22:30:59 INFO - retry: Failed, sleeping 30 seconds before retrying 22:31:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:31:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 22:31:29 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 22:31:29 INFO - retry: Failed, sleeping 60 seconds before retrying 22:32:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:32:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 22:32:29 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 22:32:29 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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! 22:32:29 INFO - Caught exception: HTTP Error 404: Not Found 22:32:29 INFO - Caught exception: HTTP Error 404: Not Found 22:32:29 INFO - Caught exception: HTTP Error 404: Not Found 22:32:29 INFO - trying https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 22:32:29 INFO - Downloading https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:32:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:32:30 INFO - Downloaded 1327 bytes. 22:32:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0.en-US.linux-x86_64.test_packages.json 22:32:30 INFO - Using the following test package requirements: 22:32:30 INFO - {u'common': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 22:32:30 INFO - u'cppunittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 22:32:30 INFO - u'firefox-50.0.en-US.linux-x86_64.cppunittest.tests.zip'], 22:32:30 INFO - u'gtest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 22:32:30 INFO - u'firefox-50.0.en-US.linux-x86_64.gtest.tests.zip'], 22:32:30 INFO - u'jittest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 22:32:30 INFO - u'jsshell-linux-x86_64.zip'], 22:32:30 INFO - u'mochitest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 22:32:30 INFO - u'firefox-50.0.en-US.linux-x86_64.mochitest.tests.zip'], 22:32:30 INFO - u'mozbase': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'], 22:32:30 INFO - u'reftest': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 22:32:30 INFO - u'firefox-50.0.en-US.linux-x86_64.reftest.tests.zip'], 22:32:30 INFO - u'talos': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 22:32:30 INFO - u'firefox-50.0.en-US.linux-x86_64.talos.tests.zip'], 22:32:30 INFO - u'web-platform': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 22:32:30 INFO - u'firefox-50.0.en-US.linux-x86_64.web-platform.tests.zip'], 22:32:30 INFO - u'xpcshell': [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip', 22:32:30 INFO - u'firefox-50.0.en-US.linux-x86_64.xpcshell.tests.zip']} 22:32:30 INFO - Downloading packages: [u'firefox-50.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:32: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')]} 22:32:30 INFO - https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:32:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:32:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:32:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:32:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:32:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:32:30 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 22:32:30 INFO - retry: Failed, sleeping 30 seconds before retrying 22:33:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:33:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:33:00 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 22:33:00 INFO - retry: Failed, sleeping 60 seconds before retrying 22:34:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:34:00 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:34:00 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 22:34:00 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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! 22:34:00 INFO - Caught exception: HTTP Error 404: Not Found 22:34:00 INFO - Caught exception: HTTP Error 404: Not Found 22:34:00 INFO - Caught exception: HTTP Error 404: Not Found 22:34:00 INFO - trying https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:34:00 INFO - Downloading https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:34:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:34:01 INFO - Downloaded 21771043 bytes. 22:34:01 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'] 22:34:01 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 22:34:02 INFO - Return code: 0 22:34:02 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 22:34:02 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')]} 22:34:02 INFO - https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:34:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:34:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:34:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:34:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:34:02 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:34:02 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 22:34:02 INFO - retry: Failed, sleeping 30 seconds before retrying 22:34:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:34:32 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:34:32 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 22:34:32 INFO - retry: Failed, sleeping 60 seconds before retrying 22:35:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:35:32 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:35:32 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 22:35:32 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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! 22:35:32 INFO - Caught exception: HTTP Error 404: Not Found 22:35:32 INFO - Caught exception: HTTP Error 404: Not Found 22:35:32 INFO - Caught exception: HTTP Error 404: Not Found 22:35:32 INFO - trying https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.common.tests.zip 22:35:32 INFO - Downloading https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:35:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:35:33 INFO - Downloaded 21771043 bytes. 22:35:33 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'] 22:35:33 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 22:35:34 INFO - Return code: 0 22:35:34 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')]} 22:35:34 INFO - https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:35:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 22:35:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 22:35:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:35:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:35:34 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 22:35:34 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 22:35:34 INFO - retry: Failed, sleeping 30 seconds before retrying 22:36:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:36:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 22:36:04 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 22:36:04 INFO - retry: Failed, sleeping 60 seconds before retrying 22:37:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:37:04 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 22:37:04 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 22:37:04 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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! 22:37:04 INFO - Caught exception: HTTP Error 404: Not Found 22:37:04 INFO - Caught exception: HTTP Error 404: Not Found 22:37:04 INFO - Caught exception: HTTP Error 404: Not Found 22:37:04 INFO - trying https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.talos.tests.zip 22:37:04 INFO - Downloading https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:37:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:37:05 INFO - Downloaded 14413740 bytes. 22:37:05 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'] 22:37:05 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 22:37:05 INFO - Return code: 0 22:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:37:05 INFO - https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:37:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 22:37:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 22:37:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:37:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:37:05 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 22:37:05 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 22:37:05 INFO - retry: Failed, sleeping 30 seconds before retrying 22:37:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:37:35 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 22:37:35 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 22:37:35 INFO - retry: Failed, sleeping 60 seconds before retrying 22:38:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:38:35 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 22:38:35 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 22:38:35 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YNTR7x_VSh-dPD5WEic86g/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! 22:38:35 INFO - Caught exception: HTTP Error 404: Not Found 22:38:35 INFO - Caught exception: HTTP Error 404: Not Found 22:38:35 INFO - Caught exception: HTTP Error 404: Not Found 22:38:35 INFO - trying https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 22:38:35 INFO - Downloading https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:38:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/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 22:38:37 INFO - Downloaded 56777905 bytes. 22:38:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 22:38:37 INFO - mkdir: /builds/slave/test/properties 22:38:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:38:37 INFO - Writing to file /builds/slave/test/properties/build_url 22:38:37 INFO - Contents: 22:38:37 INFO - build_url:https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 22:38:37 INFO - Running post-action listener: _resource_record_post_action 22:38:37 INFO - Running post-action listener: set_extra_try_arguments 22:38:37 INFO - [mozharness: 2016-09-22 05:38:37.867402Z] Finished download-and-extract step (success) 22:38:37 INFO - [mozharness: 2016-09-22 05:38:37.867728Z] Running populate-webroot step. 22:38:37 INFO - Running pre-action listener: _resource_record_pre_action 22:38:37 INFO - Running main action method: populate_webroot 22:38:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:38:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:38:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:38:37 INFO - '--tppagecycles', 22:38:37 INFO - '7'], 22:38:37 INFO - 'tests': ['tsvgm']}}, 22:38:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:38:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:38:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:38:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:38:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:38:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:38:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:37 INFO - 'talos_options': ['--disable-e10s'], 22:38:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:38:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:38:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:37 INFO - 'talos_options': ['--disable-e10s'], 22:38:37 INFO - 'tests': ['damp', 'tps']}, 22:38:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:37 INFO - 'tests': ['damp', 'tps']}, 22:38:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:38:37 INFO - 'tests': ['dromaeo_dom']}, 22:38:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:38:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:38:37 INFO - 'tests': ['basic_compositor_video']}, 22:38:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:38:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:38:37 INFO - 'tests': ['a11yr', 22:38:37 INFO - 'ts_paint', 22:38:37 INFO - 'tpaint', 22:38:37 INFO - 'sessionrestore', 22:38:37 INFO - 'sessionrestore_no_auto_restore', 22:38:37 INFO - 'tabpaint']}, 22:38:37 INFO - 'other-e10s': {'tests': ['a11yr', 22:38:37 INFO - 'ts_paint', 22:38:37 INFO - 'tpaint', 22:38:37 INFO - 'sessionrestore', 22:38:37 INFO - 'sessionrestore_no_auto_restore', 22:38:37 INFO - 'tabpaint']}, 22:38:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:38:37 INFO - 'ts_paint', 22:38:37 INFO - 'tpaint', 22:38:37 INFO - 'sessionrestore', 22:38:37 INFO - 'sessionrestore_no_auto_restore', 22:38:37 INFO - 'tabpaint']}, 22:38:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:38:37 INFO - 'ts_paint', 22:38:37 INFO - 'tpaint', 22:38:37 INFO - 'sessionrestore', 22:38:37 INFO - 'sessionrestore_no_auto_restore', 22:38:37 INFO - 'tabpaint']}, 22:38:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:38:37 INFO - 'tests': ['a11yr', 22:38:37 INFO - 'ts_paint', 22:38:37 INFO - 'tpaint', 22:38:37 INFO - 'sessionrestore', 22:38:37 INFO - 'sessionrestore_no_auto_restore', 22:38:37 INFO - 'tabpaint']}, 22:38:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:38:37 INFO - 'tests': ['a11yr', 22:38:37 INFO - 'ts_paint', 22:38:37 INFO - 'tpaint', 22:38:37 INFO - 'sessionrestore', 22:38:37 INFO - 'sessionrestore_no_auto_restore', 22:38:37 INFO - 'tabpaint']}, 22:38:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:38:37 INFO - 'tests': ['tsvgx', 22:38:37 INFO - 'tsvgr_opacity', 22:38:37 INFO - 'tart', 22:38:37 INFO - 'tscrollx', 22:38:37 INFO - 'cart']}, 22:38:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:38:37 INFO - 'tsvgr_opacity', 22:38:37 INFO - 'tart', 22:38:37 INFO - 'tscrollx', 22:38:37 INFO - 'cart']}, 22:38:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:37 INFO - 'talos_options': ['--disable-e10s'], 22:38:37 INFO - 'tests': ['tp5o']}, 22:38:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:37 INFO - 'tests': ['tp5o']}, 22:38:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:37 INFO - 'talos_options': ['--disable-e10s', 22:38:37 INFO - '--xperf_path', 22:38:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:38:37 INFO - 'tests': ['tp5n']}, 22:38:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:38:37 INFO - 'talos_options': ['--xperf_path', 22:38:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:38:37 INFO - 'tests': ['tp5n']}}, 22:38:37 INFO - 'talos.zip': {'path': '', 22:38:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:38:37 INFO - Running post-action listener: _resource_record_post_action 22:38:37 INFO - [mozharness: 2016-09-22 05:38:37.888891Z] Finished populate-webroot step (success) 22:38:37 INFO - [mozharness: 2016-09-22 05:38:37.888981Z] Running create-virtualenv step. 22:38:37 INFO - Running pre-action listener: _resource_record_pre_action 22:38:37 INFO - Running main action method: create_virtualenv 22:38:37 INFO - Creating virtualenv /builds/slave/test/build/venv 22:38:37 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 22:38:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:38:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:38:37 INFO - Using real prefix '/usr' 22:38:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:38:38 INFO - Installing distribute.............................................................................................................................................................................................done. 22:38:40 INFO - Installing pip.................done. 22:38:40 INFO - Return code: 0 22:38:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bec400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b570>, '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 0x2c7c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', '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 22:38:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:38:40 INFO - Using env: {'DISPLAY': ':0', 22:38:40 INFO - 'HOME': '/home/cltbld', 22:38:40 INFO - 'LANG': 'en_US.UTF-8', 22:38:40 INFO - 'LANGUAGE': 'en_US:en', 22:38:40 INFO - 'LOGNAME': 'cltbld', 22:38:40 INFO - 'MAIL': '/var/mail/cltbld', 22:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:40 INFO - 'MOZ_NO_REMOTE': '1', 22:38:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:40 INFO - 'NO_EM_RESTART': '1', 22:38:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:40 INFO - 'PWD': '/builds/slave/test', 22:38:40 INFO - 'SHELL': '/bin/bash', 22:38:40 INFO - 'SHLVL': '1', 22:38:40 INFO - 'TERM': 'linux', 22:38:40 INFO - 'TMOUT': '86400', 22:38:40 INFO - 'USER': 'cltbld', 22:38:40 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', 22:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:40 INFO - '_': '/tools/buildbot/bin/python'} 22:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:40 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 22:38:40 INFO - Cleaning up... 22:38:40 INFO - Return code: 0 22:38:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29bd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bec400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b570>, '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 0x2c7c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', '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 22:38:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:38:40 INFO - Using env: {'DISPLAY': ':0', 22:38:40 INFO - 'HOME': '/home/cltbld', 22:38:40 INFO - 'LANG': 'en_US.UTF-8', 22:38:40 INFO - 'LANGUAGE': 'en_US:en', 22:38:40 INFO - 'LOGNAME': 'cltbld', 22:38:40 INFO - 'MAIL': '/var/mail/cltbld', 22:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:40 INFO - 'MOZ_NO_REMOTE': '1', 22:38:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:40 INFO - 'NO_EM_RESTART': '1', 22:38:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:40 INFO - 'PWD': '/builds/slave/test', 22:38:40 INFO - 'SHELL': '/bin/bash', 22:38:40 INFO - 'SHLVL': '1', 22:38:40 INFO - 'TERM': 'linux', 22:38:40 INFO - 'TMOUT': '86400', 22:38:40 INFO - 'USER': 'cltbld', 22:38:40 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', 22:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:40 INFO - '_': '/tools/buildbot/bin/python'} 22:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:40 INFO - Downloading/unpacking psutil>=3.1.1 22:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:38:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:38:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:38:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:38:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:38:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:38:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:38:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:38:42 INFO - Installing collected packages: psutil 22:38:42 INFO - Running setup.py install for psutil 22:38:42 INFO - building 'psutil._psutil_linux' extension 22:38:42 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 22:38:43 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 22:38:43 INFO - building 'psutil._psutil_posix' extension 22:38:43 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 22:38:43 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 22:38:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:38:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:38:43 INFO - Successfully installed psutil 22:38:43 INFO - Cleaning up... 22:38:43 INFO - Return code: 0 22:38:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:43 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 0x29bd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bec400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b570>, '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 0x2c7c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', '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 22:38:43 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 22:38:43 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 22:38:43 INFO - Using env: {'DISPLAY': ':0', 22:38:43 INFO - 'HOME': '/home/cltbld', 22:38:43 INFO - 'LANG': 'en_US.UTF-8', 22:38:43 INFO - 'LANGUAGE': 'en_US:en', 22:38:43 INFO - 'LOGNAME': 'cltbld', 22:38:43 INFO - 'MAIL': '/var/mail/cltbld', 22:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:43 INFO - 'MOZ_NO_REMOTE': '1', 22:38:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:43 INFO - 'NO_EM_RESTART': '1', 22:38:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:43 INFO - 'PWD': '/builds/slave/test', 22:38:43 INFO - 'SHELL': '/bin/bash', 22:38:43 INFO - 'SHLVL': '1', 22:38:43 INFO - 'TERM': 'linux', 22:38:43 INFO - 'TMOUT': '86400', 22:38:43 INFO - 'USER': 'cltbld', 22:38:43 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', 22:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:43 INFO - '_': '/tools/buildbot/bin/python'} 22:38:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:38:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:38:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:38:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:38:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:38:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:38:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:38:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:38:45 INFO - Installing collected packages: mozsystemmonitor 22:38:45 INFO - Running setup.py install for mozsystemmonitor 22:38:45 INFO - Successfully installed mozsystemmonitor 22:38:45 INFO - Cleaning up... 22:38:45 INFO - Return code: 0 22:38:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:38:45 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')]} 22:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:45 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')]} 22:38:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:45 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 0x29bd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bec400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b570>, '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 0x2c7c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', '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 22:38:45 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 22:38:45 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 22:38:45 INFO - Using env: {'DISPLAY': ':0', 22:38:45 INFO - 'HOME': '/home/cltbld', 22:38:45 INFO - 'LANG': 'en_US.UTF-8', 22:38:45 INFO - 'LANGUAGE': 'en_US:en', 22:38:45 INFO - 'LOGNAME': 'cltbld', 22:38:45 INFO - 'MAIL': '/var/mail/cltbld', 22:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:45 INFO - 'MOZ_NO_REMOTE': '1', 22:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:45 INFO - 'NO_EM_RESTART': '1', 22:38:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:45 INFO - 'PWD': '/builds/slave/test', 22:38:45 INFO - 'SHELL': '/bin/bash', 22:38:45 INFO - 'SHLVL': '1', 22:38:45 INFO - 'TERM': 'linux', 22:38:45 INFO - 'TMOUT': '86400', 22:38:45 INFO - 'USER': 'cltbld', 22:38:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', 22:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:45 INFO - '_': '/tools/buildbot/bin/python'} 22:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:45 INFO - Downloading/unpacking jsonschema==2.5.1 22:38:45 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 22:38:45 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 22:38:45 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 22:38:45 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 22:38:45 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 22:38:45 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 22:38:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:38:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:38:47 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 22:38:47 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 22:38:47 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 22:38:47 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 22:38:47 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 22:38:47 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 22:38:48 INFO - Downloading functools32-3.2.3-2.tar.gz 22:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:38:48 INFO - warning: no files found matching '*.txt' 22:38:48 INFO - no previously-included directories found matching 'build' 22:38:48 INFO - no previously-included directories found matching 'dist' 22:38:48 INFO - no previously-included directories found matching '.git*' 22:38:48 INFO - Installing collected packages: jsonschema, functools32 22:38:48 INFO - Running setup.py install for functools32 22:38:48 INFO - warning: no files found matching '*.txt' 22:38:48 INFO - no previously-included directories found matching 'build' 22:38:48 INFO - no previously-included directories found matching 'dist' 22:38:48 INFO - no previously-included directories found matching '.git*' 22:38:48 INFO - Successfully installed jsonschema functools32 22:38:48 INFO - Cleaning up... 22:38:48 INFO - Return code: 0 22:38:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:38:48 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')]} 22:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:48 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')]} 22:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:48 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 0x29bd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bec400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b570>, '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 0x2c7c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', '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 22:38:48 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 22:38:48 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 22:38:48 INFO - Using env: {'DISPLAY': ':0', 22:38:48 INFO - 'HOME': '/home/cltbld', 22:38:48 INFO - 'LANG': 'en_US.UTF-8', 22:38:48 INFO - 'LANGUAGE': 'en_US:en', 22:38:48 INFO - 'LOGNAME': 'cltbld', 22:38:48 INFO - 'MAIL': '/var/mail/cltbld', 22:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:48 INFO - 'MOZ_NO_REMOTE': '1', 22:38:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:48 INFO - 'NO_EM_RESTART': '1', 22:38:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:48 INFO - 'PWD': '/builds/slave/test', 22:38:48 INFO - 'SHELL': '/bin/bash', 22:38:48 INFO - 'SHLVL': '1', 22:38:48 INFO - 'TERM': 'linux', 22:38:48 INFO - 'TMOUT': '86400', 22:38:48 INFO - 'USER': 'cltbld', 22:38:48 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', 22:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:48 INFO - '_': '/tools/buildbot/bin/python'} 22:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:38:48 INFO - Cleaning up... 22:38:48 INFO - Return code: 0 22:38:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:38:48 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')]} 22:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:48 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')]} 22:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:48 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 0x29bd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bec400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b570>, '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 0x2c7c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', '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 22:38:48 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 22:38:48 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 22:38:48 INFO - Using env: {'DISPLAY': ':0', 22:38:48 INFO - 'HOME': '/home/cltbld', 22:38:48 INFO - 'LANG': 'en_US.UTF-8', 22:38:48 INFO - 'LANGUAGE': 'en_US:en', 22:38:48 INFO - 'LOGNAME': 'cltbld', 22:38:48 INFO - 'MAIL': '/var/mail/cltbld', 22:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:48 INFO - 'MOZ_NO_REMOTE': '1', 22:38:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:48 INFO - 'NO_EM_RESTART': '1', 22:38:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:48 INFO - 'PWD': '/builds/slave/test', 22:38:48 INFO - 'SHELL': '/bin/bash', 22:38:48 INFO - 'SHLVL': '1', 22:38:48 INFO - 'TERM': 'linux', 22:38:48 INFO - 'TMOUT': '86400', 22:38:48 INFO - 'USER': 'cltbld', 22:38:48 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', 22:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:48 INFO - '_': '/tools/buildbot/bin/python'} 22:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:48 INFO - Downloading/unpacking blobuploader==1.2.4 22:38:48 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 22:38:48 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 22:38:48 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 22:38:48 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 22:38:48 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 22:38:48 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 22:38:50 INFO - Downloading blobuploader-1.2.4.tar.gz 22:38:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:38:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:38:50 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 22:38:50 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 22:38:50 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 22:38:50 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 22:38:50 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 22:38:50 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 22:38:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:38:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:38:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:38:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:38:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:38:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:38:51 INFO - Downloading docopt-0.6.1.tar.gz 22:38:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:38:51 INFO - Installing collected packages: blobuploader, requests, docopt 22:38:51 INFO - Running setup.py install for blobuploader 22:38:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:38:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:38:51 INFO - Running setup.py install for requests 22:38:52 INFO - Running setup.py install for docopt 22:38:52 INFO - Successfully installed blobuploader requests docopt 22:38:52 INFO - Cleaning up... 22:38:52 INFO - Return code: 0 22:38:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:38:52 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')]} 22:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:52 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')]} 22:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:52 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 0x29bd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bec400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b570>, '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 0x2c7c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', '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 22:38:52 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 22:38:52 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 22:38:52 INFO - Using env: {'DISPLAY': ':0', 22:38:52 INFO - 'HOME': '/home/cltbld', 22:38:52 INFO - 'LANG': 'en_US.UTF-8', 22:38:52 INFO - 'LANGUAGE': 'en_US:en', 22:38:52 INFO - 'LOGNAME': 'cltbld', 22:38:52 INFO - 'MAIL': '/var/mail/cltbld', 22:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:52 INFO - 'MOZ_NO_REMOTE': '1', 22:38:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:52 INFO - 'NO_EM_RESTART': '1', 22:38:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:52 INFO - 'PWD': '/builds/slave/test', 22:38:52 INFO - 'SHELL': '/bin/bash', 22:38:52 INFO - 'SHLVL': '1', 22:38:52 INFO - 'TERM': 'linux', 22:38:52 INFO - 'TMOUT': '86400', 22:38:52 INFO - 'USER': 'cltbld', 22:38:52 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', 22:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:52 INFO - '_': '/tools/buildbot/bin/python'} 22:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:38:52 INFO - Running setup.py (path:/tmp/pip-L_UXeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:38:52 INFO - Running setup.py (path:/tmp/pip-rDJIiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:38:52 INFO - Running setup.py (path:/tmp/pip-OuVNAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:38:52 INFO - Running setup.py (path:/tmp/pip-Qn8BM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:38:52 INFO - Running setup.py (path:/tmp/pip-fgSsm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:38:52 INFO - Running setup.py (path:/tmp/pip-rUMWHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:38:52 INFO - Running setup.py (path:/tmp/pip-W3BOSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:38:52 INFO - Running setup.py (path:/tmp/pip-8mte52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:38:53 INFO - Running setup.py (path:/tmp/pip-WU3nUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:38:53 INFO - Running setup.py (path:/tmp/pip-5ofZeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:38:53 INFO - Running setup.py (path:/tmp/pip-8BBG_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:38:53 INFO - Running setup.py (path:/tmp/pip-R7bvgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:38:53 INFO - Running setup.py (path:/tmp/pip-aqaDbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:38:53 INFO - Running setup.py (path:/tmp/pip-rpjLxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:38:53 INFO - Running setup.py (path:/tmp/pip-uC7Bk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:38:53 INFO - Running setup.py (path:/tmp/pip-i773C5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:38:53 INFO - Running setup.py (path:/tmp/pip-Ns1l_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:38:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:38:53 INFO - Running setup.py install for manifestparser 22:38:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:38:53 INFO - Running setup.py install for mozcrash 22:38:53 INFO - Running setup.py install for mozdebug 22:38:53 INFO - Running setup.py install for mozdevice 22:38:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:38:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:38:54 INFO - Running setup.py install for mozfile 22:38:54 INFO - Running setup.py install for mozhttpd 22:38:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:38:54 INFO - Running setup.py install for mozinfo 22:38:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:38:54 INFO - Running setup.py install for mozInstall 22:38:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:38:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:38:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:38:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:38:54 INFO - Running setup.py install for mozleak 22:38:54 INFO - Running setup.py install for mozlog 22:38:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:38:54 INFO - Running setup.py install for moznetwork 22:38:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:38:54 INFO - Running setup.py install for mozprocess 22:38:54 INFO - Running setup.py install for mozprofile 22:38:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:38:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:38:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:38:55 INFO - Running setup.py install for mozrunner 22:38:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:38:55 INFO - Running setup.py install for mozscreenshot 22:38:55 INFO - Running setup.py install for moztest 22:38:55 INFO - Running setup.py install for mozversion 22:38:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:38:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:38:55 INFO - Cleaning up... 22:38:55 INFO - Return code: 0 22:38:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:55 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 0x29bd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bec400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b570>, '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 0x2c7c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', '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 22:38:55 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 22:38:55 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 22:38:55 INFO - Using env: {'DISPLAY': ':0', 22:38:55 INFO - 'HOME': '/home/cltbld', 22:38:55 INFO - 'LANG': 'en_US.UTF-8', 22:38:55 INFO - 'LANGUAGE': 'en_US:en', 22:38:55 INFO - 'LOGNAME': 'cltbld', 22:38:55 INFO - 'MAIL': '/var/mail/cltbld', 22:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:55 INFO - 'MOZ_NO_REMOTE': '1', 22:38:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:55 INFO - 'NO_EM_RESTART': '1', 22:38:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:55 INFO - 'PWD': '/builds/slave/test', 22:38:55 INFO - 'SHELL': '/bin/bash', 22:38:55 INFO - 'SHLVL': '1', 22:38:55 INFO - 'TERM': 'linux', 22:38:55 INFO - 'TMOUT': '86400', 22:38:55 INFO - 'USER': 'cltbld', 22:38:55 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', 22:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:55 INFO - '_': '/tools/buildbot/bin/python'} 22:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:38:55 INFO - Running setup.py (path:/tmp/pip-4cyhH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:38:55 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)) 22:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:38:55 INFO - Running setup.py (path:/tmp/pip-zE2peO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:38:55 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)) 22:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:38:55 INFO - Running setup.py (path:/tmp/pip-FKvOXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:38:55 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)) 22:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:38:55 INFO - Running setup.py (path:/tmp/pip-M5Ne4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:38:55 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)) 22:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:38:55 INFO - Running setup.py (path:/tmp/pip-5DmOvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:38:56 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)) 22:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:38:56 INFO - Running setup.py (path:/tmp/pip-NhZvj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:38:56 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)) 22:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:38:56 INFO - Running setup.py (path:/tmp/pip-XTkaVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:38:56 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)) 22:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:38:56 INFO - Running setup.py (path:/tmp/pip-GnbVln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:38:56 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)) 22:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:38:56 INFO - Running setup.py (path:/tmp/pip-Z5fa7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:38:56 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)) 22:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:38:56 INFO - Running setup.py (path:/tmp/pip-OKgRZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:38:56 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)) 22:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:38:56 INFO - Running setup.py (path:/tmp/pip-qpyYbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:38:56 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)) 22:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:38:56 INFO - Running setup.py (path:/tmp/pip-gdwf8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:38:56 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)) 22:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:38:56 INFO - Running setup.py (path:/tmp/pip-hPua2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:38:56 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)) 22:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:38:56 INFO - Running setup.py (path:/tmp/pip-nRqGL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:38:56 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)) 22:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:38:56 INFO - Running setup.py (path:/tmp/pip-Q_NS8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:38:56 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)) 22:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:38:56 INFO - Running setup.py (path:/tmp/pip-8hp1lR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:38:56 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)) 22:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:38:56 INFO - Running setup.py (path:/tmp/pip-4yDk5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:38:56 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)) 22:38:56 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)) 22:38:56 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)) 22:38:56 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)) 22:38:56 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)) 22:38:56 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)) 22:38:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:38:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:38:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:38:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:38:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:38:58 INFO - Downloading blessings-1.6.tar.gz 22:38:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:38:58 INFO - Installing collected packages: blessings 22:38:58 INFO - Running setup.py install for blessings 22:38:59 INFO - Successfully installed blessings 22:38:59 INFO - Cleaning up... 22:38:59 INFO - Return code: 0 22:38:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:38:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:38:59 INFO - Reading from file tmpfile_stdout 22:38:59 INFO - Current package versions: 22:38:59 INFO - argparse == 1.2.1 22:38:59 INFO - blessings == 1.6 22:38:59 INFO - blobuploader == 1.2.4 22:38:59 INFO - docopt == 0.6.1 22:38:59 INFO - functools32 == 3.2.3-2 22:38:59 INFO - jsonschema == 2.5.1 22:38:59 INFO - manifestparser == 1.1 22:38:59 INFO - mozInstall == 1.12 22:38:59 INFO - mozcrash == 0.17 22:38:59 INFO - mozdebug == 0.1 22:38:59 INFO - mozdevice == 0.48 22:38:59 INFO - mozfile == 1.2 22:38:59 INFO - mozhttpd == 0.7 22:38:59 INFO - mozinfo == 0.9 22:38:59 INFO - mozleak == 0.1 22:38:59 INFO - mozlog == 3.3 22:38:59 INFO - moznetwork == 0.27 22:38:59 INFO - mozprocess == 0.23 22:38:59 INFO - mozprofile == 0.28 22:38:59 INFO - mozrunner == 6.12 22:38:59 INFO - mozscreenshot == 0.1 22:38:59 INFO - mozsystemmonitor == 0.3 22:38:59 INFO - moztest == 0.7 22:38:59 INFO - mozversion == 1.4 22:38:59 INFO - psutil == 3.1.1 22:38:59 INFO - requests == 1.2.3 22:38:59 INFO - wsgiref == 0.1.2 22:38:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:38: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')]} 22:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38: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')]} 22:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38:59 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 0x29bd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bec400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b570>, '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 0x2c7c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', '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 22:38:59 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 22:38:59 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 22:38:59 INFO - Using env: {'DISPLAY': ':0', 22:38:59 INFO - 'HOME': '/home/cltbld', 22:38:59 INFO - 'LANG': 'en_US.UTF-8', 22:38:59 INFO - 'LANGUAGE': 'en_US:en', 22:38:59 INFO - 'LOGNAME': 'cltbld', 22:38:59 INFO - 'MAIL': '/var/mail/cltbld', 22:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:59 INFO - 'MOZ_NO_REMOTE': '1', 22:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:59 INFO - 'NO_EM_RESTART': '1', 22:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:59 INFO - 'PWD': '/builds/slave/test', 22:38:59 INFO - 'SHELL': '/bin/bash', 22:38:59 INFO - 'SHLVL': '1', 22:38:59 INFO - 'TERM': 'linux', 22:38:59 INFO - 'TMOUT': '86400', 22:38:59 INFO - 'USER': 'cltbld', 22:38:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', 22:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:59 INFO - '_': '/tools/buildbot/bin/python'} 22:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:59 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)) 22:38:59 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)) 22:38:59 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)) 22:38:59 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)) 22:38:59 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)) 22:38:59 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)) 22:38:59 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)) 22:38:59 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)) 22:38:59 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)) 22:38:59 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)) 22:38:59 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)) 22:38:59 INFO - Cleaning up... 22:38:59 INFO - Return code: 0 22:38:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:38: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')]} 22:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38: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')]} 22:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:38: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29bd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bec400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c7b570>, '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 0x2c7c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c900>, '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': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', '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 22:38: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', 'jsonschema'] in /builds/slave/test/build 22:38: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 jsonschema 22:38:59 INFO - Using env: {'DISPLAY': ':0', 22:38:59 INFO - 'HOME': '/home/cltbld', 22:38:59 INFO - 'LANG': 'en_US.UTF-8', 22:38:59 INFO - 'LANGUAGE': 'en_US:en', 22:38:59 INFO - 'LOGNAME': 'cltbld', 22:38:59 INFO - 'MAIL': '/var/mail/cltbld', 22:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:38:59 INFO - 'MOZ_NO_REMOTE': '1', 22:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:38:59 INFO - 'NO_EM_RESTART': '1', 22:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:38:59 INFO - 'PWD': '/builds/slave/test', 22:38:59 INFO - 'SHELL': '/bin/bash', 22:38:59 INFO - 'SHLVL': '1', 22:38:59 INFO - 'TERM': 'linux', 22:38:59 INFO - 'TMOUT': '86400', 22:38:59 INFO - 'USER': 'cltbld', 22:38:59 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', 22:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:38:59 INFO - '_': '/tools/buildbot/bin/python'} 22:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:38:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:38:59 INFO - Cleaning up... 22:38:59 INFO - Return code: 0 22:38:59 INFO - Running post-action listener: _resource_record_post_action 22:38:59 INFO - Running post-action listener: _start_resource_monitoring 22:38:59 INFO - Starting resource monitoring. 22:38:59 INFO - [mozharness: 2016-09-22 05:38:59.831965Z] Finished create-virtualenv step (success) 22:38:59 INFO - [mozharness: 2016-09-22 05:38:59.832400Z] Running install step. 22:38:59 INFO - Running pre-action listener: _resource_record_pre_action 22:38:59 INFO - Running main action method: install 22:38:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:39:00 INFO - Reading from file tmpfile_stdout 22:39:00 INFO - Detecting whether we're running mozinstall >=1.0... 22:39:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:39:00 INFO - Reading from file tmpfile_stdout 22:39:00 INFO - Output received: 22:39:00 INFO - Usage: mozinstall [options] installer 22:39:00 INFO - Options: 22:39:00 INFO - -h, --help show this help message and exit 22:39:00 INFO - -d DEST, --destination=DEST 22:39:00 INFO - Directory to install application into. [default: 22:39:00 INFO - "/builds/slave/test"] 22:39:00 INFO - --app=APP Application being installed. [default: firefox] 22:39:00 INFO - mkdir: /builds/slave/test/build/application 22:39:00 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'] 22:39:00 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 22:39:13 INFO - Reading from file tmpfile_stdout 22:39:13 INFO - Output received: 22:39:13 INFO - /builds/slave/test/build/application/firefox/firefox 22:39:13 INFO - Running post-action listener: _resource_record_post_action 22:39:13 INFO - [mozharness: 2016-09-22 05:39:13.608558Z] Finished install step (success) 22:39:13 INFO - [mozharness: 2016-09-22 05:39:13.608837Z] Running run-tests step. 22:39:13 INFO - Running pre-action listener: _resource_record_pre_action 22:39:13 INFO - Running main action method: run_tests 22:39:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:39:13 INFO - Python 2.7.3 22:39:13 INFO - Return code: 0 22:39:13 INFO - grabbing minidump binary from tooltool 22:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:13 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 0x2c7b570>, '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 0x2c7c470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c7c900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:39:13 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 22:39:13 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 22:39:13 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 22:39:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:39:13 INFO - Return code: 0 22:39:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:39:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:39:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:39:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:39:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:39:13 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/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 22:39:13 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/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 22:39:13 INFO - Using env: {'DISPLAY': ':0', 22:39:13 INFO - 'HOME': '/home/cltbld', 22:39:13 INFO - 'LANG': 'en_US.UTF-8', 22:39:13 INFO - 'LANGUAGE': 'en_US:en', 22:39:13 INFO - 'LOGNAME': 'cltbld', 22:39:13 INFO - 'MAIL': '/var/mail/cltbld', 22:39:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:39:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:39:13 INFO - 'MOZ_NO_REMOTE': '1', 22:39:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:39:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:39:13 INFO - 'NO_EM_RESTART': '1', 22:39:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:39:13 INFO - 'PWD': '/builds/slave/test', 22:39:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:39:13 INFO - 'SHELL': '/bin/bash', 22:39:13 INFO - 'SHLVL': '1', 22:39:13 INFO - 'TERM': 'linux', 22:39:13 INFO - 'TMOUT': '86400', 22:39:13 INFO - 'USER': 'cltbld', 22:39:13 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291', 22:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:39:13 INFO - '_': '/tools/buildbot/bin/python'} 22:39:13 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/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 22:39:13 INFO - mozversion application_buildid: 20160921193259 22:39:13 INFO - mozversion application_changeset: a00bd4772feb80835569ff24a8f1434175953935 22:39:13 INFO - mozversion application_display_name: Firefox 22:39:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:39:13 INFO - mozversion application_name: Firefox 22:39:13 INFO - mozversion application_remotingname: firefox 22:39:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 22:39:13 INFO - mozversion application_vendor: Mozilla 22:39:13 INFO - mozversion application_version: 50.0 22:39:13 INFO - mozversion platform_buildid: 20160921193259 22:39:13 INFO - mozversion platform_changeset: a00bd4772feb80835569ff24a8f1434175953935 22:39:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 22:39:13 INFO - mozversion platform_version: 50.0 22:39:13 INFO - using testdate: 1474522753 22:39:13 INFO - actual date: 1474522753 22:39:13 INFO - starting webserver on 'localhost:57761' 22:39:13 INFO - SUITE-START | Running 2 tests 22:39:13 INFO - TEST-START | dromaeo_css 22:39:13 INFO - operating with platform_type : linux_ 22:39:13 INFO - Initialising browser for dromaeo_css test... 22:39:13 INFO - TEST-INFO | started process 21695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_x5bT3/profile http://localhost:57761/getInfo.html) 22:39:18 INFO - PROCESS | 21695 | __metrics Screen width/height:1600/1200 22:39:18 INFO - PROCESS | 21695 | colorDepth:24 22:39:18 INFO - PROCESS | 21695 | Browser inner width/height: 1024/697 22:39:18 INFO - PROCESS | 21695 | __metrics 22:39:18 ERROR - PROCESS | 21695 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 22:39:19 INFO - TEST-INFO | 21695: exit 0 22:39:19 INFO - Browser initialized. 22:39:19 INFO - Running cycle 1/1 for dromaeo_css test... 22:39:19 INFO - TEST-INFO | started process 21819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_x5bT3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:39:31 INFO - PROCESS | 21819 | RSS: Main: 150147072 22:39:31 INFO - PROCESS | 21819 | 22:40:21 INFO - PROCESS | 21819 | 1474522821023 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] 22:42:29 INFO - PROCESS | 21819 | Cycle 1(1): loaded http://localhost:57761/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57761/tests/dromaeo/cssquery-ext.html) 22:42:30 INFO - PROCESS | 21819 | RSS: Main: 158486528 22:42:30 INFO - PROCESS | 21819 | 22:45:32 INFO - PROCESS | 21819 | Cycle 1(1): loaded http://localhost:57761/tests/dromaeo/cssquery-ext.html (next: http://localhost:57761/tests/dromaeo/cssquery-jquery.html) 22:45:33 INFO - PROCESS | 21819 | RSS: Main: 154988544 22:45:33 INFO - PROCESS | 21819 | 22:48:35 INFO - PROCESS | 21819 | Cycle 1(1): loaded http://localhost:57761/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57761/tests/dromaeo/cssquery-mootools.html) 22:48:35 INFO - PROCESS | 21819 | RSS: Main: 154718208 22:48:35 INFO - PROCESS | 21819 | 22:51:37 INFO - PROCESS | 21819 | Cycle 1(1): loaded http://localhost:57761/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57761/tests/dromaeo/cssquery-prototype.html) 22:51:38 INFO - PROCESS | 21819 | RSS: Main: 156426240 22:51:38 INFO - PROCESS | 21819 | 22:54:40 INFO - PROCESS | 21819 | Cycle 1(1): loaded http://localhost:57761/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57761/tests/dromaeo/cssquery-yui.html) 22:54:41 INFO - PROCESS | 21819 | RSS: Main: 157310976 22:54:41 INFO - PROCESS | 21819 | 22:57:43 INFO - PROCESS | 21819 | Cycle 1(1): loaded http://localhost:57761/tests/dromaeo/cssquery-yui.html (next: http://localhost:57761/tests/dromaeo/cssquery-dojo.html) 22:57:43 INFO - PROCESS | 21819 | RSS: Main: 157323264 22:57:43 INFO - PROCESS | 21819 | 22:57:43 INFO - PROCESS | 21819 | __start_tp_report 22:57:43 INFO - PROCESS | 21819 | _x_x_mozilla_page_load 22:57:43 INFO - PROCESS | 21819 | _x_x_mozilla_page_load_details 22:57:43 INFO - PROCESS | 21819 | |i|pagename|runs| 22:57:43 INFO - PROCESS | 21819 | |0;dojo.html;3338.365710515002;3351.5140304655824;3358;3382.4926261060855;3384.526166336712;5869.618474799135;5895.675737834417;5904.6161999470005;5905.232319798425;5924.466797988181;5893.528517718583;5934.614250073742;5941.405859414067;5944.821655350335;5981.132735753313;5328.5470734987575;5377.274068000809;5415.864603384927;5443.074677304868;5474.507294343508;5155.561777248939;5162.251473536335;5207.713575753351;5311.920321195185;5325.467453254663;5317.441668624797;5350.91973620396;5366.892662146754;5407.972960135194;5484.396716361197;5408.945910540883;5411.567074634039;5423.810166644149;5425.9728701356435;5426.9185962210595;5136.768845401966;5154.5103215194495;5241.633085684004;5323.600729945269;5425.213344065128;5721.628094173907;5792.536597072266;5797.304323481209;5819.88360232793;5832.329282132567;6246;6291.559590828644;6293.181886354791;6300.30696623371;6300.527460440485;6080.939190608082;6256.15541901842;6328.240611126648;6369.872602547923;6373.872522549569;5880.206172166745;5970.044792833126;5973.342932277489;6002.339742628307;6014.097885317237;6510.641914694737;6539.280679125292;6568.343165683394;6572.901406478906;6593.307702691244;5983.1623572699855;6141.232345956755;6194.442500175006;6259.530535209878;6296.527760417987;6185;6317.810465685945;6353.142325786052;6359.077933699587;6385.5210859185745;6351.2060992375955;6358.968205159037;6359.904601430982;6371.23545174582;6371.55399122057;6049.0926361046195;6152.661603611755;6369.20384951881;6373.139626150411;6377.075324077982;4723.858284251478;4810.5670489656095;4813.518648135158;4848.684835485753;4851.56335929768;4263.339182426729;4269.530351661315;4277.743335399886;4295.055087880662;4297.505786834491;5833.125031245348;5979.581429299994;6050.6672133032225;6098.054801505774;6112.235970503687;6294.118823364733;6400.935990640127;6422.197225346832;6423.100765892778;6437.613743175424;6142.570020098639;6145.324014358417;6148.385161483816;6154.569180157436;6157.96921015392;5165.974170129125;5247.212918062245;5339.546138578265;5342.839714808562;5376.301080859464;6450.967745161338;6600.504962127764;6619.933800661932;6624.668766561653;6626.966865165739;6421.325760795236;6429.421352078335;6438.806835794933;6442.871142577029;6444.323346048597;6284.748610055546;6426.100345951477;6535.150430444012;6543.70553325111;6605.405513503808;6128.014278093809;6240.12638230639;6265.342139075514;6278.905816412849;6282.717277722605;6343.365663433804;6392.488600911823;6395.840103997437;6405.8718825624155;6413.8717225656155;5986.191864098291;6079.270487541523;6203.2245969253845;6213.254409470893;6236.407541283571;6055.182550355822;6131.570790044832;6167.537434692326;6176.536759743127;6177.660228687465;6077.298446247364;6120.510359171167;6133.44798968095;6136.1821086261625;6170.074488826712;6064;6150.169727086786;6174.567780255339;6224.595401298901;6245.750169993149;6133.8466538335115;6167.753289868355;6168.290646575521;6170.413810687977;6183.659898705614 22:57:43 INFO - PROCESS | 21819 | |1;ext.html;576.9105788602766;635.3329004545226;642.4507046475263;662.8806814773341;710.8080818179095;40755.18489630205;44954.325685114665;44968.550314496846;45029.09941801162;45085.7745711271;45636.54363456364;46254.76872615632;46486.30270545936;46524.30213546791;46533.069338613204;8940.195382415564;9144.222741066984;9162.633494660206;9164.770880728001;9196.678116265932;9057.682981095662;9080.909190908105;9090.727278181665;9117.407368521059;9134.406263592879;9088.54557272137;9146.86279705805;9179.173874351307;9181.403208791407;9187.586558604846;9116.908830911672;9129.087091290885;9142.405743626643;9160.992290848035;9168.220701240403;9110.5444727764;9174.770630734218;9177.219936305422;9177.862332065024;9181.311401644836;43309.78345108254;43700.78149609263;43705.12589748187;43752;43800.342994855106;3769.4722738816586;4000;4028.274910516106;4366.56334366564;4566.246569316058;34704;34913.30173396543;35050.123746906276;35065.298694026234;35230.82384588061;4767.618590512785;4814.975925120387;4818.723497769971;4865.355280605368;4926.802927882881;274432;274897;274945;275110;276314;61497.69251153805;61659.999999999105;61851;61903.38096619066;61927.38072619216;40007.39988900169;40246.195076098316;40430.59569404327;66122.66938665276;66159.33840661532;18262.086895655164;18482.630347392977;18498;18527.629447410975;18566.443006709822;14191.503297384543;14224.573262802132;14287.214203218922;14287.357068931922;14299.356528956221;20462.181512739622;20502.897485512774;20570.69143962842;20659.58680826405;20730.274440394816;7671.002769640023;7715.729949451855;7766.184550622216;7877.448578599558;7910.564918929399;1054.1988089052375;1092.8907109289166;1109.8279766636185;1161.814109742437;1220.054457795198;34245.82877085648;34287.742664446836;34405;34888.825555872056;35676.464853027224;1113.4766659669942;1167.1888037813808;1188.708766352232;1242.7017515796324;1261;17919.568279665935;17992.190351434216;18017.70317968279;18106.275748969892;18143.274269029356;660567;662854;665528;669280;674186;63392.36607633864;64055.6797216011;64082;64091;64098;1400.3138462153472;1421.9502317419049;1422.9715405692036;1434.9139051656934;1465.9340329684976;33187.83406082954;34069.48895766615;34172.65827341794;34233;34297;55594.16608750791;55777;56082.439175607724;56144;56216.437835621124;497988;501845;502265;502281;502527;31091;31535.526967095055;32115.678843212205;33919.15202119967;33981.66018339884;52957.63468598106;53153.4684653164;53574;53894.73052634712;54315;44048.779756101016;44130.338044929995;45462.77268613768;45496.77251613721;46230.537694622624;44531.55468445274;45202.321965171206;45375.54624453713;46365.53634463747;46518;44099.33850992302;44401.33397998968;44508.77745611251;44549.33176002298;44645.77677111594;36814.63185368112;37966.620333797415;38134.27985802152;38415.807920960215;39130;29662;29756.404871902872;29956.850215748782;30260.394792104475;30398.696013039586 22:57:43 INFO - PROCESS | 21819 | |2;jquery.html;403.22580645161287;407.8062920112945;429.4052736959311;432.597684153737;436.9038811461479;18741.437756867297;19737.21051157954;20273.39179824604;20430.489237769063;20483.590328193444;19527.511812204666;20017.099230534626;20083.497912552193;20689.68965465519;20701.792982070176;5804.187413762066;6017.338092809788;6022.187004754346;6027.276726792791;6030.788922387717;4448.621867141297;5943.881122377571;5974.462298393144;6732.629705366203;6743.527953043289;6659.7003134858805;6809.250982391933;6817.69320380584;6828.283030281824;6834.863302733942;6607.3392660734025;6735.528513004092;6751.257361690235;6755;6766.763163289262;5233.764480598345;5532.5573954083575;6027.638341699469;6033.33633300341;6037.577369584131;13596.864031359757;13678.726425471436;13788;13878.236696981661;14520.128792272497;2373.905043798246;2398.2805158452393;2405.723341815696;2534.35373979634;2541.771240588356;10672.146228301717;10757.246992710514;10869.891301086967;10909.618163364245;11159;2005.4986253436641;2040.7857324891665;2099.32821497121;2130.946726331839;2143.4641339665086;74074;74388.62805685992;74944.25055749428;75238.62380688117;76802.61598692027;11561.653150405502;11946.820797688042;12134.514619415124;12143.635690929286;12245.510179592717;16977.91511042437;16978.830211697972;16983.23575439108;16989.66020679604;17047.659046818993;8410.537420441935;8967.87901512311;8996.145366190201;9129.535025543066;9167;8481.703140390056;8492.193241642035;8544.871826922601;8667.566621669017;8713.520756358334;5011.0980023595375;5044.142495775727;5067.873303167376;5199.064168449715;5206.7917283309;2056.969145462819;2116.7565729941252;2167.068160690918;2191.8575292606247;2197.648376259791;461.42552522110185;483.4657703237871;948.7011591348703;1054.1145437832258;1097.6926460591046;12212.389380530938;12218.327991960528;12948.417321220568;13066.54267100647;13170.341482925814;518.9896202075937;533.7838175538913;536.2840607788646;542.7313479827432;554.5563549160655;6688.29772873851;6923.376896079377;7031.437485001187;7051.612161331073;7113.0753002109395;564698;591351;603288;610217;629300;91955;96406.51796740972;96577;97187;98360;507.17077578159973;520.2898044169681;521.3300908332774;523.3353640876066;524.1011664994553;11662.475188616701;11860.58487952952;11961.461734221806;11985.64043078709;12077.818832717341;41680;41808;42129.36805947852;42147.3677894838;42292;59956.400435995085;60743.39256607377;60872.39127608667;61112;62232.37767622447;8543.658253669784;8640.308775298086;8950.283977281671;8974.955125224333;9073.863892041756;11496.942515287705;12885.8067128995;12985.675358115745;13193.60419187426;13524.797128043285;11641;11737.413129343327;11836.58571950012;11945.82081268799;12051.638450846489;11355.318680878843;11428.885711143115;11509.366984815915;11528.250663706833;11622.476988535705;10944.288621239593;11218.270812397168;11227.831582526433;11381.715457113307;11580.884191158317;8515.787105322168;8542;8600.956995214983;8713.346499012472;8722.953245610568;10952.538002578198;11146.609868654557;11464;11919.880801191877;12114.75770484603 22:57:43 INFO - PROCESS | 21819 | |3;mootools.html;1544;1551.2786554252275;1752.8948263104214;1870.158428707082;1900.0689662065593;8654.74035778926;9222.123898229675;9228;10008.549615267304;10013.0988211061;9169.31230157739;9362;9630.85553716693;9649.131578157965;9686.854697179548;2494.0896572750953;2555.910543130991;2557.207265747624;2559.6672432583737;2560.5775047117204;2420.891059902309;2518.899244030237;2524.9747502524924;2525.6969163700383;2529.7723204911554;2510.5606518859126;2510.9328535372483;2525.9621105683427;2527.2165628655175;2543.36415896026;2391.1869964212165;2401.0515846240637;2404.158544509425;2408.5664580375524;2414.28778510339;2344.1326709117734;2347.929562113139;2357.9410514737096;2361.4332560185603;2395.7604239576076;9662.13040826322;9708.563114659786;9747.268954828416;9802;9812.46031468269;5711.657300561938;5804.158397032449;5825.621334613236;5847.210626565402;5848.4151584841175;3568.518250036238;3620.71034317254;3665.9450108248398;3693.445983102529;3694.261147770457;1145.673483057333;1160.2226508239416;1164.7728692904886;1180.250540906522;1193.9761204775943;13846.100003499841;14031.43874245029;14050.43798248069;14058.648533786738;14081.295935203301;4863.370770791754;4961.875953101201;4966.255061740696;4975.651704380731;5203.895922081613;11763.294202347886;11785;11795.941020294844;11798.764024719629;11804;5634.971825140848;5650.29371328584;5672.801451949162;5677.489025987598;5693.4875861172695;4679.298105284234;5173.3533308336455;5277.472252774692;5377;5379.515843574097;4300.688290071495;4403.801828917706;4485.102979404132;4495.730256184639;4512.887177820581;1335.1788649980192;1350.5070649212967;1381.1022835157028;1384.563862383346;1386.3969173409598;1029.7528593137592;1052.3159946034984;1053.1785207538132;1076.5155679944057;1077.9191560632985;6532.542722009413;6659.60042397448;6771.762988295386;6838.93161068383;6893.241743408322;478.9832355867528;482.2645465664889;494.21173228700167;496.27543786072016;498.4741098141423;4578.725276483422;4733.692309999839;4751.64362672801;4782.880427989258;4796.952030479651;11567.305961642329;11940;12003.63989080329;12004.519819207135;12019.399030048462;11340.6030788922;11809.291442513477;11821.881781182077;11954.342511161969;12169.634910952685;8819.338549608805;9028.052054534443;9035.864462033074;9037;9076.455412675261;6597.373249541286;6780.660966951731;6852;6872.484563657646;6881.346272104142;10991.890081099407;11114.110871130128;11136.777264454504;11208.159388045766;11229.943850280697;10996.505157268102;11101.722456938318;11110.222284440011;11352.205345625727;11410.429478526206;7817.648205830637;8319.958400207961;8533;8572.142785721378;8740.03859575459;9511.57197926081;9562.665306714232;9568.76078098053;9579.281553883347;9586.808263834824;8474.110218427222;8601.784955376166;8614.095519970313;8658.56707164652;8666.566671666518;7872.84254314899;8103.918960810316;8207.179282071746;8268.421210515206;8345.290650294794;7677.654505547375;7711.575863327571;7783.766487005399;7793.337566306927;7794.727184548514;5561;5626.606137570331;5725.456081672234;5813.331466881363;5904.468597826216;5754.798582049608;5886.323072846678;5924.733386997509;5938.693487432758;5954.612950158225 22:57:43 INFO - PROCESS | 21819 | |4;prototype.html;359.26530245647655;359.65113839575633;360.85385418905344;364.9726270529711;369.99445008324864;5845.3570107288215;5857.853553661155;5865.413458654143;5875.707344384239;5916.7041647917595;5616.241807356006;5757.798477053304;5773.797917072903;5787.13193021047;5859.44335288148;4499.48255950565;4531.977340113295;4540.500544940054;4546.977265113686;4579.793909274091;4531.909361812762;4552.044070745147;4568.269076947689;4579.542045795427;4587.1972404829185;4524.547545245466;4536.795844187003;4544.136614043337;4545.545445455461;4550.97724511377;4272.42322286492;4445.777711114448;4451.866444006685;4452.866414007585;4460.085682435093;3939.665128464084;3948.170884114311;3950.617283950623;3954.6272236657774;3961.5840336764513;5644.520215781664;5647.661140331552;5698.6580805151825;5709;5729.4843464088435;5013.298138260647;5159.7678104485385;5182.300389447414;5195.792168313263;5228.79084836606;6039.667818269993;6056.5457590680435;6085.878282434371;6096.817095487098;6149.477294429978;4261.4460120184485;4391.363252328394;4393.538678438782;4413.889652758675;4415.536368681306;6085.969570152165;6242.781502647431;6271.843203919893;6276.184096067527;6297.874042519124;4414.84548040817;4416.183006143874;4418.889527761831;4452.1763473757455;4493.707908985905;4542.364069030338;4547.090581883636;4555.794989225493;4563.680542362003;4567.634589232854;4951.306817045616;5191.844244672666;5204.750859793622;5233.2935053768015;5236.9738151309;6063.181470501426;6083.300420451616;6104.816855494342;6143.262808463013;6159.568830181934;1567.639442928133;1578.9605259868365;1583.8020247469067;1585.8572728454494;1590.1810567557718;957.6456711016968;1011.5801942194054;1013.4578000769553;1013.8327176015874;1022.7187523430968;5257.76340064698;5291.206319052096;5298;5312.867178320573;5317.867053323698;5521.723913804374;5539;5545.77816887328;5600.327960644668;5610.811783404475;4950.128925223362;5233.293505376725;5268.710220937808;5314.973425132927;5328.92006619901;2970.331675373067;2973.784530524773;2982.8359440230997;2989.611350524418;3007.29328607777;5489.807856725075;5660.33964036902;5689.77240910359;5695.743691533891;5739.569532285095;5590.357108932443;5687;5699.487046165865;5699.715014249271;5719.942800571941;5745.770169193185;5760.827175184667;5770.989162532084;5791.82624521265;5821.126830975388;5364.463553644604;5501.862453438696;5583.302087239095;5599.80400685974;5600.887982240414;5442.619016668795;5448.400675925565;5487.259220005408;5489.780408783764;5509.228707980806;6278.623282603058;6538.757636049136;6541.280459149585;6584.835379115369;6585.80242592723;4445.777711114367;4462.196804575207;4505.5494450556;4512.638988880816;4541.091781643619;6198;6290.654014029273;6331.240251169889;6394.296627370893;6431.421172094534;6150.692465376803;6173.938260617337;6174.8147555573405;6187.143856843019;6212.782552610637;5980.910286345621;6159.969200153971;6212.192414986023;6219.47134493555;6273.65494897785;6152.938470615416;6161.815145545641;6163.907541386972;6175.814725558241;6192;6239.376062393906;6265.122882796321;6275.717592708248;6289.339619340087;6313;5705.942940570541;6011.849703757441;6042.395760423922;6045.365236650088;6052.515798736179 22:57:43 INFO - PROCESS | 21819 | |5;yui.html;841.6254766628849;841.6801615386156;893.2362829780537;905.1265528764743;941.2564074381239;13680.452781888725;14943.028703134301;14967;15040.849591504082;15137.772933405993;14200.502982395617;14362;14453.494127705533;14463.493777717782;14500.347484363203;874.846901792187;879.2921698033081;893.2452077994117;898.4609234459305;900.3922352412128;895.234574438852;902.8600566912106;905.5381755304776;908.0964440381829;909.6088681866795;952.8475443928972;953.9904600953971;956.9569369378395;957.9329446938717;960.2605993385089;950.0974074629061;950.2493030505892;952.3190918493276;952.5094576293214;954.4607296877277;704.7251571886968;705.6365971524668;706.2937062937064;706.9257727938544;707.4517249131964;15472.5358239253;15578.454754083552;15605.765913511306;15611.375544978187;15630.531084067496;14976.70046599062;15593.220338983005;15701.057936523845;15847.286872090783;15941.601459963478;12237.938810305981;12306.81539776904;12389.93805030969;12506.18709783861;12671.49314027447;4075.510938687347;4092.570280120604;4131.938020929689;4167.395727619478;4213.683973701954;85499.57250213771;85656.14343856544;87235;87310.56344718236;87846;11593.072554195644;11669.183157178915;11787.941060294816;11809.23239989398;11813.822792658117;18757.249710011718;18853.717194242097;18921.62156756857;18933.526661833563;18985;8283.792905177419;8320.126386729427;8473.152684731478;8599.183077607617;8691;4935.827246046443;4955.058538877602;4966.478519755446;5061.493850614909;5103.642745007814;4005.2189822984237;4153.06556024892;4153.626173644387;4153.91692166155;4162.1259535497275;691.180950573572;694.3820000199826;709.1596458197052;709.6097146569366;715.3990647855826;793.9483933544417;797.2266901105918;799.8560259153292;819.8770184472257;850.459957926721;10007.949960250153;10197.541110650038;10397.903881405968;10437.582496700199;10684.198685098494;727.5852763924618;781.3397678961269;798.2017982017982;799.3165843204093;832.063928080909;4822.638302127354;4873.122837889214;4892.51074892515;4912.803487860517;4966.528179822911;142179.28910355383;143027;144061.27969360087;150018.24990874977;150080;122374;127367;128735;129536;131013;110824;111591.44204278926;111805;112412;112621.436892815;9587.808243834945;9593.808123837345;9659.758506037406;9680.709578712649;9707.320487565803;53392.46607533875;60046;60458.697706511186;60837.69581152066;63153;79546.6022669883;85751;91458.54270728603;94496;94936.52531737297;13059.21644701321;13192.934035329761;13405.195688258736;13413.86586134126;13788.034837561676;13852.16886986784;14101.717965640835;14354.85645143577;14441.5532921962;14485.565433037025;12623.93688031554;13140.145890517086;13252.469901203844;13310;13386.665333366744;12567.937160314506;12654.557090502156;12689.492420303453;12829.42267597979;12914.966802655952;12837.807432888327;12858.421371038512;12974.935125324691;13118.147320424141;13133.60599182026;10692.89307106919;10697.304675196086;10859.891401085888;10960.397178154959;11364.261323013978;10824.891751082389;11284.32294062359;11299.209055366375;11438.714032149262;11445.484953177294 22:57:43 INFO - PROCESS | 21819 | __end_tp_report 22:57:43 INFO - PROCESS | 21819 | __start_cc_report 22:57:43 INFO - PROCESS | 21819 | _x_x_mozilla_cycle_collect,346 22:57:43 INFO - PROCESS | 21819 | __end_cc_report 22:57:43 INFO - PROCESS | 21819 | __startTimestamp1474523863455__endTimestamp 22:57:43 INFO - PROCESS | 21819 | 22:57:43 INFO - PROCESS | 21819 | ------- Summary: start ------- 22:57:43 INFO - PROCESS | 21819 | Number of tests: 6 22:57:43 INFO - PROCESS | 21819 | 22:57:43 INFO - PROCESS | 21819 | [#0] dojo.html Cycles:165 Average:5870.72 Median:6133.85 stddev:692.81 (11.3%) stddev-sans-first:665.85 22:57:43 INFO - PROCESS | 21819 | Values: 3338.4 3351.5 3358.0 3382.5 3384.5 5869.6 5895.7 5904.6 5905.2 5924.5 5893.5 5934.6 5941.4 5944.8 5981.1 5328.5 5377.3 5415.9 5443.1 5474.5 5155.6 5162.3 5207.7 5311.9 5325.5 5317.4 5350.9 5366.9 5408.0 5484.4 5408.9 5411.6 5423.8 5426.0 5426.9 5136.8 5154.5 5241.6 5323.6 5425.2 5721.6 5792.5 5797.3 5819.9 5832.3 6246.0 6291.6 6293.2 6300.3 6300.5 6080.9 6256.2 6328.2 6369.9 6373.9 5880.2 5970.0 5973.3 6002.3 6014.1 6510.6 6539.3 6568.3 6572.9 6593.3 5983.2 6141.2 6194.4 6259.5 6296.5 6185.0 6317.8 6353.1 6359.1 6385.5 6351.2 6359.0 6359.9 6371.2 6371.6 6049.1 6152.7 6369.2 6373.1 6377.1 4723.9 4810.6 4813.5 4848.7 4851.6 4263.3 4269.5 4277.7 4295.1 4297.5 5833.1 5979.6 6050.7 6098.1 6112.2 6294.1 6400.9 6422.2 6423.1 6437.6 6142.6 6145.3 6148.4 6154.6 6158.0 5166.0 5247.2 5339.5 5342.8 5376.3 6451.0 6600.5 6619.9 6624.7 6627.0 6421.3 6429.4 6438.8 6442.9 6444.3 6284.7 6426.1 6535.2 6543.7 6605.4 6128.0 6240.1 6265.3 6278.9 6282.7 6343.4 6392.5 6395.8 6405.9 6413.9 5986.2 6079.3 6203.2 6213.3 6236.4 6055.2 6131.6 6167.5 6176.5 6177.7 6077.3 6120.5 6133.4 6136.2 6170.1 6064.0 6150.2 6174.6 6224.6 6245.8 6133.8 6167.8 6168.3 6170.4 6183.7 22:57:43 INFO - PROCESS | 21819 | 22:57:43 INFO - PROCESS | 21819 | [#1] ext.html Cycles:180 Average:65015.98 Median:44800.05 stddev:135434.95 (302.3%) stddev-sans-first:135728.46 22:57:43 INFO - PROCESS | 21819 | Values: 576.9 635.3 642.5 662.9 710.8 40755.2 44954.3 44968.6 45029.1 45085.8 45636.5 46254.8 46486.3 46524.3 46533.1 8940.2 9144.2 9162.6 9164.8 9196.7 9057.7 9080.9 9090.7 9117.4 9134.4 9088.5 9146.9 9179.2 9181.4 9187.6 9116.9 9129.1 9142.4 9161.0 9168.2 9110.5 9174.8 9177.2 9177.9 9181.3 43309.8 43700.8 43705.1 43752.0 43800.3 3769.5 4000.0 4028.3 4366.6 4566.2 34704.0 34913.3 35050.1 35065.3 35230.8 4767.6 4815.0 4818.7 4865.4 4926.8 274432.0 274897.0 274945.0 275110.0 276314.0 61497.7 61660.0 61851.0 61903.4 61927.4 40007.4 40246.2 40430.6 66122.7 66159.3 18262.1 18482.6 18498.0 18527.6 18566.4 14191.5 14224.6 14287.2 14287.4 14299.4 20462.2 20502.9 20570.7 20659.6 20730.3 7671.0 7715.7 7766.2 7877.4 7910.6 1054.2 1092.9 1109.8 1161.8 1220.1 34245.8 34287.7 34405.0 34888.8 35676.5 1113.5 1167.2 1188.7 1242.7 1261.0 17919.6 17992.2 18017.7 18106.3 18143.3 660567.0 662854.0 665528.0 669280.0 674186.0 63392.4 64055.7 64082.0 64091.0 64098.0 1400.3 1422.0 1423.0 1434.9 1465.9 33187.8 34069.5 34172.7 34233.0 34297.0 55594.2 55777.0 56082.4 56144.0 56216.4 497988.0 501845.0 502265.0 502281.0 502527.0 31091.0 31535.5 32115.7 33919.2 33981.7 52957.6 53153.5 53574.0 53894.7 54315.0 44048.8 44130.3 45462.8 45496.8 46230.5 44531.6 45202.3 45375.5 46365.5 46518.0 44099.3 44401.3 44508.8 44549.3 44645.8 36814.6 37966.6 38134.3 38415.8 39130.0 29662.0 29756.4 29956.9 30260.4 30398.7 22:57:43 INFO - PROCESS | 21819 | 22:57:43 INFO - PROCESS | 21819 | [#2] jquery.html Cycles:180 Average:31629.71 Median:434.75 stddev:98547.65 (22667.6%) stddev-sans-first:98796.20 22:57:43 INFO - PROCESS | 21819 | Values: 403.2 407.8 429.4 432.6 436.9 18741.4 19737.2 20273.4 20430.5 20483.6 19527.5 20017.1 20083.5 20689.7 20701.8 5804.2 6017.3 6022.2 6027.3 6030.8 4448.6 5943.9 5974.5 6732.6 6743.5 6659.7 6809.3 6817.7 6828.3 6834.9 6607.3 6735.5 6751.3 6755.0 6766.8 5233.8 5532.6 6027.6 6033.3 6037.6 13596.9 13678.7 13788.0 13878.2 14520.1 2373.9 2398.3 2405.7 2534.4 2541.8 10672.1 10757.2 10869.9 10909.6 11159.0 2005.5 2040.8 2099.3 2130.9 2143.5 74074.0 74388.6 74944.3 75238.6 76802.6 11561.7 11946.8 12134.5 12143.6 12245.5 16977.9 16978.8 16983.2 16989.7 17047.7 8410.5 8967.9 8996.1 9129.5 9167.0 8481.7 8492.2 8544.9 8667.6 8713.5 5011.1 5044.1 5067.9 5199.1 5206.8 2057.0 2116.8 2167.1 2191.9 2197.6 461.4 483.5 948.7 1054.1 1097.7 12212.4 12218.3 12948.4 13066.5 13170.3 519.0 533.8 536.3 542.7 554.6 6688.3 6923.4 7031.4 7051.6 7113.1 564698.0 591351.0 603288.0 610217.0 629300.0 91955.0 96406.5 96577.0 97187.0 98360.0 507.2 520.3 521.3 523.3 524.1 11662.5 11860.6 11961.5 11985.6 12077.8 41680.0 41808.0 42129.4 42147.4 42292.0 59956.4 60743.4 60872.4 61112.0 62232.4 8543.7 8640.3 8950.3 8975.0 9073.9 11496.9 12885.8 12985.7 13193.6 13524.8 11641.0 11737.4 11836.6 11945.8 12051.6 11355.3 11428.9 11509.4 11528.3 11622.5 10944.3 11218.3 11227.8 11381.7 11580.9 8515.8 8542.0 8601.0 8713.3 8723.0 10952.5 11146.6 11464.0 11919.9 12114.8 22:57:43 INFO - PROCESS | 21819 | 22:57:43 INFO - PROCESS | 21819 | [#3] mootools.html Cycles:180 Average:6382.38 Median:2615.31 stddev:3693.12 (141.2%) stddev-sans-first:3685.58 22:57:43 INFO - PROCESS | 21819 | Values: 1544.0 1551.3 1752.9 1870.2 1900.1 8654.7 9222.1 9228.0 10008.5 10013.1 9169.3 9362.0 9630.9 9649.1 9686.9 2494.1 2555.9 2557.2 2559.7 2560.6 2420.9 2518.9 2525.0 2525.7 2529.8 2510.6 2510.9 2526.0 2527.2 2543.4 2391.2 2401.1 2404.2 2408.6 2414.3 2344.1 2347.9 2357.9 2361.4 2395.8 9662.1 9708.6 9747.3 9802.0 9812.5 5711.7 5804.2 5825.6 5847.2 5848.4 3568.5 3620.7 3665.9 3693.4 3694.3 1145.7 1160.2 1164.8 1180.3 1194.0 13846.1 14031.4 14050.4 14058.6 14081.3 4863.4 4961.9 4966.3 4975.7 5203.9 11763.3 11785.0 11795.9 11798.8 11804.0 5635.0 5650.3 5672.8 5677.5 5693.5 4679.3 5173.4 5277.5 5377.0 5379.5 4300.7 4403.8 4485.1 4495.7 4512.9 1335.2 1350.5 1381.1 1384.6 1386.4 1029.8 1052.3 1053.2 1076.5 1077.9 6532.5 6659.6 6771.8 6838.9 6893.2 479.0 482.3 494.2 496.3 498.5 4578.7 4733.7 4751.6 4782.9 4797.0 11567.3 11940.0 12003.6 12004.5 12019.4 11340.6 11809.3 11821.9 11954.3 12169.6 8819.3 9028.1 9035.9 9037.0 9076.5 6597.4 6780.7 6852.0 6872.5 6881.3 10991.9 11114.1 11136.8 11208.2 11229.9 10996.5 11101.7 11110.2 11352.2 11410.4 7817.6 8320.0 8533.0 8572.1 8740.0 9511.6 9562.7 9568.8 9579.3 9586.8 8474.1 8601.8 8614.1 8658.6 8666.6 7872.8 8103.9 8207.2 8268.4 8345.3 7677.7 7711.6 7783.8 7793.3 7794.7 5561.0 5626.6 5725.5 5813.3 5904.5 5754.8 5886.3 5924.7 5938.7 5954.6 22:57:43 INFO - PROCESS | 21819 | 22:57:43 INFO - PROCESS | 21819 | [#4] prototype.html Cycles:180 Average:4990.92 Median:5505.55 stddev:1452.72 (26.4%) stddev-sans-first:1414.59 22:57:43 INFO - PROCESS | 21819 | Values: 359.3 359.7 360.9 365.0 370.0 5845.4 5857.9 5865.4 5875.7 5916.7 5616.2 5757.8 5773.8 5787.1 5859.4 4499.5 4532.0 4540.5 4547.0 4579.8 4531.9 4552.0 4568.3 4579.5 4587.2 4524.5 4536.8 4544.1 4545.5 4551.0 4272.4 4445.8 4451.9 4452.9 4460.1 3939.7 3948.2 3950.6 3954.6 3961.6 5644.5 5647.7 5698.7 5709.0 5729.5 5013.3 5159.8 5182.3 5195.8 5228.8 6039.7 6056.5 6085.9 6096.8 6149.5 4261.4 4391.4 4393.5 4413.9 4415.5 6086.0 6242.8 6271.8 6276.2 6297.9 4414.8 4416.2 4418.9 4452.2 4493.7 4542.4 4547.1 4555.8 4563.7 4567.6 4951.3 5191.8 5204.8 5233.3 5237.0 6063.2 6083.3 6104.8 6143.3 6159.6 1567.6 1579.0 1583.8 1585.9 1590.2 957.6 1011.6 1013.5 1013.8 1022.7 5257.8 5291.2 5298.0 5312.9 5317.9 5521.7 5539.0 5545.8 5600.3 5610.8 4950.1 5233.3 5268.7 5315.0 5328.9 2970.3 2973.8 2982.8 2989.6 3007.3 5489.8 5660.3 5689.8 5695.7 5739.6 5590.4 5687.0 5699.5 5699.7 5719.9 5745.8 5760.8 5771.0 5791.8 5821.1 5364.5 5501.9 5583.3 5599.8 5600.9 5442.6 5448.4 5487.3 5489.8 5509.2 6278.6 6538.8 6541.3 6584.8 6585.8 4445.8 4462.2 4505.5 4512.6 4541.1 6198.0 6290.7 6331.2 6394.3 6431.4 6150.7 6173.9 6174.8 6187.1 6212.8 5980.9 6160.0 6212.2 6219.5 6273.7 6152.9 6161.8 6163.9 6175.8 6192.0 6239.4 6265.1 6275.7 6289.3 6313.0 5705.9 6011.8 6042.4 6045.4 6052.5 22:57:43 INFO - PROCESS | 21819 | 22:57:43 INFO - PROCESS | 21819 | [#5] yui.html Cycles:180 Average:24092.06 Median:4040.36 stddev:37884.12 (937.6%) stddev-sans-first:37950.17 22:57:43 INFO - PROCESS | 21819 | Values: 841.6 841.7 893.2 905.1 941.3 13680.5 14943.0 14967.0 15040.8 15137.8 14200.5 14362.0 14453.5 14463.5 14500.3 874.8 879.3 893.2 898.5 900.4 895.2 902.9 905.5 908.1 909.6 952.8 954.0 957.0 957.9 960.3 950.1 950.2 952.3 952.5 954.5 704.7 705.6 706.3 706.9 707.5 15472.5 15578.5 15605.8 15611.4 15630.5 14976.7 15593.2 15701.1 15847.3 15941.6 12237.9 12306.8 12389.9 12506.2 12671.5 4075.5 4092.6 4131.9 4167.4 4213.7 85499.6 85656.1 87235.0 87310.6 87846.0 11593.1 11669.2 11787.9 11809.2 11813.8 18757.2 18853.7 18921.6 18933.5 18985.0 8283.8 8320.1 8473.2 8599.2 8691.0 4935.8 4955.1 4966.5 5061.5 5103.6 4005.2 4153.1 4153.6 4153.9 4162.1 691.2 694.4 709.2 709.6 715.4 793.9 797.2 799.9 819.9 850.5 10007.9 10197.5 10397.9 10437.6 10684.2 727.6 781.3 798.2 799.3 832.1 4822.6 4873.1 4892.5 4912.8 4966.5 142179.3 143027.0 144061.3 150018.2 150080.0 122374.0 127367.0 128735.0 129536.0 131013.0 110824.0 111591.4 111805.0 112412.0 112621.4 9587.8 9593.8 9659.8 9680.7 9707.3 53392.5 60046.0 60458.7 60837.7 63153.0 79546.6 85751.0 91458.5 94496.0 94936.5 13059.2 13192.9 13405.2 13413.9 13788.0 13852.2 14101.7 14354.9 14441.6 14485.6 12623.9 13140.1 13252.5 13310.0 13386.7 12567.9 12654.6 12689.5 12829.4 12915.0 12837.8 12858.4 12974.9 13118.1 13133.6 10692.9 10697.3 10859.9 10960.4 11364.3 10824.9 11284.3 11299.2 11438.7 11445.5 22:57:43 INFO - PROCESS | 21819 | -------- Summary: end -------- 22:57:43 INFO - PROCESS | 21819 | 22:57:44 INFO - TEST-INFO | 21819: exit 0 22:57:44 INFO - TEST-OK | dromaeo_css | took 1110219ms 22:57:44 INFO - TEST-START | kraken 22:57:44 INFO - operating with platform_type : linux_ 22:57:44 INFO - Initialising browser for kraken test... 22:57:44 INFO - TEST-INFO | started process 22059 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprKFPEE/profile http://localhost:57761/getInfo.html) 22:57:48 INFO - PROCESS | 22059 | __metrics Screen width/height:1600/1200 22:57:48 INFO - PROCESS | 22059 | colorDepth:24 22:57:48 INFO - PROCESS | 22059 | Browser inner width/height: 1024/697 22:57:48 INFO - PROCESS | 22059 | __metrics 22:57:49 ERROR - PROCESS | 22059 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 22:57:49 INFO - TEST-INFO | 22059: exit 0 22:57:49 INFO - Browser initialized. 22:57:49 INFO - Running cycle 1/1 for kraken test... 22:57:49 INFO - TEST-INFO | started process 22183 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprKFPEE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:58:01 INFO - PROCESS | 22183 | RSS: Main: 149970944 22:58:01 INFO - PROCESS | 22183 | 22:58:04 INFO - PROCESS | 22183 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57761/tests/kraken/driver.html?testName=audio-beat-detection) 22:58:05 INFO - PROCESS | 22183 | RSS: Main: 156475392 22:58:05 INFO - PROCESS | 22183 | 22:58:07 INFO - PROCESS | 22183 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57761/tests/kraken/driver.html?testName=audio-dft) 22:58:08 INFO - PROCESS | 22183 | RSS: Main: 154828800 22:58:08 INFO - PROCESS | 22183 | 22:58:11 INFO - PROCESS | 22183 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57761/tests/kraken/driver.html?testName=audio-fft) 22:58:11 INFO - PROCESS | 22183 | RSS: Main: 155938816 22:58:11 INFO - PROCESS | 22183 | 22:58:13 INFO - PROCESS | 22183 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57761/tests/kraken/driver.html?testName=audio-oscillator) 22:58:14 INFO - PROCESS | 22183 | RSS: Main: 155406336 22:58:14 INFO - PROCESS | 22183 | 22:58:16 INFO - PROCESS | 22183 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57761/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:58:17 INFO - PROCESS | 22183 | RSS: Main: 155504640 22:58:17 INFO - PROCESS | 22183 | 22:58:20 INFO - PROCESS | 22183 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57761/tests/kraken/driver.html?testName=imaging-darkroom) 22:58:20 INFO - PROCESS | 22183 | RSS: Main: 155172864 22:58:20 INFO - PROCESS | 22183 | 22:58:24 INFO - PROCESS | 22183 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57761/tests/kraken/driver.html?testName=imaging-desaturate) 22:58:24 INFO - PROCESS | 22183 | RSS: Main: 155672576 22:58:24 INFO - PROCESS | 22183 | 22:58:27 INFO - PROCESS | 22183 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57761/tests/kraken/driver.html?testName=json-parse-financial) 22:58:28 INFO - PROCESS | 22183 | RSS: Main: 156553216 22:58:28 INFO - PROCESS | 22183 | 22:58:29 INFO - PROCESS | 22183 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57761/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:58:30 INFO - PROCESS | 22183 | RSS: Main: 155557888 22:58:30 INFO - PROCESS | 22183 | 22:58:32 INFO - PROCESS | 22183 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57761/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:58:32 INFO - PROCESS | 22183 | RSS: Main: 155316224 22:58:32 INFO - PROCESS | 22183 | 22:58:34 INFO - PROCESS | 22183 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57761/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:58:35 INFO - PROCESS | 22183 | RSS: Main: 156291072 22:58:35 INFO - PROCESS | 22183 | 22:58:37 INFO - PROCESS | 22183 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57761/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:58:38 INFO - PROCESS | 22183 | RSS: Main: 156577792 22:58:38 INFO - PROCESS | 22183 | 22:58:41 INFO - PROCESS | 22183 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57761/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:58:41 INFO - PROCESS | 22183 | RSS: Main: 156672000 22:58:41 INFO - PROCESS | 22183 | 22:58:43 INFO - PROCESS | 22183 | Cycle 1(1): loaded http://localhost:57761/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57761/tests/kraken/driver.html?testName=ai-astar) 22:58:43 INFO - PROCESS | 22183 | RSS: Main: 158658560 22:58:43 INFO - PROCESS | 22183 | 22:58:43 INFO - PROCESS | 22183 | __start_tp_report 22:58:43 INFO - PROCESS | 22183 | _x_x_mozilla_page_load 22:58:43 INFO - PROCESS | 22183 | _x_x_mozilla_page_load_details 22:58:43 INFO - PROCESS | 22183 | |i|pagename|runs| 22:58:43 INFO - PROCESS | 22183 | |0;ai-astar;99;111;103;109;110;110;110;109;110;109 22:58:43 INFO - PROCESS | 22183 | |1;audio-beat-detection;143;132;143;185;116;148;146;123;181;117 22:58:43 INFO - PROCESS | 22183 | |2;audio-dft;162;162;162;163;161;162;162;160;161;163 22:58:43 INFO - PROCESS | 22183 | |3;audio-fft;75;75;75;175;75;74;76;75;180;75 22:58:43 INFO - PROCESS | 22183 | |4;audio-oscillator;84;83;141;83;84;84;138;83;83;144 22:58:43 INFO - PROCESS | 22183 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;118;117;117 22:58:43 INFO - PROCESS | 22183 | |6;imaging-darkroom;146;147;146;147;147;147;147;148;148;145 22:58:43 INFO - PROCESS | 22183 | |7;imaging-desaturate;95;95;95;96;95;95;96;95;96;96 22:58:43 INFO - PROCESS | 22183 | |8;json-parse-financial;55;54;52;52;53;58;53;52;52;53 22:58:43 INFO - PROCESS | 22183 | |9;json-stringify-tinderbox;63;59;59;59;59;58;59;59;69;59 22:58:43 INFO - PROCESS | 22183 | |10;stanford-crypto-aes;73;72;73;72;81;73;72;72;78;74 22:58:43 INFO - PROCESS | 22183 | |11;stanford-crypto-ccm;121;119;127;120;116;128;140;120;153;123 22:58:43 INFO - PROCESS | 22183 | |12;stanford-crypto-pbkdf2;153;160;158;152;156;155;160;154;154;150 22:58:43 INFO - PROCESS | 22183 | |13;stanford-crypto-sha256-iterative;71;72;62;70;61;65;61;62;61;61 22:58:43 INFO - PROCESS | 22183 | __end_tp_report 22:58:43 INFO - PROCESS | 22183 | __start_cc_report 22:58:43 INFO - PROCESS | 22183 | _x_x_mozilla_cycle_collect,869 22:58:43 INFO - PROCESS | 22183 | __end_cc_report 22:58:43 INFO - PROCESS | 22183 | __startTimestamp1474523923761__endTimestamp 22:58:43 INFO - PROCESS | 22183 | 22:58:43 INFO - PROCESS | 22183 | ------- Summary: start ------- 22:58:43 INFO - PROCESS | 22183 | Number of tests: 14 22:58:43 INFO - PROCESS | 22183 | 22:58:43 INFO - PROCESS | 22183 | [#0] ai-astar Cycles:10 Average:108.00 Median:110.00 stddev:3.86 (3.5%) stddev-sans-first:2.35 22:58:43 INFO - PROCESS | 22183 | Values: 99.0 111.0 103.0 109.0 110.0 110.0 110.0 109.0 110.0 109.0 22:58:43 INFO - PROCESS | 22183 | 22:58:43 INFO - PROCESS | 22183 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:144.50 stddev:23.96 (16.6%) stddev-sans-first:25.41 22:58:43 INFO - PROCESS | 22183 | Values: 143.0 132.0 143.0 185.0 116.0 148.0 146.0 123.0 181.0 117.0 22:58:43 INFO - PROCESS | 22183 | 22:58:43 INFO - PROCESS | 22183 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 22:58:43 INFO - PROCESS | 22183 | Values: 162.0 162.0 162.0 163.0 161.0 162.0 162.0 160.0 161.0 163.0 22:58:43 INFO - PROCESS | 22183 | 22:58:43 INFO - PROCESS | 22183 | [#3] audio-fft Cycles:10 Average:95.50 Median:75.00 stddev:43.24 (57.6%) stddev-sans-first:45.22 22:58:43 INFO - PROCESS | 22183 | Values: 75.0 75.0 75.0 175.0 75.0 74.0 76.0 75.0 180.0 75.0 22:58:43 INFO - PROCESS | 22183 | 22:58:43 INFO - PROCESS | 22183 | [#4] audio-oscillator Cycles:10 Average:100.70 Median:83.00 stddev:27.85 (33.6%) stddev-sans-first:28.88 22:58:43 INFO - PROCESS | 22183 | Values: 84.0 83.0 141.0 83.0 84.0 84.0 138.0 83.0 83.0 144.0 22:58:43 INFO - PROCESS | 22183 | 22:58:43 INFO - PROCESS | 22183 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 22:58:43 INFO - PROCESS | 22183 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 118.0 117.0 117.0 22:58:43 INFO - PROCESS | 22183 | 22:58:43 INFO - PROCESS | 22183 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 22:58:43 INFO - PROCESS | 22183 | Values: 146.0 147.0 146.0 147.0 147.0 147.0 147.0 148.0 148.0 145.0 22:58:43 INFO - PROCESS | 22183 | 22:58:43 INFO - PROCESS | 22183 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:58:43 INFO - PROCESS | 22183 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 96.0 22:58:43 INFO - PROCESS | 22183 | 22:58:43 INFO - PROCESS | 22183 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:1.90 (3.6%) stddev-sans-first:1.92 22:58:43 INFO - PROCESS | 22183 | Values: 55.0 54.0 52.0 52.0 53.0 58.0 53.0 52.0 52.0 53.0 22:58:43 INFO - PROCESS | 22183 | 22:58:43 INFO - PROCESS | 22183 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:59.00 stddev:3.33 (5.7%) stddev-sans-first:3.39 22:58:43 INFO - PROCESS | 22183 | Values: 63.0 59.0 59.0 59.0 59.0 58.0 59.0 59.0 69.0 59.0 22:58:43 INFO - PROCESS | 22183 | 22:58:43 INFO - PROCESS | 22183 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:73.00 stddev:3.06 (4.2%) stddev-sans-first:3.22 22:58:43 INFO - PROCESS | 22183 | Values: 73.0 72.0 73.0 72.0 81.0 73.0 72.0 72.0 78.0 74.0 22:58:43 INFO - PROCESS | 22183 | 22:58:43 INFO - PROCESS | 22183 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:125.00 stddev:11.45 (9.2%) stddev-sans-first:11.96 22:58:43 INFO - PROCESS | 22183 | Values: 121.0 119.0 127.0 120.0 116.0 128.0 140.0 120.0 153.0 123.0 22:58:43 INFO - PROCESS | 22183 | 22:58:43 INFO - PROCESS | 22183 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:155.50 stddev:3.33 (2.1%) stddev-sans-first:3.43 22:58:43 INFO - PROCESS | 22183 | Values: 153.0 160.0 158.0 152.0 156.0 155.0 160.0 154.0 154.0 150.0 22:58:43 INFO - PROCESS | 22183 | 22:58:43 INFO - PROCESS | 22183 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:63.50 stddev:4.60 (7.2%) stddev-sans-first:4.26 22:58:43 INFO - PROCESS | 22183 | Values: 71.0 72.0 62.0 70.0 61.0 65.0 61.0 62.0 61.0 61.0 22:58:43 INFO - PROCESS | 22183 | -------- Summary: end -------- 22:58:43 INFO - PROCESS | 22183 | 22:58:44 INFO - TEST-INFO | 22183: exit 0 22:58:44 INFO - TEST-OK | kraken | took 60551ms 22:58:44 INFO - SUITE-END | took 1170s 22:58:44 INFO - Completed test suite (00:19:31) 22:58:44 INFO - javascript benchmark 22:58:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7652.473837930441, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3338.365710515002, 3351.5140304655824, 3358.0, 3382.4926261060855, 3384.526166336712, 5869.618474799135, 5895.675737834417, 5904.6161999470005, 5905.232319798425, 5924.466797988181, 5893.528517718583, 5934.614250073742, 5941.405859414067, 5944.821655350335, 5981.132735753313, 5328.5470734987575, 5377.274068000809, 5415.864603384927, 5443.074677304868, 5474.507294343508, 5155.561777248939, 5162.251473536335, 5207.713575753351, 5311.920321195185, 5325.467453254663, 5317.441668624797, 5350.91973620396, 5366.892662146754, 5407.972960135194, 5484.396716361197, 5408.945910540883, 5411.567074634039, 5423.810166644149, 5425.9728701356435, 5426.9185962210595, 5136.768845401966, 5154.5103215194495, 5241.633085684004, 5323.600729945269, 5425.213344065128, 5721.628094173907, 5792.536597072266, 5797.304323481209, 5819.88360232793, 5832.329282132567, 6246.0, 6291.559590828644, 6293.181886354791, 6300.30696623371, 6300.527460440485, 6080.939190608082, 6256.15541901842, 6328.240611126648, 6369.872602547923, 6373.872522549569, 5880.206172166745, 5970.044792833126, 5973.342932277489, 6002.339742628307, 6014.097885317237, 6510.641914694737, 6539.280679125292, 6568.343165683394, 6572.901406478906, 6593.307702691244, 5983.1623572699855, 6141.232345956755, 6194.442500175006, 6259.530535209878, 6296.527760417987, 6185.0, 6317.810465685945, 6353.142325786052, 6359.077933699587, 6385.5210859185745, 6351.2060992375955, 6358.968205159037, 6359.904601430982, 6371.23545174582, 6371.55399122057, 6049.0926361046195, 6152.661603611755, 6369.20384951881, 6373.139626150411, 6377.075324077982, 4723.858284251478, 4810.5670489656095, 4813.518648135158, 4848.684835485753, 4851.56335929768, 4263.339182426729, 4269.530351661315, 4277.743335399886, 4295.055087880662, 4297.505786834491, 5833.125031245348, 5979.581429299994, 6050.6672133032225, 6098.054801505774, 6112.235970503687, 6294.118823364733, 6400.935990640127, 6422.197225346832, 6423.100765892778, 6437.613743175424, 6142.570020098639, 6145.324014358417, 6148.385161483816, 6154.569180157436, 6157.96921015392, 5165.974170129125, 5247.212918062245, 5339.546138578265, 5342.839714808562, 5376.301080859464, 6450.967745161338, 6600.504962127764, 6619.933800661932, 6624.668766561653, 6626.966865165739, 6421.325760795236, 6429.421352078335, 6438.806835794933, 6442.871142577029, 6444.323346048597, 6284.748610055546, 6426.100345951477, 6535.150430444012, 6543.70553325111, 6605.405513503808, 6128.014278093809, 6240.12638230639, 6265.342139075514, 6278.905816412849, 6282.717277722605, 6343.365663433804, 6392.488600911823, 6395.840103997437, 6405.8718825624155, 6413.8717225656155, 5986.191864098291, 6079.270487541523, 6203.2245969253845, 6213.254409470893, 6236.407541283571, 6055.182550355822, 6131.570790044832, 6167.537434692326, 6176.536759743127, 6177.660228687465, 6077.298446247364, 6120.510359171167, 6133.44798968095, 6136.1821086261625, 6170.074488826712, 6064.0, 6150.169727086786, 6174.567780255339, 6224.595401298901, 6245.750169993149, 6133.8466538335115, 6167.753289868355, 6168.290646575521, 6170.413810687977, 6183.659898705614], "value": 5822.107995857878, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.9105788602766, 635.3329004545226, 642.4507046475263, 662.8806814773341, 710.8080818179095, 40755.18489630205, 44954.325685114665, 44968.550314496846, 45029.09941801162, 45085.7745711271, 45636.54363456364, 46254.76872615632, 46486.30270545936, 46524.30213546791, 46533.069338613204, 8940.195382415564, 9144.222741066984, 9162.633494660206, 9164.770880728001, 9196.678116265932, 9057.682981095662, 9080.909190908105, 9090.727278181665, 9117.407368521059, 9134.406263592879, 9088.54557272137, 9146.86279705805, 9179.173874351307, 9181.403208791407, 9187.586558604846, 9116.908830911672, 9129.087091290885, 9142.405743626643, 9160.992290848035, 9168.220701240403, 9110.5444727764, 9174.770630734218, 9177.219936305422, 9177.862332065024, 9181.311401644836, 43309.78345108254, 43700.78149609263, 43705.12589748187, 43752.0, 43800.342994855106, 3769.4722738816586, 4000.0, 4028.274910516106, 4366.56334366564, 4566.246569316058, 34704.0, 34913.30173396543, 35050.123746906276, 35065.298694026234, 35230.82384588061, 4767.618590512785, 4814.975925120387, 4818.723497769971, 4865.355280605368, 4926.802927882881, 274432.0, 274897.0, 274945.0, 275110.0, 276314.0, 61497.69251153805, 61659.999999999105, 61851.0, 61903.38096619066, 61927.38072619216, 40007.39988900169, 40246.195076098316, 40430.59569404327, 66122.66938665276, 66159.33840661532, 18262.086895655164, 18482.630347392977, 18498.0, 18527.629447410975, 18566.443006709822, 14191.503297384543, 14224.573262802132, 14287.214203218922, 14287.357068931922, 14299.356528956221, 20462.181512739622, 20502.897485512774, 20570.69143962842, 20659.58680826405, 20730.274440394816, 7671.002769640023, 7715.729949451855, 7766.184550622216, 7877.448578599558, 7910.564918929399, 1054.1988089052375, 1092.8907109289166, 1109.8279766636185, 1161.814109742437, 1220.054457795198, 34245.82877085648, 34287.742664446836, 34405.0, 34888.825555872056, 35676.464853027224, 1113.4766659669942, 1167.1888037813808, 1188.708766352232, 1242.7017515796324, 1261.0, 17919.568279665935, 17992.190351434216, 18017.70317968279, 18106.275748969892, 18143.274269029356, 660567.0, 662854.0, 665528.0, 669280.0, 674186.0, 63392.36607633864, 64055.6797216011, 64082.0, 64091.0, 64098.0, 1400.3138462153472, 1421.9502317419049, 1422.9715405692036, 1434.9139051656934, 1465.9340329684976, 33187.83406082954, 34069.48895766615, 34172.65827341794, 34233.0, 34297.0, 55594.16608750791, 55777.0, 56082.439175607724, 56144.0, 56216.437835621124, 497988.0, 501845.0, 502265.0, 502281.0, 502527.0, 31091.0, 31535.526967095055, 32115.678843212205, 33919.15202119967, 33981.66018339884, 52957.63468598106, 53153.4684653164, 53574.0, 53894.73052634712, 54315.0, 44048.779756101016, 44130.338044929995, 45462.77268613768, 45496.77251613721, 46230.537694622624, 44531.55468445274, 45202.321965171206, 45375.54624453713, 46365.53634463747, 46518.0, 44099.33850992302, 44401.33397998968, 44508.77745611251, 44549.33176002298, 44645.77677111594, 36814.63185368112, 37966.620333797415, 38134.27985802152, 38415.807920960215, 39130.0, 29662.0, 29756.404871902872, 29956.850215748782, 30260.394792104475, 30398.696013039586], "value": 21437.668794303798, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.22580645161287, 407.8062920112945, 429.4052736959311, 432.597684153737, 436.9038811461479, 18741.437756867297, 19737.21051157954, 20273.39179824604, 20430.489237769063, 20483.590328193444, 19527.511812204666, 20017.099230534626, 20083.497912552193, 20689.68965465519, 20701.792982070176, 5804.187413762066, 6017.338092809788, 6022.187004754346, 6027.276726792791, 6030.788922387717, 4448.621867141297, 5943.881122377571, 5974.462298393144, 6732.629705366203, 6743.527953043289, 6659.7003134858805, 6809.250982391933, 6817.69320380584, 6828.283030281824, 6834.863302733942, 6607.3392660734025, 6735.528513004092, 6751.257361690235, 6755.0, 6766.763163289262, 5233.764480598345, 5532.5573954083575, 6027.638341699469, 6033.33633300341, 6037.577369584131, 13596.864031359757, 13678.726425471436, 13788.0, 13878.236696981661, 14520.128792272497, 2373.905043798246, 2398.2805158452393, 2405.723341815696, 2534.35373979634, 2541.771240588356, 10672.146228301717, 10757.246992710514, 10869.891301086967, 10909.618163364245, 11159.0, 2005.4986253436641, 2040.7857324891665, 2099.32821497121, 2130.946726331839, 2143.4641339665086, 74074.0, 74388.62805685992, 74944.25055749428, 75238.62380688117, 76802.61598692027, 11561.653150405502, 11946.820797688042, 12134.514619415124, 12143.635690929286, 12245.510179592717, 16977.91511042437, 16978.830211697972, 16983.23575439108, 16989.66020679604, 17047.659046818993, 8410.537420441935, 8967.87901512311, 8996.145366190201, 9129.535025543066, 9167.0, 8481.703140390056, 8492.193241642035, 8544.871826922601, 8667.566621669017, 8713.520756358334, 5011.0980023595375, 5044.142495775727, 5067.873303167376, 5199.064168449715, 5206.7917283309, 2056.969145462819, 2116.7565729941252, 2167.068160690918, 2191.8575292606247, 2197.648376259791, 461.42552522110185, 483.4657703237871, 948.7011591348703, 1054.1145437832258, 1097.6926460591046, 12212.389380530938, 12218.327991960528, 12948.417321220568, 13066.54267100647, 13170.341482925814, 518.9896202075937, 533.7838175538913, 536.2840607788646, 542.7313479827432, 554.5563549160655, 6688.29772873851, 6923.376896079377, 7031.437485001187, 7051.612161331073, 7113.0753002109395, 564698.0, 591351.0, 603288.0, 610217.0, 629300.0, 91955.0, 96406.51796740972, 96577.0, 97187.0, 98360.0, 507.17077578159973, 520.2898044169681, 521.3300908332774, 523.3353640876066, 524.1011664994553, 11662.475188616701, 11860.58487952952, 11961.461734221806, 11985.64043078709, 12077.818832717341, 41680.0, 41808.0, 42129.36805947852, 42147.3677894838, 42292.0, 59956.400435995085, 60743.39256607377, 60872.39127608667, 61112.0, 62232.37767622447, 8543.658253669784, 8640.308775298086, 8950.283977281671, 8974.955125224333, 9073.863892041756, 11496.942515287705, 12885.8067128995, 12985.675358115745, 13193.60419187426, 13524.797128043285, 11641.0, 11737.413129343327, 11836.58571950012, 11945.82081268799, 12051.638450846489, 11355.318680878843, 11428.885711143115, 11509.366984815915, 11528.250663706833, 11622.476988535705, 10944.288621239593, 11218.270812397168, 11227.831582526433, 11381.715457113307, 11580.884191158317, 8515.787105322168, 8542.0, 8600.956995214983, 8713.346499012472, 8722.953245610568, 10952.538002578198, 11146.609868654557, 11464.0, 11919.880801191877, 12114.75770484603], "value": 8791.649713922552, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1544.0, 1551.2786554252275, 1752.8948263104214, 1870.158428707082, 1900.0689662065593, 8654.74035778926, 9222.123898229675, 9228.0, 10008.549615267304, 10013.0988211061, 9169.31230157739, 9362.0, 9630.85553716693, 9649.131578157965, 9686.854697179548, 2494.0896572750953, 2555.910543130991, 2557.207265747624, 2559.6672432583737, 2560.5775047117204, 2420.891059902309, 2518.899244030237, 2524.9747502524924, 2525.6969163700383, 2529.7723204911554, 2510.5606518859126, 2510.9328535372483, 2525.9621105683427, 2527.2165628655175, 2543.36415896026, 2391.1869964212165, 2401.0515846240637, 2404.158544509425, 2408.5664580375524, 2414.28778510339, 2344.1326709117734, 2347.929562113139, 2357.9410514737096, 2361.4332560185603, 2395.7604239576076, 9662.13040826322, 9708.563114659786, 9747.268954828416, 9802.0, 9812.46031468269, 5711.657300561938, 5804.158397032449, 5825.621334613236, 5847.210626565402, 5848.4151584841175, 3568.518250036238, 3620.71034317254, 3665.9450108248398, 3693.445983102529, 3694.261147770457, 1145.673483057333, 1160.2226508239416, 1164.7728692904886, 1180.250540906522, 1193.9761204775943, 13846.100003499841, 14031.43874245029, 14050.43798248069, 14058.648533786738, 14081.295935203301, 4863.370770791754, 4961.875953101201, 4966.255061740696, 4975.651704380731, 5203.895922081613, 11763.294202347886, 11785.0, 11795.941020294844, 11798.764024719629, 11804.0, 5634.971825140848, 5650.29371328584, 5672.801451949162, 5677.489025987598, 5693.4875861172695, 4679.298105284234, 5173.3533308336455, 5277.472252774692, 5377.0, 5379.515843574097, 4300.688290071495, 4403.801828917706, 4485.102979404132, 4495.730256184639, 4512.887177820581, 1335.1788649980192, 1350.5070649212967, 1381.1022835157028, 1384.563862383346, 1386.3969173409598, 1029.7528593137592, 1052.3159946034984, 1053.1785207538132, 1076.5155679944057, 1077.9191560632985, 6532.542722009413, 6659.60042397448, 6771.762988295386, 6838.93161068383, 6893.241743408322, 478.9832355867528, 482.2645465664889, 494.21173228700167, 496.27543786072016, 498.4741098141423, 4578.725276483422, 4733.692309999839, 4751.64362672801, 4782.880427989258, 4796.952030479651, 11567.305961642329, 11940.0, 12003.63989080329, 12004.519819207135, 12019.399030048462, 11340.6030788922, 11809.291442513477, 11821.881781182077, 11954.342511161969, 12169.634910952685, 8819.338549608805, 9028.052054534443, 9035.864462033074, 9037.0, 9076.455412675261, 6597.373249541286, 6780.660966951731, 6852.0, 6872.484563657646, 6881.346272104142, 10991.890081099407, 11114.110871130128, 11136.777264454504, 11208.159388045766, 11229.943850280697, 10996.505157268102, 11101.722456938318, 11110.222284440011, 11352.205345625727, 11410.429478526206, 7817.648205830637, 8319.958400207961, 8533.0, 8572.142785721378, 8740.03859575459, 9511.57197926081, 9562.665306714232, 9568.76078098053, 9579.281553883347, 9586.808263834824, 8474.110218427222, 8601.784955376166, 8614.095519970313, 8658.56707164652, 8666.566671666518, 7872.84254314899, 8103.918960810316, 8207.179282071746, 8268.421210515206, 8345.290650294794, 7677.654505547375, 7711.575863327571, 7783.766487005399, 7793.337566306927, 7794.727184548514, 5561.0, 5626.606137570331, 5725.456081672234, 5813.331466881363, 5904.468597826216, 5754.798582049608, 5886.323072846678, 5924.733386997509, 5938.693487432758, 5954.612950158225], "value": 4985.53916268187, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.26530245647655, 359.65113839575633, 360.85385418905344, 364.9726270529711, 369.99445008324864, 5845.3570107288215, 5857.853553661155, 5865.413458654143, 5875.707344384239, 5916.7041647917595, 5616.241807356006, 5757.798477053304, 5773.797917072903, 5787.13193021047, 5859.44335288148, 4499.48255950565, 4531.977340113295, 4540.500544940054, 4546.977265113686, 4579.793909274091, 4531.909361812762, 4552.044070745147, 4568.269076947689, 4579.542045795427, 4587.1972404829185, 4524.547545245466, 4536.795844187003, 4544.136614043337, 4545.545445455461, 4550.97724511377, 4272.42322286492, 4445.777711114448, 4451.866444006685, 4452.866414007585, 4460.085682435093, 3939.665128464084, 3948.170884114311, 3950.617283950623, 3954.6272236657774, 3961.5840336764513, 5644.520215781664, 5647.661140331552, 5698.6580805151825, 5709.0, 5729.4843464088435, 5013.298138260647, 5159.7678104485385, 5182.300389447414, 5195.792168313263, 5228.79084836606, 6039.667818269993, 6056.5457590680435, 6085.878282434371, 6096.817095487098, 6149.477294429978, 4261.4460120184485, 4391.363252328394, 4393.538678438782, 4413.889652758675, 4415.536368681306, 6085.969570152165, 6242.781502647431, 6271.843203919893, 6276.184096067527, 6297.874042519124, 4414.84548040817, 4416.183006143874, 4418.889527761831, 4452.1763473757455, 4493.707908985905, 4542.364069030338, 4547.090581883636, 4555.794989225493, 4563.680542362003, 4567.634589232854, 4951.306817045616, 5191.844244672666, 5204.750859793622, 5233.2935053768015, 5236.9738151309, 6063.181470501426, 6083.300420451616, 6104.816855494342, 6143.262808463013, 6159.568830181934, 1567.639442928133, 1578.9605259868365, 1583.8020247469067, 1585.8572728454494, 1590.1810567557718, 957.6456711016968, 1011.5801942194054, 1013.4578000769553, 1013.8327176015874, 1022.7187523430968, 5257.76340064698, 5291.206319052096, 5298.0, 5312.867178320573, 5317.867053323698, 5521.723913804374, 5539.0, 5545.77816887328, 5600.327960644668, 5610.811783404475, 4950.128925223362, 5233.293505376725, 5268.710220937808, 5314.973425132927, 5328.92006619901, 2970.331675373067, 2973.784530524773, 2982.8359440230997, 2989.611350524418, 3007.29328607777, 5489.807856725075, 5660.33964036902, 5689.77240910359, 5695.743691533891, 5739.569532285095, 5590.357108932443, 5687.0, 5699.487046165865, 5699.715014249271, 5719.942800571941, 5745.770169193185, 5760.827175184667, 5770.989162532084, 5791.82624521265, 5821.126830975388, 5364.463553644604, 5501.862453438696, 5583.302087239095, 5599.80400685974, 5600.887982240414, 5442.619016668795, 5448.400675925565, 5487.259220005408, 5489.780408783764, 5509.228707980806, 6278.623282603058, 6538.757636049136, 6541.280459149585, 6584.835379115369, 6585.80242592723, 4445.777711114367, 4462.196804575207, 4505.5494450556, 4512.638988880816, 4541.091781643619, 6198.0, 6290.654014029273, 6331.240251169889, 6394.296627370893, 6431.421172094534, 6150.692465376803, 6173.938260617337, 6174.8147555573405, 6187.143856843019, 6212.782552610637, 5980.910286345621, 6159.969200153971, 6212.192414986023, 6219.47134493555, 6273.65494897785, 6152.938470615416, 6161.815145545641, 6163.907541386972, 6175.814725558241, 6192.0, 6239.376062393906, 6265.122882796321, 6275.717592708248, 6289.339619340087, 6313.0, 5705.942940570541, 6011.849703757441, 6042.395760423922, 6045.365236650088, 6052.515798736179], "value": 4530.758140779232, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [841.6254766628849, 841.6801615386156, 893.2362829780537, 905.1265528764743, 941.2564074381239, 13680.452781888725, 14943.028703134301, 14967.0, 15040.849591504082, 15137.772933405993, 14200.502982395617, 14362.0, 14453.494127705533, 14463.493777717782, 14500.347484363203, 874.846901792187, 879.2921698033081, 893.2452077994117, 898.4609234459305, 900.3922352412128, 895.234574438852, 902.8600566912106, 905.5381755304776, 908.0964440381829, 909.6088681866795, 952.8475443928972, 953.9904600953971, 956.9569369378395, 957.9329446938717, 960.2605993385089, 950.0974074629061, 950.2493030505892, 952.3190918493276, 952.5094576293214, 954.4607296877277, 704.7251571886968, 705.6365971524668, 706.2937062937064, 706.9257727938544, 707.4517249131964, 15472.5358239253, 15578.454754083552, 15605.765913511306, 15611.375544978187, 15630.531084067496, 14976.70046599062, 15593.220338983005, 15701.057936523845, 15847.286872090783, 15941.601459963478, 12237.938810305981, 12306.81539776904, 12389.93805030969, 12506.18709783861, 12671.49314027447, 4075.510938687347, 4092.570280120604, 4131.938020929689, 4167.395727619478, 4213.683973701954, 85499.57250213771, 85656.14343856544, 87235.0, 87310.56344718236, 87846.0, 11593.072554195644, 11669.183157178915, 11787.941060294816, 11809.23239989398, 11813.822792658117, 18757.249710011718, 18853.717194242097, 18921.62156756857, 18933.526661833563, 18985.0, 8283.792905177419, 8320.126386729427, 8473.152684731478, 8599.183077607617, 8691.0, 4935.827246046443, 4955.058538877602, 4966.478519755446, 5061.493850614909, 5103.642745007814, 4005.2189822984237, 4153.06556024892, 4153.626173644387, 4153.91692166155, 4162.1259535497275, 691.180950573572, 694.3820000199826, 709.1596458197052, 709.6097146569366, 715.3990647855826, 793.9483933544417, 797.2266901105918, 799.8560259153292, 819.8770184472257, 850.459957926721, 10007.949960250153, 10197.541110650038, 10397.903881405968, 10437.582496700199, 10684.198685098494, 727.5852763924618, 781.3397678961269, 798.2017982017982, 799.3165843204093, 832.063928080909, 4822.638302127354, 4873.122837889214, 4892.51074892515, 4912.803487860517, 4966.528179822911, 142179.28910355383, 143027.0, 144061.27969360087, 150018.24990874977, 150080.0, 122374.0, 127367.0, 128735.0, 129536.0, 131013.0, 110824.0, 111591.44204278926, 111805.0, 112412.0, 112621.436892815, 9587.808243834945, 9593.808123837345, 9659.758506037406, 9680.709578712649, 9707.320487565803, 53392.46607533875, 60046.0, 60458.697706511186, 60837.69581152066, 63153.0, 79546.6022669883, 85751.0, 91458.54270728603, 94496.0, 94936.52531737297, 13059.21644701321, 13192.934035329761, 13405.195688258736, 13413.86586134126, 13788.034837561676, 13852.16886986784, 14101.717965640835, 14354.85645143577, 14441.5532921962, 14485.565433037025, 12623.93688031554, 13140.145890517086, 13252.469901203844, 13310.0, 13386.665333366744, 12567.937160314506, 12654.557090502156, 12689.492420303453, 12829.42267597979, 12914.966802655952, 12837.807432888327, 12858.421371038512, 12974.935125324691, 13118.147320424141, 13133.60599182026, 10692.89307106919, 10697.304675196086, 10859.891401085888, 10960.397178154959, 11364.261323013978, 10824.891751082389, 11284.32294062359, 11299.209055366375, 11438.714032149262, 11445.484953177294], "value": 8101.391474035812, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1502.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 111.0, 103.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 132.0, 143.0, 185.0, 116.0, 148.0, 146.0, 123.0, 181.0, 117.0], "value": 143.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 161.0, 162.0, 162.0, 160.0, 161.0, 163.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 175.0, 75.0, 74.0, 76.0, 75.0, 180.0, 75.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 141.0, 83.0, 84.0, 84.0, 138.0, 83.0, 83.0, 144.0], "value": 100.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 145.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 52.0, 52.0, 53.0, 58.0, 53.0, 52.0, 52.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0, 59.0, 69.0, 59.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 72.0, 81.0, 73.0, 72.0, 72.0, 78.0, 74.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 127.0, 120.0, 116.0, 128.0, 140.0, 120.0, 153.0, 123.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 160.0, 158.0, 152.0, 156.0, 155.0, 160.0, 154.0, 154.0, 150.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 62.0, 70.0, 61.0, 65.0, 61.0, 62.0, 61.0, 61.0], "value": 64.6, "unit": "score"}]}]} 22:58:45 INFO - Return code: 0 22:58:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:58:45 ERROR - # TBPL SUCCESS # 22:58:45 INFO - Running post-action listener: _resource_record_post_action 22:58:45 INFO - [mozharness: 2016-09-22 05:58:45.096186Z] Finished run-tests step (success) 22:58:45 INFO - Running post-run listener: _resource_record_post_run 22:58:45 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 289067008; Read time: 0; Write time: 217228 22:58:45 INFO - TinderboxPrint: CPU usage
13.2% 22:58:45 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:58:45 INFO - TinderboxPrint: I/O write bytes / time
289,067,008 / 217,228 22:58:45 INFO - TinderboxPrint: CPU idle
8,204.2 (86.8%) 22:58:45 INFO - TinderboxPrint: CPU user
1,198.4 (12.7%) 22:58:45 INFO - TinderboxPrint: Swap in / out
0 / 0 22:58:45 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 71245824; Read time: 0; Write time: 46236 22:58:45 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 217821184; Read time: 0; Write time: 170992 22:58:45 INFO - Running post-run listener: _upload_blobber_files 22:58:45 INFO - Blob upload gear active. 22:58:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:58:45 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 22:58:45 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'] 22:58:45 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 22:58:46 INFO - (blobuploader) - INFO - Open directory for files ... 22:58:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:58:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:58:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:58:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:58:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:58:47 INFO - (blobuploader) - INFO - Done attempting. 22:58:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:58:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:58:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:58:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:58:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:58:48 INFO - (blobuploader) - INFO - Done attempting. 22:58:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:58:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:58:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:58:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:58:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:58:51 INFO - (blobuploader) - INFO - Done attempting. 22:58:51 INFO - (blobuploader) - INFO - Iteration through files over. 22:58:51 INFO - Return code: 0 22:58:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:58:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:58:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5d84d153933881af61046a92889471af83319e4646a5be0e58b1c583ec106f262116c9c4fc5910e8d23f6125458c7bb172ed6e5a54d508251f0e85e58eb22592", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b0c4698d34502d72fb758596dd1603293ee48f569f0a947980cec0735842a741683c0d29a6da09de0605f743aa6c3cff242cad5814fd1dbacb06c80add9cf1e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29280db7c5445fd8ce6831fb4b16091a6e894ed710b59814914e08e66e4986c0ce3d52de915b2f385f13b5cb3074859de2eb5f1b24bfeb8efca8a5e61fd2429d"} 22:58:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:58:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:58:51 INFO - Contents: 22:58:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5d84d153933881af61046a92889471af83319e4646a5be0e58b1c583ec106f262116c9c4fc5910e8d23f6125458c7bb172ed6e5a54d508251f0e85e58eb22592", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b0c4698d34502d72fb758596dd1603293ee48f569f0a947980cec0735842a741683c0d29a6da09de0605f743aa6c3cff242cad5814fd1dbacb06c80add9cf1e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29280db7c5445fd8ce6831fb4b16091a6e894ed710b59814914e08e66e4986c0ce3d52de915b2f385f13b5cb3074859de2eb5f1b24bfeb8efca8a5e61fd2429d"} 22:58:51 INFO - Running post-run listener: copy_logs_to_upload_dir 22:58:51 INFO - Copying logs to upload dir... 22:58:51 INFO - mkdir: /builds/slave/test/build/upload/logs 22:58:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1673.083282 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 53 secs) (at 2016-09-21 22:58:51.641859) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 22:58:51.645192) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291 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/5d84d153933881af61046a92889471af83319e4646a5be0e58b1c583ec106f262116c9c4fc5910e8d23f6125458c7bb172ed6e5a54d508251f0e85e58eb22592", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b0c4698d34502d72fb758596dd1603293ee48f569f0a947980cec0735842a741683c0d29a6da09de0605f743aa6c3cff242cad5814fd1dbacb06c80add9cf1e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29280db7c5445fd8ce6831fb4b16091a6e894ed710b59814914e08e66e4986c0ce3d52de915b2f385f13b5cb3074859de2eb5f1b24bfeb8efca8a5e61fd2429d"} build_url:https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/artifacts/public/build/firefox-50.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011375 build_url: 'https://queue.taskcluster.net/v1/task/YNTR7x_VSh-dPD5WEic86g/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/5d84d153933881af61046a92889471af83319e4646a5be0e58b1c583ec106f262116c9c4fc5910e8d23f6125458c7bb172ed6e5a54d508251f0e85e58eb22592", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b0c4698d34502d72fb758596dd1603293ee48f569f0a947980cec0735842a741683c0d29a6da09de0605f743aa6c3cff242cad5814fd1dbacb06c80add9cf1e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/29280db7c5445fd8ce6831fb4b16091a6e894ed710b59814914e08e66e4986c0ce3d52de915b2f385f13b5cb3074859de2eb5f1b24bfeb8efca8a5e61fd2429d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 22:58:51.670730) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 22:58:51.671074) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1474520804.419686-567432291 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 22:58:51.753684) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 22:58:51.754017) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 22:58:51.754352) ========= ========= Total master_lag: 0.17 =========