builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-063 starttime: 1461266653.67 results: success (0) buildid: 20160421095051 builduid: 8f69a34532084a0dac6bb2b0b05202b6 revision: d65b7e80b494915e5a07bb8d4b5104688677c565 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 12:24:13.666609) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-21 12:24:13.667331) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 12:24:13.667846) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-21 12:24:13.685991) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 12:24:13.686402) ========= 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=33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-21 12:24:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 125M=0s 2016-04-21 12:24:14 (125 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084029 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 12:24:13.784296) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 12:24:13.784631) ========= 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=33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017347 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 12:24:13.844713) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 12:24:13.845016) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d65b7e80b494915e5a07bb8d4b5104688677c565 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d65b7e80b494915e5a07bb8d4b5104688677c565 --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=33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-21 12:24:14,173 truncating revision to first 12 chars 2016-04-21 12:24:14,173 Setting DEBUG logging. 2016-04-21 12:24:14,173 attempt 1/10 2016-04-21 12:24:14,173 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d65b7e80b494?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-21 12:24:14,512 unpacking tar archive at: mozilla-inbound-d65b7e80b494/testing/mozharness/ program finished with exit code 0 elapsedTime=0.601144 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 12:24:14.459873) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 12:24:14.460215) ========= script_repo_revision: d65b7e80b494915e5a07bb8d4b5104688677c565 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-21 12:24:14.460641) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 12:24:14.460908) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-21 12:24:14.470755) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-21 12:24:14.471119) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:24:14 INFO - MultiFileLogger online at 20160421 12:24:14 in /builds/slave/test 12:24:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 12:24:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:24:14 INFO - {'append_to_log': False, 12:24:14 INFO - 'base_work_dir': '/builds/slave/test', 12:24:14 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 12:24:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:24:14 INFO - 'branch': 'Mozilla-Inbound', 12:24:14 INFO - 'buildbot_json_path': 'buildprops.json', 12:24:14 INFO - 'config_files': ('talos/linux_config.py',), 12:24:14 INFO - 'default_actions': ('clobber', 12:24:14 INFO - 'read-buildbot-config', 12:24:14 INFO - 'download-and-extract', 12:24:14 INFO - 'populate-webroot', 12:24:14 INFO - 'create-virtualenv', 12:24:14 INFO - 'install', 12:24:14 INFO - 'run-tests'), 12:24:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:24:14 INFO - 'download_minidump_stackwalk': True, 12:24:14 INFO - 'download_symbols': 'ondemand', 12:24:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:24:14 INFO - 'tooltool.py': '/tools/tooltool.py', 12:24:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:24:14 INFO - '/tools/misc-python/virtualenv.py')}, 12:24:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:24:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:24:14 INFO - 'installer_path': 'installer.exe', 12:24:14 INFO - 'log_level': 'info', 12:24:14 INFO - 'log_name': 'talos', 12:24:14 INFO - 'log_to_console': True, 12:24:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:24:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:24:14 INFO - 'opt_config_files': (), 12:24:14 INFO - 'pip_index': False, 12:24:14 INFO - 'sps_profile': False, 12:24:14 INFO - 'sps_profile_interval': 0, 12:24:14 INFO - 'suite': 'dromaeojs-e10s', 12:24:14 INFO - 'system_bits': '32', 12:24:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:24:14 INFO - 'title': 'talos-linux64-ix-063', 12:24:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:24:14 INFO - 'use_talos_json': True, 12:24:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:24:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:24:14 INFO - 'work_dir': 'build'} 12:24:14 INFO - ##### 12:24:14 INFO - ##### Running clobber step. 12:24:14 INFO - ##### 12:24:14 INFO - Running pre-action listener: _resource_record_pre_action 12:24:14 INFO - Running main action method: clobber 12:24:14 INFO - rmtree: /builds/slave/test/build 12:24:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:24:15 INFO - Running post-action listener: _resource_record_post_action 12:24:15 INFO - ##### 12:24:15 INFO - ##### Running read-buildbot-config step. 12:24:15 INFO - ##### 12:24:15 INFO - Running pre-action listener: _resource_record_pre_action 12:24:15 INFO - Running main action method: read_buildbot_config 12:24:15 INFO - Using buildbot properties: 12:24:15 INFO - { 12:24:15 INFO - "project": "", 12:24:15 INFO - "product": "firefox", 12:24:15 INFO - "script_repo_revision": "production", 12:24:15 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 12:24:15 INFO - "repository": "", 12:24:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 12:24:15 INFO - "buildid": "20160421095051", 12:24:15 INFO - "pgo_build": "True", 12:24:15 INFO - "basedir": "/builds/slave/test", 12:24:15 INFO - "buildnumber": 487, 12:24:15 INFO - "slavename": "talos-linux64-ix-063", 12:24:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:24:15 INFO - "platform": "ubuntu64_hw", 12:24:15 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 12:24:15 INFO - "branch": "mozilla-inbound", 12:24:15 INFO - "repo_path": "integration/mozilla-inbound", 12:24:15 INFO - "revision": "d65b7e80b494915e5a07bb8d4b5104688677c565", 12:24:15 INFO - "stage_platform": "linux64-pgo", 12:24:15 INFO - "builduid": "8f69a34532084a0dac6bb2b0b05202b6", 12:24:15 INFO - "slavebuilddir": "test" 12:24:15 INFO - } 12:24:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 12:24:15 INFO - Running post-action listener: _resource_record_post_action 12:24:15 INFO - ##### 12:24:15 INFO - ##### Running download-and-extract step. 12:24:15 INFO - ##### 12:24:15 INFO - Running pre-action listener: _resource_record_pre_action 12:24:15 INFO - Running main action method: download_and_extract 12:24:15 INFO - mkdir: /builds/slave/test/build/tests 12:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:15 INFO - https://queue.taskcluster.net/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:24:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:24:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:24:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGqC95MYTm23lEAzDpU3Ig/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 12:24:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGqC95MYTm23lEAzDpU3Ig/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 12:24:28 INFO - Downloaded 1361 bytes. 12:24:28 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:24:28 INFO - Using the following test package requirements: 12:24:28 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:24:28 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:24:28 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:24:28 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:28 INFO - u'jsshell-linux-x86_64.zip'], 12:24:28 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:24:28 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:24:28 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:24:28 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:24:28 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:24:28 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:24:28 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:24:28 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:24:28 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')]} 12:24:28 INFO - https://queue.taskcluster.net/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:24:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:24:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:24:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGqC95MYTm23lEAzDpU3Ig/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 12:24:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGqC95MYTm23lEAzDpU3Ig/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 12:24:33 INFO - Downloaded 23856680 bytes. 12:24:33 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'] 12:24:33 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 12:24:34 INFO - Return code: 0 12:24:34 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 12:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:34 INFO - https://queue.taskcluster.net/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:24:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:24:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:24:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGqC95MYTm23lEAzDpU3Ig/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 12:24:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGqC95MYTm23lEAzDpU3Ig/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 12:24:39 INFO - Downloaded 23856680 bytes. 12:24:39 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'] 12:24:39 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 12:24:40 INFO - Return code: 0 12:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:40 INFO - https://queue.taskcluster.net/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:24:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:24:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:24:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGqC95MYTm23lEAzDpU3Ig/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 12:24:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGqC95MYTm23lEAzDpU3Ig/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 12:24:41 INFO - Downloaded 10840145 bytes. 12:24:41 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'] 12:24:41 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 12:24:42 INFO - Return code: 0 12:24:42 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')]} 12:24:42 INFO - https://queue.taskcluster.net/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:24:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:24:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:24:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGqC95MYTm23lEAzDpU3Ig/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 12:24:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PGqC95MYTm23lEAzDpU3Ig/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 12:24:44 INFO - Downloaded 58334653 bytes. 12:24:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:24:44 INFO - mkdir: /builds/slave/test/properties 12:24:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:24:44 INFO - Writing to file /builds/slave/test/properties/build_url 12:24:44 INFO - Contents: 12:24:44 INFO - build_url:https://queue.taskcluster.net/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:24:45 INFO - Running post-action listener: _resource_record_post_action 12:24:45 INFO - Running post-action listener: set_extra_try_arguments 12:24:45 INFO - ##### 12:24:45 INFO - ##### Running populate-webroot step. 12:24:45 INFO - ##### 12:24:45 INFO - Running pre-action listener: _resource_record_pre_action 12:24:45 INFO - Running main action method: populate_webroot 12:24:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:24:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:24:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:24:45 INFO - '--tppagecycles', 12:24:45 INFO - '7'], 12:24:45 INFO - 'tests': ['tsvgm']}}, 12:24:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:24:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:24:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:24:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:24:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:24:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:24:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:45 INFO - 'talos_options': ['--disable-e10s'], 12:24:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:24:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:24:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:45 INFO - 'talos_options': ['--disable-e10s'], 12:24:45 INFO - 'tests': ['damp', 'tps']}, 12:24:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:45 INFO - 'tests': ['damp', 'tps']}, 12:24:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:24:45 INFO - 'tests': ['dromaeo_dom']}, 12:24:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:24:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:24:45 INFO - 'tests': ['a11yr', 12:24:45 INFO - 'ts_paint', 12:24:45 INFO - 'tpaint', 12:24:45 INFO - 'sessionrestore', 12:24:45 INFO - 'sessionrestore_no_auto_restore', 12:24:45 INFO - 'tabpaint']}, 12:24:45 INFO - 'other-e10s': {'tests': ['a11yr', 12:24:45 INFO - 'ts_paint', 12:24:45 INFO - 'tpaint', 12:24:45 INFO - 'sessionrestore', 12:24:45 INFO - 'sessionrestore_no_auto_restore', 12:24:45 INFO - 'tabpaint']}, 12:24:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:24:45 INFO - 'ts_paint', 12:24:45 INFO - 'tpaint', 12:24:45 INFO - 'sessionrestore', 12:24:45 INFO - 'sessionrestore_no_auto_restore', 12:24:45 INFO - 'tabpaint']}, 12:24:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:24:45 INFO - 'ts_paint', 12:24:45 INFO - 'tpaint', 12:24:45 INFO - 'sessionrestore', 12:24:45 INFO - 'sessionrestore_no_auto_restore', 12:24:45 INFO - 'tabpaint']}, 12:24:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:24:45 INFO - 'tests': ['a11yr', 12:24:45 INFO - 'ts_paint', 12:24:45 INFO - 'tpaint', 12:24:45 INFO - 'sessionrestore', 12:24:45 INFO - 'sessionrestore_no_auto_restore', 12:24:45 INFO - 'tabpaint']}, 12:24:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:24:45 INFO - 'tests': ['a11yr', 12:24:45 INFO - 'ts_paint', 12:24:45 INFO - 'tpaint', 12:24:45 INFO - 'sessionrestore', 12:24:45 INFO - 'sessionrestore_no_auto_restore', 12:24:45 INFO - 'tabpaint']}, 12:24:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:24:45 INFO - 'tests': ['tsvgx', 12:24:45 INFO - 'tsvgr_opacity', 12:24:45 INFO - 'tart', 12:24:45 INFO - 'tscrollx', 12:24:45 INFO - 'cart']}, 12:24:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:24:45 INFO - 'tsvgr_opacity', 12:24:45 INFO - 'tart', 12:24:45 INFO - 'tscrollx', 12:24:45 INFO - 'cart']}, 12:24:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:45 INFO - 'talos_options': ['--disable-e10s'], 12:24:45 INFO - 'tests': ['tp5o']}, 12:24:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:45 INFO - 'tests': ['tp5o']}, 12:24:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:45 INFO - 'talos_options': ['--disable-e10s', 12:24:45 INFO - '--xperf_path', 12:24:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:24:45 INFO - 'tests': ['tp5n']}, 12:24:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:24:45 INFO - 'talos_options': ['--xperf_path', 12:24:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:24:45 INFO - 'tests': ['tp5n']}}, 12:24:45 INFO - 'talos.zip': {'path': '', 12:24:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:24:45 INFO - Running post-action listener: _resource_record_post_action 12:24:45 INFO - ##### 12:24:45 INFO - ##### Running create-virtualenv step. 12:24:45 INFO - ##### 12:24:45 INFO - Running pre-action listener: _resource_record_pre_action 12:24:45 INFO - Running main action method: create_virtualenv 12:24:45 INFO - Creating virtualenv /builds/slave/test/build/venv 12:24:45 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 12:24:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:24:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:24:45 INFO - Using real prefix '/usr' 12:24:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:24:46 INFO - Installing distribute.............................................................................................................................................................................................done. 12:24:47 INFO - Installing pip.................done. 12:24:47 INFO - Return code: 0 12:24:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:47 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 0x7fdc9c388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e5410>, '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 0x12e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e67a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085', '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 12:24:47 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 12:24:47 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 12:24:47 INFO - Using env: {'DISPLAY': ':0', 12:24:47 INFO - 'HOME': '/home/cltbld', 12:24:47 INFO - 'LANG': 'en_US.UTF-8', 12:24:47 INFO - 'LANGUAGE': 'en_US:en', 12:24:47 INFO - 'LOGNAME': 'cltbld', 12:24:47 INFO - 'MAIL': '/var/mail/cltbld', 12:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:47 INFO - 'MOZ_NO_REMOTE': '1', 12:24:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:47 INFO - 'NO_EM_RESTART': '1', 12:24:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:47 INFO - 'PWD': '/builds/slave/test', 12:24:47 INFO - 'SHELL': '/bin/bash', 12:24:47 INFO - 'SHLVL': '1', 12:24:47 INFO - 'TERM': 'linux', 12:24:47 INFO - 'TMOUT': '86400', 12:24:47 INFO - 'USER': 'cltbld', 12:24:47 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085', 12:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:47 INFO - '_': '/tools/buildbot/bin/python'} 12:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:48 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 12:24:48 INFO - Cleaning up... 12:24:48 INFO - Return code: 0 12:24:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:24: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')]} 12:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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')]} 12:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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', '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 0x7fdc9c388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e5410>, '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 0x12e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e67a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085', '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 12:24: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', 'psutil>=0.7.1'] in /builds/slave/test/build 12:24: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 psutil>=0.7.1 12:24:48 INFO - Using env: {'DISPLAY': ':0', 12:24:48 INFO - 'HOME': '/home/cltbld', 12:24:48 INFO - 'LANG': 'en_US.UTF-8', 12:24:48 INFO - 'LANGUAGE': 'en_US:en', 12:24:48 INFO - 'LOGNAME': 'cltbld', 12:24:48 INFO - 'MAIL': '/var/mail/cltbld', 12:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:48 INFO - 'MOZ_NO_REMOTE': '1', 12:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:48 INFO - 'NO_EM_RESTART': '1', 12:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:48 INFO - 'PWD': '/builds/slave/test', 12:24:48 INFO - 'SHELL': '/bin/bash', 12:24:48 INFO - 'SHLVL': '1', 12:24:48 INFO - 'TERM': 'linux', 12:24:48 INFO - 'TMOUT': '86400', 12:24:48 INFO - 'USER': 'cltbld', 12:24:48 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085', 12:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:48 INFO - '_': '/tools/buildbot/bin/python'} 12:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:48 INFO - Downloading/unpacking psutil>=0.7.1 12:24: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 12:24: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 12:24: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 12:24: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 12:24: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 12:24: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 12:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:24:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:24:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:24:50 INFO - Installing collected packages: psutil 12:24:50 INFO - Running setup.py install for psutil 12:24:50 INFO - building 'psutil._psutil_linux' extension 12:24:50 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 12:24:50 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 12:24:50 INFO - building 'psutil._psutil_posix' extension 12:24:50 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 12:24:50 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 12:24:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:24:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:24:50 INFO - Successfully installed psutil 12:24:50 INFO - Cleaning up... 12:24:50 INFO - Return code: 0 12:24:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:24: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')]} 12:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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')]} 12:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24: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', '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 0x7fdc9c388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e5410>, '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 0x12e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e67a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085', '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 12:24: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:24: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 mozsystemmonitor==0.0.0 12:24:50 INFO - Using env: {'DISPLAY': ':0', 12:24:50 INFO - 'HOME': '/home/cltbld', 12:24:50 INFO - 'LANG': 'en_US.UTF-8', 12:24:50 INFO - 'LANGUAGE': 'en_US:en', 12:24:50 INFO - 'LOGNAME': 'cltbld', 12:24:50 INFO - 'MAIL': '/var/mail/cltbld', 12:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:50 INFO - 'MOZ_NO_REMOTE': '1', 12:24:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:50 INFO - 'NO_EM_RESTART': '1', 12:24:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:50 INFO - 'PWD': '/builds/slave/test', 12:24:50 INFO - 'SHELL': '/bin/bash', 12:24:50 INFO - 'SHLVL': '1', 12:24:50 INFO - 'TERM': 'linux', 12:24:50 INFO - 'TMOUT': '86400', 12:24:50 INFO - 'USER': 'cltbld', 12:24:50 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085', 12:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:50 INFO - '_': '/tools/buildbot/bin/python'} 12:24:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:24:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:24:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:24:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:24:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:24:53 INFO - Installing collected packages: mozsystemmonitor 12:24:53 INFO - Running setup.py install for mozsystemmonitor 12:24:53 INFO - Successfully installed mozsystemmonitor 12:24:53 INFO - Cleaning up... 12:24:53 INFO - Return code: 0 12:24:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:24:53 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')]} 12:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:53 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')]} 12:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:53 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 0x7fdc9c388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e5410>, '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 0x12e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e67a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085', '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 12:24:53 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 12:24:53 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 12:24:53 INFO - Using env: {'DISPLAY': ':0', 12:24:53 INFO - 'HOME': '/home/cltbld', 12:24:53 INFO - 'LANG': 'en_US.UTF-8', 12:24:53 INFO - 'LANGUAGE': 'en_US:en', 12:24:53 INFO - 'LOGNAME': 'cltbld', 12:24:53 INFO - 'MAIL': '/var/mail/cltbld', 12:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:53 INFO - 'MOZ_NO_REMOTE': '1', 12:24:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:53 INFO - 'NO_EM_RESTART': '1', 12:24:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:53 INFO - 'PWD': '/builds/slave/test', 12:24:53 INFO - 'SHELL': '/bin/bash', 12:24:53 INFO - 'SHLVL': '1', 12:24:53 INFO - 'TERM': 'linux', 12:24:53 INFO - 'TMOUT': '86400', 12:24:53 INFO - 'USER': 'cltbld', 12:24:53 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085', 12:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:53 INFO - '_': '/tools/buildbot/bin/python'} 12:24:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:53 INFO - Downloading/unpacking blobuploader==1.2.4 12:24: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 12:24: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 12:24: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 12:24: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 12:24: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 12:24: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 12:24:55 INFO - Downloading blobuploader-1.2.4.tar.gz 12:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:24:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:24:55 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 12:24:55 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 12:24:55 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 12:24:55 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 12:24:55 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 12:24:55 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 12:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:24:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:24:55 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 12:24:55 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 12:24:55 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 12:24:55 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 12:24:55 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 12:24:55 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 12:24:55 INFO - Downloading docopt-0.6.1.tar.gz 12:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:24:56 INFO - Installing collected packages: blobuploader, requests, docopt 12:24:56 INFO - Running setup.py install for blobuploader 12:24:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:24:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:24:56 INFO - Running setup.py install for requests 12:24:56 INFO - Running setup.py install for docopt 12:24:56 INFO - Successfully installed blobuploader requests docopt 12:24:56 INFO - Cleaning up... 12:24:56 INFO - Return code: 0 12:24:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:56 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 0x7fdc9c388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e5410>, '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 0x12e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e67a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085', '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 12:24:56 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 12:24:56 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 12:24:56 INFO - Using env: {'DISPLAY': ':0', 12:24:56 INFO - 'HOME': '/home/cltbld', 12:24:56 INFO - 'LANG': 'en_US.UTF-8', 12:24:56 INFO - 'LANGUAGE': 'en_US:en', 12:24:56 INFO - 'LOGNAME': 'cltbld', 12:24:56 INFO - 'MAIL': '/var/mail/cltbld', 12:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:56 INFO - 'MOZ_NO_REMOTE': '1', 12:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:56 INFO - 'NO_EM_RESTART': '1', 12:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:56 INFO - 'PWD': '/builds/slave/test', 12:24:56 INFO - 'SHELL': '/bin/bash', 12:24:56 INFO - 'SHLVL': '1', 12:24:56 INFO - 'TERM': 'linux', 12:24:56 INFO - 'TMOUT': '86400', 12:24:56 INFO - 'USER': 'cltbld', 12:24:56 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085', 12:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:56 INFO - '_': '/tools/buildbot/bin/python'} 12:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:24:56 INFO - Running setup.py (path:/tmp/pip-hRWjtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:24:56 INFO - Running setup.py (path:/tmp/pip-OPR10L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:24:56 INFO - Running setup.py (path:/tmp/pip-lSN9ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:24:57 INFO - Running setup.py (path:/tmp/pip-rbqhf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:24:57 INFO - Running setup.py (path:/tmp/pip-cu9JeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:24:57 INFO - Running setup.py (path:/tmp/pip-CWswIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:24:57 INFO - Running setup.py (path:/tmp/pip-sNQnQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:24:57 INFO - Running setup.py (path:/tmp/pip-pmokXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:24:57 INFO - Running setup.py (path:/tmp/pip-b_eCKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:24:57 INFO - Running setup.py (path:/tmp/pip-_J9iBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:24:57 INFO - Running setup.py (path:/tmp/pip-azkoe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:24:57 INFO - Running setup.py (path:/tmp/pip-LmRffv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:24:57 INFO - Running setup.py (path:/tmp/pip-hDerRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:24:57 INFO - Running setup.py (path:/tmp/pip-yi5j4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:57 INFO - Running setup.py (path:/tmp/pip-RkbEcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:24:57 INFO - Running setup.py (path:/tmp/pip-xOk6wA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:24:57 INFO - Running setup.py (path:/tmp/pip-UHX7Ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:24:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:24:58 INFO - Running setup.py install for manifestparser 12:24:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:24:58 INFO - Running setup.py install for mozcrash 12:24:58 INFO - Running setup.py install for mozdebug 12:24:58 INFO - Running setup.py install for mozdevice 12:24:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:24:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:24:58 INFO - Running setup.py install for mozfile 12:24:58 INFO - Running setup.py install for mozhttpd 12:24:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:24:58 INFO - Running setup.py install for mozinfo 12:24:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:24:58 INFO - Running setup.py install for mozInstall 12:24:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:24:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:24:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:24:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:24:58 INFO - Running setup.py install for mozleak 12:24:58 INFO - Running setup.py install for mozlog 12:24:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:24:59 INFO - Running setup.py install for moznetwork 12:24:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:24:59 INFO - Running setup.py install for mozprocess 12:24:59 INFO - Running setup.py install for mozprofile 12:24:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:24:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:24:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:24:59 INFO - Running setup.py install for mozrunner 12:24:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:24:59 INFO - Running setup.py install for mozscreenshot 12:24:59 INFO - Running setup.py install for moztest 12:24:59 INFO - Running setup.py install for mozversion 12:24:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:24:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:24:59 INFO - Cleaning up... 12:24:59 INFO - Return code: 0 12:24:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:24:59 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 0x7fdc9c388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e5410>, '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 0x12e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e67a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085', '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 12:24:59 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 12:24:59 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 12:24:59 INFO - Using env: {'DISPLAY': ':0', 12:24:59 INFO - 'HOME': '/home/cltbld', 12:24:59 INFO - 'LANG': 'en_US.UTF-8', 12:24:59 INFO - 'LANGUAGE': 'en_US:en', 12:24:59 INFO - 'LOGNAME': 'cltbld', 12:24:59 INFO - 'MAIL': '/var/mail/cltbld', 12:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:24:59 INFO - 'MOZ_NO_REMOTE': '1', 12:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:24:59 INFO - 'NO_EM_RESTART': '1', 12:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:24:59 INFO - 'PWD': '/builds/slave/test', 12:24:59 INFO - 'SHELL': '/bin/bash', 12:24:59 INFO - 'SHLVL': '1', 12:24:59 INFO - 'TERM': 'linux', 12:24:59 INFO - 'TMOUT': '86400', 12:24:59 INFO - 'USER': 'cltbld', 12:24:59 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085', 12:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:24:59 INFO - '_': '/tools/buildbot/bin/python'} 12:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:25:00 INFO - Running setup.py (path:/tmp/pip-3MeNnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:25:00 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)) 12:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:25:00 INFO - Running setup.py (path:/tmp/pip-c2gDIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:25:00 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)) 12:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:25:00 INFO - Running setup.py (path:/tmp/pip-t_BUwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:25:00 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)) 12:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:25:00 INFO - Running setup.py (path:/tmp/pip-sINGcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:25:00 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)) 12:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:25:00 INFO - Running setup.py (path:/tmp/pip-qRMLG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:25:00 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)) 12:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:25:00 INFO - Running setup.py (path:/tmp/pip-9VSdhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:25:00 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)) 12:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:25:00 INFO - Running setup.py (path:/tmp/pip-EkbzKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:25:00 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)) 12:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:25:00 INFO - Running setup.py (path:/tmp/pip-FsZmg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:25:00 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)) 12:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:25:00 INFO - Running setup.py (path:/tmp/pip-FC0mY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:25:00 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)) 12:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:25:00 INFO - Running setup.py (path:/tmp/pip-yTzIYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:25:00 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)) 12:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:25:00 INFO - Running setup.py (path:/tmp/pip-ofR1Xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:25:00 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)) 12:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:25:00 INFO - Running setup.py (path:/tmp/pip-_T22Nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:25:00 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)) 12:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:25:00 INFO - Running setup.py (path:/tmp/pip-o3itwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:25:01 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)) 12:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:25:01 INFO - Running setup.py (path:/tmp/pip-5VL17N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:25:01 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)) 12:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:25:01 INFO - Running setup.py (path:/tmp/pip-ywrqQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:25:01 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)) 12:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:25:01 INFO - Running setup.py (path:/tmp/pip-X8hyI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:25:01 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)) 12:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:25:01 INFO - Running setup.py (path:/tmp/pip-qPsAeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:25:01 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)) 12:25:01 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)) 12:25:01 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)) 12:25:01 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)) 12:25:01 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)) 12:25:01 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)) 12:25:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:25: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 12:25: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 12:25: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 12:25: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 12:25: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 12:25: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 12:25:03 INFO - Downloading blessings-1.6.tar.gz 12:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:25:03 INFO - Installing collected packages: blessings 12:25:03 INFO - Running setup.py install for blessings 12:25:03 INFO - Successfully installed blessings 12:25:03 INFO - Cleaning up... 12:25:03 INFO - Return code: 0 12:25:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:25:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:25:03 INFO - Reading from file tmpfile_stdout 12:25:03 INFO - Current package versions: 12:25:03 INFO - argparse == 1.2.1 12:25:03 INFO - blessings == 1.6 12:25:03 INFO - blobuploader == 1.2.4 12:25:03 INFO - docopt == 0.6.1 12:25:03 INFO - manifestparser == 1.1 12:25:03 INFO - mozInstall == 1.12 12:25:03 INFO - mozcrash == 0.17 12:25:03 INFO - mozdebug == 0.1 12:25:03 INFO - mozdevice == 0.48 12:25:03 INFO - mozfile == 1.2 12:25:03 INFO - mozhttpd == 0.7 12:25:03 INFO - mozinfo == 0.9 12:25:03 INFO - mozleak == 0.1 12:25:03 INFO - mozlog == 3.1 12:25:03 INFO - moznetwork == 0.27 12:25:03 INFO - mozprocess == 0.22 12:25:03 INFO - mozprofile == 0.28 12:25:03 INFO - mozrunner == 6.11 12:25:03 INFO - mozscreenshot == 0.1 12:25:03 INFO - mozsystemmonitor == 0.0 12:25:03 INFO - moztest == 0.7 12:25:03 INFO - mozversion == 1.4 12:25:03 INFO - psutil == 3.1.1 12:25:03 INFO - requests == 1.2.3 12:25:03 INFO - wsgiref == 0.1.2 12:25:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:25: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')]} 12:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25: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')]} 12:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:03 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 0x7fdc9c388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e5410>, '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 0x12e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e67a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085', '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 12:25:03 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 12:25:03 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 12:25:03 INFO - Using env: {'DISPLAY': ':0', 12:25:03 INFO - 'HOME': '/home/cltbld', 12:25:03 INFO - 'LANG': 'en_US.UTF-8', 12:25:03 INFO - 'LANGUAGE': 'en_US:en', 12:25:03 INFO - 'LOGNAME': 'cltbld', 12:25:03 INFO - 'MAIL': '/var/mail/cltbld', 12:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:03 INFO - 'MOZ_NO_REMOTE': '1', 12:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:03 INFO - 'NO_EM_RESTART': '1', 12:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:03 INFO - 'PWD': '/builds/slave/test', 12:25:03 INFO - 'SHELL': '/bin/bash', 12:25:03 INFO - 'SHLVL': '1', 12:25:03 INFO - 'TERM': 'linux', 12:25:03 INFO - 'TMOUT': '86400', 12:25:03 INFO - 'USER': 'cltbld', 12:25:03 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085', 12:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:03 INFO - '_': '/tools/buildbot/bin/python'} 12:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:03 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)) 12:25:03 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)) 12:25:03 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)) 12:25:03 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)) 12:25:03 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)) 12:25:03 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)) 12:25:03 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)) 12:25:03 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)) 12:25:03 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)) 12:25:03 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)) 12:25:03 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)) 12:25:03 INFO - Cleaning up... 12:25:03 INFO - Return code: 0 12:25:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:25: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')]} 12:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25: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')]} 12:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc9c388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e5410>, '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 0x12e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e67a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085', '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 12:25: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', 'jsonschema'] in /builds/slave/test/build 12:25: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 jsonschema 12:25:03 INFO - Using env: {'DISPLAY': ':0', 12:25:03 INFO - 'HOME': '/home/cltbld', 12:25:03 INFO - 'LANG': 'en_US.UTF-8', 12:25:03 INFO - 'LANGUAGE': 'en_US:en', 12:25:03 INFO - 'LOGNAME': 'cltbld', 12:25:03 INFO - 'MAIL': '/var/mail/cltbld', 12:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:03 INFO - 'MOZ_NO_REMOTE': '1', 12:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:03 INFO - 'NO_EM_RESTART': '1', 12:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:03 INFO - 'PWD': '/builds/slave/test', 12:25:03 INFO - 'SHELL': '/bin/bash', 12:25:03 INFO - 'SHLVL': '1', 12:25:03 INFO - 'TERM': 'linux', 12:25:03 INFO - 'TMOUT': '86400', 12:25:03 INFO - 'USER': 'cltbld', 12:25:03 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085', 12:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:03 INFO - '_': '/tools/buildbot/bin/python'} 12:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:04 INFO - Downloading/unpacking jsonschema 12:25: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 12:25: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 12:25: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 12:25: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 12:25: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 12:25: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 12:25:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:25:05 INFO - Downloading/unpacking functools32 (from jsonschema) 12:25: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 12:25: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 12:25: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 12:25: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 12:25: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 12:25: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 12:25:06 INFO - Downloading functools32-3.2.3-2.tar.gz 12:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:25:06 INFO - warning: no files found matching '*.txt' 12:25:06 INFO - no previously-included directories found matching 'build' 12:25:06 INFO - no previously-included directories found matching 'dist' 12:25:06 INFO - no previously-included directories found matching '.git*' 12:25:06 INFO - Installing collected packages: jsonschema, functools32 12:25:06 INFO - Running setup.py install for functools32 12:25:06 INFO - warning: no files found matching '*.txt' 12:25:06 INFO - no previously-included directories found matching 'build' 12:25:06 INFO - no previously-included directories found matching 'dist' 12:25:06 INFO - no previously-included directories found matching '.git*' 12:25:06 INFO - Successfully installed jsonschema functools32 12:25:06 INFO - Cleaning up... 12:25:06 INFO - Return code: 0 12:25:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:25:06 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')]} 12:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:06 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')]} 12:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:06 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 0x7fdc9c388f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12565a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e5410>, '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 0x12e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e67a0>, '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': '33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085', '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 12:25:06 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 12:25:06 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 12:25:06 INFO - Using env: {'DISPLAY': ':0', 12:25:06 INFO - 'HOME': '/home/cltbld', 12:25:06 INFO - 'LANG': 'en_US.UTF-8', 12:25:06 INFO - 'LANGUAGE': 'en_US:en', 12:25:06 INFO - 'LOGNAME': 'cltbld', 12:25:06 INFO - 'MAIL': '/var/mail/cltbld', 12:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:06 INFO - 'MOZ_NO_REMOTE': '1', 12:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:06 INFO - 'NO_EM_RESTART': '1', 12:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:06 INFO - 'PWD': '/builds/slave/test', 12:25:06 INFO - 'SHELL': '/bin/bash', 12:25:06 INFO - 'SHLVL': '1', 12:25:06 INFO - 'TERM': 'linux', 12:25:06 INFO - 'TMOUT': '86400', 12:25:06 INFO - 'USER': 'cltbld', 12:25:06 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085', 12:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:06 INFO - '_': '/tools/buildbot/bin/python'} 12:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:06 INFO - Downloading/unpacking flake8 12:25: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 12:25: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 12:25: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 12:25: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 12:25: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 12:25: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 12:25:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:25:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:25:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:25:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:25:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:25:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:25:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:25:09 INFO - no previously-included directories found matching 'docs/_build' 12:25:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:25:09 INFO - Running setup.py install for pep8 12:25:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:25:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:25:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:25:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:25:09 INFO - no previously-included directories found matching 'docs/_build' 12:25:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:25:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:25:09 INFO - Cleaning up... 12:25:09 INFO - Return code: 0 12:25:09 INFO - Running post-action listener: _resource_record_post_action 12:25:09 INFO - Running post-action listener: _start_resource_monitoring 12:25:09 INFO - Starting resource monitoring. 12:25:09 INFO - ##### 12:25:09 INFO - ##### Running install step. 12:25:09 INFO - ##### 12:25:09 INFO - Running pre-action listener: _resource_record_pre_action 12:25:09 INFO - Running main action method: install 12:25:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:25:09 INFO - Reading from file tmpfile_stdout 12:25:09 INFO - Detecting whether we're running mozinstall >=1.0... 12:25:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:25:09 INFO - Reading from file tmpfile_stdout 12:25:09 INFO - Output received: 12:25:09 INFO - Usage: mozinstall [options] installer 12:25:09 INFO - Options: 12:25:09 INFO - -h, --help show this help message and exit 12:25:09 INFO - -d DEST, --destination=DEST 12:25:09 INFO - Directory to install application into. [default: 12:25:09 INFO - "/builds/slave/test"] 12:25:09 INFO - --app=APP Application being installed. [default: firefox] 12:25:09 INFO - mkdir: /builds/slave/test/build/application 12:25:09 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'] 12:25:09 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 12:25:26 INFO - Reading from file tmpfile_stdout 12:25:26 INFO - Output received: 12:25:26 INFO - /builds/slave/test/build/application/firefox/firefox 12:25:26 INFO - Running post-action listener: _resource_record_post_action 12:25:26 INFO - ##### 12:25:26 INFO - ##### Running run-tests step. 12:25:26 INFO - ##### 12:25:26 INFO - Running pre-action listener: _resource_record_pre_action 12:25:26 INFO - Running main action method: run_tests 12:25:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:25:26 INFO - Python 2.7.3 12:25:26 INFO - Return code: 0 12:25:26 INFO - grabbing minidump binary from tooltool 12: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')]} 12:25:26 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 0x12e5410>, '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 0x12e6310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e67a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:25:26 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 12:25:26 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 12:25:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:25:26 INFO - Return code: 0 12:25:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:25:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:25:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:25:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:25:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:25:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:25:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:25:27 INFO - Return code: 0 12:25:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:25:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:25:27 INFO - Using env: {'DISPLAY': ':0', 12:25:27 INFO - 'HOME': '/home/cltbld', 12:25:27 INFO - 'LANG': 'en_US.UTF-8', 12:25:27 INFO - 'LANGUAGE': 'en_US:en', 12:25:27 INFO - 'LOGNAME': 'cltbld', 12:25:27 INFO - 'MAIL': '/var/mail/cltbld', 12:25:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:25:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:25:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:27 INFO - 'MOZ_NO_REMOTE': '1', 12:25:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:25:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:27 INFO - 'NO_EM_RESTART': '1', 12:25:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:27 INFO - 'PWD': '/builds/slave/test', 12:25:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:25:27 INFO - 'SHELL': '/bin/bash', 12:25:27 INFO - 'SHLVL': '1', 12:25:27 INFO - 'TERM': 'linux', 12:25:27 INFO - 'TMOUT': '86400', 12:25:27 INFO - 'USER': 'cltbld', 12:25:27 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085', 12:25:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:27 INFO - '_': '/tools/buildbot/bin/python'} 12:25:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:25:27 INFO - mozversion application_buildid: 20160421095051 12:25:27 INFO - mozversion application_changeset: d65b7e80b494915e5a07bb8d4b5104688677c565 12:25:27 INFO - mozversion application_display_name: Nightly 12:25:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:25:27 INFO - mozversion application_name: Firefox 12:25:27 INFO - mozversion application_remotingname: firefox 12:25:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:25:27 INFO - mozversion application_vendor: Mozilla 12:25:27 INFO - mozversion application_version: 48.0a1 12:25:27 INFO - mozversion platform_buildid: 20160421095051 12:25:27 INFO - mozversion platform_changeset: d65b7e80b494915e5a07bb8d4b5104688677c565 12:25:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:25:27 INFO - mozversion platform_version: 48.0a1 12:25:27 INFO - using testdate: 1461266727 12:25:27 INFO - actual date: 1461266727 12:25:27 INFO - starting webserver on 'localhost:49026' 12:25:27 INFO - SUITE-START | Running 2 tests 12:25:27 INFO - TEST-START | dromaeo_css 12:25:27 INFO - operating with platform_type : linux_ 12:25:27 INFO - Initialising browser for dromaeo_css test... 12:25:27 INFO - TEST-INFO | started process 31424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXz9mPy/profile http://localhost:49026/getInfo.html) 12:25:32 INFO - PROCESS | 31424 | 12:25:32 INFO - PROCESS | 31424 | (process:31492): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:25:32 INFO - PROCESS | 31424 | __metrics Screen width/height:1600/1200 12:25:32 INFO - PROCESS | 31424 | colorDepth:24 12:25:32 INFO - PROCESS | 31424 | Browser inner width/height: 1024/697 12:25:32 INFO - PROCESS | 31424 | __metrics 12:25:33 ERROR - PROCESS | 31424 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 12:25:34 INFO - TEST-INFO | 31424: exit 0 12:25:34 INFO - Browser initialized. 12:25:34 INFO - Running cycle 1/1 for dromaeo_css test... 12:25:34 INFO - TEST-INFO | started process 31543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXz9mPy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:25:36 INFO - PROCESS | 31543 | 12:25:36 INFO - PROCESS | 31543 | (process:31606): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:25:46 INFO - PROCESS | 31543 | RSS: Main: 163794944 12:25:46 INFO - PROCESS | 31543 | 12:26:36 INFO - PROCESS | 31543 | 1461266796153 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] 12:28:43 INFO - PROCESS | 31543 | Cycle 1(1): loaded http://localhost:49026/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49026/tests/dromaeo/cssquery-ext.html) 12:28:45 INFO - PROCESS | 31543 | RSS: Main: 168714240 12:28:45 INFO - PROCESS | 31543 | 12:31:46 INFO - PROCESS | 31543 | Cycle 1(1): loaded http://localhost:49026/tests/dromaeo/cssquery-ext.html (next: http://localhost:49026/tests/dromaeo/cssquery-jquery.html) 12:31:47 INFO - PROCESS | 31543 | RSS: Main: 166146048 12:31:47 INFO - PROCESS | 31543 | 12:34:49 INFO - PROCESS | 31543 | Cycle 1(1): loaded http://localhost:49026/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49026/tests/dromaeo/cssquery-mootools.html) 12:34:49 INFO - PROCESS | 31543 | RSS: Main: 166920192 12:34:49 INFO - PROCESS | 31543 | 12:37:51 INFO - PROCESS | 31543 | Cycle 1(1): loaded http://localhost:49026/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49026/tests/dromaeo/cssquery-prototype.html) 12:37:52 INFO - PROCESS | 31543 | RSS: Main: 164769792 12:37:52 INFO - PROCESS | 31543 | 12:40:54 INFO - PROCESS | 31543 | Cycle 1(1): loaded http://localhost:49026/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49026/tests/dromaeo/cssquery-yui.html) 12:40:55 INFO - PROCESS | 31543 | RSS: Main: 166678528 12:40:55 INFO - PROCESS | 31543 | 12:43:57 INFO - PROCESS | 31543 | Cycle 1(1): loaded http://localhost:49026/tests/dromaeo/cssquery-yui.html (next: http://localhost:49026/tests/dromaeo/cssquery-dojo.html) 12:43:57 INFO - PROCESS | 31543 | RSS: Main: 167985152 12:43:57 INFO - PROCESS | 31543 | 12:43:57 INFO - PROCESS | 31543 | __start_tp_report 12:43:57 INFO - PROCESS | 31543 | _x_x_mozilla_page_load 12:43:57 INFO - PROCESS | 31543 | _x_x_mozilla_page_load_details 12:43:57 INFO - PROCESS | 31543 | |i|pagename|runs| 12:43:57 INFO - PROCESS | 31543 | |0;dojo.html;3152.5113607390854;3205.8397080145987;3218.8390580470978;3252.918677033074;3258.4786434170537;5439.972800136004;5459.727013649322;5492.148716948869;5495.6153069285165;5539.695316757577;5416.410916657934;5475.315585551806;5493.340799104103;5543.279373681416;5556.888862222763;4950;4975.079610272093;4978.377702787152;5055.9747201263945;5106.489351064883;4913.385826771653;5052.9242061369105;5073.873153171182;5088.872778180538;5098.4136824265315;4875.731834749087;4941.678790878582;4951.084049450845;4974.850754477371;4975.751212439363;4963.057019166346;4986.326845875797;4994.275830004665;4998;5058.140116180221;4955.4548999610015;4958.851234462972;4971.1549036663855;4986.675866068694;4990.725510096943;5239.1093514102695;5250;5289.418164001957;5379.408265090837;5439.265699130646;5687.289088863892;5687.829365119053;5693.231413759131;5700.40145784695;5795.391483894215;5728.828135155952;5765.6540607563265;5775.422457754233;5822.563307751893;5846.298444186682;5448.128299472105;5462.453754624506;5490.780368785244;5504.4495550445035;5519.282493275889;5939.46544810969;5994.310654274727;6010.699465026819;6022.819315420545;6023.367546407651;5664.235328230719;5735.569832262514;5744.770209191669;5744.770209191669;5806.535477161817;5793.565482588822;5796.971015144897;5799.159121927381;5829.242198514166;5834.27071616048;5730.971345143247;5753.453421924911;5800.158976948319;5811.593188476851;5819.505342045889;5790.971045144832;5895.587308888423;5956.821295361146;5967.850803729942;5968.671723055274;4317.158154159909;4351.804168812411;4351.912961740811;4360.847370342023;4389.714668546534;3932.8623498178;3938.6061393860386;3938.665213456888;3943.723939324277;3968;5623.662580245198;5658.519025882846;5658.575606829504;5666.376698563237;5680.914786278209;5868.618539794899;5891.617044892068;5907.497862681635;5916.26046744157;5930.1994230779155;5545.500904918576;5608.1027035674915;5622.8313150605545;5627.774889004476;5650.152477128464;4815.735134567562;4818.614510839195;4897.755112244374;4906.092372911023;4910.386201724785;6062.272527296753;6085.939140608626;6092.147099406086;6101.603395779349;6110.205673262536;5806.303243610793;5807.912881306699;5809.477147056617;5886.616645088315;5901.3213480450295;5909.793157239648;5991.071383935497;6114.816555503342;6140.508759299335;6154.415330543591;5710.828675139753;5747.224124743107;5757.36668966405;5774.220480235283;5826.388229235869;5751.7411716472025;5878.647281163144;5887.646741195542;5888.587798854039;5893.705314734332;5740.13897915316;5777.884442311214;5784.1034639630925;5789.652620842763;5855.121731740102;5686.09022556389;5722.62802917809;5726.112452569859;5769.365369809234;5785.566082543742;5628.802991895264;5629.155626656035;5637.3235211774845;5646.435356464321;5647.632903861236;5618;5628.549716022627;5667.659940403589;5788.8552786179;5844.766209351748;5546.639468434539;5636.928983493123;5643.943560564506;5683.460071293221;5711.914736200109 12:43:57 INFO - PROCESS | 31543 | |1;ext.html;577.284167632136;631.8704665543563;646.4246820329905;647.8509942713176;662.2483481248781;35907.99999999997;37103.628963710355;37283.627163728386;37445.251094978084;37604.81197594015;37524.81237593815;38283.234335313275;38377.23245535087;38448;38466.807665961634;8459.36554758394;8651.307895368356;8660.696875609356;8683.56582170892;8697.47815131091;8520.40357174998;8773.692920747775;8801.735947921572;8807;8844.778880528007;8671.783205419852;8740.257078148365;8809.163129502687;8815.955920220389;8844.159804818564;8773;8777.605007774666;8839.204471597523;8839.425437346552;8847.203751662317;8698.304135669132;8787.736367908972;8795.868061979076;8826.86759698605;8827.470351778913;32437;38273.80863095695;38988.80505597482;39014.80492597547;39222.215555689014;3295.8516866741056;3507.4563442666426;3528.2237907660274;3542.6634469725336;3610.548681414823;27109.86445067782;27215.183544493695;27389.178324650293;27718.861405693046;27951.30121746952;3673.742838001341;3716.5725941516803;3733.4213196954515;3922.8626998055215;3930.233604447134;325336;328226;334747;335467;336642;52877.2068418974;52960.70392960673;53259.46740532623;53294.73352633212;53460;55666;63481;64760.495357894164;64802.351976480575;65061;15048.473303434546;15148;15280.46518371874;15301.08193508393;15304.693906122038;11626.418679066013;11655.067594592412;11672.066234701204;11687.065034797366;11700;18811.90594047021;18934.43196704101;18984.050797460073;18991.905040474987;19783.307584234484;7268;7321.682097222445;7348.889766653505;7482.812929676802;7534.246575342422;1003;1019.7501612105082;1060.173065009294;1076.5532304093713;1180.7402371478433;31795;31868.88913301861;31907.840460798012;32426;32897;1147.225622704671;1212.660455072581;1217.2939694976892;1235.092207227687;1271.8982481401652;16663.83336166647;17214.569635759206;17284.481465556055;17337.739933901;17491.03799291051;473823;475886;477753;478733;479173;57283;58160.12759808606;58513;58740;58768;1334.6596617862383;1364.6383708317303;1378.4072848675166;1386.708791153869;1396.8952328575194;30953.91661291844;31068.533971989986;31271.53092703657;31387.686123138476;31980.520292196103;50025.74987125041;50278.4916452507;50610;50723.746381267854;50869;395650;399651;400311;400660;400893;27372.315692107855;28394.148175554765;28417.43165136727;28623.713762862106;28651;47453.288200676325;47667.284990724474;47689;47832;47913.76043119762;39654.603453965094;39762;40825.1834963305;41054.178916422105;41758.791206043774;39823.40264895971;40161;40329.79835100806;41105.38341924814;41632.375514367915;41008.58991410048;41364.37953430761;41830;42419.7879010603;42751.358729618456;34194.82902585471;36874.44688329624;36988.44517332188;37016;37315.44026839654;28254.576181356886;28494.88068204431;28915.277118072216;28989.401552308085;29035.7096429033 12:43:57 INFO - PROCESS | 31543 | |2;jquery.html;383.23353293413174;390.82608239333507;391.60484927596934;394.3690095846646;395.1543696489513;14372.928135359309;17530.123493825304;17655.5586110347;18132.18405171767;18311.35910243142;16328.18359082047;16745.91627041863;16784.160791960414;17222.311107555714;17369.91315043423;5467.699276539809;5492.1212605982955;5605.831825045255;5652.293463317085;5652.491275785179;5457.181422786594;5512.724363781795;5538.947599956015;5555.527780138673;5601;5271.657342272759;5526.392096869341;5553.111502159655;5568.86077848053;5573.219749235111;5543.584231182677;5550.111982082847;5553.0837411827;5584.274044374226;5594.608377413582;4734.171519984024;4941.407031156248;4986.975065124688;5000.2749601307605;5003.574696150831;20991.370258892257;21677.67483487749;21721.2397566086;22109.115635374565;22111.005004774823;738.837455759732;1215.8540975082958;2334.2063698342477;2533.998141468238;2812.9859350703114;13425.530106446326;13427.060105792598;13515.864841351558;13843.100198487167;13952.302384880715;1912.6270377276437;1946.4841816918529;2001.7998200180011;2028.4421784009369;2040.2553068130026;77090;77362;77649.22350776476;77952;77998.22001779966;9756.90243097574;10237.795244095225;10248.948755256177;10441.634542790965;10466;12511.74976500465;13436.731265374638;14448.927755361367;14476.27618619065;14618.415263389557;7302.671379787922;7385.403635385001;7749.147593764681;7751.224877512203;7822.100458447351;7363.815904602321;7369.373603243677;7411.444141689395;7444.404447644284;7545.886811697719;6370.49622707509;6374.458171055512;6384.744610215539;6422.614643121427;6442.903356449657;1811.8731688781659;1839.843613292885;1862.590230149365;1866.1415748755724;1898.9525261868564;1000.1348833259178;1000.849872519128;1022.3149402331276;1023.0383439566783;1120.165476719849;17839.197236124404;18401.723974140397;18523.72214416785;18771.624567508847;18907.52731181704;1016.1565900302732;1025.5692609104194;1027.9668932722566;1057.4395570347729;1083.5503266144462;10510.264281500222;10676.51955661997;10682.51928663212;10774.838377424345;10824.458777061116;471350;485287;487883;492887;493855;77781;78272.60863695644;79333;79669.59606225386;80038;1028.2391030637275;1040.490159821682;1056.0864851903048;1069.1340014588209;1071.9088877445504;16411.261493233073;16659.500214993568;16717.414890478776;16816.663666726352;16989.15054247258;27891.721082788914;33740.66259337375;34335;36486.27027459383;37569.43645845369;44813.77593112014;44951.32573011342;45826.250424974605;46233.53766462292;46971.53028469672;8201.261886430011;8323.83352332962;8394.37042221848;11246.887531124585;12100.334481603597;12593.496260149492;12899.613011609667;12936.353182340657;13213.537526186537;13529;11378.260413073123;11573.537058517903;11810;11816.350100744197;12098.939505302416;11581.536738530365;11748.941255293668;11825.763484730085;12162;12236.265824050586;10909.618163364245;12220.938895305466;12313.815292770436;12354.629361119181;12840.165389249669;11503.654890353302;12147.696307592381;12309.753804923672;12641.557545485864;12657.303848288064;12262.26426414418;12271.57049503263;12349.506019759108;12587.811182832447;12675.873241267469 12:43:57 INFO - PROCESS | 31543 | |3;mootools.html;1478.7190433817573;1503.9473618423353;1642.0722291905072;1752.5881417866808;1774.6228926353137;6984.930150698491;7748.070231572212;7790;8001.359891208704;8017.3986950978615;7825.295723384908;7851.411144164196;7859.764207073797;7909.367250619951;7937.642806073726;2232.999999999996;2260.073369918334;2274.283600665793;2283.1666441748807;2284.931452056441;2223.2218723446827;2237.272886311947;2281.0533628544135;2294.5181511882524;2296.977030229693;2254.0307667702964;2261.739899911515;2274.078998005802;2323.744388117306;2346.4133966508375;2170.967435488469;2186.1036974840317;2187.912483500666;2192.3094225319132;2195.4291884110166;2246.7191601049867;2262.1856131792542;2263.592553340398;2267.4671452208718;2268.897899594522;8047.315978141865;8067;8083.43415960883;8107.513549187068;8112.594370281521;4714.882127946795;4807.951920480786;4820.566149046567;4839.274108883696;4863.975680121612;2992.4763166446;3020.3808219314988;3099.008317338453;3132.9530057049164;3211.887583934551;950.5199874063622;952.1525842000625;979.1139019187647;989.2975987049203;1019.8572199892021;10564.260501764957;10588.735281617945;10630.946845265802;10644.361338319648;10654.733631659194;4053.777042262645;4104.91790164195;4192.496900371914;4223.092035212383;4310.827566897289;9030.954845225731;9032.32257580671;9052.773680658036;9094.727158185266;9119.863202051974;4932.235503496892;4946.530079642428;4953.777080031407;4988.426330971912;4999.225120106389;4035.3139966205817;4447.933281000787;4555.066211426716;4555.794989225493;4612.76936153191;3718.442233664972;3735.869244576427;3758.962410375916;3786.981065094712;3832.425136229532;1225.577175874322;1254.3414707278569;1271;1280.2702459598127;1300.0769453687988;773.8297574533593;872.8690696395464;921.447131720962;973.1047436358567;1009.2985375164337;5471.562275017989;5483.122700367922;5535.25274087993;5612.410696876851;5656.91514627281;996.7757254617653;1004.6634377483625;1018.7911478146962;1026.1688032693542;1029.8249297619423;3977.801109944491;3998.5001874765653;4000.7999600019884;4019.658329042006;4026.59734026595;9686.70939871805;10127;10185.134263587677;10192.13366863825;10230.437325946996;10069.345492542961;10117.29178957466;10123.443210623487;10126.240531960133;10128;7279.563226206445;7300.671469783872;7306.050213472215;7317.304856038668;7392.408607311402;5241.580673546031;5319.46805319465;5333.7066461345;5437.700926449083;5457.61796674229;8682.43564168327;8843.204111629984;8940.776480587778;8949.686760963335;8971.955140224258;9200.6779762708;9210.125038121369;9283.907160928575;9387.483688396931;9448.385854919408;6210.441060304594;6740.730370785113;6890.931090689029;6913.861722765617;7071.36357727807;7964.522128672298;7964.6415911282975;7983.481073730189;8041.155678653891;8052.798680032812;7201.387882030086;7315.268473152642;7373.041504604367;7416.44376671741;7504.174540800616;7271.127464704269;7283.8543229136185;7286.817829554304;7326.853462930818;7351.742689005859;6449.4517965971545;6464.385883341075;6513.804585862432;6524.151860258136;6553.279139294769;4953.975230123826;4986.0277245936695;4986.252062190701;4995.15082435994;5012.248162775612;5070.41690205631;5123.590112791042;5145.55726146649;5270.288511051112;5270.393904700855 12:43:57 INFO - PROCESS | 31543 | |4;prototype.html;314.32106649636773;322.18969292230037;327.6903326356594;328.4170597189988;328.4186989029418;5827.388124246957;5911.88176236475;5933.0803725422575;6052.182955301033;6085.269767627885;5978.790742324019;5978.9402105978925;5989.940100598993;5993.700314984255;6004.939950600493;4542.909141817162;4547.477040140377;4547.613452856511;4552.385427967231;4569.908601827961;4455.1089782043555;4562.247229207177;4578.221702310615;4579.107074120548;4600.677952543323;4501.7524036178;4509.210888094587;4515.164694531506;4521.977390113045;4533.863984080483;4504.391907092533;4520.299353600197;4530.637548996073;4537.2286711259;4546.136234115507;3867.7872717000555;3946.954057174851;3973.205358928226;3980.8208630611402;3985.621365970228;5759.625624334447;5778.27771528559;5778.768849246025;5779.711014449261;5821.039528477796;5280.3663560373;5312.256284120188;5323.520883120499;5332.706701131437;5340.786368545254;6099.847503812396;6276.717547710318;6314.684265786738;6317.557770956035;6349.873002539924;4392.165488557164;4394.978025109886;4398.73607583546;4414.514403415622;4415.933760993587;6175.938240617626;6547.770828021044;6625.3043430440075;6637.668116594199;6649.833754156137;4339.891502712458;4341.413909122291;4351.673624478113;4374.496932852762;4386.780660966939;4464.70067915024;4486.12520558488;4491.371208030879;4497.617702495259;4504.842330518416;5023.196288593807;5166.689998600096;5185.144451165591;5194.168932970707;5202.219667049897;5955.37468565803;6146.323904370515;6272;6350.142730731292;6372.426481616584;1571.1515781478101;1588.340838552011;1589.7933268675229;1596.385391624233;1596.9041857488587;1053.7839742852698;1066.4720963123305;1086.6631344283298;1088.7278180454887;1094.4637127807316;6042.274927008787;6045.879082418327;6050.818475445743;6062.727177277033;6082.239720034996;6437.25971513282;6492.707828147744;6495.7076931538195;6498.480121590356;6540.4767618590395;5964.403559644001;6094.2077529920825;6108.533951851524;6154.661493617894;6160.661163636043;3510.964890351064;3513.209527856263;3539.469079638075;3541.220931395089;3561.1631266652316;6504.317046710122;6739.831504212336;6745.662716864137;6759.459243260528;6775.762848300285;6663.500237482208;6674.499412544079;6682.63245521501;6688.097106890605;6693.431058359996;6620.404163625297;6726.260111387744;6743.494237932076;6794.4904132189295;6808.5914845109455;6485.6108633482145;6495.285518593046;6497.772577959749;6516.771912983023;6525.249596296487;6261.655608941552;6371.267304259884;6394.936050639621;6399.968000159969;6410.326915673973;6634.436072933855;6747.831304217238;6771.424428923597;6774.153230846145;6796.184457865088;4530.29780384041;4550;4554.567316104964;4560.042391097906;4582.816687332469;6250.781222657185;6361.904571431525;6366.236051673829;6390.659652123763;6461.870762584816;6379.585326953733;6403.743850245938;6406.23125224976;6414.807555773335;6427.871442571216;6134.202553668173;6359.459445947146;6375.649339286384;6386.042093685985;6387.297397286387;6286.402791734778;6289.685515724104;6299.401556852092;6318.684065796784;6332.176817013758;6358.2687990879795;6412.294647588668;6418.582792118497;6456.12842266288;6462;6018.969905150621;6287.779927702509;6322.33615470369;6373.490120790233;6378.2346118466085 12:43:57 INFO - PROCESS | 31543 | |5;yui.html;750.4034292737273;770.9498882572632;783.2324322164283;801.1787917384681;811.8051667599777;13019.479220831166;13248.27134507603;13293.202407855511;13509.18944863309;13533.714297141756;12308.93845530771;12377.443015064322;12418.937905310484;12419.875801241986;12430.502779888793;654.4535313013615;765.877459606463;784.1805313447447;790.8536920669666;791.4657606115877;781.5388920536882;781.8514482248384;785.2932360875201;788.9013873265842;790.1624278265028;839.6347588798861;841.028611953192;841.364769598952;842.8567143585606;844.5903736687701;830;830.0578843013163;833.0752864320599;835.778518692547;839.4669384940546;608.4979891589412;609.7256234694405;609.9237595300588;615.6060121522229;617.0189398855796;12909.741805163938;12937.80593291092;12970.286634235114;12975;13031.478740850449;13234.338283085806;13392.732145357038;13427.597172084854;13429.261390623511;13510.932445337809;10744.247902646817;10893.891061089367;10909.727256818564;10963.397013164273;11071.889281107247;3804.087019115392;3819.2361527694293;3839.17457746583;3861.131245469775;3890.708196885245;51629.48370516284;53326.466735332535;53365;53486.465135348924;53742;9956.950215248877;10068.899311006942;10371.118454931264;10472.214583906238;10688.625898093529;17393.565160870825;17413.303467861144;17429.564260893327;17447.04041277742;17486.47540573785;7852.882206766903;8021.197880211932;8167.469114507538;8180.345572354197;8351.3736469765;4402.273624851928;4416.80124394403;4568.771561421982;4634.606058484999;4747.525247475294;3140.0579826052094;3262.967370326314;3270.215148364423;3270.378628060661;3287.079617707046;598.1894532907847;598.8323269484551;599.7031469422576;602.1299222623355;612.6079309242089;648.4423395879539;672.1732269308777;676.1818199977984;738.2986163145034;766.2567309709573;8317.251447369767;8394.748157555161;8496.70261540843;8535.103814099555;8881.24509416694;608.4402349838159;652.292262894755;733.3839574757122;733.9082614673166;744.5532680391722;4242.469691288589;4252.4046633471335;4307.332363483665;4323.373110898902;4325.891852703708;60295.39704602986;60426.395736042956;60867.39132608706;61017;61632.69183654053;52041.47958520366;52821.7358913203;53265;53665.46334536683;53725.462745372046;45938.77030614892;47330.976866966696;48135.518644813106;48708.756456217496;49910.75044624826;8028.799280018046;8164.632591533514;8298.087210406971;8390.24487796077;8400.537970411686;30308.24229394283;30395;30534.389312214076;31059.53410698796;31342.68657313398;39266.42934282597;40966;41027.38458923059;42102.578974209864;42384;8936.642534298815;9100.863487047567;9193.356465047382;9375.531223438937;9441;10768.784624307313;11042.282251653616;11387.373694446886;11427.714307142389;11429.714257143638;10607.787844243227;10646.574137034431;10827.566897324334;10850.186236032172;11359.318440893572;10742.73143171427;10812.891871081189;10848.728781780519;10851.891481085404;11296.6046188383;10614.469276536296;10616.203784716332;10703.893000728618;10785.730356741144;11413.714657133638;8592.957035214784;8679.392442528962;9087.182153606207;9288;9290.814183716422;9185.357025008185;9406.341556091007;9470.100340467645;9551.856722149312;9584.37701549397 12:43:57 INFO - PROCESS | 31543 | __end_tp_report 12:43:57 INFO - PROCESS | 31543 | __start_cc_report 12:43:57 INFO - PROCESS | 31543 | _x_x_mozilla_cycle_collect,351 12:43:57 INFO - PROCESS | 31543 | __end_cc_report 12:43:57 INFO - PROCESS | 31543 | __startTimestamp1461267837879__endTimestamp 12:43:57 INFO - PROCESS | 31543 | 12:43:57 INFO - PROCESS | 31543 | ------- Summary: start ------- 12:43:57 INFO - PROCESS | 31543 | Number of tests: 6 12:43:57 INFO - PROCESS | 31543 | 12:43:57 INFO - PROCESS | 31543 | [#0] dojo.html Cycles:165 Average:5430.44 Median:5658.58 stddev:623.47 (11.0%) stddev-sans-first:599.23 12:43:57 INFO - PROCESS | 31543 | Values: 3152.5 3205.8 3218.8 3252.9 3258.5 5440.0 5459.7 5492.1 5495.6 5539.7 5416.4 5475.3 5493.3 5543.3 5556.9 4950.0 4975.1 4978.4 5056.0 5106.5 4913.4 5052.9 5073.9 5088.9 5098.4 4875.7 4941.7 4951.1 4974.9 4975.8 4963.1 4986.3 4994.3 4998.0 5058.1 4955.5 4958.9 4971.2 4986.7 4990.7 5239.1 5250.0 5289.4 5379.4 5439.3 5687.3 5687.8 5693.2 5700.4 5795.4 5728.8 5765.7 5775.4 5822.6 5846.3 5448.1 5462.5 5490.8 5504.4 5519.3 5939.5 5994.3 6010.7 6022.8 6023.4 5664.2 5735.6 5744.8 5744.8 5806.5 5793.6 5797.0 5799.2 5829.2 5834.3 5731.0 5753.5 5800.2 5811.6 5819.5 5791.0 5895.6 5956.8 5967.9 5968.7 4317.2 4351.8 4351.9 4360.8 4389.7 3932.9 3938.6 3938.7 3943.7 3968.0 5623.7 5658.5 5658.6 5666.4 5680.9 5868.6 5891.6 5907.5 5916.3 5930.2 5545.5 5608.1 5622.8 5627.8 5650.2 4815.7 4818.6 4897.8 4906.1 4910.4 6062.3 6085.9 6092.1 6101.6 6110.2 5806.3 5807.9 5809.5 5886.6 5901.3 5909.8 5991.1 6114.8 6140.5 6154.4 5710.8 5747.2 5757.4 5774.2 5826.4 5751.7 5878.6 5887.6 5888.6 5893.7 5740.1 5777.9 5784.1 5789.7 5855.1 5686.1 5722.6 5726.1 5769.4 5785.6 5628.8 5629.2 5637.3 5646.4 5647.6 5618.0 5628.5 5667.7 5788.9 5844.8 5546.6 5636.9 5643.9 5683.5 5711.9 12:43:57 INFO - PROCESS | 31543 | 12:43:57 INFO - PROCESS | 31543 | [#1] ext.html Cycles:180 Average:56316.81 Median:39001.80 stddev:107643.20 (276.0%) stddev-sans-first:107863.81 12:43:57 INFO - PROCESS | 31543 | Values: 577.3 631.9 646.4 647.9 662.2 35908.0 37103.6 37283.6 37445.3 37604.8 37524.8 38283.2 38377.2 38448.0 38466.8 8459.4 8651.3 8660.7 8683.6 8697.5 8520.4 8773.7 8801.7 8807.0 8844.8 8671.8 8740.3 8809.2 8816.0 8844.2 8773.0 8777.6 8839.2 8839.4 8847.2 8698.3 8787.7 8795.9 8826.9 8827.5 32437.0 38273.8 38988.8 39014.8 39222.2 3295.9 3507.5 3528.2 3542.7 3610.5 27109.9 27215.2 27389.2 27718.9 27951.3 3673.7 3716.6 3733.4 3922.9 3930.2 325336.0 328226.0 334747.0 335467.0 336642.0 52877.2 52960.7 53259.5 53294.7 53460.0 55666.0 63481.0 64760.5 64802.4 65061.0 15048.5 15148.0 15280.5 15301.1 15304.7 11626.4 11655.1 11672.1 11687.1 11700.0 18811.9 18934.4 18984.1 18991.9 19783.3 7268.0 7321.7 7348.9 7482.8 7534.2 1003.0 1019.8 1060.2 1076.6 1180.7 31795.0 31868.9 31907.8 32426.0 32897.0 1147.2 1212.7 1217.3 1235.1 1271.9 16663.8 17214.6 17284.5 17337.7 17491.0 473823.0 475886.0 477753.0 478733.0 479173.0 57283.0 58160.1 58513.0 58740.0 58768.0 1334.7 1364.6 1378.4 1386.7 1396.9 30953.9 31068.5 31271.5 31387.7 31980.5 50025.7 50278.5 50610.0 50723.7 50869.0 395650.0 399651.0 400311.0 400660.0 400893.0 27372.3 28394.1 28417.4 28623.7 28651.0 47453.3 47667.3 47689.0 47832.0 47913.8 39654.6 39762.0 40825.2 41054.2 41758.8 39823.4 40161.0 40329.8 41105.4 41632.4 41008.6 41364.4 41830.0 42419.8 42751.4 34194.8 36874.4 36988.4 37016.0 37315.4 28254.6 28494.9 28915.3 28989.4 29035.7 12:43:57 INFO - PROCESS | 31543 | 12:43:57 INFO - PROCESS | 31543 | [#2] jquery.html Cycles:180 Average:27863.47 Median:10403.24 stddev:79747.84 (766.6%) stddev-sans-first:79944.86 12:43:57 INFO - PROCESS | 31543 | Values: 383.2 390.8 391.6 394.4 395.2 14372.9 17530.1 17655.6 18132.2 18311.4 16328.2 16745.9 16784.2 17222.3 17369.9 5467.7 5492.1 5605.8 5652.3 5652.5 5457.2 5512.7 5538.9 5555.5 5601.0 5271.7 5526.4 5553.1 5568.9 5573.2 5543.6 5550.1 5553.1 5584.3 5594.6 4734.2 4941.4 4987.0 5000.3 5003.6 20991.4 21677.7 21721.2 22109.1 22111.0 738.8 1215.9 2334.2 2534.0 2813.0 13425.5 13427.1 13515.9 13843.1 13952.3 1912.6 1946.5 2001.8 2028.4 2040.3 77090.0 77362.0 77649.2 77952.0 77998.2 9756.9 10237.8 10248.9 10441.6 10466.0 12511.7 13436.7 14448.9 14476.3 14618.4 7302.7 7385.4 7749.1 7751.2 7822.1 7363.8 7369.4 7411.4 7444.4 7545.9 6370.5 6374.5 6384.7 6422.6 6442.9 1811.9 1839.8 1862.6 1866.1 1899.0 1000.1 1000.8 1022.3 1023.0 1120.2 17839.2 18401.7 18523.7 18771.6 18907.5 1016.2 1025.6 1028.0 1057.4 1083.6 10510.3 10676.5 10682.5 10774.8 10824.5 471350.0 485287.0 487883.0 492887.0 493855.0 77781.0 78272.6 79333.0 79669.6 80038.0 1028.2 1040.5 1056.1 1069.1 1071.9 16411.3 16659.5 16717.4 16816.7 16989.2 27891.7 33740.7 34335.0 36486.3 37569.4 44813.8 44951.3 45826.3 46233.5 46971.5 8201.3 8323.8 8394.4 11246.9 12100.3 12593.5 12899.6 12936.4 13213.5 13529.0 11378.3 11573.5 11810.0 11816.4 12098.9 11581.5 11748.9 11825.8 12162.0 12236.3 10909.6 12220.9 12313.8 12354.6 12840.2 11503.7 12147.7 12309.8 12641.6 12657.3 12262.3 12271.6 12349.5 12587.8 12675.9 12:43:57 INFO - PROCESS | 31543 | 12:43:57 INFO - PROCESS | 31543 | [#3] mootools.html Cycles:180 Average:5344.07 Median:4987.34 stddev:2918.74 (58.5%) stddev-sans-first:2912.47 12:43:57 INFO - PROCESS | 31543 | Values: 1478.7 1503.9 1642.1 1752.6 1774.6 6984.9 7748.1 7790.0 8001.4 8017.4 7825.3 7851.4 7859.8 7909.4 7937.6 2233.0 2260.1 2274.3 2283.2 2284.9 2223.2 2237.3 2281.1 2294.5 2297.0 2254.0 2261.7 2274.1 2323.7 2346.4 2171.0 2186.1 2187.9 2192.3 2195.4 2246.7 2262.2 2263.6 2267.5 2268.9 8047.3 8067.0 8083.4 8107.5 8112.6 4714.9 4808.0 4820.6 4839.3 4864.0 2992.5 3020.4 3099.0 3133.0 3211.9 950.5 952.2 979.1 989.3 1019.9 10564.3 10588.7 10630.9 10644.4 10654.7 4053.8 4104.9 4192.5 4223.1 4310.8 9031.0 9032.3 9052.8 9094.7 9119.9 4932.2 4946.5 4953.8 4988.4 4999.2 4035.3 4447.9 4555.1 4555.8 4612.8 3718.4 3735.9 3759.0 3787.0 3832.4 1225.6 1254.3 1271.0 1280.3 1300.1 773.8 872.9 921.4 973.1 1009.3 5471.6 5483.1 5535.3 5612.4 5656.9 996.8 1004.7 1018.8 1026.2 1029.8 3977.8 3998.5 4000.8 4019.7 4026.6 9686.7 10127.0 10185.1 10192.1 10230.4 10069.3 10117.3 10123.4 10126.2 10128.0 7279.6 7300.7 7306.1 7317.3 7392.4 5241.6 5319.5 5333.7 5437.7 5457.6 8682.4 8843.2 8940.8 8949.7 8972.0 9200.7 9210.1 9283.9 9387.5 9448.4 6210.4 6740.7 6890.9 6913.9 7071.4 7964.5 7964.6 7983.5 8041.2 8052.8 7201.4 7315.3 7373.0 7416.4 7504.2 7271.1 7283.9 7286.8 7326.9 7351.7 6449.5 6464.4 6513.8 6524.2 6553.3 4954.0 4986.0 4986.3 4995.2 5012.2 5070.4 5123.6 5145.6 5270.3 5270.4 12:43:57 INFO - PROCESS | 31543 | 12:43:57 INFO - PROCESS | 31543 | [#4] prototype.html Cycles:180 Average:5281.91 Median:6030.62 stddev:1594.53 (26.4%) stddev-sans-first:1554.80 12:43:57 INFO - PROCESS | 31543 | Values: 314.3 322.2 327.7 328.4 328.4 5827.4 5911.9 5933.1 6052.2 6085.3 5978.8 5978.9 5989.9 5993.7 6004.9 4542.9 4547.5 4547.6 4552.4 4569.9 4455.1 4562.2 4578.2 4579.1 4600.7 4501.8 4509.2 4515.2 4522.0 4533.9 4504.4 4520.3 4530.6 4537.2 4546.1 3867.8 3947.0 3973.2 3980.8 3985.6 5759.6 5778.3 5778.8 5779.7 5821.0 5280.4 5312.3 5323.5 5332.7 5340.8 6099.8 6276.7 6314.7 6317.6 6349.9 4392.2 4395.0 4398.7 4414.5 4415.9 6175.9 6547.8 6625.3 6637.7 6649.8 4339.9 4341.4 4351.7 4374.5 4386.8 4464.7 4486.1 4491.4 4497.6 4504.8 5023.2 5166.7 5185.1 5194.2 5202.2 5955.4 6146.3 6272.0 6350.1 6372.4 1571.2 1588.3 1589.8 1596.4 1596.9 1053.8 1066.5 1086.7 1088.7 1094.5 6042.3 6045.9 6050.8 6062.7 6082.2 6437.3 6492.7 6495.7 6498.5 6540.5 5964.4 6094.2 6108.5 6154.7 6160.7 3511.0 3513.2 3539.5 3541.2 3561.2 6504.3 6739.8 6745.7 6759.5 6775.8 6663.5 6674.5 6682.6 6688.1 6693.4 6620.4 6726.3 6743.5 6794.5 6808.6 6485.6 6495.3 6497.8 6516.8 6525.2 6261.7 6371.3 6394.9 6400.0 6410.3 6634.4 6747.8 6771.4 6774.2 6796.2 4530.3 4550.0 4554.6 4560.0 4582.8 6250.8 6361.9 6366.2 6390.7 6461.9 6379.6 6403.7 6406.2 6414.8 6427.9 6134.2 6359.5 6375.6 6386.0 6387.3 6286.4 6289.7 6299.4 6318.7 6332.2 6358.3 6412.3 6418.6 6456.1 6462.0 6019.0 6287.8 6322.3 6373.5 6378.2 12:43:57 INFO - PROCESS | 31543 | 12:43:57 INFO - PROCESS | 31543 | [#5] yui.html Cycles:180 Average:13793.50 Median:52431.61 stddev:16426.02 (31.3%) stddev-sans-first:16442.89 12:43:57 INFO - PROCESS | 31543 | Values: 750.4 770.9 783.2 801.2 811.8 13019.5 13248.3 13293.2 13509.2 13533.7 12308.9 12377.4 12418.9 12419.9 12430.5 654.5 765.9 784.2 790.9 791.5 781.5 781.9 785.3 788.9 790.2 839.6 841.0 841.4 842.9 844.6 830.0 830.1 833.1 835.8 839.5 608.5 609.7 609.9 615.6 617.0 12909.7 12937.8 12970.3 12975.0 13031.5 13234.3 13392.7 13427.6 13429.3 13510.9 10744.2 10893.9 10909.7 10963.4 11071.9 3804.1 3819.2 3839.2 3861.1 3890.7 51629.5 53326.5 53365.0 53486.5 53742.0 9957.0 10068.9 10371.1 10472.2 10688.6 17393.6 17413.3 17429.6 17447.0 17486.5 7852.9 8021.2 8167.5 8180.3 8351.4 4402.3 4416.8 4568.8 4634.6 4747.5 3140.1 3263.0 3270.2 3270.4 3287.1 598.2 598.8 599.7 602.1 612.6 648.4 672.2 676.2 738.3 766.3 8317.3 8394.7 8496.7 8535.1 8881.2 608.4 652.3 733.4 733.9 744.6 4242.5 4252.4 4307.3 4323.4 4325.9 60295.4 60426.4 60867.4 61017.0 61632.7 52041.5 52821.7 53265.0 53665.5 53725.5 45938.8 47331.0 48135.5 48708.8 49910.8 8028.8 8164.6 8298.1 8390.2 8400.5 30308.2 30395.0 30534.4 31059.5 31342.7 39266.4 40966.0 41027.4 42102.6 42384.0 8936.6 9100.9 9193.4 9375.5 9441.0 10768.8 11042.3 11387.4 11427.7 11429.7 10607.8 10646.6 10827.6 10850.2 11359.3 10742.7 10812.9 10848.7 10851.9 11296.6 10614.5 10616.2 10703.9 10785.7 11413.7 8593.0 8679.4 9087.2 9288.0 9290.8 9185.4 9406.3 9470.1 9551.9 9584.4 12:43:57 INFO - PROCESS | 31543 | -------- Summary: end -------- 12:43:57 INFO - PROCESS | 31543 | 12:43:58 INFO - TEST-INFO | 31543: exit 0 12:43:58 INFO - TEST-OK | dromaeo_css | took 1110979ms 12:43:58 INFO - TEST-START | kraken 12:43:58 INFO - operating with platform_type : linux_ 12:43:58 INFO - Initialising browser for kraken test... 12:43:58 INFO - TEST-INFO | started process 31778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJslxpF/profile http://localhost:49026/getInfo.html) 12:44:02 INFO - PROCESS | 31778 | 12:44:02 INFO - PROCESS | 31778 | (process:31847): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:44:03 INFO - PROCESS | 31778 | __metrics Screen width/height:1600/1200 12:44:03 INFO - PROCESS | 31778 | colorDepth:24 12:44:03 INFO - PROCESS | 31778 | Browser inner width/height: 1024/697 12:44:03 INFO - PROCESS | 31778 | __metrics 12:44:04 ERROR - PROCESS | 31778 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 12:44:04 INFO - TEST-INFO | 31778: exit 0 12:44:04 INFO - Browser initialized. 12:44:04 INFO - Running cycle 1/1 for kraken test... 12:44:04 INFO - TEST-INFO | started process 31898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJslxpF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:44:06 INFO - PROCESS | 31898 | 12:44:06 INFO - PROCESS | 31898 | (process:31959): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:44:16 INFO - PROCESS | 31898 | RSS: Main: 163942400 12:44:16 INFO - PROCESS | 31898 | 12:44:19 INFO - PROCESS | 31898 | Cycle 1(1): loaded http://localhost:49026/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49026/tests/kraken/driver.html?testName=audio-beat-detection) 12:44:20 INFO - PROCESS | 31898 | RSS: Main: 169238528 12:44:20 INFO - PROCESS | 31898 | 12:44:22 INFO - PROCESS | 31898 | Cycle 1(1): loaded http://localhost:49026/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49026/tests/kraken/driver.html?testName=audio-dft) 12:44:23 INFO - PROCESS | 31898 | RSS: Main: 172040192 12:44:23 INFO - PROCESS | 31898 | 12:44:26 INFO - PROCESS | 31898 | Cycle 1(1): loaded http://localhost:49026/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49026/tests/kraken/driver.html?testName=audio-fft) 12:44:26 INFO - PROCESS | 31898 | RSS: Main: 164515840 12:44:26 INFO - PROCESS | 31898 | 12:44:28 INFO - PROCESS | 31898 | Cycle 1(1): loaded http://localhost:49026/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49026/tests/kraken/driver.html?testName=audio-oscillator) 12:44:29 INFO - PROCESS | 31898 | RSS: Main: 165064704 12:44:29 INFO - PROCESS | 31898 | 12:44:31 INFO - PROCESS | 31898 | Cycle 1(1): loaded http://localhost:49026/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49026/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:44:32 INFO - PROCESS | 31898 | RSS: Main: 164679680 12:44:32 INFO - PROCESS | 31898 | 12:44:35 INFO - PROCESS | 31898 | Cycle 1(1): loaded http://localhost:49026/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49026/tests/kraken/driver.html?testName=imaging-darkroom) 12:44:36 INFO - PROCESS | 31898 | RSS: Main: 165449728 12:44:36 INFO - PROCESS | 31898 | 12:44:39 INFO - PROCESS | 31898 | Cycle 1(1): loaded http://localhost:49026/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49026/tests/kraken/driver.html?testName=imaging-desaturate) 12:44:40 INFO - PROCESS | 31898 | RSS: Main: 165634048 12:44:40 INFO - PROCESS | 31898 | 12:44:42 INFO - PROCESS | 31898 | Cycle 1(1): loaded http://localhost:49026/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49026/tests/kraken/driver.html?testName=json-parse-financial) 12:44:43 INFO - PROCESS | 31898 | RSS: Main: 166428672 12:44:43 INFO - PROCESS | 31898 | 12:44:45 INFO - PROCESS | 31898 | Cycle 1(1): loaded http://localhost:49026/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49026/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:44:45 INFO - PROCESS | 31898 | RSS: Main: 166907904 12:44:45 INFO - PROCESS | 31898 | 12:44:47 INFO - PROCESS | 31898 | Cycle 1(1): loaded http://localhost:49026/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49026/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:44:48 INFO - PROCESS | 31898 | RSS: Main: 166121472 12:44:48 INFO - PROCESS | 31898 | 12:44:50 INFO - PROCESS | 31898 | Cycle 1(1): loaded http://localhost:49026/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49026/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:44:50 INFO - PROCESS | 31898 | RSS: Main: 166174720 12:44:50 INFO - PROCESS | 31898 | 12:44:53 INFO - PROCESS | 31898 | Cycle 1(1): loaded http://localhost:49026/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49026/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:44:54 INFO - PROCESS | 31898 | RSS: Main: 166690816 12:44:54 INFO - PROCESS | 31898 | 12:44:56 INFO - PROCESS | 31898 | Cycle 1(1): loaded http://localhost:49026/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49026/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:44:57 INFO - PROCESS | 31898 | RSS: Main: 166375424 12:44:57 INFO - PROCESS | 31898 | 12:44:59 INFO - PROCESS | 31898 | Cycle 1(1): loaded http://localhost:49026/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49026/tests/kraken/driver.html?testName=ai-astar) 12:44:59 INFO - PROCESS | 31898 | RSS: Main: 167800832 12:44:59 INFO - PROCESS | 31898 | 12:44:59 INFO - PROCESS | 31898 | __start_tp_report 12:44:59 INFO - PROCESS | 31898 | _x_x_mozilla_page_load 12:44:59 INFO - PROCESS | 31898 | _x_x_mozilla_page_load_details 12:44:59 INFO - PROCESS | 31898 | |i|pagename|runs| 12:44:59 INFO - PROCESS | 31898 | |0;ai-astar;114;108;111;112;112;123;111;111;111;113 12:44:59 INFO - PROCESS | 31898 | |1;audio-beat-detection;163;129;152;189;129;153;151;132;193;126 12:44:59 INFO - PROCESS | 31898 | |2;audio-dft;162;164;162;161;161;164;175;161;166;162 12:44:59 INFO - PROCESS | 31898 | |3;audio-fft;77;74;78;166;78;76;76;77;171;76 12:44:59 INFO - PROCESS | 31898 | |4;audio-oscillator;93;94;150;93;93;94;146;94;93;144 12:44:59 INFO - PROCESS | 31898 | |5;imaging-gaussian-blur;117;117;117;117;117;117;118;117;118;118 12:44:59 INFO - PROCESS | 31898 | |6;imaging-darkroom;146;146;146;147;146;146;151;149;147;148 12:44:59 INFO - PROCESS | 31898 | |7;imaging-desaturate;95;96;95;95;95;94;95;95;95;96 12:44:59 INFO - PROCESS | 31898 | |8;json-parse-financial;61;65;61;62;60;61;60;78;59;58 12:44:59 INFO - PROCESS | 31898 | |9;json-stringify-tinderbox;62;63;62;62;63;61;61;62;62;62 12:44:59 INFO - PROCESS | 31898 | |10;stanford-crypto-aes;76;77;76;77;78;77;78;78;88;77 12:44:59 INFO - PROCESS | 31898 | |11;stanford-crypto-ccm;135;135;131;130;129;135;126;135;164;127 12:44:59 INFO - PROCESS | 31898 | |12;stanford-crypto-pbkdf2;168;164;165;164;166;166;166;175;164;172 12:44:59 INFO - PROCESS | 31898 | |13;stanford-crypto-sha256-iterative;69;71;68;68;70;69;66;68;70;69 12:44:59 INFO - PROCESS | 31898 | __end_tp_report 12:44:59 INFO - PROCESS | 31898 | __start_cc_report 12:44:59 INFO - PROCESS | 31898 | _x_x_mozilla_cycle_collect,817 12:44:59 INFO - PROCESS | 31898 | __end_cc_report 12:44:59 INFO - PROCESS | 31898 | __startTimestamp1461267899498__endTimestamp 12:44:59 INFO - PROCESS | 31898 | 12:44:59 INFO - PROCESS | 31898 | ------- Summary: start ------- 12:44:59 INFO - PROCESS | 31898 | Number of tests: 14 12:44:59 INFO - PROCESS | 31898 | 12:44:59 INFO - PROCESS | 31898 | [#0] ai-astar Cycles:10 Average:112.60 Median:112.00 stddev:3.98 (3.6%) stddev-sans-first:4.19 12:44:59 INFO - PROCESS | 31898 | Values: 114.0 108.0 111.0 112.0 112.0 123.0 111.0 111.0 111.0 113.0 12:44:59 INFO - PROCESS | 31898 | 12:44:59 INFO - PROCESS | 31898 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:152.50 stddev:24.28 (15.9%) stddev-sans-first:25.41 12:44:59 INFO - PROCESS | 31898 | Values: 163.0 129.0 152.0 189.0 129.0 153.0 151.0 132.0 193.0 126.0 12:44:59 INFO - PROCESS | 31898 | 12:44:59 INFO - PROCESS | 31898 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:4.26 (2.6%) stddev-sans-first:4.47 12:44:59 INFO - PROCESS | 31898 | Values: 162.0 164.0 162.0 161.0 161.0 164.0 175.0 161.0 166.0 162.0 12:44:59 INFO - PROCESS | 31898 | 12:44:59 INFO - PROCESS | 31898 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.50 stddev:38.83 (50.8%) stddev-sans-first:40.64 12:44:59 INFO - PROCESS | 31898 | Values: 77.0 74.0 78.0 166.0 78.0 76.0 76.0 77.0 171.0 76.0 12:44:59 INFO - PROCESS | 31898 | 12:44:59 INFO - PROCESS | 31898 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:93.00 stddev:25.76 (27.7%) stddev-sans-first:26.63 12:44:59 INFO - PROCESS | 31898 | Values: 93.0 94.0 150.0 93.0 93.0 94.0 146.0 94.0 93.0 144.0 12:44:59 INFO - PROCESS | 31898 | 12:44:59 INFO - PROCESS | 31898 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 12:44:59 INFO - PROCESS | 31898 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 118.0 12:44:59 INFO - PROCESS | 31898 | 12:44:59 INFO - PROCESS | 31898 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.69 (1.1%) stddev-sans-first:1.73 12:44:59 INFO - PROCESS | 31898 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 151.0 149.0 147.0 148.0 12:44:59 INFO - PROCESS | 31898 | 12:44:59 INFO - PROCESS | 31898 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 12:44:59 INFO - PROCESS | 31898 | Values: 95.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 96.0 12:44:59 INFO - PROCESS | 31898 | 12:44:59 INFO - PROCESS | 31898 | [#8] json-parse-financial Cycles:10 Average:62.50 Median:61.00 stddev:5.76 (9.4%) stddev-sans-first:6.08 12:44:59 INFO - PROCESS | 31898 | Values: 61.0 65.0 61.0 62.0 60.0 61.0 60.0 78.0 59.0 58.0 12:44:59 INFO - PROCESS | 31898 | 12:44:59 INFO - PROCESS | 31898 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 12:44:59 INFO - PROCESS | 31898 | Values: 62.0 63.0 62.0 62.0 63.0 61.0 61.0 62.0 62.0 62.0 12:44:59 INFO - PROCESS | 31898 | 12:44:59 INFO - PROCESS | 31898 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:77.50 stddev:3.52 (4.5%) stddev-sans-first:3.64 12:44:59 INFO - PROCESS | 31898 | Values: 76.0 77.0 76.0 77.0 78.0 77.0 78.0 78.0 88.0 77.0 12:44:59 INFO - PROCESS | 31898 | 12:44:59 INFO - PROCESS | 31898 | [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:135.00 stddev:10.86 (8.0%) stddev-sans-first:11.52 12:44:59 INFO - PROCESS | 31898 | Values: 135.0 135.0 131.0 130.0 129.0 135.0 126.0 135.0 164.0 127.0 12:44:59 INFO - PROCESS | 31898 | 12:44:59 INFO - PROCESS | 31898 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:166.00 stddev:3.71 (2.2%) stddev-sans-first:3.92 12:44:59 INFO - PROCESS | 31898 | Values: 168.0 164.0 165.0 164.0 166.0 166.0 166.0 175.0 164.0 172.0 12:44:59 INFO - PROCESS | 31898 | 12:44:59 INFO - PROCESS | 31898 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.40 (2.0%) stddev-sans-first:1.48 12:44:59 INFO - PROCESS | 31898 | Values: 69.0 71.0 68.0 68.0 70.0 69.0 66.0 68.0 70.0 69.0 12:44:59 INFO - PROCESS | 31898 | -------- Summary: end -------- 12:44:59 INFO - PROCESS | 31898 | 12:45:00 INFO - TEST-INFO | 31898: exit 0 12:45:00 INFO - TEST-OK | kraken | took 61836ms 12:45:00 INFO - SUITE-END | took 1172s 12:45:00 INFO - Completed test suite (00:19:33) 12:45:00 INFO - javascript benchmark 12:45:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3152.5113607390854, 3205.8397080145987, 3218.8390580470978, 3252.918677033074, 3258.4786434170537, 5439.972800136004, 5459.727013649322, 5492.148716948869, 5495.6153069285165, 5539.695316757577, 5416.410916657934, 5475.315585551806, 5493.340799104103, 5543.279373681416, 5556.888862222763, 4950.0, 4975.079610272093, 4978.377702787152, 5055.9747201263945, 5106.489351064883, 4913.385826771653, 5052.9242061369105, 5073.873153171182, 5088.872778180538, 5098.4136824265315, 4875.731834749087, 4941.678790878582, 4951.084049450845, 4974.850754477371, 4975.751212439363, 4963.057019166346, 4986.326845875797, 4994.275830004665, 4998.0, 5058.140116180221, 4955.4548999610015, 4958.851234462972, 4971.1549036663855, 4986.675866068694, 4990.725510096943, 5239.1093514102695, 5250.0, 5289.418164001957, 5379.408265090837, 5439.265699130646, 5687.289088863892, 5687.829365119053, 5693.231413759131, 5700.40145784695, 5795.391483894215, 5728.828135155952, 5765.6540607563265, 5775.422457754233, 5822.563307751893, 5846.298444186682, 5448.128299472105, 5462.453754624506, 5490.780368785244, 5504.4495550445035, 5519.282493275889, 5939.46544810969, 5994.310654274727, 6010.699465026819, 6022.819315420545, 6023.367546407651, 5664.235328230719, 5735.569832262514, 5744.770209191669, 5744.770209191669, 5806.535477161817, 5793.565482588822, 5796.971015144897, 5799.159121927381, 5829.242198514166, 5834.27071616048, 5730.971345143247, 5753.453421924911, 5800.158976948319, 5811.593188476851, 5819.505342045889, 5790.971045144832, 5895.587308888423, 5956.821295361146, 5967.850803729942, 5968.671723055274, 4317.158154159909, 4351.804168812411, 4351.912961740811, 4360.847370342023, 4389.714668546534, 3932.8623498178, 3938.6061393860386, 3938.665213456888, 3943.723939324277, 3968.0, 5623.662580245198, 5658.519025882846, 5658.575606829504, 5666.376698563237, 5680.914786278209, 5868.618539794899, 5891.617044892068, 5907.497862681635, 5916.26046744157, 5930.1994230779155, 5545.500904918576, 5608.1027035674915, 5622.8313150605545, 5627.774889004476, 5650.152477128464, 4815.735134567562, 4818.614510839195, 4897.755112244374, 4906.092372911023, 4910.386201724785, 6062.272527296753, 6085.939140608626, 6092.147099406086, 6101.603395779349, 6110.205673262536, 5806.303243610793, 5807.912881306699, 5809.477147056617, 5886.616645088315, 5901.3213480450295, 5909.793157239648, 5991.071383935497, 6114.816555503342, 6140.508759299335, 6154.415330543591, 5710.828675139753, 5747.224124743107, 5757.36668966405, 5774.220480235283, 5826.388229235869, 5751.7411716472025, 5878.647281163144, 5887.646741195542, 5888.587798854039, 5893.705314734332, 5740.13897915316, 5777.884442311214, 5784.1034639630925, 5789.652620842763, 5855.121731740102, 5686.09022556389, 5722.62802917809, 5726.112452569859, 5769.365369809234, 5785.566082543742, 5628.802991895264, 5629.155626656035, 5637.3235211774845, 5646.435356464321, 5647.632903861236, 5618.0, 5628.549716022627, 5667.659940403589, 5788.8552786179, 5844.766209351748, 5546.639468434539, 5636.928983493123, 5643.943560564506, 5683.460071293221, 5711.914736200109], "value": 5388.151434929104, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.284167632136, 631.8704665543563, 646.4246820329905, 647.8509942713176, 662.2483481248781, 35907.99999999997, 37103.628963710355, 37283.627163728386, 37445.251094978084, 37604.81197594015, 37524.81237593815, 38283.234335313275, 38377.23245535087, 38448.0, 38466.807665961634, 8459.36554758394, 8651.307895368356, 8660.696875609356, 8683.56582170892, 8697.47815131091, 8520.40357174998, 8773.692920747775, 8801.735947921572, 8807.0, 8844.778880528007, 8671.783205419852, 8740.257078148365, 8809.163129502687, 8815.955920220389, 8844.159804818564, 8773.0, 8777.605007774666, 8839.204471597523, 8839.425437346552, 8847.203751662317, 8698.304135669132, 8787.736367908972, 8795.868061979076, 8826.86759698605, 8827.470351778913, 32437.0, 38273.80863095695, 38988.80505597482, 39014.80492597547, 39222.215555689014, 3295.8516866741056, 3507.4563442666426, 3528.2237907660274, 3542.6634469725336, 3610.548681414823, 27109.86445067782, 27215.183544493695, 27389.178324650293, 27718.861405693046, 27951.30121746952, 3673.742838001341, 3716.5725941516803, 3733.4213196954515, 3922.8626998055215, 3930.233604447134, 325336.0, 328226.0, 334747.0, 335467.0, 336642.0, 52877.2068418974, 52960.70392960673, 53259.46740532623, 53294.73352633212, 53460.0, 55666.0, 63481.0, 64760.495357894164, 64802.351976480575, 65061.0, 15048.473303434546, 15148.0, 15280.46518371874, 15301.08193508393, 15304.693906122038, 11626.418679066013, 11655.067594592412, 11672.066234701204, 11687.065034797366, 11700.0, 18811.90594047021, 18934.43196704101, 18984.050797460073, 18991.905040474987, 19783.307584234484, 7268.0, 7321.682097222445, 7348.889766653505, 7482.812929676802, 7534.246575342422, 1003.0, 1019.7501612105082, 1060.173065009294, 1076.5532304093713, 1180.7402371478433, 31795.0, 31868.88913301861, 31907.840460798012, 32426.0, 32897.0, 1147.225622704671, 1212.660455072581, 1217.2939694976892, 1235.092207227687, 1271.8982481401652, 16663.83336166647, 17214.569635759206, 17284.481465556055, 17337.739933901, 17491.03799291051, 473823.0, 475886.0, 477753.0, 478733.0, 479173.0, 57283.0, 58160.12759808606, 58513.0, 58740.0, 58768.0, 1334.6596617862383, 1364.6383708317303, 1378.4072848675166, 1386.708791153869, 1396.8952328575194, 30953.91661291844, 31068.533971989986, 31271.53092703657, 31387.686123138476, 31980.520292196103, 50025.74987125041, 50278.4916452507, 50610.0, 50723.746381267854, 50869.0, 395650.0, 399651.0, 400311.0, 400660.0, 400893.0, 27372.315692107855, 28394.148175554765, 28417.43165136727, 28623.713762862106, 28651.0, 47453.288200676325, 47667.284990724474, 47689.0, 47832.0, 47913.76043119762, 39654.603453965094, 39762.0, 40825.1834963305, 41054.178916422105, 41758.791206043774, 39823.40264895971, 40161.0, 40329.79835100806, 41105.38341924814, 41632.375514367915, 41008.58991410048, 41364.37953430761, 41830.0, 42419.7879010603, 42751.358729618456, 34194.82902585471, 36874.44688329624, 36988.44517332188, 37016.0, 37315.44026839654, 28254.576181356886, 28494.88068204431, 28915.277118072216, 28989.401552308085, 29035.7096429033], "value": 19542.007398225112, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.23353293413174, 390.82608239333507, 391.60484927596934, 394.3690095846646, 395.1543696489513, 14372.928135359309, 17530.123493825304, 17655.5586110347, 18132.18405171767, 18311.35910243142, 16328.18359082047, 16745.91627041863, 16784.160791960414, 17222.311107555714, 17369.91315043423, 5467.699276539809, 5492.1212605982955, 5605.831825045255, 5652.293463317085, 5652.491275785179, 5457.181422786594, 5512.724363781795, 5538.947599956015, 5555.527780138673, 5601.0, 5271.657342272759, 5526.392096869341, 5553.111502159655, 5568.86077848053, 5573.219749235111, 5543.584231182677, 5550.111982082847, 5553.0837411827, 5584.274044374226, 5594.608377413582, 4734.171519984024, 4941.407031156248, 4986.975065124688, 5000.2749601307605, 5003.574696150831, 20991.370258892257, 21677.67483487749, 21721.2397566086, 22109.115635374565, 22111.005004774823, 738.837455759732, 1215.8540975082958, 2334.2063698342477, 2533.998141468238, 2812.9859350703114, 13425.530106446326, 13427.060105792598, 13515.864841351558, 13843.100198487167, 13952.302384880715, 1912.6270377276437, 1946.4841816918529, 2001.7998200180011, 2028.4421784009369, 2040.2553068130026, 77090.0, 77362.0, 77649.22350776476, 77952.0, 77998.22001779966, 9756.90243097574, 10237.795244095225, 10248.948755256177, 10441.634542790965, 10466.0, 12511.74976500465, 13436.731265374638, 14448.927755361367, 14476.27618619065, 14618.415263389557, 7302.671379787922, 7385.403635385001, 7749.147593764681, 7751.224877512203, 7822.100458447351, 7363.815904602321, 7369.373603243677, 7411.444141689395, 7444.404447644284, 7545.886811697719, 6370.49622707509, 6374.458171055512, 6384.744610215539, 6422.614643121427, 6442.903356449657, 1811.8731688781659, 1839.843613292885, 1862.590230149365, 1866.1415748755724, 1898.9525261868564, 1000.1348833259178, 1000.849872519128, 1022.3149402331276, 1023.0383439566783, 1120.165476719849, 17839.197236124404, 18401.723974140397, 18523.72214416785, 18771.624567508847, 18907.52731181704, 1016.1565900302732, 1025.5692609104194, 1027.9668932722566, 1057.4395570347729, 1083.5503266144462, 10510.264281500222, 10676.51955661997, 10682.51928663212, 10774.838377424345, 10824.458777061116, 471350.0, 485287.0, 487883.0, 492887.0, 493855.0, 77781.0, 78272.60863695644, 79333.0, 79669.59606225386, 80038.0, 1028.2391030637275, 1040.490159821682, 1056.0864851903048, 1069.1340014588209, 1071.9088877445504, 16411.261493233073, 16659.500214993568, 16717.414890478776, 16816.663666726352, 16989.15054247258, 27891.721082788914, 33740.66259337375, 34335.0, 36486.27027459383, 37569.43645845369, 44813.77593112014, 44951.32573011342, 45826.250424974605, 46233.53766462292, 46971.53028469672, 8201.261886430011, 8323.83352332962, 8394.37042221848, 11246.887531124585, 12100.334481603597, 12593.496260149492, 12899.613011609667, 12936.353182340657, 13213.537526186537, 13529.0, 11378.260413073123, 11573.537058517903, 11810.0, 11816.350100744197, 12098.939505302416, 11581.536738530365, 11748.941255293668, 11825.763484730085, 12162.0, 12236.265824050586, 10909.618163364245, 12220.938895305466, 12313.815292770436, 12354.629361119181, 12840.165389249669, 11503.654890353302, 12147.696307592381, 12309.753804923672, 12641.557545485864, 12657.303848288064, 12262.26426414418, 12271.57049503263, 12349.506019759108, 12587.811182832447, 12675.873241267469], "value": 9091.897717856553, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.7190433817573, 1503.9473618423353, 1642.0722291905072, 1752.5881417866808, 1774.6228926353137, 6984.930150698491, 7748.070231572212, 7790.0, 8001.359891208704, 8017.3986950978615, 7825.295723384908, 7851.411144164196, 7859.764207073797, 7909.367250619951, 7937.642806073726, 2232.999999999996, 2260.073369918334, 2274.283600665793, 2283.1666441748807, 2284.931452056441, 2223.2218723446827, 2237.272886311947, 2281.0533628544135, 2294.5181511882524, 2296.977030229693, 2254.0307667702964, 2261.739899911515, 2274.078998005802, 2323.744388117306, 2346.4133966508375, 2170.967435488469, 2186.1036974840317, 2187.912483500666, 2192.3094225319132, 2195.4291884110166, 2246.7191601049867, 2262.1856131792542, 2263.592553340398, 2267.4671452208718, 2268.897899594522, 8047.315978141865, 8067.0, 8083.43415960883, 8107.513549187068, 8112.594370281521, 4714.882127946795, 4807.951920480786, 4820.566149046567, 4839.274108883696, 4863.975680121612, 2992.4763166446, 3020.3808219314988, 3099.008317338453, 3132.9530057049164, 3211.887583934551, 950.5199874063622, 952.1525842000625, 979.1139019187647, 989.2975987049203, 1019.8572199892021, 10564.260501764957, 10588.735281617945, 10630.946845265802, 10644.361338319648, 10654.733631659194, 4053.777042262645, 4104.91790164195, 4192.496900371914, 4223.092035212383, 4310.827566897289, 9030.954845225731, 9032.32257580671, 9052.773680658036, 9094.727158185266, 9119.863202051974, 4932.235503496892, 4946.530079642428, 4953.777080031407, 4988.426330971912, 4999.225120106389, 4035.3139966205817, 4447.933281000787, 4555.066211426716, 4555.794989225493, 4612.76936153191, 3718.442233664972, 3735.869244576427, 3758.962410375916, 3786.981065094712, 3832.425136229532, 1225.577175874322, 1254.3414707278569, 1271.0, 1280.2702459598127, 1300.0769453687988, 773.8297574533593, 872.8690696395464, 921.447131720962, 973.1047436358567, 1009.2985375164337, 5471.562275017989, 5483.122700367922, 5535.25274087993, 5612.410696876851, 5656.91514627281, 996.7757254617653, 1004.6634377483625, 1018.7911478146962, 1026.1688032693542, 1029.8249297619423, 3977.801109944491, 3998.5001874765653, 4000.7999600019884, 4019.658329042006, 4026.59734026595, 9686.70939871805, 10127.0, 10185.134263587677, 10192.13366863825, 10230.437325946996, 10069.345492542961, 10117.29178957466, 10123.443210623487, 10126.240531960133, 10128.0, 7279.563226206445, 7300.671469783872, 7306.050213472215, 7317.304856038668, 7392.408607311402, 5241.580673546031, 5319.46805319465, 5333.7066461345, 5437.700926449083, 5457.61796674229, 8682.43564168327, 8843.204111629984, 8940.776480587778, 8949.686760963335, 8971.955140224258, 9200.6779762708, 9210.125038121369, 9283.907160928575, 9387.483688396931, 9448.385854919408, 6210.441060304594, 6740.730370785113, 6890.931090689029, 6913.861722765617, 7071.36357727807, 7964.522128672298, 7964.6415911282975, 7983.481073730189, 8041.155678653891, 8052.798680032812, 7201.387882030086, 7315.268473152642, 7373.041504604367, 7416.44376671741, 7504.174540800616, 7271.127464704269, 7283.8543229136185, 7286.817829554304, 7326.853462930818, 7351.742689005859, 6449.4517965971545, 6464.385883341075, 6513.804585862432, 6524.151860258136, 6553.279139294769, 4953.975230123826, 4986.0277245936695, 4986.252062190701, 4995.15082435994, 5012.248162775612, 5070.41690205631, 5123.590112791042, 5145.55726146649, 5270.288511051112, 5270.393904700855], "value": 4348.1464837656795, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.32106649636773, 322.18969292230037, 327.6903326356594, 328.4170597189988, 328.4186989029418, 5827.388124246957, 5911.88176236475, 5933.0803725422575, 6052.182955301033, 6085.269767627885, 5978.790742324019, 5978.9402105978925, 5989.940100598993, 5993.700314984255, 6004.939950600493, 4542.909141817162, 4547.477040140377, 4547.613452856511, 4552.385427967231, 4569.908601827961, 4455.1089782043555, 4562.247229207177, 4578.221702310615, 4579.107074120548, 4600.677952543323, 4501.7524036178, 4509.210888094587, 4515.164694531506, 4521.977390113045, 4533.863984080483, 4504.391907092533, 4520.299353600197, 4530.637548996073, 4537.2286711259, 4546.136234115507, 3867.7872717000555, 3946.954057174851, 3973.205358928226, 3980.8208630611402, 3985.621365970228, 5759.625624334447, 5778.27771528559, 5778.768849246025, 5779.711014449261, 5821.039528477796, 5280.3663560373, 5312.256284120188, 5323.520883120499, 5332.706701131437, 5340.786368545254, 6099.847503812396, 6276.717547710318, 6314.684265786738, 6317.557770956035, 6349.873002539924, 4392.165488557164, 4394.978025109886, 4398.73607583546, 4414.514403415622, 4415.933760993587, 6175.938240617626, 6547.770828021044, 6625.3043430440075, 6637.668116594199, 6649.833754156137, 4339.891502712458, 4341.413909122291, 4351.673624478113, 4374.496932852762, 4386.780660966939, 4464.70067915024, 4486.12520558488, 4491.371208030879, 4497.617702495259, 4504.842330518416, 5023.196288593807, 5166.689998600096, 5185.144451165591, 5194.168932970707, 5202.219667049897, 5955.37468565803, 6146.323904370515, 6272.0, 6350.142730731292, 6372.426481616584, 1571.1515781478101, 1588.340838552011, 1589.7933268675229, 1596.385391624233, 1596.9041857488587, 1053.7839742852698, 1066.4720963123305, 1086.6631344283298, 1088.7278180454887, 1094.4637127807316, 6042.274927008787, 6045.879082418327, 6050.818475445743, 6062.727177277033, 6082.239720034996, 6437.25971513282, 6492.707828147744, 6495.7076931538195, 6498.480121590356, 6540.4767618590395, 5964.403559644001, 6094.2077529920825, 6108.533951851524, 6154.661493617894, 6160.661163636043, 3510.964890351064, 3513.209527856263, 3539.469079638075, 3541.220931395089, 3561.1631266652316, 6504.317046710122, 6739.831504212336, 6745.662716864137, 6759.459243260528, 6775.762848300285, 6663.500237482208, 6674.499412544079, 6682.63245521501, 6688.097106890605, 6693.431058359996, 6620.404163625297, 6726.260111387744, 6743.494237932076, 6794.4904132189295, 6808.5914845109455, 6485.6108633482145, 6495.285518593046, 6497.772577959749, 6516.771912983023, 6525.249596296487, 6261.655608941552, 6371.267304259884, 6394.936050639621, 6399.968000159969, 6410.326915673973, 6634.436072933855, 6747.831304217238, 6771.424428923597, 6774.153230846145, 6796.184457865088, 4530.29780384041, 4550.0, 4554.567316104964, 4560.042391097906, 4582.816687332469, 6250.781222657185, 6361.904571431525, 6366.236051673829, 6390.659652123763, 6461.870762584816, 6379.585326953733, 6403.743850245938, 6406.23125224976, 6414.807555773335, 6427.871442571216, 6134.202553668173, 6359.459445947146, 6375.649339286384, 6386.042093685985, 6387.297397286387, 6286.402791734778, 6289.685515724104, 6299.401556852092, 6318.684065796784, 6332.176817013758, 6358.2687990879795, 6412.294647588668, 6418.582792118497, 6456.12842266288, 6462.0, 6018.969905150621, 6287.779927702509, 6322.33615470369, 6373.490120790233, 6378.2346118466085], "value": 4759.7681040945845, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.4034292737273, 770.9498882572632, 783.2324322164283, 801.1787917384681, 811.8051667599777, 13019.479220831166, 13248.27134507603, 13293.202407855511, 13509.18944863309, 13533.714297141756, 12308.93845530771, 12377.443015064322, 12418.937905310484, 12419.875801241986, 12430.502779888793, 654.4535313013615, 765.877459606463, 784.1805313447447, 790.8536920669666, 791.4657606115877, 781.5388920536882, 781.8514482248384, 785.2932360875201, 788.9013873265842, 790.1624278265028, 839.6347588798861, 841.028611953192, 841.364769598952, 842.8567143585606, 844.5903736687701, 830.0, 830.0578843013163, 833.0752864320599, 835.778518692547, 839.4669384940546, 608.4979891589412, 609.7256234694405, 609.9237595300588, 615.6060121522229, 617.0189398855796, 12909.741805163938, 12937.80593291092, 12970.286634235114, 12975.0, 13031.478740850449, 13234.338283085806, 13392.732145357038, 13427.597172084854, 13429.261390623511, 13510.932445337809, 10744.247902646817, 10893.891061089367, 10909.727256818564, 10963.397013164273, 11071.889281107247, 3804.087019115392, 3819.2361527694293, 3839.17457746583, 3861.131245469775, 3890.708196885245, 51629.48370516284, 53326.466735332535, 53365.0, 53486.465135348924, 53742.0, 9956.950215248877, 10068.899311006942, 10371.118454931264, 10472.214583906238, 10688.625898093529, 17393.565160870825, 17413.303467861144, 17429.564260893327, 17447.04041277742, 17486.47540573785, 7852.882206766903, 8021.197880211932, 8167.469114507538, 8180.345572354197, 8351.3736469765, 4402.273624851928, 4416.80124394403, 4568.771561421982, 4634.606058484999, 4747.525247475294, 3140.0579826052094, 3262.967370326314, 3270.215148364423, 3270.378628060661, 3287.079617707046, 598.1894532907847, 598.8323269484551, 599.7031469422576, 602.1299222623355, 612.6079309242089, 648.4423395879539, 672.1732269308777, 676.1818199977984, 738.2986163145034, 766.2567309709573, 8317.251447369767, 8394.748157555161, 8496.70261540843, 8535.103814099555, 8881.24509416694, 608.4402349838159, 652.292262894755, 733.3839574757122, 733.9082614673166, 744.5532680391722, 4242.469691288589, 4252.4046633471335, 4307.332363483665, 4323.373110898902, 4325.891852703708, 60295.39704602986, 60426.395736042956, 60867.39132608706, 61017.0, 61632.69183654053, 52041.47958520366, 52821.7358913203, 53265.0, 53665.46334536683, 53725.462745372046, 45938.77030614892, 47330.976866966696, 48135.518644813106, 48708.756456217496, 49910.75044624826, 8028.799280018046, 8164.632591533514, 8298.087210406971, 8390.24487796077, 8400.537970411686, 30308.24229394283, 30395.0, 30534.389312214076, 31059.53410698796, 31342.68657313398, 39266.42934282597, 40966.0, 41027.38458923059, 42102.578974209864, 42384.0, 8936.642534298815, 9100.863487047567, 9193.356465047382, 9375.531223438937, 9441.0, 10768.784624307313, 11042.282251653616, 11387.373694446886, 11427.714307142389, 11429.714257143638, 10607.787844243227, 10646.574137034431, 10827.566897324334, 10850.186236032172, 11359.318440893572, 10742.73143171427, 10812.891871081189, 10848.728781780519, 10851.891481085404, 11296.6046188383, 10614.469276536296, 10616.203784716332, 10703.893000728618, 10785.730356741144, 11413.714657133638, 8592.957035214784, 8679.392442528962, 9087.182153606207, 9288.0, 9290.814183716422, 9185.357025008185, 9406.341556091007, 9470.100340467645, 9551.856722149312, 9584.37701549397], "value": 6283.3047159026255, "unit": "score"}], "name": "dromaeo_css", "value": 7066.384689325628, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 108.0, 111.0, 112.0, 112.0, 123.0, 111.0, 111.0, 111.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 129.0, 152.0, 189.0, 129.0, 153.0, 151.0, 132.0, 193.0, 126.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 161.0, 161.0, 164.0, 175.0, 161.0, 166.0, 162.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 78.0, 166.0, 78.0, 76.0, 76.0, 77.0, 171.0, 76.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 150.0, 93.0, 93.0, 94.0, 146.0, 94.0, 93.0, 144.0], "value": 109.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 151.0, 149.0, 147.0, 148.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 65.0, 61.0, 62.0, 60.0, 61.0, 60.0, 78.0, 59.0, 58.0], "value": 62.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 63.0, 61.0, 61.0, 62.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 77.0, 78.0, 77.0, 78.0, 78.0, 88.0, 77.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 131.0, 130.0, 129.0, 135.0, 126.0, 135.0, 164.0, 127.0], "value": 134.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 164.0, 165.0, 164.0, 166.0, 166.0, 166.0, 175.0, 164.0, 172.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 68.0, 68.0, 70.0, 69.0, 66.0, 68.0, 70.0, 69.0], "value": 68.8, "unit": "score"}], "name": "kraken", "value": 1565.2, "alertThreshold": 2.0}]} 12:45:00 INFO - Return code: 0 12:45:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:45:00 ERROR - # TBPL SUCCESS # 12:45:00 INFO - Running post-action listener: _resource_record_post_action 12:45:00 INFO - Running post-run listener: _resource_record_post_run 12:45:01 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534568960; Read time: 24; Write time: 1126924 12:45:01 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 0; Write bytes: 244748288; Read time: 0; Write time: 673648 12:45:01 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289820672; Read time: 24; Write time: 453276 12:45:01 INFO - Running post-run listener: _upload_blobber_files 12:45:01 INFO - Blob upload gear active. 12:45:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:45:01 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 12:45:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:45:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:45:02 INFO - (blobuploader) - INFO - Open directory for files ... 12:45:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:45:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:45:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:45:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:45:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:45:03 INFO - (blobuploader) - INFO - Done attempting. 12:45:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:45:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:45:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:45:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:45:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:45:03 INFO - (blobuploader) - INFO - Done attempting. 12:45:03 INFO - (blobuploader) - INFO - Iteration through files over. 12:45:03 INFO - Return code: 0 12:45:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:45:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:45:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/178c6c363a0523a03b0b3316661121a70f3edaa42d51083103f1756ca2f40025e39a8ce9e51440044a31a4745ce6b5cad6bb502bf4306ea22b6cd63775d00c4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/44d02a70cd1f0797f85d3b54ec2cfe4add20575d62910c2e8818c979d1de593bf6cdf4ac7188855a97cd6e0f8a9b68a8cd1325c573af7c8c6606523915bf0c3c"} 12:45:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:45:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:45:03 INFO - Contents: 12:45:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/178c6c363a0523a03b0b3316661121a70f3edaa42d51083103f1756ca2f40025e39a8ce9e51440044a31a4745ce6b5cad6bb502bf4306ea22b6cd63775d00c4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/44d02a70cd1f0797f85d3b54ec2cfe4add20575d62910c2e8818c979d1de593bf6cdf4ac7188855a97cd6e0f8a9b68a8cd1325c573af7c8c6606523915bf0c3c"} 12:45:03 INFO - Running post-run listener: copy_logs_to_upload_dir 12:45:03 INFO - Copying logs to upload dir... 12:45:03 INFO - mkdir: /builds/slave/test/build/upload/logs 12:45:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.141785 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-21 12:45:03.616715) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 12:45:03.620572) ========= 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=33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/178c6c363a0523a03b0b3316661121a70f3edaa42d51083103f1756ca2f40025e39a8ce9e51440044a31a4745ce6b5cad6bb502bf4306ea22b6cd63775d00c4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/44d02a70cd1f0797f85d3b54ec2cfe4add20575d62910c2e8818c979d1de593bf6cdf4ac7188855a97cd6e0f8a9b68a8cd1325c573af7c8c6606523915bf0c3c"} build_url:https://queue.taskcluster.net/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011476 build_url: 'https://queue.taskcluster.net/v1/task/PGqC95MYTm23lEAzDpU3Ig/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/178c6c363a0523a03b0b3316661121a70f3edaa42d51083103f1756ca2f40025e39a8ce9e51440044a31a4745ce6b5cad6bb502bf4306ea22b6cd63775d00c4c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/44d02a70cd1f0797f85d3b54ec2cfe4add20575d62910c2e8818c979d1de593bf6cdf4ac7188855a97cd6e0f8a9b68a8cd1325c573af7c8c6606523915bf0c3c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-21 12:45:03.646049) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 12:45:03.646406) ========= 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=33d5923976266a1c518c4bf7000001ab-1461265646.625961-418114085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-21 12:45:03.730012) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 12:45:03.730340) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-21 12:45:03.730640) ========= ========= Total master_lag: 0.17 =========