builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1461172333.75 results: success (0) buildid: 20160420073325 builduid: de61044225d14ffbbb4a83527e5f0eba revision: 22521e3f311e86f38ffa5eace729820413e977dc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:13.752975) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:13.753488) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:13.753782) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:13.784682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:13.784987) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 10:12: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% 78.0M=0s 2016-04-20 10:12:14 (78.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.189166 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:13.992283) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:13.992628) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017100 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:14.041646) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:14.041998) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 22521e3f311e86f38ffa5eace729820413e977dc --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 22521e3f311e86f38ffa5eace729820413e977dc --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=5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 10:12:14,167 truncating revision to first 12 chars 2016-04-20 10:12:14,168 Setting DEBUG logging. 2016-04-20 10:12:14,168 attempt 1/10 2016-04-20 10:12:14,168 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/22521e3f311e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 10:12:14,448 unpacking tar archive at: mozilla-inbound-22521e3f311e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.590321 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:14.648856) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:14.652213) ========= script_repo_revision: 22521e3f311e86f38ffa5eace729820413e977dc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:14.652631) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:14.652904) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 10:12:14.667484) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-20 10:12:14.667893) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:12:14 INFO - MultiFileLogger online at 20160420 10:12:14 in /builds/slave/test 10:12:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 10:12:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:12:14 INFO - {'append_to_log': False, 10:12:14 INFO - 'base_work_dir': '/builds/slave/test', 10:12:14 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 10:12:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:12:14 INFO - 'branch': 'Mozilla-Inbound', 10:12:14 INFO - 'buildbot_json_path': 'buildprops.json', 10:12:14 INFO - 'config_files': ('talos/linux_config.py',), 10:12:14 INFO - 'default_actions': ('clobber', 10:12:14 INFO - 'read-buildbot-config', 10:12:14 INFO - 'download-and-extract', 10:12:14 INFO - 'populate-webroot', 10:12:14 INFO - 'create-virtualenv', 10:12:14 INFO - 'install', 10:12:14 INFO - 'run-tests'), 10:12:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:12:14 INFO - 'download_minidump_stackwalk': True, 10:12:14 INFO - 'download_symbols': 'ondemand', 10:12:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:12:14 INFO - 'tooltool.py': '/tools/tooltool.py', 10:12:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:12:14 INFO - '/tools/misc-python/virtualenv.py')}, 10:12:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:12:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:12:14 INFO - 'installer_path': 'installer.exe', 10:12:14 INFO - 'log_level': 'info', 10:12:14 INFO - 'log_name': 'talos', 10:12:14 INFO - 'log_to_console': True, 10:12:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:12:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:12:14 INFO - 'opt_config_files': (), 10:12:14 INFO - 'pip_index': False, 10:12:14 INFO - 'sps_profile': False, 10:12:14 INFO - 'sps_profile_interval': 0, 10:12:14 INFO - 'suite': 'dromaeojs', 10:12:14 INFO - 'system_bits': '32', 10:12:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:12:14 INFO - 'title': 'talos-linux64-ix-051', 10:12:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:12:14 INFO - 'use_talos_json': True, 10:12:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:12:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:12:14 INFO - 'work_dir': 'build'} 10:12:14 INFO - ##### 10:12:14 INFO - ##### Running clobber step. 10:12:14 INFO - ##### 10:12:14 INFO - Running pre-action listener: _resource_record_pre_action 10:12:14 INFO - Running main action method: clobber 10:12:14 INFO - rmtree: /builds/slave/test/build 10:12:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:12:15 INFO - Running post-action listener: _resource_record_post_action 10:12:15 INFO - ##### 10:12:15 INFO - ##### Running read-buildbot-config step. 10:12:15 INFO - ##### 10:12:15 INFO - Running pre-action listener: _resource_record_pre_action 10:12:15 INFO - Running main action method: read_buildbot_config 10:12:15 INFO - Using buildbot properties: 10:12:15 INFO - { 10:12:15 INFO - "project": "", 10:12:15 INFO - "product": "firefox", 10:12:15 INFO - "script_repo_revision": "production", 10:12:15 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 10:12:15 INFO - "repository": "", 10:12:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 10:12:15 INFO - "buildid": "20160420073325", 10:12:15 INFO - "pgo_build": "True", 10:12:15 INFO - "basedir": "/builds/slave/test", 10:12:15 INFO - "buildnumber": 1734, 10:12:15 INFO - "slavename": "talos-linux64-ix-051", 10:12:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:12:15 INFO - "platform": "ubuntu64_hw", 10:12:15 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 10:12:15 INFO - "branch": "mozilla-inbound", 10:12:15 INFO - "repo_path": "integration/mozilla-inbound", 10:12:15 INFO - "revision": "22521e3f311e86f38ffa5eace729820413e977dc", 10:12:15 INFO - "stage_platform": "linux64-pgo", 10:12:15 INFO - "builduid": "de61044225d14ffbbb4a83527e5f0eba", 10:12:15 INFO - "slavebuilddir": "test" 10:12:15 INFO - } 10:12:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 10:12:15 INFO - Running post-action listener: _resource_record_post_action 10:12:15 INFO - ##### 10:12:15 INFO - ##### Running download-and-extract step. 10:12:15 INFO - ##### 10:12:15 INFO - Running pre-action listener: _resource_record_pre_action 10:12:15 INFO - Running main action method: download_and_extract 10:12:15 INFO - mkdir: /builds/slave/test/build/tests 10:12: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')]} 10:12:15 INFO - https://queue.taskcluster.net/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:12:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:12:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:12:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nq2xs03HTr-1eTbYruF9Rg/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 10:12:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nq2xs03HTr-1eTbYruF9Rg/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 10:12:18 INFO - Downloaded 1361 bytes. 10:12:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 10:12:18 INFO - Using the following test package requirements: 10:12:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:12:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:12:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:12:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:18 INFO - u'jsshell-linux-x86_64.zip'], 10:12:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:12:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 10:12:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:12:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:12:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:12:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 10:12:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:12:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:12:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:18 INFO - https://queue.taskcluster.net/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:12:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:12:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:12:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nq2xs03HTr-1eTbYruF9Rg/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 10:12:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nq2xs03HTr-1eTbYruF9Rg/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 10:12:19 INFO - Downloaded 23842317 bytes. 10:12:19 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'] 10:12:19 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 10:12:20 INFO - Return code: 0 10:12:20 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 10:12:20 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')]} 10:12:20 INFO - https://queue.taskcluster.net/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:12:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:12:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 10:12:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nq2xs03HTr-1eTbYruF9Rg/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 10:12:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nq2xs03HTr-1eTbYruF9Rg/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 10:12:21 INFO - Downloaded 23842317 bytes. 10:12:21 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'] 10:12:21 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 10:12:23 INFO - Return code: 0 10:12:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:23 INFO - https://queue.taskcluster.net/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:12:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:12:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 10:12:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nq2xs03HTr-1eTbYruF9Rg/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 10:12:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nq2xs03HTr-1eTbYruF9Rg/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 10:12:24 INFO - Downloaded 10845952 bytes. 10:12:24 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'] 10:12:24 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 10:12:24 INFO - Return code: 0 10:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:24 INFO - https://queue.taskcluster.net/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:12:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:12:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:12:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nq2xs03HTr-1eTbYruF9Rg/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 10:12:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Nq2xs03HTr-1eTbYruF9Rg/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 10:12:28 INFO - Downloaded 58312138 bytes. 10:12:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:12:28 INFO - mkdir: /builds/slave/test/properties 10:12:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:12:28 INFO - Writing to file /builds/slave/test/properties/build_url 10:12:28 INFO - Contents: 10:12:28 INFO - build_url:https://queue.taskcluster.net/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 10:12:29 INFO - Running post-action listener: _resource_record_post_action 10:12:29 INFO - Running post-action listener: set_extra_try_arguments 10:12:29 INFO - ##### 10:12:29 INFO - ##### Running populate-webroot step. 10:12:29 INFO - ##### 10:12:29 INFO - Running pre-action listener: _resource_record_pre_action 10:12:29 INFO - Running main action method: populate_webroot 10:12:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:12:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:12:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:12:29 INFO - '--tppagecycles', 10:12:29 INFO - '7'], 10:12:29 INFO - 'tests': ['tsvgm']}}, 10:12:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:12:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:12:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:12:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:12:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:12:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:12:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:29 INFO - 'talos_options': ['--disable-e10s'], 10:12:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:12:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:29 INFO - 'talos_options': ['--disable-e10s'], 10:12:29 INFO - 'tests': ['damp', 'tps']}, 10:12:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:29 INFO - 'tests': ['damp', 'tps']}, 10:12:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:12:29 INFO - 'tests': ['dromaeo_dom']}, 10:12:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:12:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:12:29 INFO - 'tests': ['a11yr', 10:12:29 INFO - 'ts_paint', 10:12:29 INFO - 'tpaint', 10:12:29 INFO - 'sessionrestore', 10:12:29 INFO - 'sessionrestore_no_auto_restore', 10:12:29 INFO - 'tabpaint']}, 10:12:29 INFO - 'other-e10s': {'tests': ['a11yr', 10:12:29 INFO - 'ts_paint', 10:12:29 INFO - 'tpaint', 10:12:29 INFO - 'sessionrestore', 10:12:29 INFO - 'sessionrestore_no_auto_restore', 10:12:29 INFO - 'tabpaint']}, 10:12:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:12:29 INFO - 'ts_paint', 10:12:29 INFO - 'tpaint', 10:12:29 INFO - 'sessionrestore', 10:12:29 INFO - 'sessionrestore_no_auto_restore', 10:12:29 INFO - 'tabpaint']}, 10:12:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:12:29 INFO - 'ts_paint', 10:12:29 INFO - 'tpaint', 10:12:29 INFO - 'sessionrestore', 10:12:29 INFO - 'sessionrestore_no_auto_restore', 10:12:29 INFO - 'tabpaint']}, 10:12:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:12:29 INFO - 'tests': ['a11yr', 10:12:29 INFO - 'ts_paint', 10:12:29 INFO - 'tpaint', 10:12:29 INFO - 'sessionrestore', 10:12:29 INFO - 'sessionrestore_no_auto_restore', 10:12:29 INFO - 'tabpaint']}, 10:12:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:12:29 INFO - 'tests': ['a11yr', 10:12:29 INFO - 'ts_paint', 10:12:29 INFO - 'tpaint', 10:12:29 INFO - 'sessionrestore', 10:12:29 INFO - 'sessionrestore_no_auto_restore', 10:12:29 INFO - 'tabpaint']}, 10:12:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:12:29 INFO - 'tests': ['tsvgx', 10:12:29 INFO - 'tsvgr_opacity', 10:12:29 INFO - 'tart', 10:12:29 INFO - 'tscrollx', 10:12:29 INFO - 'cart']}, 10:12:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:12:29 INFO - 'tsvgr_opacity', 10:12:29 INFO - 'tart', 10:12:29 INFO - 'tscrollx', 10:12:29 INFO - 'cart']}, 10:12:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:29 INFO - 'talos_options': ['--disable-e10s'], 10:12:29 INFO - 'tests': ['tp5o']}, 10:12:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:29 INFO - 'tests': ['tp5o']}, 10:12:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:29 INFO - 'talos_options': ['--disable-e10s', 10:12:29 INFO - '--xperf_path', 10:12:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:29 INFO - 'tests': ['tp5n']}, 10:12:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:12:29 INFO - 'talos_options': ['--xperf_path', 10:12:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:12:29 INFO - 'tests': ['tp5n']}}, 10:12:29 INFO - 'talos.zip': {'path': '', 10:12:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:12:29 INFO - Running post-action listener: _resource_record_post_action 10:12:29 INFO - ##### 10:12:29 INFO - ##### Running create-virtualenv step. 10:12:29 INFO - ##### 10:12:29 INFO - Running pre-action listener: _resource_record_pre_action 10:12:29 INFO - Running main action method: create_virtualenv 10:12:29 INFO - Creating virtualenv /builds/slave/test/build/venv 10:12:29 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 10:12:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:12:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:12:29 INFO - Using real prefix '/usr' 10:12:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:12:29 INFO - Installing distribute.............................................................................................................................................................................................done. 10:12:31 INFO - Installing pip.................done. 10:12:31 INFO - Return code: 0 10:12:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:12:31 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')]} 10:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:31 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')]} 10:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:31 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 0x7f62a1211f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3410>, '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 0x10a4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a47a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981', '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 10:12:31 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 10:12:31 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 10:12:31 INFO - Using env: {'DISPLAY': ':0', 10:12:31 INFO - 'HOME': '/home/cltbld', 10:12:31 INFO - 'LANG': 'en_US.UTF-8', 10:12:31 INFO - 'LANGUAGE': 'en_US:en', 10:12:31 INFO - 'LOGNAME': 'cltbld', 10:12:31 INFO - 'MAIL': '/var/mail/cltbld', 10:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:31 INFO - 'MOZ_NO_REMOTE': '1', 10:12:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:31 INFO - 'NO_EM_RESTART': '1', 10:12:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:31 INFO - 'PWD': '/builds/slave/test', 10:12:31 INFO - 'SHELL': '/bin/bash', 10:12:31 INFO - 'SHLVL': '1', 10:12:31 INFO - 'TERM': 'linux', 10:12:31 INFO - 'TMOUT': '86400', 10:12:31 INFO - 'USER': 'cltbld', 10:12:31 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981', 10:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:31 INFO - '_': '/tools/buildbot/bin/python'} 10:12:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:32 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 10:12:32 INFO - Cleaning up... 10:12:32 INFO - Return code: 0 10:12:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:32 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 0x7f62a1211f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3410>, '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 0x10a4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a47a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981', '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 10:12:32 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 10:12:32 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 10:12:32 INFO - Using env: {'DISPLAY': ':0', 10:12:32 INFO - 'HOME': '/home/cltbld', 10:12:32 INFO - 'LANG': 'en_US.UTF-8', 10:12:32 INFO - 'LANGUAGE': 'en_US:en', 10:12:32 INFO - 'LOGNAME': 'cltbld', 10:12:32 INFO - 'MAIL': '/var/mail/cltbld', 10:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:32 INFO - 'MOZ_NO_REMOTE': '1', 10:12:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:32 INFO - 'NO_EM_RESTART': '1', 10:12:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:32 INFO - 'PWD': '/builds/slave/test', 10:12:32 INFO - 'SHELL': '/bin/bash', 10:12:32 INFO - 'SHLVL': '1', 10:12:32 INFO - 'TERM': 'linux', 10:12:32 INFO - 'TMOUT': '86400', 10:12:32 INFO - 'USER': 'cltbld', 10:12:32 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981', 10:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:32 INFO - '_': '/tools/buildbot/bin/python'} 10:12:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:32 INFO - Downloading/unpacking psutil>=0.7.1 10:12:32 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 10:12:32 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 10:12:32 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 10:12:32 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 10:12:32 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 10:12:32 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 10:12:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:12:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:34 INFO - Installing collected packages: psutil 10:12:34 INFO - Running setup.py install for psutil 10:12:34 INFO - building 'psutil._psutil_linux' extension 10:12:34 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 10:12:35 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 10:12:36 INFO - building 'psutil._psutil_posix' extension 10:12:36 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 10:12:36 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 10:12:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:12:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:12:36 INFO - Successfully installed psutil 10:12:36 INFO - Cleaning up... 10:12:36 INFO - Return code: 0 10:12:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:12:36 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')]} 10:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:36 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')]} 10:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:36 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 0x7f62a1211f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3410>, '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 0x10a4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a47a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981', '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 10:12:36 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 10:12:36 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 10:12:36 INFO - Using env: {'DISPLAY': ':0', 10:12:36 INFO - 'HOME': '/home/cltbld', 10:12:36 INFO - 'LANG': 'en_US.UTF-8', 10:12:36 INFO - 'LANGUAGE': 'en_US:en', 10:12:36 INFO - 'LOGNAME': 'cltbld', 10:12:36 INFO - 'MAIL': '/var/mail/cltbld', 10:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:36 INFO - 'MOZ_NO_REMOTE': '1', 10:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:36 INFO - 'NO_EM_RESTART': '1', 10:12:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:36 INFO - 'PWD': '/builds/slave/test', 10:12:36 INFO - 'SHELL': '/bin/bash', 10:12:36 INFO - 'SHLVL': '1', 10:12:36 INFO - 'TERM': 'linux', 10:12:36 INFO - 'TMOUT': '86400', 10:12:36 INFO - 'USER': 'cltbld', 10:12:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981', 10:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:36 INFO - '_': '/tools/buildbot/bin/python'} 10:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:12:36 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 10:12:36 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 10:12:36 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 10:12:36 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 10:12:36 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 10:12:36 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 10:12:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:12:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:12:38 INFO - Installing collected packages: mozsystemmonitor 10:12:38 INFO - Running setup.py install for mozsystemmonitor 10:12:38 INFO - Successfully installed mozsystemmonitor 10:12:38 INFO - Cleaning up... 10:12:38 INFO - Return code: 0 10:12:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:38 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 0x7f62a1211f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3410>, '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 0x10a4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a47a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981', '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 10:12:38 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 10:12:38 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 10:12:38 INFO - Using env: {'DISPLAY': ':0', 10:12:38 INFO - 'HOME': '/home/cltbld', 10:12:38 INFO - 'LANG': 'en_US.UTF-8', 10:12:38 INFO - 'LANGUAGE': 'en_US:en', 10:12:38 INFO - 'LOGNAME': 'cltbld', 10:12:38 INFO - 'MAIL': '/var/mail/cltbld', 10:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:38 INFO - 'MOZ_NO_REMOTE': '1', 10:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:38 INFO - 'NO_EM_RESTART': '1', 10:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:38 INFO - 'PWD': '/builds/slave/test', 10:12:38 INFO - 'SHELL': '/bin/bash', 10:12:38 INFO - 'SHLVL': '1', 10:12:38 INFO - 'TERM': 'linux', 10:12:38 INFO - 'TMOUT': '86400', 10:12:38 INFO - 'USER': 'cltbld', 10:12:38 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981', 10:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:38 INFO - '_': '/tools/buildbot/bin/python'} 10:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:38 INFO - Downloading/unpacking blobuploader==1.2.4 10:12:38 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 10:12:38 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 10:12:38 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 10:12:38 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 10:12:38 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 10:12:38 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 10:12:40 INFO - Downloading blobuploader-1.2.4.tar.gz 10:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:12:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:12:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:12:41 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 10:12:41 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 10:12:41 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 10:12:41 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 10:12:41 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 10:12:41 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 10:12:41 INFO - Downloading docopt-0.6.1.tar.gz 10:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:12:41 INFO - Installing collected packages: blobuploader, requests, docopt 10:12:41 INFO - Running setup.py install for blobuploader 10:12:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:12:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:12:41 INFO - Running setup.py install for requests 10:12:42 INFO - Running setup.py install for docopt 10:12:42 INFO - Successfully installed blobuploader requests docopt 10:12:42 INFO - Cleaning up... 10:12:42 INFO - Return code: 0 10:12:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12: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')]} 10:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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')]} 10:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:42 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 0x7f62a1211f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3410>, '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 0x10a4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a47a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981', '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 10:12:42 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 10:12:42 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 10:12:42 INFO - Using env: {'DISPLAY': ':0', 10:12:42 INFO - 'HOME': '/home/cltbld', 10:12:42 INFO - 'LANG': 'en_US.UTF-8', 10:12:42 INFO - 'LANGUAGE': 'en_US:en', 10:12:42 INFO - 'LOGNAME': 'cltbld', 10:12:42 INFO - 'MAIL': '/var/mail/cltbld', 10:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:42 INFO - 'MOZ_NO_REMOTE': '1', 10:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:42 INFO - 'NO_EM_RESTART': '1', 10:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:42 INFO - 'PWD': '/builds/slave/test', 10:12:42 INFO - 'SHELL': '/bin/bash', 10:12:42 INFO - 'SHLVL': '1', 10:12:42 INFO - 'TERM': 'linux', 10:12:42 INFO - 'TMOUT': '86400', 10:12:42 INFO - 'USER': 'cltbld', 10:12:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981', 10:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:42 INFO - '_': '/tools/buildbot/bin/python'} 10:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:42 INFO - Running setup.py (path:/tmp/pip-2uIR1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:42 INFO - Running setup.py (path:/tmp/pip-1CYDtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:42 INFO - Running setup.py (path:/tmp/pip-4u8RpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:42 INFO - Running setup.py (path:/tmp/pip-mBkttP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:42 INFO - Running setup.py (path:/tmp/pip-gS4pEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:42 INFO - Running setup.py (path:/tmp/pip-Rr2qlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:42 INFO - Running setup.py (path:/tmp/pip-r3_LaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:42 INFO - Running setup.py (path:/tmp/pip-_okYE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:42 INFO - Running setup.py (path:/tmp/pip-OnvjTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:43 INFO - Running setup.py (path:/tmp/pip-HksvLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:43 INFO - Running setup.py (path:/tmp/pip-IGVDCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:43 INFO - Running setup.py (path:/tmp/pip-gCuZG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:43 INFO - Running setup.py (path:/tmp/pip-U2QJjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:43 INFO - Running setup.py (path:/tmp/pip-EV3vRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:43 INFO - Running setup.py (path:/tmp/pip-FY9dEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:43 INFO - Running setup.py (path:/tmp/pip-RNxSqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:43 INFO - Running setup.py (path:/tmp/pip-DyPTBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:12:43 INFO - Running setup.py install for manifestparser 10:12:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:12:43 INFO - Running setup.py install for mozcrash 10:12:43 INFO - Running setup.py install for mozdebug 10:12:43 INFO - Running setup.py install for mozdevice 10:12:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Running setup.py install for mozfile 10:12:44 INFO - Running setup.py install for mozhttpd 10:12:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Running setup.py install for mozinfo 10:12:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Running setup.py install for mozInstall 10:12:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Running setup.py install for mozleak 10:12:44 INFO - Running setup.py install for mozlog 10:12:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Running setup.py install for moznetwork 10:12:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Running setup.py install for mozprocess 10:12:44 INFO - Running setup.py install for mozprofile 10:12:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:12:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:12:45 INFO - Running setup.py install for mozrunner 10:12:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:12:45 INFO - Running setup.py install for mozscreenshot 10:12:45 INFO - Running setup.py install for moztest 10:12:45 INFO - Running setup.py install for mozversion 10:12:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:12:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:12:45 INFO - Cleaning up... 10:12:45 INFO - Return code: 0 10:12:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:45 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 0x7f62a1211f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3410>, '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 0x10a4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a47a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981', '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 10:12:45 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 10:12:45 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 10:12:45 INFO - Using env: {'DISPLAY': ':0', 10:12:45 INFO - 'HOME': '/home/cltbld', 10:12:45 INFO - 'LANG': 'en_US.UTF-8', 10:12:45 INFO - 'LANGUAGE': 'en_US:en', 10:12:45 INFO - 'LOGNAME': 'cltbld', 10:12:45 INFO - 'MAIL': '/var/mail/cltbld', 10:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:45 INFO - 'MOZ_NO_REMOTE': '1', 10:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:45 INFO - 'NO_EM_RESTART': '1', 10:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:45 INFO - 'PWD': '/builds/slave/test', 10:12:45 INFO - 'SHELL': '/bin/bash', 10:12:45 INFO - 'SHLVL': '1', 10:12:45 INFO - 'TERM': 'linux', 10:12:45 INFO - 'TMOUT': '86400', 10:12:45 INFO - 'USER': 'cltbld', 10:12:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981', 10:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:45 INFO - '_': '/tools/buildbot/bin/python'} 10:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:45 INFO - Running setup.py (path:/tmp/pip-nZnbWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:45 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)) 10:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:45 INFO - Running setup.py (path:/tmp/pip-kbBtdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:45 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)) 10:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:45 INFO - Running setup.py (path:/tmp/pip-csLMDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:45 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)) 10:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:45 INFO - Running setup.py (path:/tmp/pip-tj1mMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:45 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)) 10:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:45 INFO - Running setup.py (path:/tmp/pip-EoqPiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:46 INFO - Running setup.py (path:/tmp/pip-g2az1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:46 INFO - Running setup.py (path:/tmp/pip-kTuhqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:46 INFO - Running setup.py (path:/tmp/pip-KaUfZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:46 INFO - Running setup.py (path:/tmp/pip-nR0fY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:46 INFO - Running setup.py (path:/tmp/pip-FCp_IN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:46 INFO - Running setup.py (path:/tmp/pip-Umzgpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:46 INFO - Running setup.py (path:/tmp/pip-apvttc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:46 INFO - Running setup.py (path:/tmp/pip-EOIIpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:46 INFO - Running setup.py (path:/tmp/pip-8XAqnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:46 INFO - Running setup.py (path:/tmp/pip-yogCgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:46 INFO - Running setup.py (path:/tmp/pip-9Eo4Kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:46 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)) 10:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:46 INFO - Running setup.py (path:/tmp/pip-8E1r0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:46 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)) 10:12:46 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)) 10:12:46 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)) 10:12:46 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)) 10:12:46 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)) 10:12:46 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)) 10:12:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:12:46 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 10:12:46 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 10:12:46 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 10:12:46 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 10:12:46 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 10:12:46 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 10:12:48 INFO - Downloading blessings-1.6.tar.gz 10:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:12:48 INFO - Installing collected packages: blessings 10:12:48 INFO - Running setup.py install for blessings 10:12:48 INFO - Successfully installed blessings 10:12:48 INFO - Cleaning up... 10:12:49 INFO - Return code: 0 10:12:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:12:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:49 INFO - Reading from file tmpfile_stdout 10:12:49 INFO - Current package versions: 10:12:49 INFO - argparse == 1.2.1 10:12:49 INFO - blessings == 1.6 10:12:49 INFO - blobuploader == 1.2.4 10:12:49 INFO - docopt == 0.6.1 10:12:49 INFO - manifestparser == 1.1 10:12:49 INFO - mozInstall == 1.12 10:12:49 INFO - mozcrash == 0.17 10:12:49 INFO - mozdebug == 0.1 10:12:49 INFO - mozdevice == 0.48 10:12:49 INFO - mozfile == 1.2 10:12:49 INFO - mozhttpd == 0.7 10:12:49 INFO - mozinfo == 0.9 10:12:49 INFO - mozleak == 0.1 10:12:49 INFO - mozlog == 3.1 10:12:49 INFO - moznetwork == 0.27 10:12:49 INFO - mozprocess == 0.22 10:12:49 INFO - mozprofile == 0.28 10:12:49 INFO - mozrunner == 6.11 10:12:49 INFO - mozscreenshot == 0.1 10:12:49 INFO - mozsystemmonitor == 0.0 10:12:49 INFO - moztest == 0.7 10:12:49 INFO - mozversion == 1.4 10:12:49 INFO - psutil == 3.1.1 10:12:49 INFO - requests == 1.2.3 10:12:49 INFO - wsgiref == 0.1.2 10:12:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:49 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')]} 10:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:49 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')]} 10:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:49 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 0x7f62a1211f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3410>, '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 0x10a4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a47a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981', '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 10:12:49 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 10:12:49 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 10:12:49 INFO - Using env: {'DISPLAY': ':0', 10:12:49 INFO - 'HOME': '/home/cltbld', 10:12:49 INFO - 'LANG': 'en_US.UTF-8', 10:12:49 INFO - 'LANGUAGE': 'en_US:en', 10:12:49 INFO - 'LOGNAME': 'cltbld', 10:12:49 INFO - 'MAIL': '/var/mail/cltbld', 10:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:49 INFO - 'MOZ_NO_REMOTE': '1', 10:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:49 INFO - 'NO_EM_RESTART': '1', 10:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:49 INFO - 'PWD': '/builds/slave/test', 10:12:49 INFO - 'SHELL': '/bin/bash', 10:12:49 INFO - 'SHLVL': '1', 10:12:49 INFO - 'TERM': 'linux', 10:12:49 INFO - 'TMOUT': '86400', 10:12:49 INFO - 'USER': 'cltbld', 10:12:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981', 10:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:49 INFO - '_': '/tools/buildbot/bin/python'} 10:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:49 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)) 10:12:49 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)) 10:12:49 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)) 10:12:49 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)) 10:12:49 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)) 10:12:49 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)) 10:12:49 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)) 10:12:49 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)) 10:12:49 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)) 10:12:49 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)) 10:12:49 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)) 10:12:49 INFO - Cleaning up... 10:12:49 INFO - Return code: 0 10:12:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:12:49 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')]} 10:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:49 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')]} 10:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:49 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 0x7f62a1211f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3410>, '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 0x10a4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a47a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981', '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 10:12:49 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 10:12:49 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 10:12:49 INFO - Using env: {'DISPLAY': ':0', 10:12:49 INFO - 'HOME': '/home/cltbld', 10:12:49 INFO - 'LANG': 'en_US.UTF-8', 10:12:49 INFO - 'LANGUAGE': 'en_US:en', 10:12:49 INFO - 'LOGNAME': 'cltbld', 10:12:49 INFO - 'MAIL': '/var/mail/cltbld', 10:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:49 INFO - 'MOZ_NO_REMOTE': '1', 10:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:49 INFO - 'NO_EM_RESTART': '1', 10:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:49 INFO - 'PWD': '/builds/slave/test', 10:12:49 INFO - 'SHELL': '/bin/bash', 10:12:49 INFO - 'SHLVL': '1', 10:12:49 INFO - 'TERM': 'linux', 10:12:49 INFO - 'TMOUT': '86400', 10:12:49 INFO - 'USER': 'cltbld', 10:12:49 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981', 10:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:49 INFO - '_': '/tools/buildbot/bin/python'} 10:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:49 INFO - Downloading/unpacking jsonschema 10:12:49 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 10:12:49 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 10:12:49 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 10:12:49 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 10:12:49 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 10:12:49 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 10:12:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:12:51 INFO - Downloading/unpacking functools32 (from jsonschema) 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12:51 INFO - Downloading functools32-3.2.3-2.tar.gz 10:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:12:51 INFO - warning: no files found matching '*.txt' 10:12:51 INFO - no previously-included directories found matching 'build' 10:12:51 INFO - no previously-included directories found matching 'dist' 10:12:51 INFO - no previously-included directories found matching '.git*' 10:12:51 INFO - Installing collected packages: jsonschema, functools32 10:12:51 INFO - Running setup.py install for functools32 10:12:51 INFO - warning: no files found matching '*.txt' 10:12:51 INFO - no previously-included directories found matching 'build' 10:12:51 INFO - no previously-included directories found matching 'dist' 10:12:51 INFO - no previously-included directories found matching '.git*' 10:12:51 INFO - Successfully installed jsonschema functools32 10:12:51 INFO - Cleaning up... 10:12:52 INFO - Return code: 0 10:12:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:52 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 0x7f62a1211f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf498a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10145a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3410>, '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 0x10a4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a47a0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981', '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 10:12:52 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 10:12:52 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 10:12:52 INFO - Using env: {'DISPLAY': ':0', 10:12:52 INFO - 'HOME': '/home/cltbld', 10:12:52 INFO - 'LANG': 'en_US.UTF-8', 10:12:52 INFO - 'LANGUAGE': 'en_US:en', 10:12:52 INFO - 'LOGNAME': 'cltbld', 10:12:52 INFO - 'MAIL': '/var/mail/cltbld', 10:12:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:52 INFO - 'MOZ_NO_REMOTE': '1', 10:12:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:52 INFO - 'NO_EM_RESTART': '1', 10:12:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:52 INFO - 'PWD': '/builds/slave/test', 10:12:52 INFO - 'SHELL': '/bin/bash', 10:12:52 INFO - 'SHLVL': '1', 10:12:52 INFO - 'TERM': 'linux', 10:12:52 INFO - 'TMOUT': '86400', 10:12:52 INFO - 'USER': 'cltbld', 10:12:52 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981', 10:12:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:52 INFO - '_': '/tools/buildbot/bin/python'} 10:12:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:52 INFO - Downloading/unpacking flake8 10:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:12:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:12:54 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 10:12:54 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 10:12:54 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 10:12:54 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 10:12:54 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 10:12:54 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 10:12:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:12:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:12:54 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 10:12:54 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 10:12:54 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 10:12:54 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 10:12:54 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 10:12:54 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 10:12:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:12:54 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 10:12:54 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 10:12:54 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 10:12:54 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 10:12:54 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 10:12:54 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 10:12:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:12:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:12:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:12:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:12:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:12:54 INFO - no previously-included directories found matching 'docs/_build' 10:12:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:12:54 INFO - Running setup.py install for pep8 10:12:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:12:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:12:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:12:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:12:55 INFO - no previously-included directories found matching 'docs/_build' 10:12:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:12:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:12:55 INFO - Cleaning up... 10:12:55 INFO - Return code: 0 10:12:55 INFO - Running post-action listener: _resource_record_post_action 10:12:55 INFO - Running post-action listener: _start_resource_monitoring 10:12:55 INFO - Starting resource monitoring. 10:12:55 INFO - ##### 10:12:55 INFO - ##### Running install step. 10:12:55 INFO - ##### 10:12:55 INFO - Running pre-action listener: _resource_record_pre_action 10:12:55 INFO - Running main action method: install 10:12:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:55 INFO - Reading from file tmpfile_stdout 10:12:55 INFO - Detecting whether we're running mozinstall >=1.0... 10:12:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:12:55 INFO - Reading from file tmpfile_stdout 10:12:55 INFO - Output received: 10:12:55 INFO - Usage: mozinstall [options] installer 10:12:55 INFO - Options: 10:12:55 INFO - -h, --help show this help message and exit 10:12:55 INFO - -d DEST, --destination=DEST 10:12:55 INFO - Directory to install application into. [default: 10:12:55 INFO - "/builds/slave/test"] 10:12:55 INFO - --app=APP Application being installed. [default: firefox] 10:12:55 INFO - mkdir: /builds/slave/test/build/application 10:12:55 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'] 10:12:55 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 10:13:11 INFO - Reading from file tmpfile_stdout 10:13:11 INFO - Output received: 10:13:11 INFO - /builds/slave/test/build/application/firefox/firefox 10:13:11 INFO - Running post-action listener: _resource_record_post_action 10:13:11 INFO - ##### 10:13:11 INFO - ##### Running run-tests step. 10:13:11 INFO - ##### 10:13:11 INFO - Running pre-action listener: _resource_record_pre_action 10:13:11 INFO - Running main action method: run_tests 10:13:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:13:11 INFO - Python 2.7.3 10:13:11 INFO - Return code: 0 10:13:11 INFO - grabbing minidump binary from tooltool 10:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:13:11 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 0x10a3410>, '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 0x10a4310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a47a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:13:11 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 10:13:11 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 10:13:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:13:12 INFO - Return code: 0 10:13:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:13:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:13:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:13:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:13:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:13:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:13:13 INFO - Return code: 0 10:13:13 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:13:13 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:13:13 INFO - Using env: {'DISPLAY': ':0', 10:13:13 INFO - 'HOME': '/home/cltbld', 10:13:13 INFO - 'LANG': 'en_US.UTF-8', 10:13:13 INFO - 'LANGUAGE': 'en_US:en', 10:13:13 INFO - 'LOGNAME': 'cltbld', 10:13:13 INFO - 'MAIL': '/var/mail/cltbld', 10:13:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:13:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:13 INFO - 'MOZ_NO_REMOTE': '1', 10:13:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:13:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:13:13 INFO - 'NO_EM_RESTART': '1', 10:13:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:13 INFO - 'PWD': '/builds/slave/test', 10:13:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:13:13 INFO - 'SHELL': '/bin/bash', 10:13:13 INFO - 'SHLVL': '1', 10:13:13 INFO - 'TERM': 'linux', 10:13:13 INFO - 'TMOUT': '86400', 10:13:13 INFO - 'USER': 'cltbld', 10:13:13 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981', 10:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:13 INFO - '_': '/tools/buildbot/bin/python'} 10:13:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:13:13 INFO - mozversion application_buildid: 20160420073325 10:13:13 INFO - mozversion application_changeset: 22521e3f311e86f38ffa5eace729820413e977dc 10:13:13 INFO - mozversion application_display_name: Nightly 10:13:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:13:13 INFO - mozversion application_name: Firefox 10:13:13 INFO - mozversion application_remotingname: firefox 10:13:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:13:13 INFO - mozversion application_vendor: Mozilla 10:13:13 INFO - mozversion application_version: 48.0a1 10:13:13 INFO - mozversion platform_buildid: 20160420073325 10:13:13 INFO - mozversion platform_changeset: 22521e3f311e86f38ffa5eace729820413e977dc 10:13:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 10:13:13 INFO - mozversion platform_version: 48.0a1 10:13:13 INFO - using testdate: 1461172393 10:13:13 INFO - actual date: 1461172393 10:13:13 INFO - starting webserver on 'localhost:59443' 10:13:13 INFO - SUITE-START | Running 2 tests 10:13:13 INFO - TEST-START | dromaeo_css 10:13:13 INFO - operating with platform_type : linux_ 10:13:13 INFO - Initialising browser for dromaeo_css test... 10:13:13 INFO - TEST-INFO | started process 3327 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfYIbKc/profile http://localhost:59443/getInfo.html) 10:13:17 INFO - PROCESS | 3327 | __metrics Screen width/height:1600/1200 10:13:17 INFO - PROCESS | 3327 | colorDepth:24 10:13:17 INFO - PROCESS | 3327 | Browser inner width/height: 1024/697 10:13:17 INFO - PROCESS | 3327 | __metrics 10:13:19 ERROR - PROCESS | 3327 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:13:19 INFO - PROCESS | 3327 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 10:13:20 INFO - TEST-INFO | 3327: exit 0 10:13:20 INFO - Browser initialized. 10:13:20 INFO - Running cycle 1/1 for dromaeo_css test... 10:13:20 INFO - TEST-INFO | started process 3408 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfYIbKc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:13:31 INFO - PROCESS | 3408 | RSS: Main: 153223168 10:13:31 INFO - PROCESS | 3408 | 10:14:23 INFO - PROCESS | 3408 | 1461172463185 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] 10:16:31 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:59443/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59443/tests/dromaeo/cssquery-ext.html) 10:16:32 INFO - PROCESS | 3408 | RSS: Main: 254226432 10:16:32 INFO - PROCESS | 3408 | 10:19:34 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:59443/tests/dromaeo/cssquery-ext.html (next: http://localhost:59443/tests/dromaeo/cssquery-jquery.html) 10:19:34 INFO - PROCESS | 3408 | RSS: Main: 236138496 10:19:34 INFO - PROCESS | 3408 | 10:22:36 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:59443/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59443/tests/dromaeo/cssquery-mootools.html) 10:22:37 INFO - PROCESS | 3408 | RSS: Main: 238985216 10:22:37 INFO - PROCESS | 3408 | 10:25:39 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:59443/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59443/tests/dromaeo/cssquery-prototype.html) 10:25:39 INFO - PROCESS | 3408 | RSS: Main: 224845824 10:25:39 INFO - PROCESS | 3408 | 10:28:42 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:59443/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59443/tests/dromaeo/cssquery-yui.html) 10:28:43 INFO - PROCESS | 3408 | RSS: Main: 224305152 10:28:43 INFO - PROCESS | 3408 | 10:31:45 INFO - PROCESS | 3408 | Cycle 1(1): loaded http://localhost:59443/tests/dromaeo/cssquery-yui.html (next: http://localhost:59443/tests/dromaeo/cssquery-dojo.html) 10:31:45 INFO - PROCESS | 3408 | RSS: Main: 257269760 10:31:45 INFO - PROCESS | 3408 | 10:31:45 INFO - PROCESS | 3408 | __start_tp_report 10:31:45 INFO - PROCESS | 3408 | _x_x_mozilla_page_load 10:31:45 INFO - PROCESS | 3408 | _x_x_mozilla_page_load_details 10:31:45 INFO - PROCESS | 3408 | |i|pagename|runs| 10:31:45 INFO - PROCESS | 3408 | |0;dojo.html;3060.403221371833;3134.435801555719;3172.492401215806;3174.8730050797967;3199.8080115193084;5304.310439642846;5329.946700532993;5344.625876188668;5385.434529374413;5430.212619170218;5326.973365133179;5347.598930080249;5383.246345511622;5412.756425960832;5414.702191379472;4685;4731.053789242157;4923.606111511071;4972.129877271463;4993.775280112403;4812.422509298872;4956.925646115311;4971.602271818264;5007.173816320321;5026.648134630577;4861.319415281863;4896.534829191221;4917.803287868481;4938.209886418156;4964.255361695738;4911.435184953741;4933.383327084114;4939.283803848458;4945.950540494585;4971.6271279654175;4677.391939047936;4815.133276010351;4880.463149053601;4890.975545122252;4968.552830245295;5261.053010458116;5280.1815718563685;5281.15501519755;5320.361556613231;5324.387695414999;5695.658260504341;5708.914366284509;5713.314402271712;5717;5718.914216286759;5701.629394089371;5717.914231286534;5752.993226185401;5755.453231942959;5760.884782304331;5302.390225124122;5306.310179676618;5311.389190243094;5314.840554783363;5319.335083114611;5739.454751798572;5756.884862302731;5757.337906140848;5757.740901659436;5770.971145144247;5512.972435137879;5537.833864984057;5641.097424412156;5705.144228365778;5712.114622233477;5656.264685590847;5660.85847853807;5664;5668.773249069991;5684.261046063985;5627.127795191752;5629.774809007676;5631.211630371751;5639.577031722637;5646.407127251661;5555.583331250173;5701.686407247558;5772.076467765221;5802.941970580325;5808.332041815161;4245.936310955338;4246.3842742802735;4247.6389506892265;4272.060146767706;4289.656827453796;3734.458503516975;3821.2357528494413;3828.636279553438;3863.3239183142837;3866.0914685048992;5325.440828713007;5341;5351.973240133774;5371;5394.568434525228;5710.172025056344;5732.398098199712;5754.251947246831;5754.625949313281;5767.22142510764;5337.653052551572;5361.812336568201;5428.83713488596;5477.424870388551;5504.4770746778995;4844.588210002189;4847.2729090635985;4850.490698476679;4852.102361063215;4869.050535145612;5820.039693450618;5834.066549352168;5836.9124463133085;5838.5037271831525;5842.152887831241;5537.224788529528;5627.155926611041;5649.943500564942;5691.146328050825;5712.02895507773;5797.710114494343;5804.854878628068;5814.592978491465;5827.4172582741385;5859.267591551056;5527.972360138174;5542.334919809648;5546.334439867242;5547.472990065938;5565.6104072714525;5515.779368825202;5641.464060914206;5659.236003139524;5714.228579141929;5793.246877905845;5544.362398324244;5553.555715542828;5554.50009499147;5559.972200138974;5593.860153496195;5501.174823776466;5532.197831314517;5536.252605898313;5536.584756143386;5537.197106419466;5272.261883336259;5399.217113518439;5400.05499037659;5470.589705772162;5481.369642491005;5554.861128471821;5581.413951535193;5582.0231459495235;5584.609077364546;5604.8318550443555;5442.455754424526;5451.890962180813;5460.836174914759;5506;5509.5041446270025 10:31:45 INFO - PROCESS | 3408 | |1;ext.html;596.0463258785943;627.9937200627993;637.751277001969;640.8750293692731;664.8936170212764;30034.699653003463;30843.69156308436;30848.383032339367;35848;37211.255774884485;39355;40198.59801401985;40199.59800401995;40211.597884021154;40280.79859600698;8418.074011858675;8621.13788621136;8625.698100566482;8641.783955401133;8714.085021072791;8507.659693612248;8622.65509379624;8627.396082274243;8627.870581941275;8631.568421578895;8738.432001919886;8754.037055923844;8765;8797.824043519126;8803.515806630665;8732.607032683545;8777.297816174754;8788.956055219747;8790.912090879074;8795.560221988906;8649.783755406103;8717.215450609412;8785.912140878574;8792.560371981439;8794.12058794122;38105.42841857374;38601.42097868534;38609.42085868714;38644.420333695016;38754.61245387538;3447.4311738563106;3640.5631324240994;3726.441033844918;3737;3816.599257078022;30087.699123008926;30562.083137505688;30967.22581935447;31092;31093.68906310953;4125.195586860564;4134.689898257612;4143.274926887782;4171.687123465752;4174.833006679729;273522;273767;274079.999999998;274781;275745;54867.725661372235;55470;55504.44495554993;55524.722376388665;55528.44471555314;56862.7156864213;61933.38066619366;63791;63917.68041159764;64102.67948660227;15960.36158553668;16220.675586488203;16222.675546489005;16247.67504649924;16255.918720406558;12311.322877241837;12358.196717213352;12361.690957726129;12373.195742276723;12387.876121238673;19170.41360212002;19277.132529036226;19326.4202073938;19410;19472.90263548673;6853.485988550879;6926.272741362185;6950.6177160256675;7154.642267886585;7175.569465832067;1035.2080658296409;1058.88352281249;1111.8999290063932;1187.5249900040053;1201.3872924808236;31936.361272774415;32566.674333256837;32704.836475817945;32906.67093329084;33148.33703325968;1092.5575142067316;1176.6117181330312;1181.4624345922584;1197.9460924258428;1274.6430999320205;16886.577835553962;16915.154242287837;17137;17277.82722172787;17283.222254998305;437892;445452;445674;445986;446127;54581.727091364286;56123;56324.71837640786;56393.71803140958;56395.71802140963;1352.9852610542093;1406.2336026865382;1416.1361569442631;1417.2205287092058;1497.3262032085388;29606.851965740032;31603.841980789948;32026.83986580052;32142.67857321397;32412.675873241908;44737;45429;45489.772551138354;45616.31575526304;45711.314330285735;276643;283249;283960;283990;284672;25033.499330013663;27440.313992150357;27649.170524884285;27962.86018569894;28146.577801333406;41713.58286417218;41715.16569668529;42105.15789684128;42405.57594424016;42764.78617606892;37649;38512.80743596264;38758.4186237201;38811;38851.805740972246;37036.62963370332;37290.8135459321;37959.240815184094;37992;38817;39107.80446097751;39660;39738.2052358957;39814;40259.1948161041;32266.516002260454;33536.66463335336;33588.83205584054;33898;34428.655713442546;26923;27006.189814305602;27368;27500.58749118805;27530.862345688143 10:31:45 INFO - PROCESS | 3408 | |2;jquery.html;385.0854221224593;387.34151941699116;390.83725915401664;397.61630027023926;404.24406360106605;14046.719065618681;15969.281382337793;18167.636647267045;18836.62326753466;18839.058047097642;14870.33083511242;17648.205830737614;17651;18384.356547520838;18554.072296385195;5445.83662490126;5640.0693885508845;5640.689762063085;5641.802536911209;5671.688057156875;4001.6998725095586;5590.357108932464;5634.323881134249;5871.324797648261;6237.750489980395;6141.723622437001;6142.109394137848;6188.907166392485;6189.721462534174;6192.59748116371;5239.004589128072;5525.281713377235;5525.309336332958;5534.308211473566;6146.108814221935;5333.866653333659;5335.452718711608;5344.679319240858;5347.893042139174;5364.329458817648;11953.880461195364;12187.32969686667;12220.327881966488;12226.572069977508;12240.081993850408;2235.2065016918923;2343.7304709958403;2372.50177462733;2416.4321384474633;2773.1819113361607;9662.9516852416;10103.393796372242;10169.288149829516;10791.082757965582;13848.09987350819;1909.6180763847285;1960.4608732598506;1996.4409965209763;2016.1330627830027;2038.775734669185;73697.2630273701;74333.62833185853;75008.24991750067;75554.24445755527;77281.90872365098;10365.170786337076;10365.792684146274;10545.261831671709;10556.841647375295;10658.89341106579;14495.565133046026;14580.708385832224;14595.92702036483;14609.92695036518;14614.588592882268;7414.666340014713;7813.68745250195;7820.687172513036;7957.721479748181;7987.3610111190965;6209.6895155242055;7482.326590606872;7528.736494222676;7662.195469475736;7684.231576842383;4267.509236437787;4460.152571011562;4628.375169352162;4723.504032076651;4750.12122757291;1937.0314842578712;1948.6005368899341;1967.9409617711492;1983.1769815526395;2010.662909165418;891.9018907920124;965.1458459263462;1011.3426272922659;1017.1151098544166;1054.1882750282239;18434.81565184358;18529.629407411776;18559.44321670352;18812;18982.71525927112;1018.3756907732155;1033.7312298802365;1055.1875056206677;1101.4878081692052;1116.2186469471403;10285.537150828231;10560.894391055992;10582.576696932036;10728.678139655824;10794.136469082454;418431;419024;429655;435131;435654;85148.57425712956;86896;87205;87446.56276718575;87550;1001.5643195210107;1010.282699283517;1063.776606912557;1086.760912599227;1092.8743194532572;16357.754633680743;16379.76727712235;16429.34282628729;16808.411705590246;16952.15239238058;34035.65964340424;34306.14234644154;34840.9547713569;35423;35812.82093589516;51967;53548.732256338466;55187.724061379435;55411.72294138504;55433.445665544445;8048.678052877819;8245.711400100967;8358.414910956175;8413.915860841313;8525.786855328666;11281;13447.663808404477;13539.796903046265;13602.727945441233;13635.318234088058;11439.542418303176;11671.183017189054;11688;11960.342181180118;12069.456874440846;11083.501242443948;11262.774744505228;11320.37737924422;11678.532858685558;11703.882961170279;11376.829347559627;11943.581974630846;12027.879721202677;12037.518499259932;12107.697307567381;8244.422890397615;8276.462029968034;8414.621342039745;8441.535715535705;8607.440516366416;11691.298522088702;11846.585369512026;11892.464839082435;11981.460834262305;12249.326287054297 10:31:45 INFO - PROCESS | 3408 | |3;mootools.html;1351.6012776231023;1465.8754005909498;1525.9856988774816;1693.246505305139;1828.3600739741091;7522.360599349055;7840.13758486566;7848.9607551962235;7857.449978501507;7857.449978501507;7615.543067415959;7752.418568607363;7761.767146985585;7765.961170194141;7766.145723970359;1960.882347059174;2188.277868303456;2260.5930932432157;2289.2331069091874;2316.9768302317016;2287.931362059141;2304.83866129371;2309.2379514760087;2311.560803447348;2314.0396735354807;2242.9663555046604;2276.943076423086;2277.3851060213733;2282.7146606674164;2283.4519715268298;1888.291890541047;2171.250918433138;2257.6726374675745;2261.2989973108224;2264.762199968996;2220.888955552216;2229.7770222977733;2232.4865280985464;2240.215924426454;2256.7856053674873;7784.299413052796;7839.490433121829;7842.529448233125;7850.293473587348;7858.803529911741;4863.805447782084;5001.97459520801;5029.748512574393;5035.597152227813;5072.949270507284;3203.823789691566;3256.3161736035463;3291.572095627553;3324.1357247115925;3357.9496307555405;990.1435258501416;999.975000624983;1005.8038682456923;1017.099866618041;1021.5198856537415;10349;10628.043476087189;10669.413182274971;10670.30643008202;10743.731406714816;4299.699021068558;4322.848700295474;4422.646188304928;4434.17967675981;4474.865754027384;8383.8323233535;8406.579671016425;8417.621207045697;8433.536155511505;8440.831183376298;4368.453943257093;4924.4583095859425;4926.531979462017;4939.580135688435;4990.775415106329;4445.110977804387;4527.683062185615;4559.156556037144;4561.384213131185;4567.634589232854;3605.9098522537147;3630.201355701794;3680.0983758979223;3711.6473934976134;3750.6811920986474;1093.0763504838399;1108.1578000719512;1108.6673997800629;1114.5430373546808;1133.246391149876;864.6584599083327;943.7310366545502;1002.1832206751474;1004.914582260516;1016.2124353625999;5700.714964251771;5765.374913554223;5833.241678581842;5840.59115861894;5845.649261044351;443.21993291806007;446.3839900936687;447.8231098716054;449.6560131499406;1009.4397609326747;3912.8630497932436;3925.6074392560517;3986.242613903407;3995.5405128410603;4004.4794176756836;9703.07820757027;9816.116549510578;9883.061109194616;9904.702858914245;10008.39949603026;9830.852537211947;9859.063388978035;9882.950585247028;9896.703098907044;9897.505124743733;7418.33235008841;7700.422468314899;7887.211278872067;7919.802004949923;7923.920760792434;5831.970840145772;5881.588288819913;6007.158997740233;6054.697265136638;6078.149059131813;9021.548922553715;9152.771180720536;9245.630174792934;9314.115159059878;9328.813423731623;9267;9456.763580910532;9462.858057129011;9594.904050959402;9613.855792162984;6290.150829637941;7158.642067896689;7165.892511612435;7370.520916140434;7500.324970752658;7726.4205184610255;7757.030371203599;7789.805254868674;7817.5309481431295;7819.921800781919;6840;7027.6837542309695;7036.120484939383;7078.433725302067;7195.964020179866;6852.177738671391;6897.55165914214;6955.130608673916;6968.0941477607585;7137.500374973702;6602.537822352389;6640.335966403321;6731.663416829237;6749.831254218684;6753.3246675332075;4798.352222449925;4854.296127061486;4861.878453038702;4885.2427873679635;4912.557869791736;5028.421731500925;5049.444561098203;5071.011152825311;5141.948580514297;5153.896922061613 10:31:45 INFO - PROCESS | 3408 | |4;prototype.html;304.7805579982412;310.3173019357414;313.0358495832835;327.63305098289914;332.27563910674735;5583.888322233558;5642.125470552066;5650.29371328584;5653.575981801366;5654.303708887338;5515.972420137894;5551.861203469915;5576;5584.296789479207;5586.273784408021;4119.155573107506;4131.483564554431;4267.829286828539;4310.137972405516;4311.439512863323;4284.443022407083;4306.978465107686;4309.095090031097;4309.525952145277;4317.438732964726;4017.537983131948;4258.403823464718;4271.530131685512;4277.978610106945;4279.871603851874;4212.389203565496;4334.718243314206;4338.045629961403;4342.934855977162;4352.825886964518;3778.8677396290996;3787.8484860605545;3797.9430308545393;3812.694984401241;3824.7513911595656;5341.732913354355;5390.380106287748;5392.541633961118;5400.972995134999;5427.62006659534;5013.498650134994;5025.924611130836;5027.396712394536;5040.672356296829;5045.823396181153;5860.941390586082;5892.675902825343;5903.439173278532;5910.438508341744;5930.436608522184;4066.064805094845;4195.244855925932;4198.454200953887;4205.3271476563905;4225.450691410097;6127.816165514997;6153.077038444225;6165.784197553109;6178.258608966953;6180.412860778219;4333.371661109121;4333.371661109121;4339.848105316362;4341.717788343748;4345.326474396474;4039.232545816344;4396.824127034947;4403.735775853459;4405.60349568534;4412.713173643703;4885.853424397274;4894.486078961658;4900.117978763786;4907.2393778964315;4908.533689299511;5886.646801191942;5900.203472531153;5934.350374519726;5952.85117872048;5965.284165900033;1431.9140851548732;1454.1057249791513;1465.6848777512673;1472.3815997281167;1475.0854470228312;889.3374436045187;958.2860768727343;959.1846930109351;971.8968970218853;996.6910257820099;5600.831975040755;5626.718664066781;5676.148577713376;5678.119891416837;5699.829005129853;6024.728887200086;6032.788852390146;6042.154098426224;6051;6054.848628784315;5484.396716361197;5717.8570535736935;5821.88356232873;5836.795712150054;5848.298204215522;3270.3459308138467;3282.097423208637;3283.4910588858766;3291.2594666200393;3301.1747063234193;6236.376362363727;6359.745610175633;6380.61827231568;6385.233771947396;6399.616023038632;6213.285472170758;6246.875062498724;6258.749650013949;6262;6270.090836828635;6061.666433384648;6268;6278.497720182374;6291.874162516816;6293.77971770995;6096.451319381277;6108.664023478751;6114.174586430775;6114.388561144028;6117.877642447037;5945.197398351167;6003.189569408249;6037.335893051673;6052.455279024909;6055.576109672281;6084.817455476343;6297.086922396135;6312.147860038836;6314.336994615683;6323.462505687068;4180.414741936071;4188.937165942452;4211.978940105279;4225.28170211071;4228.408022876862;5935.109733540004;6133.662648554194;6144.170536977451;6171.47542458896;6182.6599537025895;5915.231019967377;5933.495652869382;5959.374265702038;5962.850928726816;5968.612040217372;5869.618474799125;5924.229850119457;5944.375840536682;5956.404359564009;5962.970185149046;5667.404922483245;5815.651060936358;5842.152887831156;5849.824505264849;5866.560007999503;5915.911261330997;5955.166276721176;5975.910361344497;5987.2815262168815;6023.48800351975;5699.658020518782;5878.207851270612;5878.765459253605;5889.322727886348;5897.734601942837 10:31:45 INFO - PROCESS | 3408 | |5;yui.html;713.0373995106606;717.3257138290004;728.4718579030204;746.4961151222926;750.7897788619186;14128.364223609937;14203.64490887727;14390.1365918045;14415.639609009753;14429.42282308709;10920.071793897509;13569.389377478012;13637.249951252701;13676.3161841908;13759;810.088650268448;838.5220424358118;838.7232213369604;840.017179899516;840.3739214285366;829.0631586307464;833.2500749325625;836.6611522333434;837.1795640272506;837.3259526081501;694.7429451103098;849.4266370200121;865.909079546648;867.7787164273133;868.6872725818732;875.8554838451648;875.9956200219021;876.5923845411883;878.8505953987806;879.2350654930219;639.3798015924546;639.728115550889;640.3404493371835;640.9423151916303;642.3159335307929;13668.863311366858;13764.242966636832;13764.862351376558;13779.104358216684;13797.034207605471;14109.153450792985;14279.143251404948;14285.85714142866;14376;14798.260086995715;11579.478923448465;11847.468704940866;11921.761564768743;11948.70128246792;12455.12814103013;3870.283997460451;3878.961210387888;3931.469251651019;3952.7825969571663;3959.307121253769;53136;54807;54808.17787733187;54973.175402368994;55000.72499637516;10305.381677099398;10434.321769084985;10638.095761860173;10763.461826908624;10839.295445795999;17837;17929.282828686708;17933.282668693108;18286.908565457088;18547.258109675462;8561;8569.185927336894;8621.568921553897;8678.392512524062;8719;4730.266808644666;4787.952120478751;4818.204996175592;4860.586850117779;4862.149123903303;3401.557797486311;3464.636213197578;3470.809105499222;3470.930581388358;3473.6526347365566;491.3244289102484;508.3366207099696;644.2944975252185;647.0262255305735;656.2748163279603;741.210610699614;776.1539921485495;779.7972527142983;806.9273765361146;827.3918669777709;9290.489023103793;9373.297002724687;9790.804183916282;9812.65655702047;10136.695899123039;631.5705320382092;641.9229692436937;689.1557841643946;773.1997382708981;781.2304879693497;4655.767211639404;4813.15769740294;4829.323894654751;4860.635452341088;4890.608751299887;65599.34400656028;66648.33351666518;66672.6666366665;67779;67796.6610166956;55264.17103743447;57343.71328143332;57654;57700.422995769506;58813.117803232984;52143.73928130335;53263.73368133212;53690.46309536933;54075;54280.45719542833;8997.640094396413;9066.637334506546;9104.544772761468;9222.769430764285;9309.348345615741;32854.67145328516;33232.667673322954;33841.49237761485;34115.82942085274;34124;40320.1935961285;40934.59065409308;42014.36978445387;44377.77811110924;48253.27620085772;10834.349939003685;11037.780489627048;11422.771544569228;11908.940455297668;12272.570460034212;13263;13776.380062897395;14080.577582672537;14125.364358604093;14574.635634109232;13191.208527488381;13604.93197534006;13736;14032.719345612826;14048.78926816119;12693.873061269269;12837.037222208184;13044.478220871059;13052;13065.150765200231;11835.52657893709;11878.049756019325;12059.095567832272;12443.751124977269;12570.685732856751;10965.342079475256;11111.11111111093;11183.384913829492;11200.271982321123;11387.202895797545;11262.17086190699;11327.773444531229;11427.49011523093;11474.25417347903;11522.481488333213 10:31:45 INFO - PROCESS | 3408 | __end_tp_report 10:31:45 INFO - PROCESS | 3408 | __start_cc_report 10:31:45 INFO - PROCESS | 3408 | _x_x_mozilla_cycle_collect,857 10:31:45 INFO - PROCESS | 3408 | __end_cc_report 10:31:45 INFO - PROCESS | 3408 | __startTimestamp1461173505982__endTimestamp 10:31:45 INFO - PROCESS | 3408 | 10:31:45 INFO - PROCESS | 3408 | ------- Summary: start ------- 10:31:45 INFO - PROCESS | 3408 | Number of tests: 6 10:31:45 INFO - PROCESS | 3408 | 10:31:45 INFO - PROCESS | 3408 | [#0] dojo.html Cycles:165 Average:5284.30 Median:5501.17 stddev:589.51 (10.7%) stddev-sans-first:564.91 10:31:45 INFO - PROCESS | 3408 | Values: 3060.4 3134.4 3172.5 3174.9 3199.8 5304.3 5329.9 5344.6 5385.4 5430.2 5327.0 5347.6 5383.2 5412.8 5414.7 4685.0 4731.1 4923.6 4972.1 4993.8 4812.4 4956.9 4971.6 5007.2 5026.6 4861.3 4896.5 4917.8 4938.2 4964.3 4911.4 4933.4 4939.3 4946.0 4971.6 4677.4 4815.1 4880.5 4891.0 4968.6 5261.1 5280.2 5281.2 5320.4 5324.4 5695.7 5708.9 5713.3 5717.0 5718.9 5701.6 5717.9 5753.0 5755.5 5760.9 5302.4 5306.3 5311.4 5314.8 5319.3 5739.5 5756.9 5757.3 5757.7 5771.0 5513.0 5537.8 5641.1 5705.1 5712.1 5656.3 5660.9 5664.0 5668.8 5684.3 5627.1 5629.8 5631.2 5639.6 5646.4 5555.6 5701.7 5772.1 5802.9 5808.3 4245.9 4246.4 4247.6 4272.1 4289.7 3734.5 3821.2 3828.6 3863.3 3866.1 5325.4 5341.0 5352.0 5371.0 5394.6 5710.2 5732.4 5754.3 5754.6 5767.2 5337.7 5361.8 5428.8 5477.4 5504.5 4844.6 4847.3 4850.5 4852.1 4869.1 5820.0 5834.1 5836.9 5838.5 5842.2 5537.2 5627.2 5649.9 5691.1 5712.0 5797.7 5804.9 5814.6 5827.4 5859.3 5528.0 5542.3 5546.3 5547.5 5565.6 5515.8 5641.5 5659.2 5714.2 5793.2 5544.4 5553.6 5554.5 5560.0 5593.9 5501.2 5532.2 5536.3 5536.6 5537.2 5272.3 5399.2 5400.1 5470.6 5481.4 5554.9 5581.4 5582.0 5584.6 5604.8 5442.5 5451.9 5460.8 5506.0 5509.5 10:31:45 INFO - PROCESS | 3408 | 10:31:46 INFO - PROCESS | 3408 | [#1] ext.html Cycles:180 Average:50011.25 Median:21164.70 stddev:90336.72 (426.8%) stddev-sans-first:90513.95 10:31:46 INFO - PROCESS | 3408 | Values: 596.0 628.0 637.8 640.9 664.9 30034.7 30843.7 30848.4 35848.0 37211.3 39355.0 40198.6 40199.6 40211.6 40280.8 8418.1 8621.1 8625.7 8641.8 8714.1 8507.7 8622.7 8627.4 8627.9 8631.6 8738.4 8754.0 8765.0 8797.8 8803.5 8732.6 8777.3 8789.0 8790.9 8795.6 8649.8 8717.2 8785.9 8792.6 8794.1 38105.4 38601.4 38609.4 38644.4 38754.6 3447.4 3640.6 3726.4 3737.0 3816.6 30087.7 30562.1 30967.2 31092.0 31093.7 4125.2 4134.7 4143.3 4171.7 4174.8 273522.0 273767.0 274080.0 274781.0 275745.0 54867.7 55470.0 55504.4 55524.7 55528.4 56862.7 61933.4 63791.0 63917.7 64102.7 15960.4 16220.7 16222.7 16247.7 16255.9 12311.3 12358.2 12361.7 12373.2 12387.9 19170.4 19277.1 19326.4 19410.0 19472.9 6853.5 6926.3 6950.6 7154.6 7175.6 1035.2 1058.9 1111.9 1187.5 1201.4 31936.4 32566.7 32704.8 32906.7 33148.3 1092.6 1176.6 1181.5 1197.9 1274.6 16886.6 16915.2 17137.0 17277.8 17283.2 437892.0 445452.0 445674.0 445986.0 446127.0 54581.7 56123.0 56324.7 56393.7 56395.7 1353.0 1406.2 1416.1 1417.2 1497.3 29606.9 31603.8 32026.8 32142.7 32412.7 44737.0 45429.0 45489.8 45616.3 45711.3 276643.0 283249.0 283960.0 283990.0 284672.0 25033.5 27440.3 27649.2 27962.9 28146.6 41713.6 41715.2 42105.2 42405.6 42764.8 37649.0 38512.8 38758.4 38811.0 38851.8 37036.6 37290.8 37959.2 37992.0 38817.0 39107.8 39660.0 39738.2 39814.0 40259.2 32266.5 33536.7 33588.8 33898.0 34428.7 26923.0 27006.2 27368.0 27500.6 27530.9 10:31:46 INFO - PROCESS | 3408 | 10:31:46 INFO - PROCESS | 3408 | [#2] jquery.html Cycles:180 Average:26165.38 Median:2027.45 stddev:70653.03 (3484.8%) stddev-sans-first:70824.71 10:31:46 INFO - PROCESS | 3408 | Values: 385.1 387.3 390.8 397.6 404.2 14046.7 15969.3 18167.6 18836.6 18839.1 14870.3 17648.2 17651.0 18384.4 18554.1 5445.8 5640.1 5640.7 5641.8 5671.7 4001.7 5590.4 5634.3 5871.3 6237.8 6141.7 6142.1 6188.9 6189.7 6192.6 5239.0 5525.3 5525.3 5534.3 6146.1 5333.9 5335.5 5344.7 5347.9 5364.3 11953.9 12187.3 12220.3 12226.6 12240.1 2235.2 2343.7 2372.5 2416.4 2773.2 9663.0 10103.4 10169.3 10791.1 13848.1 1909.6 1960.5 1996.4 2016.1 2038.8 73697.3 74333.6 75008.2 75554.2 77281.9 10365.2 10365.8 10545.3 10556.8 10658.9 14495.6 14580.7 14595.9 14609.9 14614.6 7414.7 7813.7 7820.7 7957.7 7987.4 6209.7 7482.3 7528.7 7662.2 7684.2 4267.5 4460.2 4628.4 4723.5 4750.1 1937.0 1948.6 1967.9 1983.2 2010.7 891.9 965.1 1011.3 1017.1 1054.2 18434.8 18529.6 18559.4 18812.0 18982.7 1018.4 1033.7 1055.2 1101.5 1116.2 10285.5 10560.9 10582.6 10728.7 10794.1 418431.0 419024.0 429655.0 435131.0 435654.0 85148.6 86896.0 87205.0 87446.6 87550.0 1001.6 1010.3 1063.8 1086.8 1092.9 16357.8 16379.8 16429.3 16808.4 16952.2 34035.7 34306.1 34841.0 35423.0 35812.8 51967.0 53548.7 55187.7 55411.7 55433.4 8048.7 8245.7 8358.4 8413.9 8525.8 11281.0 13447.7 13539.8 13602.7 13635.3 11439.5 11671.2 11688.0 11960.3 12069.5 11083.5 11262.8 11320.4 11678.5 11703.9 11376.8 11943.6 12027.9 12037.5 12107.7 8244.4 8276.5 8414.6 8441.5 8607.4 11691.3 11846.6 11892.5 11981.5 12249.3 10:31:46 INFO - PROCESS | 3408 | 10:31:46 INFO - PROCESS | 3408 | [#3] mootools.html Cycles:180 Average:5332.10 Median:5032.67 stddev:2913.27 (57.9%) stddev-sans-first:2906.08 10:31:46 INFO - PROCESS | 3408 | Values: 1351.6 1465.9 1526.0 1693.2 1828.4 7522.4 7840.1 7849.0 7857.4 7857.4 7615.5 7752.4 7761.8 7766.0 7766.1 1960.9 2188.3 2260.6 2289.2 2317.0 2287.9 2304.8 2309.2 2311.6 2314.0 2243.0 2276.9 2277.4 2282.7 2283.5 1888.3 2171.3 2257.7 2261.3 2264.8 2220.9 2229.8 2232.5 2240.2 2256.8 7784.3 7839.5 7842.5 7850.3 7858.8 4863.8 5002.0 5029.7 5035.6 5072.9 3203.8 3256.3 3291.6 3324.1 3357.9 990.1 1000.0 1005.8 1017.1 1021.5 10349.0 10628.0 10669.4 10670.3 10743.7 4299.7 4322.8 4422.6 4434.2 4474.9 8383.8 8406.6 8417.6 8433.5 8440.8 4368.5 4924.5 4926.5 4939.6 4990.8 4445.1 4527.7 4559.2 4561.4 4567.6 3605.9 3630.2 3680.1 3711.6 3750.7 1093.1 1108.2 1108.7 1114.5 1133.2 864.7 943.7 1002.2 1004.9 1016.2 5700.7 5765.4 5833.2 5840.6 5845.6 443.2 446.4 447.8 449.7 1009.4 3912.9 3925.6 3986.2 3995.5 4004.5 9703.1 9816.1 9883.1 9904.7 10008.4 9830.9 9859.1 9883.0 9896.7 9897.5 7418.3 7700.4 7887.2 7919.8 7923.9 5832.0 5881.6 6007.2 6054.7 6078.1 9021.5 9152.8 9245.6 9314.1 9328.8 9267.0 9456.8 9462.9 9594.9 9613.9 6290.2 7158.6 7165.9 7370.5 7500.3 7726.4 7757.0 7789.8 7817.5 7819.9 6840.0 7027.7 7036.1 7078.4 7196.0 6852.2 6897.6 6955.1 6968.1 7137.5 6602.5 6640.3 6731.7 6749.8 6753.3 4798.4 4854.3 4861.9 4885.2 4912.6 5028.4 5049.4 5071.0 5141.9 5153.9 10:31:46 INFO - PROCESS | 3408 | 10:31:46 INFO - PROCESS | 3408 | [#4] prototype.html Cycles:180 Average:4965.31 Median:5688.89 stddev:1492.10 (26.2%) stddev-sans-first:1454.71 10:31:46 INFO - PROCESS | 3408 | Values: 304.8 310.3 313.0 327.6 332.3 5583.9 5642.1 5650.3 5653.6 5654.3 5516.0 5551.9 5576.0 5584.3 5586.3 4119.2 4131.5 4267.8 4310.1 4311.4 4284.4 4307.0 4309.1 4309.5 4317.4 4017.5 4258.4 4271.5 4278.0 4279.9 4212.4 4334.7 4338.0 4342.9 4352.8 3778.9 3787.8 3797.9 3812.7 3824.8 5341.7 5390.4 5392.5 5401.0 5427.6 5013.5 5025.9 5027.4 5040.7 5045.8 5860.9 5892.7 5903.4 5910.4 5930.4 4066.1 4195.2 4198.5 4205.3 4225.5 6127.8 6153.1 6165.8 6178.3 6180.4 4333.4 4333.4 4339.8 4341.7 4345.3 4039.2 4396.8 4403.7 4405.6 4412.7 4885.9 4894.5 4900.1 4907.2 4908.5 5886.6 5900.2 5934.4 5952.9 5965.3 1431.9 1454.1 1465.7 1472.4 1475.1 889.3 958.3 959.2 971.9 996.7 5600.8 5626.7 5676.1 5678.1 5699.8 6024.7 6032.8 6042.2 6051.0 6054.8 5484.4 5717.9 5821.9 5836.8 5848.3 3270.3 3282.1 3283.5 3291.3 3301.2 6236.4 6359.7 6380.6 6385.2 6399.6 6213.3 6246.9 6258.7 6262.0 6270.1 6061.7 6268.0 6278.5 6291.9 6293.8 6096.5 6108.7 6114.2 6114.4 6117.9 5945.2 6003.2 6037.3 6052.5 6055.6 6084.8 6297.1 6312.1 6314.3 6323.5 4180.4 4188.9 4212.0 4225.3 4228.4 5935.1 6133.7 6144.2 6171.5 6182.7 5915.2 5933.5 5959.4 5962.9 5968.6 5869.6 5924.2 5944.4 5956.4 5963.0 5667.4 5815.7 5842.2 5849.8 5866.6 5915.9 5955.2 5975.9 5987.3 6023.5 5699.7 5878.2 5878.8 5889.3 5897.7 10:31:46 INFO - PROCESS | 3408 | 10:31:46 INFO - PROCESS | 3408 | [#5] yui.html Cycles:180 Average:15095.30 Median:4693.02 stddev:17671.34 (376.5%) stddev-sans-first:17687.91 10:31:46 INFO - PROCESS | 3408 | Values: 713.0 717.3 728.5 746.5 750.8 14128.4 14203.6 14390.1 14415.6 14429.4 10920.1 13569.4 13637.2 13676.3 13759.0 810.1 838.5 838.7 840.0 840.4 829.1 833.3 836.7 837.2 837.3 694.7 849.4 865.9 867.8 868.7 875.9 876.0 876.6 878.9 879.2 639.4 639.7 640.3 640.9 642.3 13668.9 13764.2 13764.9 13779.1 13797.0 14109.2 14279.1 14285.9 14376.0 14798.3 11579.5 11847.5 11921.8 11948.7 12455.1 3870.3 3879.0 3931.5 3952.8 3959.3 53136.0 54807.0 54808.2 54973.2 55000.7 10305.4 10434.3 10638.1 10763.5 10839.3 17837.0 17929.3 17933.3 18286.9 18547.3 8561.0 8569.2 8621.6 8678.4 8719.0 4730.3 4788.0 4818.2 4860.6 4862.1 3401.6 3464.6 3470.8 3470.9 3473.7 491.3 508.3 644.3 647.0 656.3 741.2 776.2 779.8 806.9 827.4 9290.5 9373.3 9790.8 9812.7 10136.7 631.6 641.9 689.2 773.2 781.2 4655.8 4813.2 4829.3 4860.6 4890.6 65599.3 66648.3 66672.7 67779.0 67796.7 55264.2 57343.7 57654.0 57700.4 58813.1 52143.7 53263.7 53690.5 54075.0 54280.5 8997.6 9066.6 9104.5 9222.8 9309.3 32854.7 33232.7 33841.5 34115.8 34124.0 40320.2 40934.6 42014.4 44377.8 48253.3 10834.3 11037.8 11422.8 11908.9 12272.6 13263.0 13776.4 14080.6 14125.4 14574.6 13191.2 13604.9 13736.0 14032.7 14048.8 12693.9 12837.0 13044.5 13052.0 13065.2 11835.5 11878.0 12059.1 12443.8 12570.7 10965.3 11111.1 11183.4 11200.3 11387.2 11262.2 11327.8 11427.5 11474.3 11522.5 10:31:46 INFO - PROCESS | 3408 | -------- Summary: end -------- 10:31:46 INFO - PROCESS | 3408 | 10:31:46 INFO - TEST-INFO | 3408: exit 0 10:31:46 INFO - TEST-OK | dromaeo_css | took 1113362ms 10:31:46 INFO - TEST-START | kraken 10:31:46 INFO - operating with platform_type : linux_ 10:31:46 INFO - Initialising browser for kraken test... 10:31:46 INFO - TEST-INFO | started process 3584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoSJIvT/profile http://localhost:59443/getInfo.html) 10:31:50 INFO - PROCESS | 3584 | __metrics Screen width/height:1600/1200 10:31:50 INFO - PROCESS | 3584 | colorDepth:24 10:31:50 INFO - PROCESS | 3584 | Browser inner width/height: 1024/697 10:31:50 INFO - PROCESS | 3584 | __metrics 10:31:51 ERROR - PROCESS | 3584 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 10:31:52 INFO - TEST-INFO | 3584: exit 0 10:31:52 INFO - Browser initialized. 10:31:52 INFO - Running cycle 1/1 for kraken test... 10:31:52 INFO - TEST-INFO | started process 3665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoSJIvT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:32:04 INFO - PROCESS | 3665 | RSS: Main: 153600000 10:32:04 INFO - PROCESS | 3665 | 10:32:06 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59443/tests/kraken/driver.html?testName=audio-beat-detection) 10:32:07 INFO - PROCESS | 3665 | RSS: Main: 208908288 10:32:07 INFO - PROCESS | 3665 | 10:32:10 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59443/tests/kraken/driver.html?testName=audio-dft) 10:32:10 INFO - PROCESS | 3665 | RSS: Main: 194187264 10:32:10 INFO - PROCESS | 3665 | 10:32:14 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59443/tests/kraken/driver.html?testName=audio-fft) 10:32:14 INFO - PROCESS | 3665 | RSS: Main: 264142848 10:32:14 INFO - PROCESS | 3665 | 10:32:16 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59443/tests/kraken/driver.html?testName=audio-oscillator) 10:32:17 INFO - PROCESS | 3665 | RSS: Main: 172769280 10:32:17 INFO - PROCESS | 3665 | 10:32:19 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59443/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:32:20 INFO - PROCESS | 3665 | RSS: Main: 177180672 10:32:20 INFO - PROCESS | 3665 | 10:32:23 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59443/tests/kraken/driver.html?testName=imaging-darkroom) 10:32:23 INFO - PROCESS | 3665 | RSS: Main: 213413888 10:32:23 INFO - PROCESS | 3665 | 10:32:27 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59443/tests/kraken/driver.html?testName=imaging-desaturate) 10:32:27 INFO - PROCESS | 3665 | RSS: Main: 213925888 10:32:27 INFO - PROCESS | 3665 | 10:32:30 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59443/tests/kraken/driver.html?testName=json-parse-financial) 10:32:31 INFO - PROCESS | 3665 | RSS: Main: 213639168 10:32:31 INFO - PROCESS | 3665 | 10:32:32 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59443/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:32:33 INFO - PROCESS | 3665 | RSS: Main: 204926976 10:32:33 INFO - PROCESS | 3665 | 10:32:34 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59443/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:32:35 INFO - PROCESS | 3665 | RSS: Main: 204050432 10:32:35 INFO - PROCESS | 3665 | 10:32:37 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59443/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:32:38 INFO - PROCESS | 3665 | RSS: Main: 216944640 10:32:38 INFO - PROCESS | 3665 | 10:32:41 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59443/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:32:41 INFO - PROCESS | 3665 | RSS: Main: 222785536 10:32:41 INFO - PROCESS | 3665 | 10:32:44 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59443/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:32:45 INFO - PROCESS | 3665 | RSS: Main: 218898432 10:32:45 INFO - PROCESS | 3665 | 10:32:46 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59443/tests/kraken/driver.html?testName=ai-astar) 10:32:47 INFO - PROCESS | 3665 | RSS: Main: 282882048 10:32:47 INFO - PROCESS | 3665 | 10:32:47 INFO - PROCESS | 3665 | __start_tp_report 10:32:47 INFO - PROCESS | 3665 | _x_x_mozilla_page_load 10:32:47 INFO - PROCESS | 3665 | _x_x_mozilla_page_load_details 10:32:47 INFO - PROCESS | 3665 | |i|pagename|runs| 10:32:47 INFO - PROCESS | 3665 | |0;ai-astar;111;113;106;109;112;110;100;113;112;110 10:32:47 INFO - PROCESS | 3665 | |1;audio-beat-detection;161;132;153;185;132;154;151;129;183;128 10:32:47 INFO - PROCESS | 3665 | |2;audio-dft;160;159;158;159;160;160;159;161;159;160 10:32:47 INFO - PROCESS | 3665 | |3;audio-fft;76;76;104;112;74;74;73;124;101;73 10:32:47 INFO - PROCESS | 3665 | |4;audio-oscillator;92;92;143;93;92;92;152;91;92;143 10:32:47 INFO - PROCESS | 3665 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;117;117;117 10:32:47 INFO - PROCESS | 3665 | |6;imaging-darkroom;146;145;145;146;145;146;146;145;145;145 10:32:47 INFO - PROCESS | 3665 | |7;imaging-desaturate;94;94;95;95;94;95;95;94;95;95 10:32:47 INFO - PROCESS | 3665 | |8;json-parse-financial;55;56;56;55;56;56;57;81;53;54 10:32:47 INFO - PROCESS | 3665 | |9;json-stringify-tinderbox;62;62;63;62;63;61;62;62;63;62 10:32:47 INFO - PROCESS | 3665 | |10;stanford-crypto-aes;77;76;77;85;77;80;77;80;77;79 10:32:47 INFO - PROCESS | 3665 | |11;stanford-crypto-ccm;130;135;127;136;124;122;128;135;178;133 10:32:47 INFO - PROCESS | 3665 | |12;stanford-crypto-pbkdf2;170;169;167;171;163;168;169;164;164;165 10:32:47 INFO - PROCESS | 3665 | |13;stanford-crypto-sha256-iterative;69;69;67;69;67;67;68;68;69;67 10:32:47 INFO - PROCESS | 3665 | __end_tp_report 10:32:47 INFO - PROCESS | 3665 | __start_cc_report 10:32:47 INFO - PROCESS | 3665 | _x_x_mozilla_cycle_collect,1617 10:32:47 INFO - PROCESS | 3665 | __end_cc_report 10:32:47 INFO - PROCESS | 3665 | __startTimestamp1461173567071__endTimestamp 10:32:47 INFO - PROCESS | 3665 | 10:32:47 INFO - PROCESS | 3665 | ------- Summary: start ------- 10:32:47 INFO - PROCESS | 3665 | Number of tests: 14 10:32:47 INFO - PROCESS | 3665 | 10:32:47 INFO - PROCESS | 3665 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.50 stddev:3.98 (3.6%) stddev-sans-first:4.19 10:32:47 INFO - PROCESS | 3665 | Values: 111.0 113.0 106.0 109.0 112.0 110.0 100.0 113.0 112.0 110.0 10:32:47 INFO - PROCESS | 3665 | 10:32:47 INFO - PROCESS | 3665 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:153.50 stddev:21.15 (13.8%) stddev-sans-first:22.11 10:32:47 INFO - PROCESS | 3665 | Values: 161.0 132.0 153.0 185.0 132.0 154.0 151.0 129.0 183.0 128.0 10:32:47 INFO - PROCESS | 3665 | 10:32:47 INFO - PROCESS | 3665 | [#2] audio-dft Cycles:10 Average:159.50 Median:160.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 10:32:47 INFO - PROCESS | 3665 | Values: 160.0 159.0 158.0 159.0 160.0 160.0 159.0 161.0 159.0 160.0 10:32:47 INFO - PROCESS | 3665 | 10:32:47 INFO - PROCESS | 3665 | [#3] audio-fft Cycles:10 Average:88.70 Median:73.50 stddev:19.50 (26.5%) stddev-sans-first:20.13 10:32:47 INFO - PROCESS | 3665 | Values: 76.0 76.0 104.0 112.0 74.0 74.0 73.0 124.0 101.0 73.0 10:32:47 INFO - PROCESS | 3665 | 10:32:47 INFO - PROCESS | 3665 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:92.00 stddev:26.20 (28.5%) stddev-sans-first:27.13 10:32:47 INFO - PROCESS | 3665 | Values: 92.0 92.0 143.0 93.0 92.0 92.0 152.0 91.0 92.0 143.0 10:32:47 INFO - PROCESS | 3665 | 10:32:47 INFO - PROCESS | 3665 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:32:47 INFO - PROCESS | 3665 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 10:32:47 INFO - PROCESS | 3665 | 10:32:47 INFO - PROCESS | 3665 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 10:32:47 INFO - PROCESS | 3665 | Values: 146.0 145.0 145.0 146.0 145.0 146.0 146.0 145.0 145.0 145.0 10:32:47 INFO - PROCESS | 3665 | 10:32:47 INFO - PROCESS | 3665 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 10:32:47 INFO - PROCESS | 3665 | Values: 94.0 94.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 10:32:47 INFO - PROCESS | 3665 | 10:32:47 INFO - PROCESS | 3665 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:56.00 stddev:8.20 (14.6%) stddev-sans-first:8.63 10:32:47 INFO - PROCESS | 3665 | Values: 55.0 56.0 56.0 55.0 56.0 56.0 57.0 81.0 53.0 54.0 10:32:47 INFO - PROCESS | 3665 | 10:32:47 INFO - PROCESS | 3665 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 10:32:47 INFO - PROCESS | 3665 | Values: 62.0 62.0 63.0 62.0 63.0 61.0 62.0 62.0 63.0 62.0 10:32:47 INFO - PROCESS | 3665 | 10:32:47 INFO - PROCESS | 3665 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:78.00 stddev:2.68 (3.4%) stddev-sans-first:2.78 10:32:47 INFO - PROCESS | 3665 | Values: 77.0 76.0 77.0 85.0 77.0 80.0 77.0 80.0 77.0 79.0 10:32:47 INFO - PROCESS | 3665 | 10:32:47 INFO - PROCESS | 3665 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:134.00 stddev:15.92 (11.9%) stddev-sans-first:16.79 10:32:47 INFO - PROCESS | 3665 | Values: 130.0 135.0 127.0 136.0 124.0 122.0 128.0 135.0 178.0 133.0 10:32:47 INFO - PROCESS | 3665 | 10:32:47 INFO - PROCESS | 3665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:168.50 stddev:2.83 (1.7%) stddev-sans-first:2.78 10:32:47 INFO - PROCESS | 3665 | Values: 170.0 169.0 167.0 171.0 163.0 168.0 169.0 164.0 164.0 165.0 10:32:47 INFO - PROCESS | 3665 | 10:32:47 INFO - PROCESS | 3665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:0.94 (1.4%) stddev-sans-first:0.93 10:32:47 INFO - PROCESS | 3665 | Values: 69.0 69.0 67.0 69.0 67.0 67.0 68.0 68.0 69.0 67.0 10:32:47 INFO - PROCESS | 3665 | -------- Summary: end -------- 10:32:47 INFO - PROCESS | 3665 | 10:32:47 INFO - TEST-INFO | 3665: exit 0 10:32:47 INFO - TEST-OK | kraken | took 61313ms 10:32:48 INFO - SUITE-END | took 1174s 10:32:48 INFO - Completed test suite (00:19:34) 10:32:48 INFO - javascript benchmark 10:32:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3060.403221371833, 3134.435801555719, 3172.492401215806, 3174.8730050797967, 3199.8080115193084, 5304.310439642846, 5329.946700532993, 5344.625876188668, 5385.434529374413, 5430.212619170218, 5326.973365133179, 5347.598930080249, 5383.246345511622, 5412.756425960832, 5414.702191379472, 4685.0, 4731.053789242157, 4923.606111511071, 4972.129877271463, 4993.775280112403, 4812.422509298872, 4956.925646115311, 4971.602271818264, 5007.173816320321, 5026.648134630577, 4861.319415281863, 4896.534829191221, 4917.803287868481, 4938.209886418156, 4964.255361695738, 4911.435184953741, 4933.383327084114, 4939.283803848458, 4945.950540494585, 4971.6271279654175, 4677.391939047936, 4815.133276010351, 4880.463149053601, 4890.975545122252, 4968.552830245295, 5261.053010458116, 5280.1815718563685, 5281.15501519755, 5320.361556613231, 5324.387695414999, 5695.658260504341, 5708.914366284509, 5713.314402271712, 5717.0, 5718.914216286759, 5701.629394089371, 5717.914231286534, 5752.993226185401, 5755.453231942959, 5760.884782304331, 5302.390225124122, 5306.310179676618, 5311.389190243094, 5314.840554783363, 5319.335083114611, 5739.454751798572, 5756.884862302731, 5757.337906140848, 5757.740901659436, 5770.971145144247, 5512.972435137879, 5537.833864984057, 5641.097424412156, 5705.144228365778, 5712.114622233477, 5656.264685590847, 5660.85847853807, 5664.0, 5668.773249069991, 5684.261046063985, 5627.127795191752, 5629.774809007676, 5631.211630371751, 5639.577031722637, 5646.407127251661, 5555.583331250173, 5701.686407247558, 5772.076467765221, 5802.941970580325, 5808.332041815161, 4245.936310955338, 4246.3842742802735, 4247.6389506892265, 4272.060146767706, 4289.656827453796, 3734.458503516975, 3821.2357528494413, 3828.636279553438, 3863.3239183142837, 3866.0914685048992, 5325.440828713007, 5341.0, 5351.973240133774, 5371.0, 5394.568434525228, 5710.172025056344, 5732.398098199712, 5754.251947246831, 5754.625949313281, 5767.22142510764, 5337.653052551572, 5361.812336568201, 5428.83713488596, 5477.424870388551, 5504.4770746778995, 4844.588210002189, 4847.2729090635985, 4850.490698476679, 4852.102361063215, 4869.050535145612, 5820.039693450618, 5834.066549352168, 5836.9124463133085, 5838.5037271831525, 5842.152887831241, 5537.224788529528, 5627.155926611041, 5649.943500564942, 5691.146328050825, 5712.02895507773, 5797.710114494343, 5804.854878628068, 5814.592978491465, 5827.4172582741385, 5859.267591551056, 5527.972360138174, 5542.334919809648, 5546.334439867242, 5547.472990065938, 5565.6104072714525, 5515.779368825202, 5641.464060914206, 5659.236003139524, 5714.228579141929, 5793.246877905845, 5544.362398324244, 5553.555715542828, 5554.50009499147, 5559.972200138974, 5593.860153496195, 5501.174823776466, 5532.197831314517, 5536.252605898313, 5536.584756143386, 5537.197106419466, 5272.261883336259, 5399.217113518439, 5400.05499037659, 5470.589705772162, 5481.369642491005, 5554.861128471821, 5581.413951535193, 5582.0231459495235, 5584.609077364546, 5604.8318550443555, 5442.455754424526, 5451.890962180813, 5460.836174914759, 5506.0, 5509.5041446270025], "value": 5245.241839045322, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.0463258785943, 627.9937200627993, 637.751277001969, 640.8750293692731, 664.8936170212764, 30034.699653003463, 30843.69156308436, 30848.383032339367, 35848.0, 37211.255774884485, 39355.0, 40198.59801401985, 40199.59800401995, 40211.597884021154, 40280.79859600698, 8418.074011858675, 8621.13788621136, 8625.698100566482, 8641.783955401133, 8714.085021072791, 8507.659693612248, 8622.65509379624, 8627.396082274243, 8627.870581941275, 8631.568421578895, 8738.432001919886, 8754.037055923844, 8765.0, 8797.824043519126, 8803.515806630665, 8732.607032683545, 8777.297816174754, 8788.956055219747, 8790.912090879074, 8795.560221988906, 8649.783755406103, 8717.215450609412, 8785.912140878574, 8792.560371981439, 8794.12058794122, 38105.42841857374, 38601.42097868534, 38609.42085868714, 38644.420333695016, 38754.61245387538, 3447.4311738563106, 3640.5631324240994, 3726.441033844918, 3737.0, 3816.599257078022, 30087.699123008926, 30562.083137505688, 30967.22581935447, 31092.0, 31093.68906310953, 4125.195586860564, 4134.689898257612, 4143.274926887782, 4171.687123465752, 4174.833006679729, 273522.0, 273767.0, 274079.999999998, 274781.0, 275745.0, 54867.725661372235, 55470.0, 55504.44495554993, 55524.722376388665, 55528.44471555314, 56862.7156864213, 61933.38066619366, 63791.0, 63917.68041159764, 64102.67948660227, 15960.36158553668, 16220.675586488203, 16222.675546489005, 16247.67504649924, 16255.918720406558, 12311.322877241837, 12358.196717213352, 12361.690957726129, 12373.195742276723, 12387.876121238673, 19170.41360212002, 19277.132529036226, 19326.4202073938, 19410.0, 19472.90263548673, 6853.485988550879, 6926.272741362185, 6950.6177160256675, 7154.642267886585, 7175.569465832067, 1035.2080658296409, 1058.88352281249, 1111.8999290063932, 1187.5249900040053, 1201.3872924808236, 31936.361272774415, 32566.674333256837, 32704.836475817945, 32906.67093329084, 33148.33703325968, 1092.5575142067316, 1176.6117181330312, 1181.4624345922584, 1197.9460924258428, 1274.6430999320205, 16886.577835553962, 16915.154242287837, 17137.0, 17277.82722172787, 17283.222254998305, 437892.0, 445452.0, 445674.0, 445986.0, 446127.0, 54581.727091364286, 56123.0, 56324.71837640786, 56393.71803140958, 56395.71802140963, 1352.9852610542093, 1406.2336026865382, 1416.1361569442631, 1417.2205287092058, 1497.3262032085388, 29606.851965740032, 31603.841980789948, 32026.83986580052, 32142.67857321397, 32412.675873241908, 44737.0, 45429.0, 45489.772551138354, 45616.31575526304, 45711.314330285735, 276643.0, 283249.0, 283960.0, 283990.0, 284672.0, 25033.499330013663, 27440.313992150357, 27649.170524884285, 27962.86018569894, 28146.577801333406, 41713.58286417218, 41715.16569668529, 42105.15789684128, 42405.57594424016, 42764.78617606892, 37649.0, 38512.80743596264, 38758.4186237201, 38811.0, 38851.805740972246, 37036.62963370332, 37290.8135459321, 37959.240815184094, 37992.0, 38817.0, 39107.80446097751, 39660.0, 39738.2052358957, 39814.0, 40259.1948161041, 32266.516002260454, 33536.66463335336, 33588.83205584054, 33898.0, 34428.655713442546, 26923.0, 27006.189814305602, 27368.0, 27500.58749118805, 27530.862345688143], "value": 19071.837576423255, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.0854221224593, 387.34151941699116, 390.83725915401664, 397.61630027023926, 404.24406360106605, 14046.719065618681, 15969.281382337793, 18167.636647267045, 18836.62326753466, 18839.058047097642, 14870.33083511242, 17648.205830737614, 17651.0, 18384.356547520838, 18554.072296385195, 5445.83662490126, 5640.0693885508845, 5640.689762063085, 5641.802536911209, 5671.688057156875, 4001.6998725095586, 5590.357108932464, 5634.323881134249, 5871.324797648261, 6237.750489980395, 6141.723622437001, 6142.109394137848, 6188.907166392485, 6189.721462534174, 6192.59748116371, 5239.004589128072, 5525.281713377235, 5525.309336332958, 5534.308211473566, 6146.108814221935, 5333.866653333659, 5335.452718711608, 5344.679319240858, 5347.893042139174, 5364.329458817648, 11953.880461195364, 12187.32969686667, 12220.327881966488, 12226.572069977508, 12240.081993850408, 2235.2065016918923, 2343.7304709958403, 2372.50177462733, 2416.4321384474633, 2773.1819113361607, 9662.9516852416, 10103.393796372242, 10169.288149829516, 10791.082757965582, 13848.09987350819, 1909.6180763847285, 1960.4608732598506, 1996.4409965209763, 2016.1330627830027, 2038.775734669185, 73697.2630273701, 74333.62833185853, 75008.24991750067, 75554.24445755527, 77281.90872365098, 10365.170786337076, 10365.792684146274, 10545.261831671709, 10556.841647375295, 10658.89341106579, 14495.565133046026, 14580.708385832224, 14595.92702036483, 14609.92695036518, 14614.588592882268, 7414.666340014713, 7813.68745250195, 7820.687172513036, 7957.721479748181, 7987.3610111190965, 6209.6895155242055, 7482.326590606872, 7528.736494222676, 7662.195469475736, 7684.231576842383, 4267.509236437787, 4460.152571011562, 4628.375169352162, 4723.504032076651, 4750.12122757291, 1937.0314842578712, 1948.6005368899341, 1967.9409617711492, 1983.1769815526395, 2010.662909165418, 891.9018907920124, 965.1458459263462, 1011.3426272922659, 1017.1151098544166, 1054.1882750282239, 18434.81565184358, 18529.629407411776, 18559.44321670352, 18812.0, 18982.71525927112, 1018.3756907732155, 1033.7312298802365, 1055.1875056206677, 1101.4878081692052, 1116.2186469471403, 10285.537150828231, 10560.894391055992, 10582.576696932036, 10728.678139655824, 10794.136469082454, 418431.0, 419024.0, 429655.0, 435131.0, 435654.0, 85148.57425712956, 86896.0, 87205.0, 87446.56276718575, 87550.0, 1001.5643195210107, 1010.282699283517, 1063.776606912557, 1086.760912599227, 1092.8743194532572, 16357.754633680743, 16379.76727712235, 16429.34282628729, 16808.411705590246, 16952.15239238058, 34035.65964340424, 34306.14234644154, 34840.9547713569, 35423.0, 35812.82093589516, 51967.0, 53548.732256338466, 55187.724061379435, 55411.72294138504, 55433.445665544445, 8048.678052877819, 8245.711400100967, 8358.414910956175, 8413.915860841313, 8525.786855328666, 11281.0, 13447.663808404477, 13539.796903046265, 13602.727945441233, 13635.318234088058, 11439.542418303176, 11671.183017189054, 11688.0, 11960.342181180118, 12069.456874440846, 11083.501242443948, 11262.774744505228, 11320.37737924422, 11678.532858685558, 11703.882961170279, 11376.829347559627, 11943.581974630846, 12027.879721202677, 12037.518499259932, 12107.697307567381, 8244.422890397615, 8276.462029968034, 8414.621342039745, 8441.535715535705, 8607.440516366416, 11691.298522088702, 11846.585369512026, 11892.464839082435, 11981.460834262305, 12249.326287054297], "value": 8827.740062307206, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.6012776231023, 1465.8754005909498, 1525.9856988774816, 1693.246505305139, 1828.3600739741091, 7522.360599349055, 7840.13758486566, 7848.9607551962235, 7857.449978501507, 7857.449978501507, 7615.543067415959, 7752.418568607363, 7761.767146985585, 7765.961170194141, 7766.145723970359, 1960.882347059174, 2188.277868303456, 2260.5930932432157, 2289.2331069091874, 2316.9768302317016, 2287.931362059141, 2304.83866129371, 2309.2379514760087, 2311.560803447348, 2314.0396735354807, 2242.9663555046604, 2276.943076423086, 2277.3851060213733, 2282.7146606674164, 2283.4519715268298, 1888.291890541047, 2171.250918433138, 2257.6726374675745, 2261.2989973108224, 2264.762199968996, 2220.888955552216, 2229.7770222977733, 2232.4865280985464, 2240.215924426454, 2256.7856053674873, 7784.299413052796, 7839.490433121829, 7842.529448233125, 7850.293473587348, 7858.803529911741, 4863.805447782084, 5001.97459520801, 5029.748512574393, 5035.597152227813, 5072.949270507284, 3203.823789691566, 3256.3161736035463, 3291.572095627553, 3324.1357247115925, 3357.9496307555405, 990.1435258501416, 999.975000624983, 1005.8038682456923, 1017.099866618041, 1021.5198856537415, 10349.0, 10628.043476087189, 10669.413182274971, 10670.30643008202, 10743.731406714816, 4299.699021068558, 4322.848700295474, 4422.646188304928, 4434.17967675981, 4474.865754027384, 8383.8323233535, 8406.579671016425, 8417.621207045697, 8433.536155511505, 8440.831183376298, 4368.453943257093, 4924.4583095859425, 4926.531979462017, 4939.580135688435, 4990.775415106329, 4445.110977804387, 4527.683062185615, 4559.156556037144, 4561.384213131185, 4567.634589232854, 3605.9098522537147, 3630.201355701794, 3680.0983758979223, 3711.6473934976134, 3750.6811920986474, 1093.0763504838399, 1108.1578000719512, 1108.6673997800629, 1114.5430373546808, 1133.246391149876, 864.6584599083327, 943.7310366545502, 1002.1832206751474, 1004.914582260516, 1016.2124353625999, 5700.714964251771, 5765.374913554223, 5833.241678581842, 5840.59115861894, 5845.649261044351, 443.21993291806007, 446.3839900936687, 447.8231098716054, 449.6560131499406, 1009.4397609326747, 3912.8630497932436, 3925.6074392560517, 3986.242613903407, 3995.5405128410603, 4004.4794176756836, 9703.07820757027, 9816.116549510578, 9883.061109194616, 9904.702858914245, 10008.39949603026, 9830.852537211947, 9859.063388978035, 9882.950585247028, 9896.703098907044, 9897.505124743733, 7418.33235008841, 7700.422468314899, 7887.211278872067, 7919.802004949923, 7923.920760792434, 5831.970840145772, 5881.588288819913, 6007.158997740233, 6054.697265136638, 6078.149059131813, 9021.548922553715, 9152.771180720536, 9245.630174792934, 9314.115159059878, 9328.813423731623, 9267.0, 9456.763580910532, 9462.858057129011, 9594.904050959402, 9613.855792162984, 6290.150829637941, 7158.642067896689, 7165.892511612435, 7370.520916140434, 7500.324970752658, 7726.4205184610255, 7757.030371203599, 7789.805254868674, 7817.5309481431295, 7819.921800781919, 6840.0, 7027.6837542309695, 7036.120484939383, 7078.433725302067, 7195.964020179866, 6852.177738671391, 6897.55165914214, 6955.130608673916, 6968.0941477607585, 7137.500374973702, 6602.537822352389, 6640.335966403321, 6731.663416829237, 6749.831254218684, 6753.3246675332075, 4798.352222449925, 4854.296127061486, 4861.878453038702, 4885.2427873679635, 4912.557869791736, 5028.421731500925, 5049.444561098203, 5071.011152825311, 5141.948580514297, 5153.896922061613], "value": 4278.221164884711, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.7805579982412, 310.3173019357414, 313.0358495832835, 327.63305098289914, 332.27563910674735, 5583.888322233558, 5642.125470552066, 5650.29371328584, 5653.575981801366, 5654.303708887338, 5515.972420137894, 5551.861203469915, 5576.0, 5584.296789479207, 5586.273784408021, 4119.155573107506, 4131.483564554431, 4267.829286828539, 4310.137972405516, 4311.439512863323, 4284.443022407083, 4306.978465107686, 4309.095090031097, 4309.525952145277, 4317.438732964726, 4017.537983131948, 4258.403823464718, 4271.530131685512, 4277.978610106945, 4279.871603851874, 4212.389203565496, 4334.718243314206, 4338.045629961403, 4342.934855977162, 4352.825886964518, 3778.8677396290996, 3787.8484860605545, 3797.9430308545393, 3812.694984401241, 3824.7513911595656, 5341.732913354355, 5390.380106287748, 5392.541633961118, 5400.972995134999, 5427.62006659534, 5013.498650134994, 5025.924611130836, 5027.396712394536, 5040.672356296829, 5045.823396181153, 5860.941390586082, 5892.675902825343, 5903.439173278532, 5910.438508341744, 5930.436608522184, 4066.064805094845, 4195.244855925932, 4198.454200953887, 4205.3271476563905, 4225.450691410097, 6127.816165514997, 6153.077038444225, 6165.784197553109, 6178.258608966953, 6180.412860778219, 4333.371661109121, 4333.371661109121, 4339.848105316362, 4341.717788343748, 4345.326474396474, 4039.232545816344, 4396.824127034947, 4403.735775853459, 4405.60349568534, 4412.713173643703, 4885.853424397274, 4894.486078961658, 4900.117978763786, 4907.2393778964315, 4908.533689299511, 5886.646801191942, 5900.203472531153, 5934.350374519726, 5952.85117872048, 5965.284165900033, 1431.9140851548732, 1454.1057249791513, 1465.6848777512673, 1472.3815997281167, 1475.0854470228312, 889.3374436045187, 958.2860768727343, 959.1846930109351, 971.8968970218853, 996.6910257820099, 5600.831975040755, 5626.718664066781, 5676.148577713376, 5678.119891416837, 5699.829005129853, 6024.728887200086, 6032.788852390146, 6042.154098426224, 6051.0, 6054.848628784315, 5484.396716361197, 5717.8570535736935, 5821.88356232873, 5836.795712150054, 5848.298204215522, 3270.3459308138467, 3282.097423208637, 3283.4910588858766, 3291.2594666200393, 3301.1747063234193, 6236.376362363727, 6359.745610175633, 6380.61827231568, 6385.233771947396, 6399.616023038632, 6213.285472170758, 6246.875062498724, 6258.749650013949, 6262.0, 6270.090836828635, 6061.666433384648, 6268.0, 6278.497720182374, 6291.874162516816, 6293.77971770995, 6096.451319381277, 6108.664023478751, 6114.174586430775, 6114.388561144028, 6117.877642447037, 5945.197398351167, 6003.189569408249, 6037.335893051673, 6052.455279024909, 6055.576109672281, 6084.817455476343, 6297.086922396135, 6312.147860038836, 6314.336994615683, 6323.462505687068, 4180.414741936071, 4188.937165942452, 4211.978940105279, 4225.28170211071, 4228.408022876862, 5935.109733540004, 6133.662648554194, 6144.170536977451, 6171.47542458896, 6182.6599537025895, 5915.231019967377, 5933.495652869382, 5959.374265702038, 5962.850928726816, 5968.612040217372, 5869.618474799125, 5924.229850119457, 5944.375840536682, 5956.404359564009, 5962.970185149046, 5667.404922483245, 5815.651060936358, 5842.152887831156, 5849.824505264849, 5866.560007999503, 5915.911261330997, 5955.166276721176, 5975.910361344497, 5987.2815262168815, 6023.48800351975, 5699.658020518782, 5878.207851270612, 5878.765459253605, 5889.322727886348, 5897.734601942837], "value": 4474.575873793224, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.0373995106606, 717.3257138290004, 728.4718579030204, 746.4961151222926, 750.7897788619186, 14128.364223609937, 14203.64490887727, 14390.1365918045, 14415.639609009753, 14429.42282308709, 10920.071793897509, 13569.389377478012, 13637.249951252701, 13676.3161841908, 13759.0, 810.088650268448, 838.5220424358118, 838.7232213369604, 840.017179899516, 840.3739214285366, 829.0631586307464, 833.2500749325625, 836.6611522333434, 837.1795640272506, 837.3259526081501, 694.7429451103098, 849.4266370200121, 865.909079546648, 867.7787164273133, 868.6872725818732, 875.8554838451648, 875.9956200219021, 876.5923845411883, 878.8505953987806, 879.2350654930219, 639.3798015924546, 639.728115550889, 640.3404493371835, 640.9423151916303, 642.3159335307929, 13668.863311366858, 13764.242966636832, 13764.862351376558, 13779.104358216684, 13797.034207605471, 14109.153450792985, 14279.143251404948, 14285.85714142866, 14376.0, 14798.260086995715, 11579.478923448465, 11847.468704940866, 11921.761564768743, 11948.70128246792, 12455.12814103013, 3870.283997460451, 3878.961210387888, 3931.469251651019, 3952.7825969571663, 3959.307121253769, 53136.0, 54807.0, 54808.17787733187, 54973.175402368994, 55000.72499637516, 10305.381677099398, 10434.321769084985, 10638.095761860173, 10763.461826908624, 10839.295445795999, 17837.0, 17929.282828686708, 17933.282668693108, 18286.908565457088, 18547.258109675462, 8561.0, 8569.185927336894, 8621.568921553897, 8678.392512524062, 8719.0, 4730.266808644666, 4787.952120478751, 4818.204996175592, 4860.586850117779, 4862.149123903303, 3401.557797486311, 3464.636213197578, 3470.809105499222, 3470.930581388358, 3473.6526347365566, 491.3244289102484, 508.3366207099696, 644.2944975252185, 647.0262255305735, 656.2748163279603, 741.210610699614, 776.1539921485495, 779.7972527142983, 806.9273765361146, 827.3918669777709, 9290.489023103793, 9373.297002724687, 9790.804183916282, 9812.65655702047, 10136.695899123039, 631.5705320382092, 641.9229692436937, 689.1557841643946, 773.1997382708981, 781.2304879693497, 4655.767211639404, 4813.15769740294, 4829.323894654751, 4860.635452341088, 4890.608751299887, 65599.34400656028, 66648.33351666518, 66672.6666366665, 67779.0, 67796.6610166956, 55264.17103743447, 57343.71328143332, 57654.0, 57700.422995769506, 58813.117803232984, 52143.73928130335, 53263.73368133212, 53690.46309536933, 54075.0, 54280.45719542833, 8997.640094396413, 9066.637334506546, 9104.544772761468, 9222.769430764285, 9309.348345615741, 32854.67145328516, 33232.667673322954, 33841.49237761485, 34115.82942085274, 34124.0, 40320.1935961285, 40934.59065409308, 42014.36978445387, 44377.77811110924, 48253.27620085772, 10834.349939003685, 11037.780489627048, 11422.771544569228, 11908.940455297668, 12272.570460034212, 13263.0, 13776.380062897395, 14080.577582672537, 14125.364358604093, 14574.635634109232, 13191.208527488381, 13604.93197534006, 13736.0, 14032.719345612826, 14048.78926816119, 12693.873061269269, 12837.037222208184, 13044.478220871059, 13052.0, 13065.150765200231, 11835.52657893709, 11878.049756019325, 12059.095567832272, 12443.751124977269, 12570.685732856751, 10965.342079475256, 11111.11111111093, 11183.384913829492, 11200.271982321123, 11387.202895797545, 11262.17086190699, 11327.773444531229, 11427.49011523093, 11474.25417347903, 11522.481488333213], "value": 6837.710088519839, "unit": "score"}], "name": "dromaeo_css", "value": 6979.583069434766, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 106.0, 109.0, 112.0, 110.0, 100.0, 113.0, 112.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 132.0, 153.0, 185.0, 132.0, 154.0, 151.0, 129.0, 183.0, 128.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 158.0, 159.0, 160.0, 160.0, 159.0, 161.0, 159.0, 160.0], "value": 159.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 104.0, 112.0, 74.0, 74.0, 73.0, 124.0, 101.0, 73.0], "value": 88.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 143.0, 93.0, 92.0, 92.0, 152.0, 91.0, 92.0, 143.0], "value": 108.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 55.0, 56.0, 56.0, 57.0, 81.0, 53.0, 54.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 63.0, 61.0, 62.0, 62.0, 63.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 85.0, 77.0, 80.0, 77.0, 80.0, 77.0, 79.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 135.0, 127.0, 136.0, 124.0, 122.0, 128.0, 135.0, 178.0, 133.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 167.0, 171.0, 163.0, 168.0, 169.0, 164.0, 164.0, 165.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 69.0, 67.0, 67.0, 68.0, 68.0, 69.0, 67.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1542.0, "alertThreshold": 2.0}]} 10:32:48 INFO - Return code: 0 10:32:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:32:48 ERROR - # TBPL SUCCESS # 10:32:48 INFO - Running post-action listener: _resource_record_post_action 10:32:48 INFO - Running post-run listener: _resource_record_post_run 10:32:49 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 7671808; Write bytes: 422166528; Read time: 1428; Write time: 356332 10:32:49 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 77398016; Read time: 0; Write time: 38796 10:32:49 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 5910528; Write bytes: 322887680; Read time: 1380; Write time: 289260 10:32:49 INFO - Running post-run listener: _upload_blobber_files 10:32:49 INFO - Blob upload gear active. 10:32:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:32:49 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 10:32:49 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'] 10:32:49 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 10:32:49 INFO - (blobuploader) - INFO - Open directory for files ... 10:32:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:32:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:32:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:50 INFO - (blobuploader) - INFO - Done attempting. 10:32:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:32:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:32:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:51 INFO - (blobuploader) - INFO - Done attempting. 10:32:51 INFO - (blobuploader) - INFO - Iteration through files over. 10:32:51 INFO - Return code: 0 10:32:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:32:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:32:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ffaff7386efb069cdb156e277d6f73b3e2a588f405a0c2b4f4e4f025161f4258fef8ef4e32aef06e4e17c2cd8cac48284cfa1e92057e8f0b3e589849a4d5d45e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3921ffa473c2c26ed30d182e3ea34ea9da6861e6253a005f2f6dc3eb64da4e058ccee339735f5006af2bfbbd92ad1948e1bba7d1df644ead216c5c7d1dc7dc07"} 10:32:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:32:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:32:51 INFO - Contents: 10:32:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ffaff7386efb069cdb156e277d6f73b3e2a588f405a0c2b4f4e4f025161f4258fef8ef4e32aef06e4e17c2cd8cac48284cfa1e92057e8f0b3e589849a4d5d45e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3921ffa473c2c26ed30d182e3ea34ea9da6861e6253a005f2f6dc3eb64da4e058ccee339735f5006af2bfbbd92ad1948e1bba7d1df644ead216c5c7d1dc7dc07"} 10:32:51 INFO - Running post-run listener: copy_logs_to_upload_dir 10:32:51 INFO - Copying logs to upload dir... 10:32:51 INFO - mkdir: /builds/slave/test/build/upload/logs 10:32:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.069536 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-04-20 10:32:51.749708) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 10:32:51.753398) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ffaff7386efb069cdb156e277d6f73b3e2a588f405a0c2b4f4e4f025161f4258fef8ef4e32aef06e4e17c2cd8cac48284cfa1e92057e8f0b3e589849a4d5d45e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3921ffa473c2c26ed30d182e3ea34ea9da6861e6253a005f2f6dc3eb64da4e058ccee339735f5006af2bfbbd92ad1948e1bba7d1df644ead216c5c7d1dc7dc07"} build_url:https://queue.taskcluster.net/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011103 build_url: 'https://queue.taskcluster.net/v1/task/Nq2xs03HTr-1eTbYruF9Rg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ffaff7386efb069cdb156e277d6f73b3e2a588f405a0c2b4f4e4f025161f4258fef8ef4e32aef06e4e17c2cd8cac48284cfa1e92057e8f0b3e589849a4d5d45e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3921ffa473c2c26ed30d182e3ea34ea9da6861e6253a005f2f6dc3eb64da4e058ccee339735f5006af2bfbbd92ad1948e1bba7d1df644ead216c5c7d1dc7dc07"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 10:32:51.777995) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:32:51.778368) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1461168526.654032-684969981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004364 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 10:32:51.861848) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 10:32:51.862174) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 10:32:51.862472) ========= ========= Total master_lag: 0.17 =========