builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1461248724.37 results: success (0) buildid: 20160421060426 builduid: 2f75b451552b41d5a81a70d69e0cfd47 revision: 1152d99d8c53ac9dae371a6e6d9fab03d3f98697 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:24.372763) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:24.373671) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:24.373952) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:24.390945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:24.391416) ========= 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=41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 07:25:24-- 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% 228M=0s 2016-04-21 07:25:24 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105938 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:24.512596) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:24.513109) ========= 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=41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020131 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:24.565497) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:24.566060) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1152d99d8c53ac9dae371a6e6d9fab03d3f98697 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1152d99d8c53ac9dae371a6e6d9fab03d3f98697 --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=41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 07:25:25,123 truncating revision to first 12 chars 2016-04-21 07:25:25,123 Setting DEBUG logging. 2016-04-21 07:25:25,123 attempt 1/10 2016-04-21 07:25:25,123 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1152d99d8c53?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 07:25:25,385 unpacking tar archive at: mozilla-central-1152d99d8c53/testing/mozharness/ program finished with exit code 0 elapsedTime=0.562836 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:25.144128) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:25.144634) ========= script_repo_revision: 1152d99d8c53ac9dae371a6e6d9fab03d3f98697 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:25.145225) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:25.145637) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 07:25:25.157723) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-21 07:25:25.158329) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:25:25 INFO - MultiFileLogger online at 20160421 07:25:25 in /builds/slave/test 07:25:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:25:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:25:25 INFO - {'append_to_log': False, 07:25:25 INFO - 'base_work_dir': '/builds/slave/test', 07:25:25 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:25:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:25:25 INFO - 'branch': 'Firefox-Non-PGO', 07:25:25 INFO - 'buildbot_json_path': 'buildprops.json', 07:25:25 INFO - 'config_files': ('talos/linux_config.py',), 07:25:25 INFO - 'default_actions': ('clobber', 07:25:25 INFO - 'read-buildbot-config', 07:25:25 INFO - 'download-and-extract', 07:25:25 INFO - 'populate-webroot', 07:25:25 INFO - 'create-virtualenv', 07:25:25 INFO - 'install', 07:25:25 INFO - 'run-tests'), 07:25:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:25:25 INFO - 'download_minidump_stackwalk': True, 07:25:25 INFO - 'download_symbols': 'ondemand', 07:25:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:25:25 INFO - 'tooltool.py': '/tools/tooltool.py', 07:25:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:25:25 INFO - '/tools/misc-python/virtualenv.py')}, 07:25:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:25:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:25:25 INFO - 'installer_path': 'installer.exe', 07:25:25 INFO - 'log_level': 'info', 07:25:25 INFO - 'log_name': 'talos', 07:25:25 INFO - 'log_to_console': True, 07:25:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:25:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:25:25 INFO - 'opt_config_files': (), 07:25:25 INFO - 'pip_index': False, 07:25:25 INFO - 'sps_profile': False, 07:25:25 INFO - 'sps_profile_interval': 0, 07:25:25 INFO - 'suite': 'dromaeojs', 07:25:25 INFO - 'system_bits': '32', 07:25:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:25:25 INFO - 'title': 'talos-linux64-ix-026', 07:25:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:25:25 INFO - 'use_talos_json': True, 07:25:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:25:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:25:25 INFO - 'work_dir': 'build'} 07:25:25 INFO - ##### 07:25:25 INFO - ##### Running clobber step. 07:25:25 INFO - ##### 07:25:25 INFO - Running pre-action listener: _resource_record_pre_action 07:25:25 INFO - Running main action method: clobber 07:25:25 INFO - rmtree: /builds/slave/test/build 07:25:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:25:26 INFO - Running post-action listener: _resource_record_post_action 07:25:26 INFO - ##### 07:25:26 INFO - ##### Running read-buildbot-config step. 07:25:26 INFO - ##### 07:25:26 INFO - Running pre-action listener: _resource_record_pre_action 07:25:26 INFO - Running main action method: read_buildbot_config 07:25:26 INFO - Using buildbot properties: 07:25:26 INFO - { 07:25:26 INFO - "project": "", 07:25:26 INFO - "product": "firefox", 07:25:26 INFO - "script_repo_revision": "production", 07:25:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:25:26 INFO - "repository": "", 07:25:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:25:26 INFO - "buildid": "20160421060426", 07:25:26 INFO - "pgo_build": "False", 07:25:26 INFO - "basedir": "/builds/slave/test", 07:25:26 INFO - "buildnumber": 480, 07:25:26 INFO - "slavename": "talos-linux64-ix-026", 07:25:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:25:26 INFO - "platform": "ubuntu64_hw", 07:25:26 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:25:26 INFO - "branch": "mozilla-central", 07:25:26 INFO - "repo_path": "mozilla-central", 07:25:26 INFO - "revision": "1152d99d8c53ac9dae371a6e6d9fab03d3f98697", 07:25:26 INFO - "stage_platform": "linux64", 07:25:26 INFO - "builduid": "2f75b451552b41d5a81a70d69e0cfd47", 07:25:26 INFO - "slavebuilddir": "test" 07:25:26 INFO - } 07:25:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 07:25:26 INFO - Running post-action listener: _resource_record_post_action 07:25:26 INFO - ##### 07:25:26 INFO - ##### Running download-and-extract step. 07:25:26 INFO - ##### 07:25:26 INFO - Running pre-action listener: _resource_record_pre_action 07:25:26 INFO - Running main action method: download_and_extract 07:25:26 INFO - mkdir: /builds/slave/test/build/tests 07:25:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:26 INFO - https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:25:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:25:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:25:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:25:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:25:27 INFO - Downloaded 1361 bytes. 07:25:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 07:25:27 INFO - Using the following test package requirements: 07:25:27 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:25:27 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:25:27 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:25:27 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:27 INFO - u'jsshell-linux-x86_64.zip'], 07:25:27 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:25:27 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 07:25:27 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:25:27 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:25:27 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:25:27 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 07:25:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:25:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:25:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:27 INFO - https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:25:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:25:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:25:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:25:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:25:31 INFO - Downloaded 22274940 bytes. 07:25:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:25:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:25:32 INFO - Return code: 0 07:25:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:25:32 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')]} 07:25:32 INFO - https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:25:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:25:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:25:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 07:25:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:25:37 INFO - Downloaded 22274940 bytes. 07:25:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:25:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:25:38 INFO - Return code: 0 07:25:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:38 INFO - https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:25:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:25:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:25:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 07:25:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:25:39 INFO - Downloaded 10845952 bytes. 07:25:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:25:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:25:39 INFO - Return code: 0 07:25:39 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')]} 07:25:39 INFO - https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:25:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:25:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:25:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:25:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:25:41 INFO - Downloaded 54611704 bytes. 07:25:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:25:41 INFO - mkdir: /builds/slave/test/properties 07:25:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:25:41 INFO - Writing to file /builds/slave/test/properties/build_url 07:25:41 INFO - Contents: 07:25:41 INFO - build_url:https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 07:25:42 INFO - Running post-action listener: _resource_record_post_action 07:25:42 INFO - Running post-action listener: set_extra_try_arguments 07:25:42 INFO - ##### 07:25:42 INFO - ##### Running populate-webroot step. 07:25:42 INFO - ##### 07:25:42 INFO - Running pre-action listener: _resource_record_pre_action 07:25:42 INFO - Running main action method: populate_webroot 07:25:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:25:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:25:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:25:42 INFO - '--tppagecycles', 07:25:42 INFO - '7'], 07:25:42 INFO - 'tests': ['tsvgm']}}, 07:25:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:25:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:25:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:25:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:25:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:25:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:25:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:42 INFO - 'talos_options': ['--disable-e10s'], 07:25:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:25:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:25:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:42 INFO - 'talos_options': ['--disable-e10s'], 07:25:42 INFO - 'tests': ['damp', 'tps']}, 07:25:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:42 INFO - 'tests': ['damp', 'tps']}, 07:25:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:25:42 INFO - 'tests': ['dromaeo_dom']}, 07:25:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:25:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:25:42 INFO - 'tests': ['a11yr', 07:25:42 INFO - 'ts_paint', 07:25:42 INFO - 'tpaint', 07:25:42 INFO - 'sessionrestore', 07:25:42 INFO - 'sessionrestore_no_auto_restore', 07:25:42 INFO - 'tabpaint']}, 07:25:42 INFO - 'other-e10s': {'tests': ['a11yr', 07:25:42 INFO - 'ts_paint', 07:25:42 INFO - 'tpaint', 07:25:42 INFO - 'sessionrestore', 07:25:42 INFO - 'sessionrestore_no_auto_restore', 07:25:42 INFO - 'tabpaint']}, 07:25:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:25:42 INFO - 'ts_paint', 07:25:42 INFO - 'tpaint', 07:25:42 INFO - 'sessionrestore', 07:25:42 INFO - 'sessionrestore_no_auto_restore', 07:25:42 INFO - 'tabpaint']}, 07:25:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:25:42 INFO - 'ts_paint', 07:25:42 INFO - 'tpaint', 07:25:42 INFO - 'sessionrestore', 07:25:42 INFO - 'sessionrestore_no_auto_restore', 07:25:42 INFO - 'tabpaint']}, 07:25:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:25:42 INFO - 'tests': ['a11yr', 07:25:42 INFO - 'ts_paint', 07:25:42 INFO - 'tpaint', 07:25:42 INFO - 'sessionrestore', 07:25:42 INFO - 'sessionrestore_no_auto_restore', 07:25:42 INFO - 'tabpaint']}, 07:25:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:25:42 INFO - 'tests': ['a11yr', 07:25:42 INFO - 'ts_paint', 07:25:42 INFO - 'tpaint', 07:25:42 INFO - 'sessionrestore', 07:25:42 INFO - 'sessionrestore_no_auto_restore', 07:25:42 INFO - 'tabpaint']}, 07:25:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:25:42 INFO - 'tests': ['tsvgx', 07:25:42 INFO - 'tsvgr_opacity', 07:25:42 INFO - 'tart', 07:25:42 INFO - 'tscrollx', 07:25:42 INFO - 'cart']}, 07:25:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:25:42 INFO - 'tsvgr_opacity', 07:25:42 INFO - 'tart', 07:25:42 INFO - 'tscrollx', 07:25:42 INFO - 'cart']}, 07:25:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:42 INFO - 'talos_options': ['--disable-e10s'], 07:25:42 INFO - 'tests': ['tp5o']}, 07:25:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:42 INFO - 'tests': ['tp5o']}, 07:25:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:42 INFO - 'talos_options': ['--disable-e10s', 07:25:42 INFO - '--xperf_path', 07:25:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:25:42 INFO - 'tests': ['tp5n']}, 07:25:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:25:42 INFO - 'talos_options': ['--xperf_path', 07:25:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:25:42 INFO - 'tests': ['tp5n']}}, 07:25:42 INFO - 'talos.zip': {'path': '', 07:25:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:25:42 INFO - Running post-action listener: _resource_record_post_action 07:25:42 INFO - ##### 07:25:42 INFO - ##### Running create-virtualenv step. 07:25:42 INFO - ##### 07:25:42 INFO - Running pre-action listener: _resource_record_pre_action 07:25:42 INFO - Running main action method: create_virtualenv 07:25:42 INFO - Creating virtualenv /builds/slave/test/build/venv 07:25:42 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 07:25:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:25:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:25:42 INFO - Using real prefix '/usr' 07:25:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:25:43 INFO - Installing distribute.............................................................................................................................................................................................done. 07:25:45 INFO - Installing pip.................done. 07:25:45 INFO - Return code: 0 07:25:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:25: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')]} 07:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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')]} 07:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff56aa40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b1410>, '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 0x14b2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b27a0>, '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': '41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965', '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 07:25: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', 'pip>=1.5'] in /builds/slave/test/build 07:25: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 pip>=1.5 07:25:45 INFO - Using env: {'DISPLAY': ':0', 07:25:45 INFO - 'HOME': '/home/cltbld', 07:25:45 INFO - 'LANG': 'en_US.UTF-8', 07:25:45 INFO - 'LANGUAGE': 'en_US:en', 07:25:45 INFO - 'LOGNAME': 'cltbld', 07:25:45 INFO - 'MAIL': '/var/mail/cltbld', 07:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:45 INFO - 'MOZ_NO_REMOTE': '1', 07:25:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:45 INFO - 'NO_EM_RESTART': '1', 07:25:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:45 INFO - 'PWD': '/builds/slave/test', 07:25:45 INFO - 'SHELL': '/bin/bash', 07:25:45 INFO - 'SHLVL': '1', 07:25:45 INFO - 'TERM': 'linux', 07:25:45 INFO - 'TMOUT': '86400', 07:25:45 INFO - 'USER': 'cltbld', 07:25:45 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965', 07:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:45 INFO - '_': '/tools/buildbot/bin/python'} 07:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:45 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 07:25:45 INFO - Cleaning up... 07:25:45 INFO - Return code: 0 07:25:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:25: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')]} 07:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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')]} 07:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff56aa40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b1410>, '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 0x14b2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b27a0>, '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': '41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965', '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 07:25: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', 'psutil>=0.7.1'] in /builds/slave/test/build 07:25: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 psutil>=0.7.1 07:25:45 INFO - Using env: {'DISPLAY': ':0', 07:25:45 INFO - 'HOME': '/home/cltbld', 07:25:45 INFO - 'LANG': 'en_US.UTF-8', 07:25:45 INFO - 'LANGUAGE': 'en_US:en', 07:25:45 INFO - 'LOGNAME': 'cltbld', 07:25:45 INFO - 'MAIL': '/var/mail/cltbld', 07:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:45 INFO - 'MOZ_NO_REMOTE': '1', 07:25:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:45 INFO - 'NO_EM_RESTART': '1', 07:25:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:45 INFO - 'PWD': '/builds/slave/test', 07:25:45 INFO - 'SHELL': '/bin/bash', 07:25:45 INFO - 'SHLVL': '1', 07:25:45 INFO - 'TERM': 'linux', 07:25:45 INFO - 'TMOUT': '86400', 07:25:45 INFO - 'USER': 'cltbld', 07:25:45 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965', 07:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:45 INFO - '_': '/tools/buildbot/bin/python'} 07:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:45 INFO - Downloading/unpacking psutil>=0.7.1 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:25:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:47 INFO - Installing collected packages: psutil 07:25:47 INFO - Running setup.py install for psutil 07:25:47 INFO - building 'psutil._psutil_linux' extension 07:25:47 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 07:25:47 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 07:25:47 INFO - building 'psutil._psutil_posix' extension 07:25:47 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 07:25:48 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 07:25:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:25:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:25:48 INFO - Successfully installed psutil 07:25:48 INFO - Cleaning up... 07:25:48 INFO - Return code: 0 07:25:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:25: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')]} 07:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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')]} 07:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25: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', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff56aa40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b1410>, '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 0x14b2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b27a0>, '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': '41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965', '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 07:25: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:25: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 mozsystemmonitor==0.0.0 07:25:48 INFO - Using env: {'DISPLAY': ':0', 07:25:48 INFO - 'HOME': '/home/cltbld', 07:25:48 INFO - 'LANG': 'en_US.UTF-8', 07:25:48 INFO - 'LANGUAGE': 'en_US:en', 07:25:48 INFO - 'LOGNAME': 'cltbld', 07:25:48 INFO - 'MAIL': '/var/mail/cltbld', 07:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:48 INFO - 'MOZ_NO_REMOTE': '1', 07:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:48 INFO - 'NO_EM_RESTART': '1', 07:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:48 INFO - 'PWD': '/builds/slave/test', 07:25:48 INFO - 'SHELL': '/bin/bash', 07:25:48 INFO - 'SHLVL': '1', 07:25:48 INFO - 'TERM': 'linux', 07:25:48 INFO - 'TMOUT': '86400', 07:25:48 INFO - 'USER': 'cltbld', 07:25:48 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965', 07:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:48 INFO - '_': '/tools/buildbot/bin/python'} 07:25:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:25:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:25:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:25:50 INFO - Installing collected packages: mozsystemmonitor 07:25:50 INFO - Running setup.py install for mozsystemmonitor 07:25:50 INFO - Successfully installed mozsystemmonitor 07:25:50 INFO - Cleaning up... 07:25:50 INFO - Return code: 0 07:25:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:50 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 0x7ff56aa40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b1410>, '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 0x14b2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b27a0>, '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': '41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965', '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 07:25:50 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 07:25:50 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 07:25:50 INFO - Using env: {'DISPLAY': ':0', 07:25:50 INFO - 'HOME': '/home/cltbld', 07:25:50 INFO - 'LANG': 'en_US.UTF-8', 07:25:50 INFO - 'LANGUAGE': 'en_US:en', 07:25:50 INFO - 'LOGNAME': 'cltbld', 07:25:50 INFO - 'MAIL': '/var/mail/cltbld', 07:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:50 INFO - 'MOZ_NO_REMOTE': '1', 07:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:50 INFO - 'NO_EM_RESTART': '1', 07:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:50 INFO - 'PWD': '/builds/slave/test', 07:25:50 INFO - 'SHELL': '/bin/bash', 07:25:50 INFO - 'SHLVL': '1', 07:25:50 INFO - 'TERM': 'linux', 07:25:50 INFO - 'TMOUT': '86400', 07:25:50 INFO - 'USER': 'cltbld', 07:25:50 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965', 07:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:50 INFO - '_': '/tools/buildbot/bin/python'} 07:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:50 INFO - Downloading/unpacking blobuploader==1.2.4 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25: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 07:25:52 INFO - Downloading blobuploader-1.2.4.tar.gz 07:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:25:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:25:52 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 07:25:52 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 07:25:52 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 07:25:52 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 07:25:52 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 07:25:52 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 07:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:25:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:25:53 INFO - Downloading docopt-0.6.1.tar.gz 07:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:25:53 INFO - Installing collected packages: blobuploader, requests, docopt 07:25:53 INFO - Running setup.py install for blobuploader 07:25:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:25:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:25:53 INFO - Running setup.py install for requests 07:25:53 INFO - Running setup.py install for docopt 07:25:53 INFO - Successfully installed blobuploader requests docopt 07:25:53 INFO - Cleaning up... 07:25:54 INFO - Return code: 0 07:25:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:54 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 0x7ff56aa40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b1410>, '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 0x14b2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b27a0>, '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': '41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965', '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 07:25:54 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 07:25:54 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 07:25:54 INFO - Using env: {'DISPLAY': ':0', 07:25:54 INFO - 'HOME': '/home/cltbld', 07:25:54 INFO - 'LANG': 'en_US.UTF-8', 07:25:54 INFO - 'LANGUAGE': 'en_US:en', 07:25:54 INFO - 'LOGNAME': 'cltbld', 07:25:54 INFO - 'MAIL': '/var/mail/cltbld', 07:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:54 INFO - 'MOZ_NO_REMOTE': '1', 07:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:54 INFO - 'NO_EM_RESTART': '1', 07:25:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:54 INFO - 'PWD': '/builds/slave/test', 07:25:54 INFO - 'SHELL': '/bin/bash', 07:25:54 INFO - 'SHLVL': '1', 07:25:54 INFO - 'TERM': 'linux', 07:25:54 INFO - 'TMOUT': '86400', 07:25:54 INFO - 'USER': 'cltbld', 07:25:54 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965', 07:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:54 INFO - '_': '/tools/buildbot/bin/python'} 07:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:54 INFO - Running setup.py (path:/tmp/pip-GumKfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:54 INFO - Running setup.py (path:/tmp/pip-eqTIMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:54 INFO - Running setup.py (path:/tmp/pip-Rrox_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:54 INFO - Running setup.py (path:/tmp/pip-GDAGVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:54 INFO - Running setup.py (path:/tmp/pip-pYeDZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:54 INFO - Running setup.py (path:/tmp/pip-hM9I__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:54 INFO - Running setup.py (path:/tmp/pip-hTbPJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:54 INFO - Running setup.py (path:/tmp/pip-VBQSkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:54 INFO - Running setup.py (path:/tmp/pip-b8PV2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:54 INFO - Running setup.py (path:/tmp/pip-7tX0DQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:54 INFO - Running setup.py (path:/tmp/pip-FsUsXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:55 INFO - Running setup.py (path:/tmp/pip-A_ozyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:55 INFO - Running setup.py (path:/tmp/pip-5qkriU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:55 INFO - Running setup.py (path:/tmp/pip-7rP6Hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:55 INFO - Running setup.py (path:/tmp/pip-tTp3oM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:55 INFO - Running setup.py (path:/tmp/pip-szPd6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:55 INFO - Running setup.py (path:/tmp/pip-FNocqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:25:55 INFO - Running setup.py install for manifestparser 07:25:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:25:55 INFO - Running setup.py install for mozcrash 07:25:55 INFO - Running setup.py install for mozdebug 07:25:55 INFO - Running setup.py install for mozdevice 07:25:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:25:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:25:55 INFO - Running setup.py install for mozfile 07:25:55 INFO - Running setup.py install for mozhttpd 07:25:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:25:56 INFO - Running setup.py install for mozinfo 07:25:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:25:56 INFO - Running setup.py install for mozInstall 07:25:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:25:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:25:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:25:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:25:56 INFO - Running setup.py install for mozleak 07:25:56 INFO - Running setup.py install for mozlog 07:25:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:25:56 INFO - Running setup.py install for moznetwork 07:25:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:25:56 INFO - Running setup.py install for mozprocess 07:25:56 INFO - Running setup.py install for mozprofile 07:25:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:25:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:25:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:25:56 INFO - Running setup.py install for mozrunner 07:25:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:25:56 INFO - Running setup.py install for mozscreenshot 07:25:57 INFO - Running setup.py install for moztest 07:25:57 INFO - Running setup.py install for mozversion 07:25:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:25:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:25:57 INFO - Cleaning up... 07:25:57 INFO - Return code: 0 07:25:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:25:57 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')]} 07:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:57 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')]} 07:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:25:57 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 0x7ff56aa40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b1410>, '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 0x14b2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b27a0>, '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': '41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965', '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 07:25:57 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 07:25:57 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 07:25:57 INFO - Using env: {'DISPLAY': ':0', 07:25:57 INFO - 'HOME': '/home/cltbld', 07:25:57 INFO - 'LANG': 'en_US.UTF-8', 07:25:57 INFO - 'LANGUAGE': 'en_US:en', 07:25:57 INFO - 'LOGNAME': 'cltbld', 07:25:57 INFO - 'MAIL': '/var/mail/cltbld', 07:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:25:57 INFO - 'MOZ_NO_REMOTE': '1', 07:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:25:57 INFO - 'NO_EM_RESTART': '1', 07:25:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:25:57 INFO - 'PWD': '/builds/slave/test', 07:25:57 INFO - 'SHELL': '/bin/bash', 07:25:57 INFO - 'SHLVL': '1', 07:25:57 INFO - 'TERM': 'linux', 07:25:57 INFO - 'TMOUT': '86400', 07:25:57 INFO - 'USER': 'cltbld', 07:25:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965', 07:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:25:57 INFO - '_': '/tools/buildbot/bin/python'} 07:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:25:57 INFO - Running setup.py (path:/tmp/pip-l6a_LQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:25:57 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)) 07:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:25:57 INFO - Running setup.py (path:/tmp/pip-OLEaa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:25:57 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)) 07:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:25:57 INFO - Running setup.py (path:/tmp/pip-8pFREN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:25:57 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)) 07:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:25:57 INFO - Running setup.py (path:/tmp/pip-0bnLIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:25:57 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)) 07:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:25:57 INFO - Running setup.py (path:/tmp/pip-Gbk0sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:25:57 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)) 07:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:25:57 INFO - Running setup.py (path:/tmp/pip-u_yw1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:25:57 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)) 07:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:25:57 INFO - Running setup.py (path:/tmp/pip-Fx65bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:25:57 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)) 07:25:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:25:57 INFO - Running setup.py (path:/tmp/pip-51CiM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:25:58 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)) 07:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:25:58 INFO - Running setup.py (path:/tmp/pip-B9ALMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:25:58 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)) 07:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:25:58 INFO - Running setup.py (path:/tmp/pip-uB3mjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:25:58 INFO - Running setup.py (path:/tmp/pip-jGKE7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:25:58 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)) 07:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:25:58 INFO - Running setup.py (path:/tmp/pip-yX0dEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:25:58 INFO - Running setup.py (path:/tmp/pip-zu8ukz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:25:58 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)) 07:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:25:58 INFO - Running setup.py (path:/tmp/pip-ZDqbxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:58 INFO - Running setup.py (path:/tmp/pip-Nwed0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:25:58 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)) 07:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:25:58 INFO - Running setup.py (path:/tmp/pip-fXRHnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:25:58 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)) 07:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:25:58 INFO - Running setup.py (path:/tmp/pip-IfAUFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:25:58 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)) 07:25:58 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)) 07:25:58 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)) 07:25:58 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)) 07:25:58 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)) 07:25:58 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)) 07:25:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:25:58 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 07:25:58 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 07:25:58 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 07:25:58 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 07:25:58 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 07:25:58 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 07:26:00 INFO - Downloading blessings-1.6.tar.gz 07:26:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:26:00 INFO - Installing collected packages: blessings 07:26:00 INFO - Running setup.py install for blessings 07:26:00 INFO - Successfully installed blessings 07:26:00 INFO - Cleaning up... 07:26:00 INFO - Return code: 0 07:26:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:26:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:26:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:26:01 INFO - Reading from file tmpfile_stdout 07:26:01 INFO - Current package versions: 07:26:01 INFO - argparse == 1.2.1 07:26:01 INFO - blessings == 1.6 07:26:01 INFO - blobuploader == 1.2.4 07:26:01 INFO - docopt == 0.6.1 07:26:01 INFO - manifestparser == 1.1 07:26:01 INFO - mozInstall == 1.12 07:26:01 INFO - mozcrash == 0.17 07:26:01 INFO - mozdebug == 0.1 07:26:01 INFO - mozdevice == 0.48 07:26:01 INFO - mozfile == 1.2 07:26:01 INFO - mozhttpd == 0.7 07:26:01 INFO - mozinfo == 0.9 07:26:01 INFO - mozleak == 0.1 07:26:01 INFO - mozlog == 3.1 07:26:01 INFO - moznetwork == 0.27 07:26:01 INFO - mozprocess == 0.22 07:26:01 INFO - mozprofile == 0.28 07:26:01 INFO - mozrunner == 6.11 07:26:01 INFO - mozscreenshot == 0.1 07:26:01 INFO - mozsystemmonitor == 0.0 07:26:01 INFO - moztest == 0.7 07:26:01 INFO - mozversion == 1.4 07:26:01 INFO - psutil == 3.1.1 07:26:01 INFO - requests == 1.2.3 07:26:01 INFO - wsgiref == 0.1.2 07:26:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:01 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 0x7ff56aa40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b1410>, '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 0x14b2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b27a0>, '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': '41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965', '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 07:26:01 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 07:26:01 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 07:26:01 INFO - Using env: {'DISPLAY': ':0', 07:26:01 INFO - 'HOME': '/home/cltbld', 07:26:01 INFO - 'LANG': 'en_US.UTF-8', 07:26:01 INFO - 'LANGUAGE': 'en_US:en', 07:26:01 INFO - 'LOGNAME': 'cltbld', 07:26:01 INFO - 'MAIL': '/var/mail/cltbld', 07:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:01 INFO - 'MOZ_NO_REMOTE': '1', 07:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:01 INFO - 'NO_EM_RESTART': '1', 07:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:01 INFO - 'PWD': '/builds/slave/test', 07:26:01 INFO - 'SHELL': '/bin/bash', 07:26:01 INFO - 'SHLVL': '1', 07:26:01 INFO - 'TERM': 'linux', 07:26:01 INFO - 'TMOUT': '86400', 07:26:01 INFO - 'USER': 'cltbld', 07:26:01 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965', 07:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:01 INFO - '_': '/tools/buildbot/bin/python'} 07:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:01 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)) 07:26:01 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)) 07:26:01 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)) 07:26:01 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)) 07:26:01 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)) 07:26:01 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)) 07:26:01 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)) 07:26:01 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)) 07:26:01 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)) 07:26:01 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)) 07:26:01 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)) 07:26:01 INFO - Cleaning up... 07:26:01 INFO - Return code: 0 07:26:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff56aa40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b1410>, '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 0x14b2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b27a0>, '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': '41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965', '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 07:26:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:26:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:26:01 INFO - Using env: {'DISPLAY': ':0', 07:26:01 INFO - 'HOME': '/home/cltbld', 07:26:01 INFO - 'LANG': 'en_US.UTF-8', 07:26:01 INFO - 'LANGUAGE': 'en_US:en', 07:26:01 INFO - 'LOGNAME': 'cltbld', 07:26:01 INFO - 'MAIL': '/var/mail/cltbld', 07:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:01 INFO - 'MOZ_NO_REMOTE': '1', 07:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:01 INFO - 'NO_EM_RESTART': '1', 07:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:01 INFO - 'PWD': '/builds/slave/test', 07:26:01 INFO - 'SHELL': '/bin/bash', 07:26:01 INFO - 'SHLVL': '1', 07:26:01 INFO - 'TERM': 'linux', 07:26:01 INFO - 'TMOUT': '86400', 07:26:01 INFO - 'USER': 'cltbld', 07:26:01 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965', 07:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:01 INFO - '_': '/tools/buildbot/bin/python'} 07:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:01 INFO - Downloading/unpacking jsonschema 07:26:01 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 07:26:01 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 07:26:01 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 07:26:01 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 07:26:01 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 07:26:01 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 07:26:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:26:03 INFO - Downloading/unpacking functools32 (from jsonschema) 07:26:03 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 07:26:03 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 07:26:03 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 07:26:03 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 07:26:03 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 07:26:03 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 07:26:03 INFO - Downloading functools32-3.2.3-2.tar.gz 07:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:26:03 INFO - warning: no files found matching '*.txt' 07:26:03 INFO - no previously-included directories found matching 'build' 07:26:03 INFO - no previously-included directories found matching 'dist' 07:26:03 INFO - no previously-included directories found matching '.git*' 07:26:03 INFO - Installing collected packages: jsonschema, functools32 07:26:03 INFO - Running setup.py install for functools32 07:26:03 INFO - warning: no files found matching '*.txt' 07:26:03 INFO - no previously-included directories found matching 'build' 07:26:03 INFO - no previously-included directories found matching 'dist' 07:26:03 INFO - no previously-included directories found matching '.git*' 07:26:03 INFO - Successfully installed jsonschema functools32 07:26:03 INFO - Cleaning up... 07:26:03 INFO - Return code: 0 07:26:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:26:03 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')]} 07:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:26:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:03 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')]} 07:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:26:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:26:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff56aa40f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14225a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b1410>, '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 0x14b2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b27a0>, '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': '41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965', '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 07:26:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:26:03 INFO - Using env: {'DISPLAY': ':0', 07:26:03 INFO - 'HOME': '/home/cltbld', 07:26:03 INFO - 'LANG': 'en_US.UTF-8', 07:26:03 INFO - 'LANGUAGE': 'en_US:en', 07:26:03 INFO - 'LOGNAME': 'cltbld', 07:26:03 INFO - 'MAIL': '/var/mail/cltbld', 07:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:03 INFO - 'MOZ_NO_REMOTE': '1', 07:26:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:03 INFO - 'NO_EM_RESTART': '1', 07:26:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:03 INFO - 'PWD': '/builds/slave/test', 07:26:03 INFO - 'SHELL': '/bin/bash', 07:26:03 INFO - 'SHLVL': '1', 07:26:03 INFO - 'TERM': 'linux', 07:26:03 INFO - 'TMOUT': '86400', 07:26:03 INFO - 'USER': 'cltbld', 07:26:03 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965', 07:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:03 INFO - '_': '/tools/buildbot/bin/python'} 07:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:26:04 INFO - Downloading/unpacking flake8 07:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:26:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:26:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:26:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:26:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:26:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:26:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:26:06 INFO - no previously-included directories found matching 'docs/_build' 07:26:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:26:06 INFO - Running setup.py install for pep8 07:26:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:26:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:26:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:26:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:26:06 INFO - no previously-included directories found matching 'docs/_build' 07:26:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:26:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:26:06 INFO - Cleaning up... 07:26:06 INFO - Return code: 0 07:26:06 INFO - Running post-action listener: _resource_record_post_action 07:26:06 INFO - Running post-action listener: _start_resource_monitoring 07:26:06 INFO - Starting resource monitoring. 07:26:06 INFO - ##### 07:26:06 INFO - ##### Running install step. 07:26:06 INFO - ##### 07:26:06 INFO - Running pre-action listener: _resource_record_pre_action 07:26:06 INFO - Running main action method: install 07:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:26:07 INFO - Reading from file tmpfile_stdout 07:26:07 INFO - Detecting whether we're running mozinstall >=1.0... 07:26:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:26:07 INFO - Reading from file tmpfile_stdout 07:26:07 INFO - Output received: 07:26:07 INFO - Usage: mozinstall [options] installer 07:26:07 INFO - Options: 07:26:07 INFO - -h, --help show this help message and exit 07:26:07 INFO - -d DEST, --destination=DEST 07:26:07 INFO - Directory to install application into. [default: 07:26:07 INFO - "/builds/slave/test"] 07:26:07 INFO - --app=APP Application being installed. [default: firefox] 07:26:07 INFO - mkdir: /builds/slave/test/build/application 07:26:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:26:22 INFO - Reading from file tmpfile_stdout 07:26:22 INFO - Output received: 07:26:22 INFO - /builds/slave/test/build/application/firefox/firefox 07:26:22 INFO - Running post-action listener: _resource_record_post_action 07:26:22 INFO - ##### 07:26:22 INFO - ##### Running run-tests step. 07:26:22 INFO - ##### 07:26:22 INFO - Running pre-action listener: _resource_record_pre_action 07:26:22 INFO - Running main action method: run_tests 07:26:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:26:22 INFO - Python 2.7.3 07:26:22 INFO - Return code: 0 07:26:22 INFO - grabbing minidump binary from tooltool 07:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:26:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b1410>, '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 0x14b2310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14b27a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:26:22 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 07:26:22 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 07:26:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:26:22 INFO - Return code: 0 07:26:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:26:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:26:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:26:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:26:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:26:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:26:23 INFO - Return code: 0 07:26:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:26:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:26:23 INFO - Using env: {'DISPLAY': ':0', 07:26:23 INFO - 'HOME': '/home/cltbld', 07:26:23 INFO - 'LANG': 'en_US.UTF-8', 07:26:23 INFO - 'LANGUAGE': 'en_US:en', 07:26:23 INFO - 'LOGNAME': 'cltbld', 07:26:23 INFO - 'MAIL': '/var/mail/cltbld', 07:26:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:26:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:26:23 INFO - 'MOZ_NO_REMOTE': '1', 07:26:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:26:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:26:23 INFO - 'NO_EM_RESTART': '1', 07:26:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:26:23 INFO - 'PWD': '/builds/slave/test', 07:26:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:26:23 INFO - 'SHELL': '/bin/bash', 07:26:23 INFO - 'SHLVL': '1', 07:26:23 INFO - 'TERM': 'linux', 07:26:23 INFO - 'TMOUT': '86400', 07:26:23 INFO - 'USER': 'cltbld', 07:26:23 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965', 07:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:26:23 INFO - '_': '/tools/buildbot/bin/python'} 07:26:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:26:24 INFO - mozversion application_buildid: 20160421060426 07:26:24 INFO - mozversion application_changeset: 1152d99d8c53ac9dae371a6e6d9fab03d3f98697 07:26:24 INFO - mozversion application_display_name: Nightly 07:26:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:26:24 INFO - mozversion application_name: Firefox 07:26:24 INFO - mozversion application_remotingname: firefox 07:26:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:26:24 INFO - mozversion application_vendor: Mozilla 07:26:24 INFO - mozversion application_version: 48.0a1 07:26:24 INFO - mozversion platform_buildid: 20160421060426 07:26:24 INFO - mozversion platform_changeset: 1152d99d8c53ac9dae371a6e6d9fab03d3f98697 07:26:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:26:24 INFO - mozversion platform_version: 48.0a1 07:26:24 INFO - using testdate: 1461248784 07:26:24 INFO - actual date: 1461248784 07:26:24 INFO - starting webserver on 'localhost:59889' 07:26:24 INFO - SUITE-START | Running 2 tests 07:26:24 INFO - TEST-START | dromaeo_css 07:26:24 INFO - operating with platform_type : linux_ 07:26:24 INFO - Initialising browser for dromaeo_css test... 07:26:24 INFO - TEST-INFO | started process 7164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHIcWhn/profile http://localhost:59889/getInfo.html) 07:26:28 INFO - PROCESS | 7164 | __metrics Screen width/height:1600/1200 07:26:28 INFO - PROCESS | 7164 | colorDepth:24 07:26:28 INFO - PROCESS | 7164 | Browser inner width/height: 1024/697 07:26:28 INFO - PROCESS | 7164 | __metrics 07:26:29 ERROR - PROCESS | 7164 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:26:30 INFO - TEST-INFO | 7164: exit 0 07:26:30 INFO - Browser initialized. 07:26:30 INFO - Running cycle 1/1 for dromaeo_css test... 07:26:30 INFO - TEST-INFO | started process 7247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHIcWhn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:26:42 INFO - PROCESS | 7247 | RSS: Main: 155443200 07:26:42 INFO - PROCESS | 7247 | 07:27:33 INFO - PROCESS | 7247 | 1461248853528 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] 07:29:44 INFO - PROCESS | 7247 | Cycle 1(1): loaded http://localhost:59889/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59889/tests/dromaeo/cssquery-ext.html) 07:29:45 INFO - PROCESS | 7247 | RSS: Main: 262828032 07:29:45 INFO - PROCESS | 7247 | 07:32:48 INFO - PROCESS | 7247 | Cycle 1(1): loaded http://localhost:59889/tests/dromaeo/cssquery-ext.html (next: http://localhost:59889/tests/dromaeo/cssquery-jquery.html) 07:32:49 INFO - PROCESS | 7247 | RSS: Main: 245997568 07:32:49 INFO - PROCESS | 7247 | 07:35:51 INFO - PROCESS | 7247 | Cycle 1(1): loaded http://localhost:59889/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59889/tests/dromaeo/cssquery-mootools.html) 07:35:51 INFO - PROCESS | 7247 | RSS: Main: 240635904 07:35:51 INFO - PROCESS | 7247 | 07:38:53 INFO - PROCESS | 7247 | Cycle 1(1): loaded http://localhost:59889/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59889/tests/dromaeo/cssquery-prototype.html) 07:38:54 INFO - PROCESS | 7247 | RSS: Main: 236613632 07:38:54 INFO - PROCESS | 7247 | 07:41:57 INFO - PROCESS | 7247 | Cycle 1(1): loaded http://localhost:59889/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59889/tests/dromaeo/cssquery-yui.html) 07:41:58 INFO - PROCESS | 7247 | RSS: Main: 218824704 07:41:58 INFO - PROCESS | 7247 | 07:45:00 INFO - PROCESS | 7247 | Cycle 1(1): loaded http://localhost:59889/tests/dromaeo/cssquery-yui.html (next: http://localhost:59889/tests/dromaeo/cssquery-dojo.html) 07:45:01 INFO - PROCESS | 7247 | RSS: Main: 261427200 07:45:01 INFO - PROCESS | 7247 | 07:45:01 INFO - PROCESS | 7247 | __start_tp_report 07:45:01 INFO - PROCESS | 7247 | _x_x_mozilla_page_load 07:45:01 INFO - PROCESS | 7247 | _x_x_mozilla_page_load_details 07:45:01 INFO - PROCESS | 7247 | |i|pagename|runs| 07:45:01 INFO - PROCESS | 7247 | |0;dojo.html;2565.8460492370455;2605.5961325994476;2614.6470226519436;2629.1586692258475;2645.603159526071;4447.733136011841;4540.931886021708;4544.750038747868;4554.294084416916;4576.656750743691;4643.373144625474;4675.625949924007;4705.741184234866;4733.668643194977;4736.431628204612;4185.309423945046;4196.412502249687;4212.578742125794;4235.343521754117;4381.671374646899;4302.440682711243;4362.520122786491;4365.36702178184;4366;4395.802188901491;4091.672666186713;4182.958170418287;4239.618434340893;4320.805563749639;4325.52419233884;4225.302825033866;4257.893552661178;4262.573742625744;4266.210751011042;4318.52496225415;4224.302990006676;4247.235497610429;4251.149770045972;4285.185814695198;4287.2068667296335;4399.64802815774;4479.328100784908;4519.570640789153;4525.818967241339;4561.087782443491;4957.677750946177;4983.202687569971;4985.376827896513;4987.900241995139;5006.123928312567;5001.549860512535;5009.073321435546;5027.4469808321055;5028.346314979066;5045.949540504585;4525.705829121097;4582.5417458253905;4646.9070618587775;4661.86014419568;4671.27595222741;5059.367579052619;5066.341375621146;5067.189249720101;5089.720065396439;5096.082705113041;4840.515948405202;4844.176489996709;4855.757212139379;4856.247281671346;4897.946941407615;4747.311639812277;4917.729524876167;4931.284963680247;4985.127602669519;5023.271625614266;4861.489543597942;4863.02739452111;4902.2646603009125;4908.9754551227015;4917.7786999585105;4842.394700662418;4846.95153048465;4853.344798452164;4856.538628830255;4901.436334821541;4043.91912161761;4114.547399786021;4147;4148.56440073794;4192.517860446027;3581.71346292296;3598.784072955631;3637.909052273714;3640.8361623726996;3672.081979505124;4244.469441319835;4268.658507319407;4279.850205242864;4287.335463003239;4316.266234740102;4749.596284315872;4839.637027222972;4999.850004499871;5016.899662006739;5073.720945348041;4283.593058659422;4291.635211007037;4291.806868690916;4330.761808100522;4336.02439451121;4437.201303765353;4480.9103817924115;4482.439695038121;4485.304777759453;4528.41130653013;4465.732056076516;4603.930941035954;4680.1107789520565;4723.45680246776;4724.338592596971;4963;4985.750712464434;4986.401631804061;4990.176620857518;5026.74866256693;4678.69588476748;4705.905881882275;4711;4739.668223224479;4757.381540399726;4742.905141897074;4898.92651610219;4907.33750943618;4922.286268491121;4973.154563724248;4879.804807807648;4894.952142658548;4902.583280421204;4903.877403064952;4966.056449274771;4759.309900064541;4759.309900064541;4761.381020467317;4810.927836082392;4828.927566086441;4633.791479383503;4760.476347601831;4799.064182484382;4854.004928989478;4856.174450343379;4787.497312782108;4796.304535842353;4800.303955926302;4807.7836497357;4846.103470857903;4878.853634390974;4897.9020419592125;4902.313676085422;4909.803607855646;4951.034548263054;4616.076784643152;4708.034852855088;4771.7375544344;4791.448983366958;4808.374911261513 07:45:01 INFO - PROCESS | 7247 | |1;ext.html;555.4781388599243;572.3017918139869;592.1295695327866;600.5885968111846;602.8071017274472;31744.68255317446;32965.50551741723;32990.50514242288;35044.12389690256;35088.298234035305;36295;36779.63220367795;37020.81489592555;37083.81458092706;37196.442053369225;7232.529885557448;7614.809629759245;7795.532268063906;9475.905240947572;9768.07203315684;9846.753831154243;9900.55447504864;9977.551010204523;10013.349132306414;10015.949920250388;9840.16358609519;9941.304108712393;9941.801163976716;9948.35335703177;9953.850692239623;7462;10024.649137280234;10382.740431489197;10394.896051039468;10399.688009359732;9695.175910047654;9695.854562181574;9696.612135514571;9699.175570076552;9765.560549775206;35229;35481;35507.28985420303;35617.1095722609;36016.819915900254;3202.6957439043254;3340.8329583520726;3492.1967947372245;3496.8950931472095;3816.3893776995824;29173.124806255848;29300.41399172026;29310.560341594894;29414.70585294141;29595.260118496994;3338.749593780476;3447.120984149051;3458.8270586470576;3484.7212223022098;3573.0888623401124;232606;233968.83015584984;234171;235514.99999999828;235597;52024.79752024843;53486.465135348924;53631.73184134132;53725.731371343674;53942.46057539453;56646.71676641673;57261;57343.42656573464;57577.42422575804;57632.13551796726;11782.646520604396;13566;13781.310934453237;13789.586312410644;13796.172229666252;9006.684766033288;9071.729957805912;9101.317401194938;9125;10240.231982601186;17583.472495825146;17846.821531784517;17857.28570857151;17889.7316540252;17919.641607168043;6393.680315984182;6402.775902843378;6448.387403196689;6628.502862285348;6652.401283884474;908.40953380302;919;930.5021813329836;1041.0890470838017;1067.9305845120043;27274.040785009085;27281.863590681918;27727.445451090865;28181.43637127246;28218.43563128726;947.4078700811992;959.6928982725461;1043.0820877627639;1060.1095080132725;1062.9689201474557;14599.41602335916;14802.259887005606;15102.244887755569;15215.543533694006;15387.230638468032;319786;322829;323632;324133;324301;48527.75736121297;48872.26691599629;49023.264651030266;49073.263901041515;49112.75443622759;1095.5782023920688;1100.8789033206501;1233.4018001269378;1239.0830785219052;1241.8633950265464;25750.742492574835;27827.860860696375;27981.72018279791;28005.859970700018;28088.43823123567;39446.21107577775;39871.40192897167;40248.3962740565;40314.798426007685;40326.798366007984;225061;225506;225797;226252;226448;31332.53001204938;32561.837190813894;37006.629933700315;37760.81119594385;38158.61841381661;36042;36853.815730921175;37142.44286335761;37299.62700372961;37689.24621507609;31229.37541249117;34036.82981585076;34165.487517687754;34487.31025379428;35296.29407411786;34632;34925;35003.47494787529;35010.64989350074;35015.299694005465;34368;34711;34847.825760871034;35023.12442188965;35247.47128793019;30406.391872162876;31394;31404.52893206558;31643.367132656756;31663.84168079237;24152.879235604414;24203.878980604983;24337.51324973526;24988.625170622818;25049.87475062686 07:45:01 INFO - PROCESS | 7247 | |2;jquery.html;369.2135750850688;370.13388670511006;370.35188420264535;374.1693440561952;382.56005593567374;15697.215139243035;15882.285297161641;16176.19119044046;16182.19089045546;16189;14931.253437328118;16302.077608002637;16569.337226510954;16591.751123733153;16638.417655382033;4936.901261974767;5109.744512774365;5182.689038657673;5212.895742085156;5223.869403264911;3639.781613103209;5073.416557095944;5561.944380556203;5892.970535147339;5914.349421563625;5852.502537284336;5870.412958704117;5891.793787217448;5894.263217097863;5897.734601942923;5779.682117483537;5831.183634291203;5832;5848.941510584882;5855.912161317584;3301.983490082534;4849.466558678542;5005.299258103832;5133.717645529495;5139.408967968694;18703.43889683298;19198.712019319722;19242.518937026547;20071.698924516142;20146.798532014785;1875.953101172468;1918.5011896906765;1931.6346049019216;2033.7900545870054;2061.6186005589016;6233.438990490832;11695.7076073098;12706.174098683648;12893.613191604267;13249.205047697169;1732.5148958291697;1761.3218910719338;1785.3840425053336;1790.5523619095227;1792.0770803036446;62711;64143;64376.67811660958;64636;64738.99999999953;9142.314326425545;9332.860007099898;9515.666951656658;9530.90469095314;9737.90262097384;13111.737765244641;13182.406791694397;13191.802122968164;13212.207267563977;13217.93391033058;6829.453643708492;6914.619695916773;6981.616011119438;7000.894986575206;7162.068931038932;6342.112104305401;6609.768658096944;6728.226253980757;6760.121184246016;6762.661866906635;5800.4199580042505;5981.936231999953;6019.909701354483;6035.849103772441;6077.665728384981;1595.1625396666843;1670.8412700793406;1699.898006119612;1717.1671739206474;1755.5260079778388;835.9122292159358;892.7277180460022;901.909809019106;937.2829785214317;941.1012483078644;15798.842011579736;15816.446424375092;15960.122193279482;16309.184540772914;16674.749878751827;909.4452384045727;915.0620613870835;947.725159703692;961.4808003678075;986.5018165826211;9654.75863103428;9754.804903901882;9838.9016109838;9906.157976571927;9951.651692190739;374505;386104;391123;392452;399978;66572;69265;72000.2799972004;72876;72883;990.0396615283164;993.6820217530321;1013.8948546084803;1064.2337516987757;1067.300917898762;15315.770263445835;15727.528174154793;15736.134512601458;15773.369065237262;16322.755158672868;33129.686337001374;33695.326093478485;34364.31271374608;35054.824725876206;35403;47996.760016199696;50401.49598504115;50811.23783143182;50816.23775643294;51004.489955099976;7688.231176882267;7742.806429839074;7875.763727088197;7893.684252629831;7904.604769761604;9745.512724363613;11487.368194749035;11733.471993760131;11790.646280611596;11911.106666999836;10332.638357657446;10443.373397596168;10484.26610137283;10624.8937510627;10631.096356809758;10393.636222732168;10560.84158737635;10597.89402105969;10631;10745.140388769036;10337.328073675188;10556.208284378548;10571.735706607089;10736.248462607542;10973.780524389307;7367.8158046049275;7475.252474752481;7705.113911900204;7958.681652733826;8120.67517299325;10176.643817466353;10480.580776768844;10528.736781580521;10664.680059598224;10841.891581084405 07:45:01 INFO - PROCESS | 7247 | |3;mootools.html;1245.364863919401;1441.6323837421457;1447.956561303161;1584.643455222575;1767.187093936789;6728.9327106728915;7338.816529586763;7496.92503074969;7509.061367329084;7523.473356865022;7255.201927787953;7389.8152546186375;7417.443691723115;7426.925730742691;7432.851342973137;2171.7285339332584;2185.2133232036454;2193.484531135182;2199.626063569197;2200.5378870437225;2135.540858715376;2183.6942828004094;2190.802827745503;2196.3410976707005;2218.7670294619074;2150.9892450537727;2165.577712346093;2168.913243470259;2172.728408948881;2229.687843701883;2146.1200907627876;2151.4191168384527;2154.838387120972;2156.3423155937435;2156.762756096828;2097.685347197917;2128.914843406277;2134.9146034158616;2135.39141344716;2155.3964889830872;7559.735409260649;7573.924260757377;7622.428317876182;7627.466077374586;7806.921930780676;4224.45082139323;4307.590778876001;4318.071614602875;4333.111712099044;4339.132173565299;2932.7067293270716;2965.7182567656037;2983.970160298413;2987.253186703324;3004.278973046475;931.5156118818244;937.0442149008041;940.7036783413203;963.1668606655263;973.5716284834721;10299.485025748683;10395.584176632925;10403.84394234087;10457.79084418315;10494.527746251437;3925.568187499373;4002.539707933625;4154.605312495308;4171.0615111599645;4176.749395036247;8273.627686754111;8279.337652987746;8287.295579875778;8305.584720763938;8347.4156809024;4450.844220452269;4451.643868490513;4497.955020449819;4514.841980530731;4515.88710282239;3481.164520515109;3915.8629447969183;4037.4751282333696;4145.1295228002455;4167.874963751032;3382.6955573997966;3407.6081250656493;3457.9654203458144;3478.6347433519622;3479.565054368204;1061.0768631290673;1072.0458791675414;1074.790415868898;1081.8052750504985;1086.1093902999464;747.3834086878347;787.8109253779052;796.832640182136;802.7591722483348;807.4267270238079;4959.355283813154;4998.225275082368;5032.79868805251;5116.8209112681625;5271.341082364705;398.9920201595952;400.4873761585176;420.0800247458057;420.3505583872924;424.33167760776286;3501.9124521886647;3838.0788610733225;3840.097577069442;3840.615938406193;3851.4993050903204;9231.630734770533;9564.76088097803;9724.222062235005;9734.853977190207;9736.367136136128;9457.668981585612;9554.856677149848;9562.56968436422;9564.856527152098;9566.808663826685;7170.4980651354945;7201.71193152268;7258.709651613876;7330.413566914634;7367.373773229336;5341.252224688469;5476.644018138808;5498.257735205696;5511.889762204813;5531.170324451204;8291.792705182419;8472.957635212031;8473.237408633253;8519.701810436605;8595.398322117391;8346.248837604644;8552.957235214033;8594.742157735278;8722.302215822845;8740.868886966573;6178.783742568989;6473.77341793035;6648.767293144717;6711.0940023096255;6825.35159159879;7430.145533263744;7453.180150183367;7500.512466689648;7507.587082710504;7513.962430187814;6627.900581491185;6695.899561506484;6728.7308507659145;6751.696173672099;6960.060391847036;6527.15147030883;6618.8345291368105;6711.697973591297;6754.696038678369;6773.966130169318;6331.176946996861;6368.267649220214;6426.325235850169;6426.4216220540375;6437.0666253392055;4580.404547408815;4582.404287442611;4592.839250626212;4607.40103786519;4638.443386793607;4777.4505931818285;4790.161721698759;4848.854534363974;4860.8298709545;4868.440129385024 07:45:01 INFO - PROCESS | 7247 | |4;prototype.html;281.2869376131506;297.51802080629386;301.9849007549622;307.46347623397173;311.6820842740404;4838.758062096898;5001.124803159446;5008.198688209887;5051.570616497602;5071.974640126794;4833.734144622044;5033.54698077173;5040.924386134211;5049.318342023826;5054.873628159298;3966.8809935701975;3970.6896724080984;3979.6418322351055;3990.820413081404;3997.34043882759;3739.7756134631873;3847.2690188864026;3970.3845903884944;3972.4637173981578;3990.660793832528;3939.9212015759667;3950.3679411294197;3961.445397644332;3968;3979.403089536578;3936.547297060846;3945.9013524661827;3951.8659923641344;3962.643362097425;3965.365541513373;3455.274392377604;3491.336646037245;3501.7898926064263;3524.788512689247;3525.5416795816636;4762.214234651278;4835.661503694742;4839.395075615548;4842.249451335048;4844.370231869834;4477.910441791146;4503.5946764791;4504.909901801979;4520.95479045212;4530.932036019462;5264.605154613381;5269.473052694738;5281.128613778722;5286.550643195333;5287.339082614673;3504.5969713482764;3702.259548090393;3718.5497655913946;3722.1625134344827;3736.981315093434;5470.617056806025;5547.861303467405;5548.4174161713245;5563.082091454905;5568.6658800472105;3785.7539259948016;3792.222594368148;3792.829322680431;3798.164403831153;3821.9426708599394;3651.7626354286886;3824.4836947012354;3840.7695538267794;3870.670992965573;3877.2827027000094;4365.367021781887;4419.734815911055;4425.291953287523;4425.672298310558;4435.977820110878;5276.366835979707;5280.287161233261;5292.126799078186;5296.629235953446;5303.946960530422;1261.1802328486374;1290.825738525306;1295.2875918244927;1300.466808608466;1303.2310936547483;890.5172887142963;891.9777005574913;910.0808183734343;913.6573784830689;913.8126684029758;4647.372604698322;4648.5119062498625;4651.813927442864;4653.488116307203;4665.626749860071;5412.458754124556;5425.186222066722;5436.864078398072;5445.428230035789;5448.645838020516;4473.172463094338;4631.652626053059;4639.8144074237325;4640.419947506562;4643.4892161862845;2886.5958765772807;2887.7834162437903;2898.2609434594465;2900.2894290898444;2907.636545431821;5114.769835357418;5130.640855140179;5135.820246291437;5137.255098010843;5137.614678899023;5366.382865970385;5532.197831314517;5540.335159780852;5549.667019978814;5678.659280443187;5194.506636814351;5213.139831927765;5217.582593392595;5230.267762513251;5252.947470525322;5491.231227628055;5505.311836020497;5528.364238112668;5550.084236100998;5577.191307260506;5190.351206099238;5407.729613519387;5413;5427.972860135674;5439.048166570913;5229.712365819764;5235.502627250406;5239.869003274948;5253.658512196695;5253.711045892513;3798.3352913240624;3801.5818259990824;3819.1406933439753;3820.6943444524927;3822.3372832817813;5209.6874187548865;5388.434214407431;5498.230247765236;5536.864942686659;5545.694986775766;5197.789790269893;5366.463353664759;5367.396812545834;5386.111291636836;5387.141436204503;5314.867128321668;5335.759890805;5338.54622357104;5340.118880384693;5353.946460535345;5145.948540514697;5259.973700131475;5263.421023687315;5264.525153619393;5269.815556455505;5345.812896548602;5378.865528361665;5390.811321603725;5394.973025134849;5402.162664786964;5267.157254839208;5271.551918087006;5280.60395470349;5288.418273989935;5294.814681486129 07:45:01 INFO - PROCESS | 7247 | |5;yui.html;757.5341165183411;783.9333656639185;787.527483509894;789.8104454930818;796.2833449895094;11564.768704625902;11826.467808948597;11832.940835295833;11853.288802671836;11854.644360669183;12443.377831108432;12461.314627695474;12511.937440312808;12547.811782823243;12566.811497827517;629.1475051305483;770.9074911010687;797.0952968380872;806.9596520173997;807.3904202327235;786.685325869651;792.3779832831228;792.8652129138061;792.8810678398229;792.9563873986929;842.8187939592987;846.9110743371949;847.4788005376711;848.9151084891523;848.995755021224;658.5982550644103;807.2855522862251;833.8707500337457;843.569779412498;843.7173546861778;614.3058344071216;616.3097330989276;616.8118723789242;617.527591392585;618.9102580125901;12832.679183020406;12848.421821018077;12857.742845143139;12880.484780608764;12887;11963.820542691867;12392.690182745413;12662.204143111288;12853.550125745554;12908.806367904488;9783.657571984946;9890.258230632659;9963.45201013944;10217.642382516577;10226.284160108795;3234.951475727866;3262.2496825730213;3305.471124620049;3329.766916315859;3376.2403459221723;42434;42481;42962.78518607418;43004.56995430037;43115.137697246195;9894.55474503649;9916.950415248022;9934.751631209134;10004.449755263531;10017.198624110199;17217.741733874;17257.56856078608;17270.913645431945;17288.827111728973;17316;6661.134052573231;6690.163729533809;6739.865202695919;6763.458923286125;6826.624535650488;3812.4090765931323;3850.614938506183;3922.764634121962;3934.449177115206;4019.537753158366;2882.6108475355977;2941.5440606705565;2949.7640188784844;2950.542665886791;2952.9557056644167;510.42067253666613;518.2537146509015;522.4148953172471;536.0057094090484;538.3889285660725;444.89767353508876;542.8018773147852;562.9859253518613;606.6026752477135;673.245964519741;7945.205479452008;7997.160298168725;8034.196580341919;8260.463069900557;8393.328533717287;649.2792999770252;663.4393937123124;665.2947875252248;668.6088638146641;672.4217173231017;3803.886731811475;4018.417329487208;4069.8575549855614;4138.710290279711;4177.5195852476745;50902.49097508978;52146.47853521492;52474.47525524772;52551.73724131432;53149;42976.78511607485;44837.77581112074;45458;45605;46188.76905615518;41565.168696626504;41616;41739.165216695495;42361.57638423638;44536.10927781426;8166.591670416574;8285.544295063588;8470.32237421017;8859.077704076008;8979.82040359176;29040.56439153372;29131;29559.26101847471;30140.698593014666;30206.84896575591;38954;39675.2064958705;39992;40034.599654004254;40576.391354130305;10266;10436.112930401001;10849.02358787713;10999.780004399707;11333.829992549954;12232.388380580758;12291.631251062483;12322.50709971627;13056.281904495345;13142.540011099565;8905.688300909436;10306.536205870603;11492.482838272465;11747.47136378848;12185.634430967086;11207.49566269536;11341.149413793833;11458;11647.825282620937;11847.881521184678;10865.130789536975;10888.891111089104;10938.507767150339;11152.21934464612;11295.322280663186;9176.357654964355;9580.70188473647;10095.697129086138;10209.336393134423;10241;9282.35023548345;10112.868615355661;10142.46088652264;10184.745381365525;10283.12593429567 07:45:01 INFO - PROCESS | 7247 | __end_tp_report 07:45:01 INFO - PROCESS | 7247 | __start_cc_report 07:45:01 INFO - PROCESS | 7247 | _x_x_mozilla_cycle_collect,996 07:45:01 INFO - PROCESS | 7247 | __end_cc_report 07:45:01 INFO - PROCESS | 7247 | __startTimestamp1461249901196__endTimestamp 07:45:01 INFO - PROCESS | 7247 | 07:45:01 INFO - PROCESS | 7247 | ------- Summary: start ------- 07:45:01 INFO - PROCESS | 7247 | Number of tests: 6 07:45:01 INFO - PROCESS | 7247 | 07:45:01 INFO - PROCESS | 7247 | [#0] dojo.html Cycles:165 Average:4571.40 Median:4723.46 stddev:478.74 (10.1%) stddev-sans-first:453.62 07:45:01 INFO - PROCESS | 7247 | Values: 2565.8 2605.6 2614.6 2629.2 2645.6 4447.7 4540.9 4544.8 4554.3 4576.7 4643.4 4675.6 4705.7 4733.7 4736.4 4185.3 4196.4 4212.6 4235.3 4381.7 4302.4 4362.5 4365.4 4366.0 4395.8 4091.7 4183.0 4239.6 4320.8 4325.5 4225.3 4257.9 4262.6 4266.2 4318.5 4224.3 4247.2 4251.1 4285.2 4287.2 4399.6 4479.3 4519.6 4525.8 4561.1 4957.7 4983.2 4985.4 4987.9 5006.1 5001.5 5009.1 5027.4 5028.3 5045.9 4525.7 4582.5 4646.9 4661.9 4671.3 5059.4 5066.3 5067.2 5089.7 5096.1 4840.5 4844.2 4855.8 4856.2 4897.9 4747.3 4917.7 4931.3 4985.1 5023.3 4861.5 4863.0 4902.3 4909.0 4917.8 4842.4 4847.0 4853.3 4856.5 4901.4 4043.9 4114.5 4147.0 4148.6 4192.5 3581.7 3598.8 3637.9 3640.8 3672.1 4244.5 4268.7 4279.9 4287.3 4316.3 4749.6 4839.6 4999.9 5016.9 5073.7 4283.6 4291.6 4291.8 4330.8 4336.0 4437.2 4480.9 4482.4 4485.3 4528.4 4465.7 4603.9 4680.1 4723.5 4724.3 4963.0 4985.8 4986.4 4990.2 5026.7 4678.7 4705.9 4711.0 4739.7 4757.4 4742.9 4898.9 4907.3 4922.3 4973.2 4879.8 4895.0 4902.6 4903.9 4966.1 4759.3 4759.3 4761.4 4810.9 4828.9 4633.8 4760.5 4799.1 4854.0 4856.2 4787.5 4796.3 4800.3 4807.8 4846.1 4878.9 4897.9 4902.3 4909.8 4951.0 4616.1 4708.0 4771.7 4791.4 4808.4 07:45:01 INFO - PROCESS | 7247 | 07:45:01 INFO - PROCESS | 7247 | [#1] ext.html Cycles:180 Average:42377.08 Median:19170.01 stddev:69105.37 (360.5%) stddev-sans-first:69227.88 07:45:01 INFO - PROCESS | 7247 | Values: 555.5 572.3 592.1 600.6 602.8 31744.7 32965.5 32990.5 35044.1 35088.3 36295.0 36779.6 37020.8 37083.8 37196.4 7232.5 7614.8 7795.5 9475.9 9768.1 9846.8 9900.6 9977.6 10013.3 10015.9 9840.2 9941.3 9941.8 9948.4 9953.9 7462.0 10024.6 10382.7 10394.9 10399.7 9695.2 9695.9 9696.6 9699.2 9765.6 35229.0 35481.0 35507.3 35617.1 36016.8 3202.7 3340.8 3492.2 3496.9 3816.4 29173.1 29300.4 29310.6 29414.7 29595.3 3338.7 3447.1 3458.8 3484.7 3573.1 232606.0 233968.8 234171.0 235515.0 235597.0 52024.8 53486.5 53631.7 53725.7 53942.5 56646.7 57261.0 57343.4 57577.4 57632.1 11782.6 13566.0 13781.3 13789.6 13796.2 9006.7 9071.7 9101.3 9125.0 10240.2 17583.5 17846.8 17857.3 17889.7 17919.6 6393.7 6402.8 6448.4 6628.5 6652.4 908.4 919.0 930.5 1041.1 1067.9 27274.0 27281.9 27727.4 28181.4 28218.4 947.4 959.7 1043.1 1060.1 1063.0 14599.4 14802.3 15102.2 15215.5 15387.2 319786.0 322829.0 323632.0 324133.0 324301.0 48527.8 48872.3 49023.3 49073.3 49112.8 1095.6 1100.9 1233.4 1239.1 1241.9 25750.7 27827.9 27981.7 28005.9 28088.4 39446.2 39871.4 40248.4 40314.8 40326.8 225061.0 225506.0 225797.0 226252.0 226448.0 31332.5 32561.8 37006.6 37760.8 38158.6 36042.0 36853.8 37142.4 37299.6 37689.2 31229.4 34036.8 34165.5 34487.3 35296.3 34632.0 34925.0 35003.5 35010.6 35015.3 34368.0 34711.0 34847.8 35023.1 35247.5 30406.4 31394.0 31404.5 31643.4 31663.8 24152.9 24203.9 24337.5 24988.6 25049.9 07:45:01 INFO - PROCESS | 7247 | 07:45:01 INFO - PROCESS | 7247 | [#2] jquery.html Cycles:180 Average:23882.55 Median:391787.50 stddev:63956.05 (16.3%) stddev-sans-first:64111.10 07:45:01 INFO - PROCESS | 7247 | Values: 369.2 370.1 370.4 374.2 382.6 15697.2 15882.3 16176.2 16182.2 16189.0 14931.3 16302.1 16569.3 16591.8 16638.4 4936.9 5109.7 5182.7 5212.9 5223.9 3639.8 5073.4 5561.9 5893.0 5914.3 5852.5 5870.4 5891.8 5894.3 5897.7 5779.7 5831.2 5832.0 5848.9 5855.9 3302.0 4849.5 5005.3 5133.7 5139.4 18703.4 19198.7 19242.5 20071.7 20146.8 1876.0 1918.5 1931.6 2033.8 2061.6 6233.4 11695.7 12706.2 12893.6 13249.2 1732.5 1761.3 1785.4 1790.6 1792.1 62711.0 64143.0 64376.7 64636.0 64739.0 9142.3 9332.9 9515.7 9530.9 9737.9 13111.7 13182.4 13191.8 13212.2 13217.9 6829.5 6914.6 6981.6 7000.9 7162.1 6342.1 6609.8 6728.2 6760.1 6762.7 5800.4 5981.9 6019.9 6035.8 6077.7 1595.2 1670.8 1699.9 1717.2 1755.5 835.9 892.7 901.9 937.3 941.1 15798.8 15816.4 15960.1 16309.2 16674.7 909.4 915.1 947.7 961.5 986.5 9654.8 9754.8 9838.9 9906.2 9951.7 374505.0 386104.0 391123.0 392452.0 399978.0 66572.0 69265.0 72000.3 72876.0 72883.0 990.0 993.7 1013.9 1064.2 1067.3 15315.8 15727.5 15736.1 15773.4 16322.8 33129.7 33695.3 34364.3 35054.8 35403.0 47996.8 50401.5 50811.2 50816.2 51004.5 7688.2 7742.8 7875.8 7893.7 7904.6 9745.5 11487.4 11733.5 11790.6 11911.1 10332.6 10443.4 10484.3 10624.9 10631.1 10393.6 10560.8 10597.9 10631.0 10745.1 10337.3 10556.2 10571.7 10736.2 10973.8 7367.8 7475.3 7705.1 7958.7 8120.7 10176.6 10480.6 10528.7 10664.7 10841.9 07:45:01 INFO - PROCESS | 7247 | 07:45:01 INFO - PROCESS | 7247 | [#3] mootools.html Cycles:180 Average:5026.34 Median:4978.79 stddev:2801.54 (56.3%) stddev-sans-first:2794.98 07:45:01 INFO - PROCESS | 7247 | Values: 1245.4 1441.6 1448.0 1584.6 1767.2 6728.9 7338.8 7496.9 7509.1 7523.5 7255.2 7389.8 7417.4 7426.9 7432.9 2171.7 2185.2 2193.5 2199.6 2200.5 2135.5 2183.7 2190.8 2196.3 2218.8 2151.0 2165.6 2168.9 2172.7 2229.7 2146.1 2151.4 2154.8 2156.3 2156.8 2097.7 2128.9 2134.9 2135.4 2155.4 7559.7 7573.9 7622.4 7627.5 7806.9 4224.5 4307.6 4318.1 4333.1 4339.1 2932.7 2965.7 2984.0 2987.3 3004.3 931.5 937.0 940.7 963.2 973.6 10299.5 10395.6 10403.8 10457.8 10494.5 3925.6 4002.5 4154.6 4171.1 4176.7 8273.6 8279.3 8287.3 8305.6 8347.4 4450.8 4451.6 4498.0 4514.8 4515.9 3481.2 3915.9 4037.5 4145.1 4167.9 3382.7 3407.6 3458.0 3478.6 3479.6 1061.1 1072.0 1074.8 1081.8 1086.1 747.4 787.8 796.8 802.8 807.4 4959.4 4998.2 5032.8 5116.8 5271.3 399.0 400.5 420.1 420.4 424.3 3501.9 3838.1 3840.1 3840.6 3851.5 9231.6 9564.8 9724.2 9734.9 9736.4 9457.7 9554.9 9562.6 9564.9 9566.8 7170.5 7201.7 7258.7 7330.4 7367.4 5341.3 5476.6 5498.3 5511.9 5531.2 8291.8 8473.0 8473.2 8519.7 8595.4 8346.2 8553.0 8594.7 8722.3 8740.9 6178.8 6473.8 6648.8 6711.1 6825.4 7430.1 7453.2 7500.5 7507.6 7514.0 6627.9 6695.9 6728.7 6751.7 6960.1 6527.2 6618.8 6711.7 6754.7 6774.0 6331.2 6368.3 6426.3 6426.4 6437.1 4580.4 4582.4 4592.8 4607.4 4638.4 4777.5 4790.2 4848.9 4860.8 4868.4 07:45:01 INFO - PROCESS | 7247 | 07:45:01 INFO - PROCESS | 7247 | [#4] prototype.html Cycles:180 Average:4399.56 Median:5045.12 stddev:1293.72 (25.6%) stddev-sans-first:1259.88 07:45:01 INFO - PROCESS | 7247 | Values: 281.3 297.5 302.0 307.5 311.7 4838.8 5001.1 5008.2 5051.6 5072.0 4833.7 5033.5 5040.9 5049.3 5054.9 3966.9 3970.7 3979.6 3990.8 3997.3 3739.8 3847.3 3970.4 3972.5 3990.7 3939.9 3950.4 3961.4 3968.0 3979.4 3936.5 3945.9 3951.9 3962.6 3965.4 3455.3 3491.3 3501.8 3524.8 3525.5 4762.2 4835.7 4839.4 4842.2 4844.4 4477.9 4503.6 4504.9 4521.0 4530.9 5264.6 5269.5 5281.1 5286.6 5287.3 3504.6 3702.3 3718.5 3722.2 3737.0 5470.6 5547.9 5548.4 5563.1 5568.7 3785.8 3792.2 3792.8 3798.2 3821.9 3651.8 3824.5 3840.8 3870.7 3877.3 4365.4 4419.7 4425.3 4425.7 4436.0 5276.4 5280.3 5292.1 5296.6 5303.9 1261.2 1290.8 1295.3 1300.5 1303.2 890.5 892.0 910.1 913.7 913.8 4647.4 4648.5 4651.8 4653.5 4665.6 5412.5 5425.2 5436.9 5445.4 5448.6 4473.2 4631.7 4639.8 4640.4 4643.5 2886.6 2887.8 2898.3 2900.3 2907.6 5114.8 5130.6 5135.8 5137.3 5137.6 5366.4 5532.2 5540.3 5549.7 5678.7 5194.5 5213.1 5217.6 5230.3 5252.9 5491.2 5505.3 5528.4 5550.1 5577.2 5190.4 5407.7 5413.0 5428.0 5439.0 5229.7 5235.5 5239.9 5253.7 5253.7 3798.3 3801.6 3819.1 3820.7 3822.3 5209.7 5388.4 5498.2 5536.9 5545.7 5197.8 5366.5 5367.4 5386.1 5387.1 5314.9 5335.8 5338.5 5340.1 5353.9 5145.9 5260.0 5263.4 5264.5 5269.8 5345.8 5378.9 5390.8 5395.0 5402.2 5267.2 5271.6 5280.6 5288.4 5294.8 07:45:01 INFO - PROCESS | 7247 | 07:45:01 INFO - PROCESS | 7247 | [#5] yui.html Cycles:180 Average:12763.66 Median:41677.58 stddev:14172.03 (34.0%) stddev-sans-first:14183.11 07:45:01 INFO - PROCESS | 7247 | Values: 757.5 783.9 787.5 789.8 796.3 11564.8 11826.5 11832.9 11853.3 11854.6 12443.4 12461.3 12511.9 12547.8 12566.8 629.1 770.9 797.1 807.0 807.4 786.7 792.4 792.9 792.9 793.0 842.8 846.9 847.5 848.9 849.0 658.6 807.3 833.9 843.6 843.7 614.3 616.3 616.8 617.5 618.9 12832.7 12848.4 12857.7 12880.5 12887.0 11963.8 12392.7 12662.2 12853.6 12908.8 9783.7 9890.3 9963.5 10217.6 10226.3 3235.0 3262.2 3305.5 3329.8 3376.2 42434.0 42481.0 42962.8 43004.6 43115.1 9894.6 9917.0 9934.8 10004.4 10017.2 17217.7 17257.6 17270.9 17288.8 17316.0 6661.1 6690.2 6739.9 6763.5 6826.6 3812.4 3850.6 3922.8 3934.4 4019.5 2882.6 2941.5 2949.8 2950.5 2953.0 510.4 518.3 522.4 536.0 538.4 444.9 542.8 563.0 606.6 673.2 7945.2 7997.2 8034.2 8260.5 8393.3 649.3 663.4 665.3 668.6 672.4 3803.9 4018.4 4069.9 4138.7 4177.5 50902.5 52146.5 52474.5 52551.7 53149.0 42976.8 44837.8 45458.0 45605.0 46188.8 41565.2 41616.0 41739.2 42361.6 44536.1 8166.6 8285.5 8470.3 8859.1 8979.8 29040.6 29131.0 29559.3 30140.7 30206.8 38954.0 39675.2 39992.0 40034.6 40576.4 10266.0 10436.1 10849.0 10999.8 11333.8 12232.4 12291.6 12322.5 13056.3 13142.5 8905.7 10306.5 11492.5 11747.5 12185.6 11207.5 11341.1 11458.0 11647.8 11847.9 10865.1 10888.9 10938.5 11152.2 11295.3 9176.4 9580.7 10095.7 10209.3 10241.0 9282.4 10112.9 10142.5 10184.7 10283.1 07:45:01 INFO - PROCESS | 7247 | -------- Summary: end -------- 07:45:01 INFO - PROCESS | 7247 | 07:45:01 INFO - TEST-INFO | 7247: exit 0 07:45:01 INFO - TEST-OK | dromaeo_css | took 1117709ms 07:45:01 INFO - TEST-START | kraken 07:45:01 INFO - operating with platform_type : linux_ 07:45:01 INFO - Initialising browser for kraken test... 07:45:01 INFO - TEST-INFO | started process 7462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4xhoIj/profile http://localhost:59889/getInfo.html) 07:45:05 INFO - PROCESS | 7462 | __metrics Screen width/height:1600/1200 07:45:05 INFO - PROCESS | 7462 | colorDepth:24 07:45:05 INFO - PROCESS | 7462 | Browser inner width/height: 1024/697 07:45:05 INFO - PROCESS | 7462 | __metrics 07:45:06 ERROR - PROCESS | 7462 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:45:07 INFO - TEST-INFO | 7462: exit 0 07:45:07 INFO - Browser initialized. 07:45:07 INFO - Running cycle 1/1 for kraken test... 07:45:07 INFO - TEST-INFO | started process 7541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4xhoIj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:45:19 INFO - PROCESS | 7541 | RSS: Main: 155004928 07:45:19 INFO - PROCESS | 7541 | 07:45:22 INFO - PROCESS | 7541 | Cycle 1(1): loaded http://localhost:59889/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59889/tests/kraken/driver.html?testName=audio-beat-detection) 07:45:23 INFO - PROCESS | 7541 | RSS: Main: 210702336 07:45:23 INFO - PROCESS | 7541 | 07:45:26 INFO - PROCESS | 7541 | Cycle 1(1): loaded http://localhost:59889/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59889/tests/kraken/driver.html?testName=audio-dft) 07:45:26 INFO - PROCESS | 7541 | RSS: Main: 196108288 07:45:26 INFO - PROCESS | 7541 | 07:45:29 INFO - PROCESS | 7541 | Cycle 1(1): loaded http://localhost:59889/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59889/tests/kraken/driver.html?testName=audio-fft) 07:45:30 INFO - PROCESS | 7541 | RSS: Main: 266653696 07:45:30 INFO - PROCESS | 7541 | 07:45:32 INFO - PROCESS | 7541 | Cycle 1(1): loaded http://localhost:59889/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59889/tests/kraken/driver.html?testName=audio-oscillator) 07:45:33 INFO - PROCESS | 7541 | RSS: Main: 173379584 07:45:33 INFO - PROCESS | 7541 | 07:45:35 INFO - PROCESS | 7541 | Cycle 1(1): loaded http://localhost:59889/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59889/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:45:36 INFO - PROCESS | 7541 | RSS: Main: 178577408 07:45:36 INFO - PROCESS | 7541 | 07:45:39 INFO - PROCESS | 7541 | Cycle 1(1): loaded http://localhost:59889/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59889/tests/kraken/driver.html?testName=imaging-darkroom) 07:45:39 INFO - PROCESS | 7541 | RSS: Main: 214937600 07:45:39 INFO - PROCESS | 7541 | 07:45:43 INFO - PROCESS | 7541 | Cycle 1(1): loaded http://localhost:59889/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59889/tests/kraken/driver.html?testName=imaging-desaturate) 07:45:43 INFO - PROCESS | 7541 | RSS: Main: 215969792 07:45:43 INFO - PROCESS | 7541 | 07:45:46 INFO - PROCESS | 7541 | Cycle 1(1): loaded http://localhost:59889/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59889/tests/kraken/driver.html?testName=json-parse-financial) 07:45:47 INFO - PROCESS | 7541 | RSS: Main: 215371776 07:45:47 INFO - PROCESS | 7541 | 07:45:49 INFO - PROCESS | 7541 | Cycle 1(1): loaded http://localhost:59889/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59889/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:45:49 INFO - PROCESS | 7541 | RSS: Main: 200880128 07:45:49 INFO - PROCESS | 7541 | 07:45:51 INFO - PROCESS | 7541 | Cycle 1(1): loaded http://localhost:59889/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59889/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:45:52 INFO - PROCESS | 7541 | RSS: Main: 203448320 07:45:52 INFO - PROCESS | 7541 | 07:45:54 INFO - PROCESS | 7541 | Cycle 1(1): loaded http://localhost:59889/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59889/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:45:54 INFO - PROCESS | 7541 | RSS: Main: 218791936 07:45:54 INFO - PROCESS | 7541 | 07:45:57 INFO - PROCESS | 7541 | Cycle 1(1): loaded http://localhost:59889/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59889/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:45:58 INFO - PROCESS | 7541 | RSS: Main: 224706560 07:45:58 INFO - PROCESS | 7541 | 07:46:01 INFO - PROCESS | 7541 | Cycle 1(1): loaded http://localhost:59889/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59889/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:46:01 INFO - PROCESS | 7541 | RSS: Main: 218185728 07:46:01 INFO - PROCESS | 7541 | 07:46:03 INFO - PROCESS | 7541 | Cycle 1(1): loaded http://localhost:59889/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59889/tests/kraken/driver.html?testName=ai-astar) 07:46:03 INFO - PROCESS | 7541 | RSS: Main: 281518080 07:46:03 INFO - PROCESS | 7541 | 07:46:03 INFO - PROCESS | 7541 | __start_tp_report 07:46:03 INFO - PROCESS | 7541 | _x_x_mozilla_page_load 07:46:03 INFO - PROCESS | 7541 | _x_x_mozilla_page_load_details 07:46:03 INFO - PROCESS | 7541 | |i|pagename|runs| 07:46:03 INFO - PROCESS | 7541 | |0;ai-astar;112;113;107;111;114;114;102;114;113;114 07:46:03 INFO - PROCESS | 7541 | |1;audio-beat-detection;156;137;158;185;133;153;174;134;182;136 07:46:03 INFO - PROCESS | 7541 | |2;audio-dft;161;161;159;161;161;162;162;162;162;162 07:46:03 INFO - PROCESS | 7541 | |3;audio-fft;77;74;104;109;74;73;74;119;101;77 07:46:03 INFO - PROCESS | 7541 | |4;audio-oscillator;95;94;149;94;95;95;143;94;94;148 07:46:03 INFO - PROCESS | 7541 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;117 07:46:03 INFO - PROCESS | 7541 | |6;imaging-darkroom;145;146;145;146;145;147;146;147;145;146 07:46:03 INFO - PROCESS | 7541 | |7;imaging-desaturate;95;95;95;95;94;95;96;95;95;95 07:46:04 INFO - PROCESS | 7541 | |8;json-parse-financial;71;65;65;65;64;66;65;81;64;64 07:46:04 INFO - PROCESS | 7541 | |9;json-stringify-tinderbox;65;66;66;66;66;65;66;66;66;65 07:46:04 INFO - PROCESS | 7541 | |10;stanford-crypto-aes;81;79;88;78;87;79;79;81;80;80 07:46:04 INFO - PROCESS | 7541 | |11;stanford-crypto-ccm;137;136;135;135;136;130;131;141;169;134 07:46:04 INFO - PROCESS | 7541 | |12;stanford-crypto-pbkdf2;182;183;177;177;181;177;182;176;176;176 07:46:04 INFO - PROCESS | 7541 | |13;stanford-crypto-sha256-iterative;74;77;75;73;73;72;73;71;72;71 07:46:04 INFO - PROCESS | 7541 | __end_tp_report 07:46:04 INFO - PROCESS | 7541 | __start_cc_report 07:46:04 INFO - PROCESS | 7541 | _x_x_mozilla_cycle_collect,1869 07:46:04 INFO - PROCESS | 7541 | __end_cc_report 07:46:04 INFO - PROCESS | 7541 | __startTimestamp1461249963992__endTimestamp 07:46:04 INFO - PROCESS | 7541 | 07:46:04 INFO - PROCESS | 7541 | ------- Summary: start ------- 07:46:04 INFO - PROCESS | 7541 | Number of tests: 14 07:46:04 INFO - PROCESS | 7541 | 07:46:04 INFO - PROCESS | 7541 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.50 stddev:3.95 (3.5%) stddev-sans-first:4.18 07:46:04 INFO - PROCESS | 7541 | Values: 112.0 113.0 107.0 111.0 114.0 114.0 102.0 114.0 113.0 114.0 07:46:04 INFO - PROCESS | 7541 | 07:46:04 INFO - PROCESS | 7541 | [#1] audio-beat-detection Cycles:10 Average:154.80 Median:157.00 stddev:20.04 (12.8%) stddev-sans-first:21.25 07:46:04 INFO - PROCESS | 7541 | Values: 156.0 137.0 158.0 185.0 133.0 153.0 174.0 134.0 182.0 136.0 07:46:04 INFO - PROCESS | 7541 | 07:46:04 INFO - PROCESS | 7541 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 07:46:04 INFO - PROCESS | 7541 | Values: 161.0 161.0 159.0 161.0 161.0 162.0 162.0 162.0 162.0 162.0 07:46:04 INFO - PROCESS | 7541 | 07:46:04 INFO - PROCESS | 7541 | [#3] audio-fft Cycles:10 Average:88.20 Median:74.00 stddev:17.89 (24.2%) stddev-sans-first:18.51 07:46:04 INFO - PROCESS | 7541 | Values: 77.0 74.0 104.0 109.0 74.0 73.0 74.0 119.0 101.0 77.0 07:46:04 INFO - PROCESS | 7541 | 07:46:04 INFO - PROCESS | 7541 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:94.00 stddev:25.28 (26.9%) stddev-sans-first:26.22 07:46:04 INFO - PROCESS | 7541 | Values: 95.0 94.0 149.0 94.0 95.0 95.0 143.0 94.0 94.0 148.0 07:46:04 INFO - PROCESS | 7541 | 07:46:04 INFO - PROCESS | 7541 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 07:46:04 INFO - PROCESS | 7541 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 07:46:04 INFO - PROCESS | 7541 | 07:46:04 INFO - PROCESS | 7541 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 07:46:04 INFO - PROCESS | 7541 | Values: 145.0 146.0 145.0 146.0 145.0 147.0 146.0 147.0 145.0 146.0 07:46:04 INFO - PROCESS | 7541 | 07:46:04 INFO - PROCESS | 7541 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 07:46:04 INFO - PROCESS | 7541 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 96.0 95.0 95.0 95.0 07:46:04 INFO - PROCESS | 7541 | 07:46:04 INFO - PROCESS | 7541 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:65.00 stddev:5.33 (8.2%) stddev-sans-first:5.46 07:46:04 INFO - PROCESS | 7541 | Values: 71.0 65.0 65.0 65.0 64.0 66.0 65.0 81.0 64.0 64.0 07:46:04 INFO - PROCESS | 7541 | 07:46:04 INFO - PROCESS | 7541 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 07:46:04 INFO - PROCESS | 7541 | Values: 65.0 66.0 66.0 66.0 66.0 65.0 66.0 66.0 66.0 65.0 07:46:04 INFO - PROCESS | 7541 | 07:46:04 INFO - PROCESS | 7541 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.50 stddev:3.46 (4.3%) stddev-sans-first:3.67 07:46:04 INFO - PROCESS | 7541 | Values: 81.0 79.0 88.0 78.0 87.0 79.0 79.0 81.0 80.0 80.0 07:46:04 INFO - PROCESS | 7541 | 07:46:04 INFO - PROCESS | 7541 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:136.00 stddev:11.18 (8.2%) stddev-sans-first:11.84 07:46:04 INFO - PROCESS | 7541 | Values: 137.0 136.0 135.0 135.0 136.0 130.0 131.0 141.0 169.0 134.0 07:46:04 INFO - PROCESS | 7541 | 07:46:04 INFO - PROCESS | 7541 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.70 Median:179.00 stddev:2.91 (1.6%) stddev-sans-first:2.83 07:46:04 INFO - PROCESS | 7541 | Values: 182.0 183.0 177.0 177.0 181.0 177.0 182.0 176.0 176.0 176.0 07:46:04 INFO - PROCESS | 7541 | 07:46:04 INFO - PROCESS | 7541 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:73.00 stddev:1.85 (2.5%) stddev-sans-first:1.94 07:46:04 INFO - PROCESS | 7541 | Values: 74.0 77.0 75.0 73.0 73.0 72.0 73.0 71.0 72.0 71.0 07:46:04 INFO - PROCESS | 7541 | -------- Summary: end -------- 07:46:04 INFO - PROCESS | 7541 | 07:46:04 INFO - TEST-INFO | 7541: exit 0 07:46:05 INFO - TEST-OK | kraken | took 63140ms 07:46:05 INFO - SUITE-END | took 1180s 07:46:05 INFO - Completed test suite (00:19:40) 07:46:05 INFO - javascript benchmark 07:46:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2565.8460492370455, 2605.5961325994476, 2614.6470226519436, 2629.1586692258475, 2645.603159526071, 4447.733136011841, 4540.931886021708, 4544.750038747868, 4554.294084416916, 4576.656750743691, 4643.373144625474, 4675.625949924007, 4705.741184234866, 4733.668643194977, 4736.431628204612, 4185.309423945046, 4196.412502249687, 4212.578742125794, 4235.343521754117, 4381.671374646899, 4302.440682711243, 4362.520122786491, 4365.36702178184, 4366.0, 4395.802188901491, 4091.672666186713, 4182.958170418287, 4239.618434340893, 4320.805563749639, 4325.52419233884, 4225.302825033866, 4257.893552661178, 4262.573742625744, 4266.210751011042, 4318.52496225415, 4224.302990006676, 4247.235497610429, 4251.149770045972, 4285.185814695198, 4287.2068667296335, 4399.64802815774, 4479.328100784908, 4519.570640789153, 4525.818967241339, 4561.087782443491, 4957.677750946177, 4983.202687569971, 4985.376827896513, 4987.900241995139, 5006.123928312567, 5001.549860512535, 5009.073321435546, 5027.4469808321055, 5028.346314979066, 5045.949540504585, 4525.705829121097, 4582.5417458253905, 4646.9070618587775, 4661.86014419568, 4671.27595222741, 5059.367579052619, 5066.341375621146, 5067.189249720101, 5089.720065396439, 5096.082705113041, 4840.515948405202, 4844.176489996709, 4855.757212139379, 4856.247281671346, 4897.946941407615, 4747.311639812277, 4917.729524876167, 4931.284963680247, 4985.127602669519, 5023.271625614266, 4861.489543597942, 4863.02739452111, 4902.2646603009125, 4908.9754551227015, 4917.7786999585105, 4842.394700662418, 4846.95153048465, 4853.344798452164, 4856.538628830255, 4901.436334821541, 4043.91912161761, 4114.547399786021, 4147.0, 4148.56440073794, 4192.517860446027, 3581.71346292296, 3598.784072955631, 3637.909052273714, 3640.8361623726996, 3672.081979505124, 4244.469441319835, 4268.658507319407, 4279.850205242864, 4287.335463003239, 4316.266234740102, 4749.596284315872, 4839.637027222972, 4999.850004499871, 5016.899662006739, 5073.720945348041, 4283.593058659422, 4291.635211007037, 4291.806868690916, 4330.761808100522, 4336.02439451121, 4437.201303765353, 4480.9103817924115, 4482.439695038121, 4485.304777759453, 4528.41130653013, 4465.732056076516, 4603.930941035954, 4680.1107789520565, 4723.45680246776, 4724.338592596971, 4963.0, 4985.750712464434, 4986.401631804061, 4990.176620857518, 5026.74866256693, 4678.69588476748, 4705.905881882275, 4711.0, 4739.668223224479, 4757.381540399726, 4742.905141897074, 4898.92651610219, 4907.33750943618, 4922.286268491121, 4973.154563724248, 4879.804807807648, 4894.952142658548, 4902.583280421204, 4903.877403064952, 4966.056449274771, 4759.309900064541, 4759.309900064541, 4761.381020467317, 4810.927836082392, 4828.927566086441, 4633.791479383503, 4760.476347601831, 4799.064182484382, 4854.004928989478, 4856.174450343379, 4787.497312782108, 4796.304535842353, 4800.303955926302, 4807.7836497357, 4846.103470857903, 4878.853634390974, 4897.9020419592125, 4902.313676085422, 4909.803607855646, 4951.034548263054, 4616.076784643152, 4708.034852855088, 4771.7375544344, 4791.448983366958, 4808.374911261513], "value": 4541.143168352251, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.4781388599243, 572.3017918139869, 592.1295695327866, 600.5885968111846, 602.8071017274472, 31744.68255317446, 32965.50551741723, 32990.50514242288, 35044.12389690256, 35088.298234035305, 36295.0, 36779.63220367795, 37020.81489592555, 37083.81458092706, 37196.442053369225, 7232.529885557448, 7614.809629759245, 7795.532268063906, 9475.905240947572, 9768.07203315684, 9846.753831154243, 9900.55447504864, 9977.551010204523, 10013.349132306414, 10015.949920250388, 9840.16358609519, 9941.304108712393, 9941.801163976716, 9948.35335703177, 9953.850692239623, 7462.0, 10024.649137280234, 10382.740431489197, 10394.896051039468, 10399.688009359732, 9695.175910047654, 9695.854562181574, 9696.612135514571, 9699.175570076552, 9765.560549775206, 35229.0, 35481.0, 35507.28985420303, 35617.1095722609, 36016.819915900254, 3202.6957439043254, 3340.8329583520726, 3492.1967947372245, 3496.8950931472095, 3816.3893776995824, 29173.124806255848, 29300.41399172026, 29310.560341594894, 29414.70585294141, 29595.260118496994, 3338.749593780476, 3447.120984149051, 3458.8270586470576, 3484.7212223022098, 3573.0888623401124, 232606.0, 233968.83015584984, 234171.0, 235514.99999999828, 235597.0, 52024.79752024843, 53486.465135348924, 53631.73184134132, 53725.731371343674, 53942.46057539453, 56646.71676641673, 57261.0, 57343.42656573464, 57577.42422575804, 57632.13551796726, 11782.646520604396, 13566.0, 13781.310934453237, 13789.586312410644, 13796.172229666252, 9006.684766033288, 9071.729957805912, 9101.317401194938, 9125.0, 10240.231982601186, 17583.472495825146, 17846.821531784517, 17857.28570857151, 17889.7316540252, 17919.641607168043, 6393.680315984182, 6402.775902843378, 6448.387403196689, 6628.502862285348, 6652.401283884474, 908.40953380302, 919.0, 930.5021813329836, 1041.0890470838017, 1067.9305845120043, 27274.040785009085, 27281.863590681918, 27727.445451090865, 28181.43637127246, 28218.43563128726, 947.4078700811992, 959.6928982725461, 1043.0820877627639, 1060.1095080132725, 1062.9689201474557, 14599.41602335916, 14802.259887005606, 15102.244887755569, 15215.543533694006, 15387.230638468032, 319786.0, 322829.0, 323632.0, 324133.0, 324301.0, 48527.75736121297, 48872.26691599629, 49023.264651030266, 49073.263901041515, 49112.75443622759, 1095.5782023920688, 1100.8789033206501, 1233.4018001269378, 1239.0830785219052, 1241.8633950265464, 25750.742492574835, 27827.860860696375, 27981.72018279791, 28005.859970700018, 28088.43823123567, 39446.21107577775, 39871.40192897167, 40248.3962740565, 40314.798426007685, 40326.798366007984, 225061.0, 225506.0, 225797.0, 226252.0, 226448.0, 31332.53001204938, 32561.837190813894, 37006.629933700315, 37760.81119594385, 38158.61841381661, 36042.0, 36853.815730921175, 37142.44286335761, 37299.62700372961, 37689.24621507609, 31229.37541249117, 34036.82981585076, 34165.487517687754, 34487.31025379428, 35296.29407411786, 34632.0, 34925.0, 35003.47494787529, 35010.64989350074, 35015.299694005465, 34368.0, 34711.0, 34847.825760871034, 35023.12442188965, 35247.47128793019, 30406.391872162876, 31394.0, 31404.52893206558, 31643.367132656756, 31663.84168079237, 24152.879235604414, 24203.878980604983, 24337.51324973526, 24988.625170622818, 25049.87475062686], "value": 17517.778320482717, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.2135750850688, 370.13388670511006, 370.35188420264535, 374.1693440561952, 382.56005593567374, 15697.215139243035, 15882.285297161641, 16176.19119044046, 16182.19089045546, 16189.0, 14931.253437328118, 16302.077608002637, 16569.337226510954, 16591.751123733153, 16638.417655382033, 4936.901261974767, 5109.744512774365, 5182.689038657673, 5212.895742085156, 5223.869403264911, 3639.781613103209, 5073.416557095944, 5561.944380556203, 5892.970535147339, 5914.349421563625, 5852.502537284336, 5870.412958704117, 5891.793787217448, 5894.263217097863, 5897.734601942923, 5779.682117483537, 5831.183634291203, 5832.0, 5848.941510584882, 5855.912161317584, 3301.983490082534, 4849.466558678542, 5005.299258103832, 5133.717645529495, 5139.408967968694, 18703.43889683298, 19198.712019319722, 19242.518937026547, 20071.698924516142, 20146.798532014785, 1875.953101172468, 1918.5011896906765, 1931.6346049019216, 2033.7900545870054, 2061.6186005589016, 6233.438990490832, 11695.7076073098, 12706.174098683648, 12893.613191604267, 13249.205047697169, 1732.5148958291697, 1761.3218910719338, 1785.3840425053336, 1790.5523619095227, 1792.0770803036446, 62711.0, 64143.0, 64376.67811660958, 64636.0, 64738.99999999953, 9142.314326425545, 9332.860007099898, 9515.666951656658, 9530.90469095314, 9737.90262097384, 13111.737765244641, 13182.406791694397, 13191.802122968164, 13212.207267563977, 13217.93391033058, 6829.453643708492, 6914.619695916773, 6981.616011119438, 7000.894986575206, 7162.068931038932, 6342.112104305401, 6609.768658096944, 6728.226253980757, 6760.121184246016, 6762.661866906635, 5800.4199580042505, 5981.936231999953, 6019.909701354483, 6035.849103772441, 6077.665728384981, 1595.1625396666843, 1670.8412700793406, 1699.898006119612, 1717.1671739206474, 1755.5260079778388, 835.9122292159358, 892.7277180460022, 901.909809019106, 937.2829785214317, 941.1012483078644, 15798.842011579736, 15816.446424375092, 15960.122193279482, 16309.184540772914, 16674.749878751827, 909.4452384045727, 915.0620613870835, 947.725159703692, 961.4808003678075, 986.5018165826211, 9654.75863103428, 9754.804903901882, 9838.9016109838, 9906.157976571927, 9951.651692190739, 374505.0, 386104.0, 391123.0, 392452.0, 399978.0, 66572.0, 69265.0, 72000.2799972004, 72876.0, 72883.0, 990.0396615283164, 993.6820217530321, 1013.8948546084803, 1064.2337516987757, 1067.300917898762, 15315.770263445835, 15727.528174154793, 15736.134512601458, 15773.369065237262, 16322.755158672868, 33129.686337001374, 33695.326093478485, 34364.31271374608, 35054.824725876206, 35403.0, 47996.760016199696, 50401.49598504115, 50811.23783143182, 50816.23775643294, 51004.489955099976, 7688.231176882267, 7742.806429839074, 7875.763727088197, 7893.684252629831, 7904.604769761604, 9745.512724363613, 11487.368194749035, 11733.471993760131, 11790.646280611596, 11911.106666999836, 10332.638357657446, 10443.373397596168, 10484.26610137283, 10624.8937510627, 10631.096356809758, 10393.636222732168, 10560.84158737635, 10597.89402105969, 10631.0, 10745.140388769036, 10337.328073675188, 10556.208284378548, 10571.735706607089, 10736.248462607542, 10973.780524389307, 7367.8158046049275, 7475.252474752481, 7705.113911900204, 7958.681652733826, 8120.67517299325, 10176.643817466353, 10480.580776768844, 10528.736781580521, 10664.680059598224, 10841.891581084405], "value": 8268.425825720286, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1245.364863919401, 1441.6323837421457, 1447.956561303161, 1584.643455222575, 1767.187093936789, 6728.9327106728915, 7338.816529586763, 7496.92503074969, 7509.061367329084, 7523.473356865022, 7255.201927787953, 7389.8152546186375, 7417.443691723115, 7426.925730742691, 7432.851342973137, 2171.7285339332584, 2185.2133232036454, 2193.484531135182, 2199.626063569197, 2200.5378870437225, 2135.540858715376, 2183.6942828004094, 2190.802827745503, 2196.3410976707005, 2218.7670294619074, 2150.9892450537727, 2165.577712346093, 2168.913243470259, 2172.728408948881, 2229.687843701883, 2146.1200907627876, 2151.4191168384527, 2154.838387120972, 2156.3423155937435, 2156.762756096828, 2097.685347197917, 2128.914843406277, 2134.9146034158616, 2135.39141344716, 2155.3964889830872, 7559.735409260649, 7573.924260757377, 7622.428317876182, 7627.466077374586, 7806.921930780676, 4224.45082139323, 4307.590778876001, 4318.071614602875, 4333.111712099044, 4339.132173565299, 2932.7067293270716, 2965.7182567656037, 2983.970160298413, 2987.253186703324, 3004.278973046475, 931.5156118818244, 937.0442149008041, 940.7036783413203, 963.1668606655263, 973.5716284834721, 10299.485025748683, 10395.584176632925, 10403.84394234087, 10457.79084418315, 10494.527746251437, 3925.568187499373, 4002.539707933625, 4154.605312495308, 4171.0615111599645, 4176.749395036247, 8273.627686754111, 8279.337652987746, 8287.295579875778, 8305.584720763938, 8347.4156809024, 4450.844220452269, 4451.643868490513, 4497.955020449819, 4514.841980530731, 4515.88710282239, 3481.164520515109, 3915.8629447969183, 4037.4751282333696, 4145.1295228002455, 4167.874963751032, 3382.6955573997966, 3407.6081250656493, 3457.9654203458144, 3478.6347433519622, 3479.565054368204, 1061.0768631290673, 1072.0458791675414, 1074.790415868898, 1081.8052750504985, 1086.1093902999464, 747.3834086878347, 787.8109253779052, 796.832640182136, 802.7591722483348, 807.4267270238079, 4959.355283813154, 4998.225275082368, 5032.79868805251, 5116.8209112681625, 5271.341082364705, 398.9920201595952, 400.4873761585176, 420.0800247458057, 420.3505583872924, 424.33167760776286, 3501.9124521886647, 3838.0788610733225, 3840.097577069442, 3840.615938406193, 3851.4993050903204, 9231.630734770533, 9564.76088097803, 9724.222062235005, 9734.853977190207, 9736.367136136128, 9457.668981585612, 9554.856677149848, 9562.56968436422, 9564.856527152098, 9566.808663826685, 7170.4980651354945, 7201.71193152268, 7258.709651613876, 7330.413566914634, 7367.373773229336, 5341.252224688469, 5476.644018138808, 5498.257735205696, 5511.889762204813, 5531.170324451204, 8291.792705182419, 8472.957635212031, 8473.237408633253, 8519.701810436605, 8595.398322117391, 8346.248837604644, 8552.957235214033, 8594.742157735278, 8722.302215822845, 8740.868886966573, 6178.783742568989, 6473.77341793035, 6648.767293144717, 6711.0940023096255, 6825.35159159879, 7430.145533263744, 7453.180150183367, 7500.512466689648, 7507.587082710504, 7513.962430187814, 6627.900581491185, 6695.899561506484, 6728.7308507659145, 6751.696173672099, 6960.060391847036, 6527.15147030883, 6618.8345291368105, 6711.697973591297, 6754.696038678369, 6773.966130169318, 6331.176946996861, 6368.267649220214, 6426.325235850169, 6426.4216220540375, 6437.0666253392055, 4580.404547408815, 4582.404287442611, 4592.839250626212, 4607.40103786519, 4638.443386793607, 4777.4505931818285, 4790.161721698759, 4848.854534363974, 4860.8298709545, 4868.440129385024], "value": 3990.6983719536065, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.2869376131506, 297.51802080629386, 301.9849007549622, 307.46347623397173, 311.6820842740404, 4838.758062096898, 5001.124803159446, 5008.198688209887, 5051.570616497602, 5071.974640126794, 4833.734144622044, 5033.54698077173, 5040.924386134211, 5049.318342023826, 5054.873628159298, 3966.8809935701975, 3970.6896724080984, 3979.6418322351055, 3990.820413081404, 3997.34043882759, 3739.7756134631873, 3847.2690188864026, 3970.3845903884944, 3972.4637173981578, 3990.660793832528, 3939.9212015759667, 3950.3679411294197, 3961.445397644332, 3968.0, 3979.403089536578, 3936.547297060846, 3945.9013524661827, 3951.8659923641344, 3962.643362097425, 3965.365541513373, 3455.274392377604, 3491.336646037245, 3501.7898926064263, 3524.788512689247, 3525.5416795816636, 4762.214234651278, 4835.661503694742, 4839.395075615548, 4842.249451335048, 4844.370231869834, 4477.910441791146, 4503.5946764791, 4504.909901801979, 4520.95479045212, 4530.932036019462, 5264.605154613381, 5269.473052694738, 5281.128613778722, 5286.550643195333, 5287.339082614673, 3504.5969713482764, 3702.259548090393, 3718.5497655913946, 3722.1625134344827, 3736.981315093434, 5470.617056806025, 5547.861303467405, 5548.4174161713245, 5563.082091454905, 5568.6658800472105, 3785.7539259948016, 3792.222594368148, 3792.829322680431, 3798.164403831153, 3821.9426708599394, 3651.7626354286886, 3824.4836947012354, 3840.7695538267794, 3870.670992965573, 3877.2827027000094, 4365.367021781887, 4419.734815911055, 4425.291953287523, 4425.672298310558, 4435.977820110878, 5276.366835979707, 5280.287161233261, 5292.126799078186, 5296.629235953446, 5303.946960530422, 1261.1802328486374, 1290.825738525306, 1295.2875918244927, 1300.466808608466, 1303.2310936547483, 890.5172887142963, 891.9777005574913, 910.0808183734343, 913.6573784830689, 913.8126684029758, 4647.372604698322, 4648.5119062498625, 4651.813927442864, 4653.488116307203, 4665.626749860071, 5412.458754124556, 5425.186222066722, 5436.864078398072, 5445.428230035789, 5448.645838020516, 4473.172463094338, 4631.652626053059, 4639.8144074237325, 4640.419947506562, 4643.4892161862845, 2886.5958765772807, 2887.7834162437903, 2898.2609434594465, 2900.2894290898444, 2907.636545431821, 5114.769835357418, 5130.640855140179, 5135.820246291437, 5137.255098010843, 5137.614678899023, 5366.382865970385, 5532.197831314517, 5540.335159780852, 5549.667019978814, 5678.659280443187, 5194.506636814351, 5213.139831927765, 5217.582593392595, 5230.267762513251, 5252.947470525322, 5491.231227628055, 5505.311836020497, 5528.364238112668, 5550.084236100998, 5577.191307260506, 5190.351206099238, 5407.729613519387, 5413.0, 5427.972860135674, 5439.048166570913, 5229.712365819764, 5235.502627250406, 5239.869003274948, 5253.658512196695, 5253.711045892513, 3798.3352913240624, 3801.5818259990824, 3819.1406933439753, 3820.6943444524927, 3822.3372832817813, 5209.6874187548865, 5388.434214407431, 5498.230247765236, 5536.864942686659, 5545.694986775766, 5197.789790269893, 5366.463353664759, 5367.396812545834, 5386.111291636836, 5387.141436204503, 5314.867128321668, 5335.759890805, 5338.54622357104, 5340.118880384693, 5353.946460535345, 5145.948540514697, 5259.973700131475, 5263.421023687315, 5264.525153619393, 5269.815556455505, 5345.812896548602, 5378.865528361665, 5390.811321603725, 5394.973025134849, 5402.162664786964, 5267.157254839208, 5271.551918087006, 5280.60395470349, 5288.418273989935, 5294.814681486129], "value": 3982.931841290424, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.5341165183411, 783.9333656639185, 787.527483509894, 789.8104454930818, 796.2833449895094, 11564.768704625902, 11826.467808948597, 11832.940835295833, 11853.288802671836, 11854.644360669183, 12443.377831108432, 12461.314627695474, 12511.937440312808, 12547.811782823243, 12566.811497827517, 629.1475051305483, 770.9074911010687, 797.0952968380872, 806.9596520173997, 807.3904202327235, 786.685325869651, 792.3779832831228, 792.8652129138061, 792.8810678398229, 792.9563873986929, 842.8187939592987, 846.9110743371949, 847.4788005376711, 848.9151084891523, 848.995755021224, 658.5982550644103, 807.2855522862251, 833.8707500337457, 843.569779412498, 843.7173546861778, 614.3058344071216, 616.3097330989276, 616.8118723789242, 617.527591392585, 618.9102580125901, 12832.679183020406, 12848.421821018077, 12857.742845143139, 12880.484780608764, 12887.0, 11963.820542691867, 12392.690182745413, 12662.204143111288, 12853.550125745554, 12908.806367904488, 9783.657571984946, 9890.258230632659, 9963.45201013944, 10217.642382516577, 10226.284160108795, 3234.951475727866, 3262.2496825730213, 3305.471124620049, 3329.766916315859, 3376.2403459221723, 42434.0, 42481.0, 42962.78518607418, 43004.56995430037, 43115.137697246195, 9894.55474503649, 9916.950415248022, 9934.751631209134, 10004.449755263531, 10017.198624110199, 17217.741733874, 17257.56856078608, 17270.913645431945, 17288.827111728973, 17316.0, 6661.134052573231, 6690.163729533809, 6739.865202695919, 6763.458923286125, 6826.624535650488, 3812.4090765931323, 3850.614938506183, 3922.764634121962, 3934.449177115206, 4019.537753158366, 2882.6108475355977, 2941.5440606705565, 2949.7640188784844, 2950.542665886791, 2952.9557056644167, 510.42067253666613, 518.2537146509015, 522.4148953172471, 536.0057094090484, 538.3889285660725, 444.89767353508876, 542.8018773147852, 562.9859253518613, 606.6026752477135, 673.245964519741, 7945.205479452008, 7997.160298168725, 8034.196580341919, 8260.463069900557, 8393.328533717287, 649.2792999770252, 663.4393937123124, 665.2947875252248, 668.6088638146641, 672.4217173231017, 3803.886731811475, 4018.417329487208, 4069.8575549855614, 4138.710290279711, 4177.5195852476745, 50902.49097508978, 52146.47853521492, 52474.47525524772, 52551.73724131432, 53149.0, 42976.78511607485, 44837.77581112074, 45458.0, 45605.0, 46188.76905615518, 41565.168696626504, 41616.0, 41739.165216695495, 42361.57638423638, 44536.10927781426, 8166.591670416574, 8285.544295063588, 8470.32237421017, 8859.077704076008, 8979.82040359176, 29040.56439153372, 29131.0, 29559.26101847471, 30140.698593014666, 30206.84896575591, 38954.0, 39675.2064958705, 39992.0, 40034.599654004254, 40576.391354130305, 10266.0, 10436.112930401001, 10849.02358787713, 10999.780004399707, 11333.829992549954, 12232.388380580758, 12291.631251062483, 12322.50709971627, 13056.281904495345, 13142.540011099565, 8905.688300909436, 10306.536205870603, 11492.482838272465, 11747.47136378848, 12185.634430967086, 11207.49566269536, 11341.149413793833, 11458.0, 11647.825282620937, 11847.881521184678, 10865.130789536975, 10888.891111089104, 10938.507767150339, 11152.21934464612, 11295.322280663186, 9176.357654964355, 9580.70188473647, 10095.697129086138, 10209.336393134423, 10241.0, 9282.35023548345, 10112.868615355661, 10142.46088652264, 10184.745381365525, 10283.12593429567], "value": 6007.17876643083, "unit": "score"}], "name": "dromaeo_css", "value": 6304.8273500663945, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 107.0, 111.0, 114.0, 114.0, 102.0, 114.0, 113.0, 114.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 137.0, 158.0, 185.0, 133.0, 153.0, 174.0, 134.0, 182.0, 136.0], "value": 154.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 161.0, 161.0, 162.0, 162.0, 162.0, 162.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 104.0, 109.0, 74.0, 73.0, 74.0, 119.0, 101.0, 77.0], "value": 88.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 149.0, 94.0, 95.0, 95.0, 143.0, 94.0, 94.0, 148.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 147.0, 146.0, 147.0, 145.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 65.0, 65.0, 65.0, 64.0, 66.0, 65.0, 81.0, 64.0, 64.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 65.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 88.0, 78.0, 87.0, 79.0, 79.0, 81.0, 80.0, 80.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 135.0, 135.0, 136.0, 130.0, 131.0, 141.0, 169.0, 134.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 177.0, 177.0, 181.0, 177.0, 182.0, 176.0, 176.0, 176.0], "value": 178.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 73.0, 73.0, 72.0, 73.0, 71.0, 72.0, 71.0], "value": 73.1, "unit": "score"}], "name": "kraken", "value": 1587.6000000000001, "alertThreshold": 2.0}]} 07:46:05 INFO - Return code: 0 07:46:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:46:05 ERROR - # TBPL SUCCESS # 07:46:05 INFO - Running post-action listener: _resource_record_post_action 07:46:05 INFO - Running post-run listener: _resource_record_post_run 07:46:06 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 2486272; Write bytes: 518672384; Read time: 572; Write time: 388084 07:46:06 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234422272; Read time: 0; Write time: 241948 07:46:06 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 2486272; Write bytes: 284250112; Read time: 572; Write time: 146136 07:46:06 INFO - Running post-run listener: _upload_blobber_files 07:46:06 INFO - Blob upload gear active. 07:46:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:46:06 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 07:46:06 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:46:06 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:46:06 INFO - (blobuploader) - INFO - Open directory for files ... 07:46:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:46:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:46:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:46:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:46:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:46:07 INFO - (blobuploader) - INFO - Done attempting. 07:46:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:46:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:46:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:46:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:46:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:46:08 INFO - (blobuploader) - INFO - Done attempting. 07:46:08 INFO - (blobuploader) - INFO - Iteration through files over. 07:46:08 INFO - Return code: 0 07:46:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:46:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:46:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da2728572da3ab81db7a0f04dfeaccb5fce292919e8870c2d1a38b7c931d420c5379e398495a76c5220aae2de8acdd78d2740852e343cd244160e7b08d0ff274", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/140b124a44784fa71e9602d293450dceda024f31a11a9b6777be0167bb8c52d2ba6a213a781fc09903b3cba16566e59e62a01437a619d206f408fe0219f16de9"} 07:46:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:46:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:46:08 INFO - Contents: 07:46:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da2728572da3ab81db7a0f04dfeaccb5fce292919e8870c2d1a38b7c931d420c5379e398495a76c5220aae2de8acdd78d2740852e343cd244160e7b08d0ff274", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/140b124a44784fa71e9602d293450dceda024f31a11a9b6777be0167bb8c52d2ba6a213a781fc09903b3cba16566e59e62a01437a619d206f408fe0219f16de9"} 07:46:08 INFO - Running post-run listener: copy_logs_to_upload_dir 07:46:08 INFO - Copying logs to upload dir... 07:46:08 INFO - mkdir: /builds/slave/test/build/upload/logs 07:46:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.852245 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-04-21 07:46:08.028147) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 07:46:08.031395) ========= 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=41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da2728572da3ab81db7a0f04dfeaccb5fce292919e8870c2d1a38b7c931d420c5379e398495a76c5220aae2de8acdd78d2740852e343cd244160e7b08d0ff274", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/140b124a44784fa71e9602d293450dceda024f31a11a9b6777be0167bb8c52d2ba6a213a781fc09903b3cba16566e59e62a01437a619d206f408fe0219f16de9"} build_url:https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011179 build_url: 'https://queue.taskcluster.net/v1/task/bfIwgbP4SxGdaatx-QfMew/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/da2728572da3ab81db7a0f04dfeaccb5fce292919e8870c2d1a38b7c931d420c5379e398495a76c5220aae2de8acdd78d2740852e343cd244160e7b08d0ff274", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/140b124a44784fa71e9602d293450dceda024f31a11a9b6777be0167bb8c52d2ba6a213a781fc09903b3cba16566e59e62a01437a619d206f408fe0219f16de9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 07:46:08.056099) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:46:08.056420) ========= 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=41bf3e9aed84707956354da8000001c5-1461248405.518015-1004688965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004743 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 07:46:08.142064) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 07:46:08.142522) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 07:46:08.143035) ========= ========= Total master_lag: 0.17 =========