builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1461095773.76 results: success (0) buildid: 20160419103127 builduid: 70f1e1e0e67143d98b98e2d75f0bd32b revision: c9facac780945244c621f0417354187ea9247475 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 12:56:13.776947) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-19 12:56:13.777737) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 12:56:13.778099) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-19 12:56:13.804931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 12:56:13.805266) ========= 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=ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-19 12:56:14-- 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% 46.1M=0s 2016-04-19 12:56:14 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119591 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 12:56:13.938966) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 12:56:13.939348) ========= 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=ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015245 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 12:56:13.989754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 12:56:13.990197) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c9facac780945244c621f0417354187ea9247475 --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 c9facac780945244c621f0417354187ea9247475 --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=ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-19 12:56:14,458 truncating revision to first 12 chars 2016-04-19 12:56:14,458 Setting DEBUG logging. 2016-04-19 12:56:14,458 attempt 1/10 2016-04-19 12:56:14,458 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c9facac78094?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-19 12:56:14,719 unpacking tar archive at: mozilla-inbound-c9facac78094/testing/mozharness/ program finished with exit code 0 elapsedTime=0.528584 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 12:56:14.532719) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 12:56:14.533104) ========= script_repo_revision: c9facac780945244c621f0417354187ea9247475 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-19 12:56:14.533581) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 12:56:14.533903) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-19 12:56:14.542950) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-19 12:56:14.543373) ========= /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=ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:56:15 INFO - MultiFileLogger online at 20160419 12:56:15 in /builds/slave/test 12:56:15 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 12:56:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:56:15 INFO - {'append_to_log': False, 12:56:15 INFO - 'base_work_dir': '/builds/slave/test', 12:56:15 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 12:56:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:56:15 INFO - 'branch': 'Mozilla-Inbound', 12:56:15 INFO - 'buildbot_json_path': 'buildprops.json', 12:56:15 INFO - 'config_files': ('talos/linux_config.py',), 12:56:15 INFO - 'default_actions': ('clobber', 12:56:15 INFO - 'read-buildbot-config', 12:56:15 INFO - 'download-and-extract', 12:56:15 INFO - 'populate-webroot', 12:56:15 INFO - 'create-virtualenv', 12:56:15 INFO - 'install', 12:56:15 INFO - 'run-tests'), 12:56:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:56:15 INFO - 'download_minidump_stackwalk': True, 12:56:15 INFO - 'download_symbols': 'ondemand', 12:56:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:56:15 INFO - 'tooltool.py': '/tools/tooltool.py', 12:56:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:56:15 INFO - '/tools/misc-python/virtualenv.py')}, 12:56:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:56:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:56:15 INFO - 'installer_path': 'installer.exe', 12:56:15 INFO - 'log_level': 'info', 12:56:15 INFO - 'log_name': 'talos', 12:56:15 INFO - 'log_to_console': True, 12:56:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:56:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:56:15 INFO - 'opt_config_files': (), 12:56:15 INFO - 'pip_index': False, 12:56:15 INFO - 'sps_profile': False, 12:56:15 INFO - 'sps_profile_interval': 0, 12:56:15 INFO - 'suite': 'dromaeojs', 12:56:15 INFO - 'system_bits': '32', 12:56:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:56:15 INFO - 'title': 'talos-linux64-ix-035', 12:56:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:56:15 INFO - 'use_talos_json': True, 12:56:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:56:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:56:15 INFO - 'work_dir': 'build'} 12:56:15 INFO - ##### 12:56:15 INFO - ##### Running clobber step. 12:56:15 INFO - ##### 12:56:15 INFO - Running pre-action listener: _resource_record_pre_action 12:56:15 INFO - Running main action method: clobber 12:56:15 INFO - rmtree: /builds/slave/test/build 12:56:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:56:15 INFO - Running post-action listener: _resource_record_post_action 12:56:15 INFO - ##### 12:56:15 INFO - ##### Running read-buildbot-config step. 12:56:15 INFO - ##### 12:56:15 INFO - Running pre-action listener: _resource_record_pre_action 12:56:15 INFO - Running main action method: read_buildbot_config 12:56:15 INFO - Using buildbot properties: 12:56:15 INFO - { 12:56:15 INFO - "project": "", 12:56:15 INFO - "product": "firefox", 12:56:15 INFO - "script_repo_revision": "production", 12:56:15 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 12:56:15 INFO - "repository": "", 12:56:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 12:56:15 INFO - "buildid": "20160419103127", 12:56:15 INFO - "pgo_build": "True", 12:56:15 INFO - "basedir": "/builds/slave/test", 12:56:15 INFO - "buildnumber": 865, 12:56:15 INFO - "slavename": "talos-linux64-ix-035", 12:56:15 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:56:15 INFO - "platform": "ubuntu64_hw", 12:56:15 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 12:56:15 INFO - "branch": "mozilla-inbound", 12:56:15 INFO - "repo_path": "integration/mozilla-inbound", 12:56:15 INFO - "revision": "c9facac780945244c621f0417354187ea9247475", 12:56:15 INFO - "stage_platform": "linux64-pgo", 12:56:15 INFO - "builduid": "70f1e1e0e67143d98b98e2d75f0bd32b", 12:56:15 INFO - "slavebuilddir": "test" 12:56:15 INFO - } 12:56:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 12:56:15 INFO - Running post-action listener: _resource_record_post_action 12:56:15 INFO - ##### 12:56:15 INFO - ##### Running download-and-extract step. 12:56:15 INFO - ##### 12:56:15 INFO - Running pre-action listener: _resource_record_pre_action 12:56:15 INFO - Running main action method: download_and_extract 12:56:15 INFO - mkdir: /builds/slave/test/build/tests 12:56:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:15 INFO - https://queue.taskcluster.net/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:56:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:56:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:56:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:56:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:56:25 INFO - Downloaded 1361 bytes. 12:56:25 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 12:56:25 INFO - Using the following test package requirements: 12:56:25 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:56:25 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:56:25 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:56:25 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:25 INFO - u'jsshell-linux-x86_64.zip'], 12:56:25 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:56:25 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 12:56:25 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:56:25 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:56:25 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:56:25 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:25 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:56:25 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:25 INFO - https://queue.taskcluster.net/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:56:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:56:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:56:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:56:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:56:27 INFO - Downloaded 23782294 bytes. 12:56:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:56:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:56:28 INFO - Return code: 0 12:56:28 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:28 INFO - https://queue.taskcluster.net/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:56:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:56:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:56:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 12:56:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:56:42 INFO - Downloaded 23782294 bytes. 12:56:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:56:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:56:43 INFO - Return code: 0 12:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:43 INFO - https://queue.taskcluster.net/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:56:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:56:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:56:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 12:56:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:56:44 INFO - Downloaded 10845952 bytes. 12:56:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:56:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:56:44 INFO - Return code: 0 12:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:44 INFO - https://queue.taskcluster.net/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:56:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:56:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:56:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:56:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:56:46 INFO - Downloaded 58238599 bytes. 12:56:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:56:46 INFO - mkdir: /builds/slave/test/properties 12:56:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:56:46 INFO - Writing to file /builds/slave/test/properties/build_url 12:56:46 INFO - Contents: 12:56:46 INFO - build_url:https://queue.taskcluster.net/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 12:56:47 INFO - Running post-action listener: _resource_record_post_action 12:56:47 INFO - Running post-action listener: set_extra_try_arguments 12:56:47 INFO - ##### 12:56:47 INFO - ##### Running populate-webroot step. 12:56:47 INFO - ##### 12:56:47 INFO - Running pre-action listener: _resource_record_pre_action 12:56:47 INFO - Running main action method: populate_webroot 12:56:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:56:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:56:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:56:47 INFO - '--tppagecycles', 12:56:47 INFO - '7'], 12:56:47 INFO - 'tests': ['tsvgm']}}, 12:56:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:56:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:56:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:56:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:56:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:56:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:56:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:47 INFO - 'talos_options': ['--disable-e10s'], 12:56:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:56:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:56:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:47 INFO - 'talos_options': ['--disable-e10s'], 12:56:47 INFO - 'tests': ['damp', 'tps']}, 12:56:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:47 INFO - 'tests': ['damp', 'tps']}, 12:56:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:56:47 INFO - 'tests': ['dromaeo_dom']}, 12:56:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:56:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:56:47 INFO - 'tests': ['a11yr', 12:56:47 INFO - 'ts_paint', 12:56:47 INFO - 'tpaint', 12:56:47 INFO - 'sessionrestore', 12:56:47 INFO - 'sessionrestore_no_auto_restore', 12:56:47 INFO - 'tabpaint']}, 12:56:47 INFO - 'other-e10s': {'tests': ['a11yr', 12:56:47 INFO - 'ts_paint', 12:56:47 INFO - 'tpaint', 12:56:47 INFO - 'sessionrestore', 12:56:47 INFO - 'sessionrestore_no_auto_restore', 12:56:47 INFO - 'tabpaint']}, 12:56:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:56:47 INFO - 'ts_paint', 12:56:47 INFO - 'tpaint', 12:56:47 INFO - 'sessionrestore', 12:56:47 INFO - 'sessionrestore_no_auto_restore', 12:56:47 INFO - 'tabpaint']}, 12:56:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:56:47 INFO - 'ts_paint', 12:56:47 INFO - 'tpaint', 12:56:47 INFO - 'sessionrestore', 12:56:47 INFO - 'sessionrestore_no_auto_restore', 12:56:47 INFO - 'tabpaint']}, 12:56:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:56:47 INFO - 'tests': ['a11yr', 12:56:47 INFO - 'ts_paint', 12:56:47 INFO - 'tpaint', 12:56:47 INFO - 'sessionrestore', 12:56:47 INFO - 'sessionrestore_no_auto_restore', 12:56:47 INFO - 'tabpaint']}, 12:56:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:56:47 INFO - 'tests': ['a11yr', 12:56:47 INFO - 'ts_paint', 12:56:47 INFO - 'tpaint', 12:56:47 INFO - 'sessionrestore', 12:56:47 INFO - 'sessionrestore_no_auto_restore', 12:56:47 INFO - 'tabpaint']}, 12:56:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:56:47 INFO - 'tests': ['tsvgx', 12:56:47 INFO - 'tsvgr_opacity', 12:56:47 INFO - 'tart', 12:56:47 INFO - 'tscrollx', 12:56:47 INFO - 'cart']}, 12:56:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:56:47 INFO - 'tsvgr_opacity', 12:56:47 INFO - 'tart', 12:56:47 INFO - 'tscrollx', 12:56:47 INFO - 'cart']}, 12:56:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:47 INFO - 'talos_options': ['--disable-e10s'], 12:56:47 INFO - 'tests': ['tp5o']}, 12:56:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:47 INFO - 'tests': ['tp5o']}, 12:56:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:47 INFO - 'talos_options': ['--disable-e10s', 12:56:47 INFO - '--xperf_path', 12:56:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:56:47 INFO - 'tests': ['tp5n']}, 12:56:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:47 INFO - 'talos_options': ['--xperf_path', 12:56:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:56:47 INFO - 'tests': ['tp5n']}}, 12:56:47 INFO - 'talos.zip': {'path': '', 12:56:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:56:47 INFO - Running post-action listener: _resource_record_post_action 12:56:47 INFO - ##### 12:56:47 INFO - ##### Running create-virtualenv step. 12:56:47 INFO - ##### 12:56:47 INFO - Running pre-action listener: _resource_record_pre_action 12:56:47 INFO - Running main action method: create_virtualenv 12:56:47 INFO - Creating virtualenv /builds/slave/test/build/venv 12:56:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:56:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:56:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:56:47 INFO - Using real prefix '/usr' 12:56:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:56:48 INFO - Installing distribute.............................................................................................................................................................................................done. 12:56:50 INFO - Installing pip.................done. 12:56:50 INFO - Return code: 0 12:56:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2e884cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ed410>, '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 0x24ee310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:56:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:56:50 INFO - Using env: {'DISPLAY': ':0', 12:56:50 INFO - 'HOME': '/home/cltbld', 12:56:50 INFO - 'LANG': 'en_US.UTF-8', 12:56:50 INFO - 'LANGUAGE': 'en_US:en', 12:56:50 INFO - 'LOGNAME': 'cltbld', 12:56:50 INFO - 'MAIL': '/var/mail/cltbld', 12:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:50 INFO - 'MOZ_NO_REMOTE': '1', 12:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:50 INFO - 'NO_EM_RESTART': '1', 12:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:50 INFO - 'PWD': '/builds/slave/test', 12:56:50 INFO - 'SHELL': '/bin/bash', 12:56:50 INFO - 'SHLVL': '1', 12:56:50 INFO - 'TERM': 'linux', 12:56:50 INFO - 'TMOUT': '86400', 12:56:50 INFO - 'USER': 'cltbld', 12:56:50 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416', 12:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:50 INFO - '_': '/tools/buildbot/bin/python'} 12:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:56:50 INFO - Cleaning up... 12:56:50 INFO - Return code: 0 12:56:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2e884cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ed410>, '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 0x24ee310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:56:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:56:50 INFO - Using env: {'DISPLAY': ':0', 12:56:50 INFO - 'HOME': '/home/cltbld', 12:56:50 INFO - 'LANG': 'en_US.UTF-8', 12:56:50 INFO - 'LANGUAGE': 'en_US:en', 12:56:50 INFO - 'LOGNAME': 'cltbld', 12:56:50 INFO - 'MAIL': '/var/mail/cltbld', 12:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:50 INFO - 'MOZ_NO_REMOTE': '1', 12:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:50 INFO - 'NO_EM_RESTART': '1', 12:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:50 INFO - 'PWD': '/builds/slave/test', 12:56:50 INFO - 'SHELL': '/bin/bash', 12:56:50 INFO - 'SHLVL': '1', 12:56:50 INFO - 'TERM': 'linux', 12:56:50 INFO - 'TMOUT': '86400', 12:56:50 INFO - 'USER': 'cltbld', 12:56:50 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416', 12:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:50 INFO - '_': '/tools/buildbot/bin/python'} 12:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:50 INFO - Downloading/unpacking psutil>=0.7.1 12:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:56:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:56:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:56:52 INFO - Installing collected packages: psutil 12:56:52 INFO - Running setup.py install for psutil 12:56:52 INFO - building 'psutil._psutil_linux' extension 12:56:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:56:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:56:53 INFO - building 'psutil._psutil_posix' extension 12:56:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:56:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:56:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:56:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:56:53 INFO - Successfully installed psutil 12:56:53 INFO - Cleaning up... 12:56:53 INFO - Return code: 0 12:56:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2e884cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ed410>, '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 0x24ee310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:56:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:56:53 INFO - Using env: {'DISPLAY': ':0', 12:56:53 INFO - 'HOME': '/home/cltbld', 12:56:53 INFO - 'LANG': 'en_US.UTF-8', 12:56:53 INFO - 'LANGUAGE': 'en_US:en', 12:56:53 INFO - 'LOGNAME': 'cltbld', 12:56:53 INFO - 'MAIL': '/var/mail/cltbld', 12:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:53 INFO - 'MOZ_NO_REMOTE': '1', 12:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:53 INFO - 'NO_EM_RESTART': '1', 12:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:53 INFO - 'PWD': '/builds/slave/test', 12:56:53 INFO - 'SHELL': '/bin/bash', 12:56:53 INFO - 'SHLVL': '1', 12:56:53 INFO - 'TERM': 'linux', 12:56:53 INFO - 'TMOUT': '86400', 12:56:53 INFO - 'USER': 'cltbld', 12:56:53 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416', 12:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:53 INFO - '_': '/tools/buildbot/bin/python'} 12:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:56:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:56:55 INFO - Installing collected packages: mozsystemmonitor 12:56:55 INFO - Running setup.py install for mozsystemmonitor 12:56:55 INFO - Successfully installed mozsystemmonitor 12:56:55 INFO - Cleaning up... 12:56:55 INFO - Return code: 0 12:56:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:55 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 0x7f2e884cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ed410>, '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 0x24ee310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:56:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:56:55 INFO - Using env: {'DISPLAY': ':0', 12:56:55 INFO - 'HOME': '/home/cltbld', 12:56:55 INFO - 'LANG': 'en_US.UTF-8', 12:56:55 INFO - 'LANGUAGE': 'en_US:en', 12:56:55 INFO - 'LOGNAME': 'cltbld', 12:56:55 INFO - 'MAIL': '/var/mail/cltbld', 12:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:55 INFO - 'MOZ_NO_REMOTE': '1', 12:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:55 INFO - 'NO_EM_RESTART': '1', 12:56:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:55 INFO - 'PWD': '/builds/slave/test', 12:56:55 INFO - 'SHELL': '/bin/bash', 12:56:55 INFO - 'SHLVL': '1', 12:56:55 INFO - 'TERM': 'linux', 12:56:55 INFO - 'TMOUT': '86400', 12:56:55 INFO - 'USER': 'cltbld', 12:56:55 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416', 12:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:55 INFO - '_': '/tools/buildbot/bin/python'} 12:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:55 INFO - Downloading/unpacking blobuploader==1.2.4 12:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:57 INFO - Downloading blobuploader-1.2.4.tar.gz 12:56:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:56:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:56:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:58 INFO - Downloading docopt-0.6.1.tar.gz 12:56:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:56:58 INFO - Installing collected packages: blobuploader, requests, docopt 12:56:58 INFO - Running setup.py install for blobuploader 12:56:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:56:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:56:58 INFO - Running setup.py install for requests 12:56:58 INFO - Running setup.py install for docopt 12:56:59 INFO - Successfully installed blobuploader requests docopt 12:56:59 INFO - Cleaning up... 12:56:59 INFO - Return code: 0 12:56:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:59 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 0x7f2e884cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ed410>, '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 0x24ee310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:56:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:56:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:56:59 INFO - Using env: {'DISPLAY': ':0', 12:56:59 INFO - 'HOME': '/home/cltbld', 12:56:59 INFO - 'LANG': 'en_US.UTF-8', 12:56:59 INFO - 'LANGUAGE': 'en_US:en', 12:56:59 INFO - 'LOGNAME': 'cltbld', 12:56:59 INFO - 'MAIL': '/var/mail/cltbld', 12:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:59 INFO - 'MOZ_NO_REMOTE': '1', 12:56:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:59 INFO - 'NO_EM_RESTART': '1', 12:56:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:56:59 INFO - 'PWD': '/builds/slave/test', 12:56:59 INFO - 'SHELL': '/bin/bash', 12:56:59 INFO - 'SHLVL': '1', 12:56:59 INFO - 'TERM': 'linux', 12:56:59 INFO - 'TMOUT': '86400', 12:56:59 INFO - 'USER': 'cltbld', 12:56:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416', 12:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:59 INFO - '_': '/tools/buildbot/bin/python'} 12:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:56:59 INFO - Running setup.py (path:/tmp/pip-d94a8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:56:59 INFO - Running setup.py (path:/tmp/pip-Net15I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:56:59 INFO - Running setup.py (path:/tmp/pip-Wy3JrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:56:59 INFO - Running setup.py (path:/tmp/pip-F0zj8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:56:59 INFO - Running setup.py (path:/tmp/pip-L8bzf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:56:59 INFO - Running setup.py (path:/tmp/pip-GMkzaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:56:59 INFO - Running setup.py (path:/tmp/pip-D97NO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:56:59 INFO - Running setup.py (path:/tmp/pip-G1g8PA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:56:59 INFO - Running setup.py (path:/tmp/pip-cNW206-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:56:59 INFO - Running setup.py (path:/tmp/pip-P6IEWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:57:00 INFO - Running setup.py (path:/tmp/pip-6yG1tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:57:00 INFO - Running setup.py (path:/tmp/pip-rVWzGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:57:00 INFO - Running setup.py (path:/tmp/pip-9GQmse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:57:00 INFO - Running setup.py (path:/tmp/pip-Zx2hy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:00 INFO - Running setup.py (path:/tmp/pip-A1kFpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:57:00 INFO - Running setup.py (path:/tmp/pip-weGJZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:57:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:57:00 INFO - Running setup.py (path:/tmp/pip-89Zq_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:57:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:57:00 INFO - Running setup.py install for manifestparser 12:57:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:57:00 INFO - Running setup.py install for mozcrash 12:57:00 INFO - Running setup.py install for mozdebug 12:57:00 INFO - Running setup.py install for mozdevice 12:57:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:57:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:57:00 INFO - Running setup.py install for mozfile 12:57:01 INFO - Running setup.py install for mozhttpd 12:57:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:57:01 INFO - Running setup.py install for mozinfo 12:57:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:57:01 INFO - Running setup.py install for mozInstall 12:57:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:57:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:57:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:57:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:57:01 INFO - Running setup.py install for mozleak 12:57:01 INFO - Running setup.py install for mozlog 12:57:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:57:01 INFO - Running setup.py install for moznetwork 12:57:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:57:01 INFO - Running setup.py install for mozprocess 12:57:01 INFO - Running setup.py install for mozprofile 12:57:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:57:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:57:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:57:01 INFO - Running setup.py install for mozrunner 12:57:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:57:02 INFO - Running setup.py install for mozscreenshot 12:57:02 INFO - Running setup.py install for moztest 12:57:02 INFO - Running setup.py install for mozversion 12:57:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:57:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:57:02 INFO - Cleaning up... 12:57:02 INFO - Return code: 0 12:57:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:02 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 0x7f2e884cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ed410>, '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 0x24ee310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:57:02 INFO - Using env: {'DISPLAY': ':0', 12:57:02 INFO - 'HOME': '/home/cltbld', 12:57:02 INFO - 'LANG': 'en_US.UTF-8', 12:57:02 INFO - 'LANGUAGE': 'en_US:en', 12:57:02 INFO - 'LOGNAME': 'cltbld', 12:57:02 INFO - 'MAIL': '/var/mail/cltbld', 12:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:02 INFO - 'MOZ_NO_REMOTE': '1', 12:57:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:02 INFO - 'NO_EM_RESTART': '1', 12:57:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:02 INFO - 'PWD': '/builds/slave/test', 12:57:02 INFO - 'SHELL': '/bin/bash', 12:57:02 INFO - 'SHLVL': '1', 12:57:02 INFO - 'TERM': 'linux', 12:57:02 INFO - 'TMOUT': '86400', 12:57:02 INFO - 'USER': 'cltbld', 12:57:02 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416', 12:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:02 INFO - '_': '/tools/buildbot/bin/python'} 12:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:57:02 INFO - Running setup.py (path:/tmp/pip-gq2rmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:57:02 INFO - Running setup.py (path:/tmp/pip-hr5dpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:57:02 INFO - Running setup.py (path:/tmp/pip-fNXdz4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:57:02 INFO - Running setup.py (path:/tmp/pip-rDogt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:57:02 INFO - Running setup.py (path:/tmp/pip-cwGx3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:57:02 INFO - Running setup.py (path:/tmp/pip-h9SR7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:57:02 INFO - Running setup.py (path:/tmp/pip-3CCWI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:57:03 INFO - Running setup.py (path:/tmp/pip-cfsupC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:57:03 INFO - Running setup.py (path:/tmp/pip-j22xTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:57:03 INFO - Running setup.py (path:/tmp/pip-bWe1T7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:57:03 INFO - Running setup.py (path:/tmp/pip-JxVbfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:57:03 INFO - Running setup.py (path:/tmp/pip-ri1nsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:57:03 INFO - Running setup.py (path:/tmp/pip-KVuvdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:57:03 INFO - Running setup.py (path:/tmp/pip-VwwwYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:03 INFO - Running setup.py (path:/tmp/pip-PB1k4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:57:03 INFO - Running setup.py (path:/tmp/pip-sBE66i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:57:03 INFO - Running setup.py (path:/tmp/pip-dtlHL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:57:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:05 INFO - Downloading blessings-1.6.tar.gz 12:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:57:05 INFO - Installing collected packages: blessings 12:57:05 INFO - Running setup.py install for blessings 12:57:05 INFO - Successfully installed blessings 12:57:05 INFO - Cleaning up... 12:57:05 INFO - Return code: 0 12:57:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:57:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:57:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:57:06 INFO - Reading from file tmpfile_stdout 12:57:06 INFO - Current package versions: 12:57:06 INFO - argparse == 1.2.1 12:57:06 INFO - blessings == 1.6 12:57:06 INFO - blobuploader == 1.2.4 12:57:06 INFO - docopt == 0.6.1 12:57:06 INFO - manifestparser == 1.1 12:57:06 INFO - mozInstall == 1.12 12:57:06 INFO - mozcrash == 0.17 12:57:06 INFO - mozdebug == 0.1 12:57:06 INFO - mozdevice == 0.48 12:57:06 INFO - mozfile == 1.2 12:57:06 INFO - mozhttpd == 0.7 12:57:06 INFO - mozinfo == 0.9 12:57:06 INFO - mozleak == 0.1 12:57:06 INFO - mozlog == 3.1 12:57:06 INFO - moznetwork == 0.27 12:57:06 INFO - mozprocess == 0.22 12:57:06 INFO - mozprofile == 0.28 12:57:06 INFO - mozrunner == 6.11 12:57:06 INFO - mozscreenshot == 0.1 12:57:06 INFO - mozsystemmonitor == 0.0 12:57:06 INFO - moztest == 0.7 12:57:06 INFO - mozversion == 1.4 12:57:06 INFO - psutil == 3.1.1 12:57:06 INFO - requests == 1.2.3 12:57:06 INFO - wsgiref == 0.1.2 12:57:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:06 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 0x7f2e884cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ed410>, '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 0x24ee310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:57:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:57:06 INFO - Using env: {'DISPLAY': ':0', 12:57:06 INFO - 'HOME': '/home/cltbld', 12:57:06 INFO - 'LANG': 'en_US.UTF-8', 12:57:06 INFO - 'LANGUAGE': 'en_US:en', 12:57:06 INFO - 'LOGNAME': 'cltbld', 12:57:06 INFO - 'MAIL': '/var/mail/cltbld', 12:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:06 INFO - 'MOZ_NO_REMOTE': '1', 12:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:06 INFO - 'NO_EM_RESTART': '1', 12:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:06 INFO - 'PWD': '/builds/slave/test', 12:57:06 INFO - 'SHELL': '/bin/bash', 12:57:06 INFO - 'SHLVL': '1', 12:57:06 INFO - 'TERM': 'linux', 12:57:06 INFO - 'TMOUT': '86400', 12:57:06 INFO - 'USER': 'cltbld', 12:57:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416', 12:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:06 INFO - '_': '/tools/buildbot/bin/python'} 12:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:57:06 INFO - Cleaning up... 12:57:06 INFO - Return code: 0 12:57:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2e884cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ed410>, '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 0x24ee310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:57:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:57:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:57:06 INFO - Using env: {'DISPLAY': ':0', 12:57:06 INFO - 'HOME': '/home/cltbld', 12:57:06 INFO - 'LANG': 'en_US.UTF-8', 12:57:06 INFO - 'LANGUAGE': 'en_US:en', 12:57:06 INFO - 'LOGNAME': 'cltbld', 12:57:06 INFO - 'MAIL': '/var/mail/cltbld', 12:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:06 INFO - 'MOZ_NO_REMOTE': '1', 12:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:06 INFO - 'NO_EM_RESTART': '1', 12:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:06 INFO - 'PWD': '/builds/slave/test', 12:57:06 INFO - 'SHELL': '/bin/bash', 12:57:06 INFO - 'SHLVL': '1', 12:57:06 INFO - 'TERM': 'linux', 12:57:06 INFO - 'TMOUT': '86400', 12:57:06 INFO - 'USER': 'cltbld', 12:57:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416', 12:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:06 INFO - '_': '/tools/buildbot/bin/python'} 12:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:06 INFO - Downloading/unpacking jsonschema 12:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:57:08 INFO - Downloading/unpacking functools32 (from jsonschema) 12:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:08 INFO - Downloading functools32-3.2.3-2.tar.gz 12:57:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:57:08 INFO - warning: no files found matching '*.txt' 12:57:08 INFO - no previously-included directories found matching 'build' 12:57:08 INFO - no previously-included directories found matching 'dist' 12:57:08 INFO - no previously-included directories found matching '.git*' 12:57:08 INFO - Installing collected packages: jsonschema, functools32 12:57:08 INFO - Running setup.py install for functools32 12:57:08 INFO - warning: no files found matching '*.txt' 12:57:08 INFO - no previously-included directories found matching 'build' 12:57:08 INFO - no previously-included directories found matching 'dist' 12:57:08 INFO - no previously-included directories found matching '.git*' 12:57:08 INFO - Successfully installed jsonschema functools32 12:57:08 INFO - Cleaning up... 12:57:08 INFO - Return code: 0 12:57:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:08 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 0x7f2e884cff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x245e5a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ed410>, '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 0x24ee310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee7a0>, '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': 'ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:57:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:57:08 INFO - Using env: {'DISPLAY': ':0', 12:57:08 INFO - 'HOME': '/home/cltbld', 12:57:08 INFO - 'LANG': 'en_US.UTF-8', 12:57:08 INFO - 'LANGUAGE': 'en_US:en', 12:57:08 INFO - 'LOGNAME': 'cltbld', 12:57:08 INFO - 'MAIL': '/var/mail/cltbld', 12:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:08 INFO - 'MOZ_NO_REMOTE': '1', 12:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:08 INFO - 'NO_EM_RESTART': '1', 12:57:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:08 INFO - 'PWD': '/builds/slave/test', 12:57:08 INFO - 'SHELL': '/bin/bash', 12:57:08 INFO - 'SHLVL': '1', 12:57:08 INFO - 'TERM': 'linux', 12:57:08 INFO - 'TMOUT': '86400', 12:57:08 INFO - 'USER': 'cltbld', 12:57:08 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416', 12:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:08 INFO - '_': '/tools/buildbot/bin/python'} 12:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:09 INFO - Downloading/unpacking flake8 12:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:57:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:57:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:57:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:57:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:57:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:57:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:57:11 INFO - no previously-included directories found matching 'docs/_build' 12:57:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:57:11 INFO - Running setup.py install for pep8 12:57:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:57:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:57:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:57:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:57:11 INFO - no previously-included directories found matching 'docs/_build' 12:57:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:57:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:57:11 INFO - Cleaning up... 12:57:11 INFO - Return code: 0 12:57:11 INFO - Running post-action listener: _resource_record_post_action 12:57:11 INFO - Running post-action listener: _start_resource_monitoring 12:57:11 INFO - Starting resource monitoring. 12:57:11 INFO - ##### 12:57:11 INFO - ##### Running install step. 12:57:11 INFO - ##### 12:57:11 INFO - Running pre-action listener: _resource_record_pre_action 12:57:11 INFO - Running main action method: install 12:57:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:57:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:57:12 INFO - Reading from file tmpfile_stdout 12:57:12 INFO - Detecting whether we're running mozinstall >=1.0... 12:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:57:12 INFO - Reading from file tmpfile_stdout 12:57:12 INFO - Output received: 12:57:12 INFO - Usage: mozinstall [options] installer 12:57:12 INFO - Options: 12:57:12 INFO - -h, --help show this help message and exit 12:57:12 INFO - -d DEST, --destination=DEST 12:57:12 INFO - Directory to install application into. [default: 12:57:12 INFO - "/builds/slave/test"] 12:57:12 INFO - --app=APP Application being installed. [default: firefox] 12:57:12 INFO - mkdir: /builds/slave/test/build/application 12:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:57:28 INFO - Reading from file tmpfile_stdout 12:57:28 INFO - Output received: 12:57:28 INFO - /builds/slave/test/build/application/firefox/firefox 12:57:28 INFO - Running post-action listener: _resource_record_post_action 12:57:28 INFO - ##### 12:57:28 INFO - ##### Running run-tests step. 12:57:28 INFO - ##### 12:57:28 INFO - Running pre-action listener: _resource_record_pre_action 12:57:28 INFO - Running main action method: run_tests 12:57:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:57:28 INFO - Python 2.7.3 12:57:28 INFO - Return code: 0 12:57:28 INFO - grabbing minidump binary from tooltool 12:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:28 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 0x24ed410>, '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 0x24ee310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24ee7a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:57:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:57:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:57:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:57:28 INFO - Return code: 0 12:57:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:57:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:57:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:57:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:57:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:57:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:57:29 INFO - Return code: 0 12:57:29 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/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 12:57:29 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/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 12:57:29 INFO - Using env: {'DISPLAY': ':0', 12:57:29 INFO - 'HOME': '/home/cltbld', 12:57:29 INFO - 'LANG': 'en_US.UTF-8', 12:57:29 INFO - 'LANGUAGE': 'en_US:en', 12:57:29 INFO - 'LOGNAME': 'cltbld', 12:57:29 INFO - 'MAIL': '/var/mail/cltbld', 12:57:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:57:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:29 INFO - 'MOZ_NO_REMOTE': '1', 12:57:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:29 INFO - 'NO_EM_RESTART': '1', 12:57:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:29 INFO - 'PWD': '/builds/slave/test', 12:57:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:57:29 INFO - 'SHELL': '/bin/bash', 12:57:29 INFO - 'SHLVL': '1', 12:57:29 INFO - 'TERM': 'linux', 12:57:29 INFO - 'TMOUT': '86400', 12:57:29 INFO - 'USER': 'cltbld', 12:57:29 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416', 12:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:29 INFO - '_': '/tools/buildbot/bin/python'} 12:57:29 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/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 12:57:30 INFO - mozversion application_buildid: 20160419103127 12:57:30 INFO - mozversion application_changeset: c9facac780945244c621f0417354187ea9247475 12:57:30 INFO - mozversion application_display_name: Nightly 12:57:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:57:30 INFO - mozversion application_name: Firefox 12:57:30 INFO - mozversion application_remotingname: firefox 12:57:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:57:30 INFO - mozversion application_vendor: Mozilla 12:57:30 INFO - mozversion application_version: 48.0a1 12:57:30 INFO - mozversion platform_buildid: 20160419103127 12:57:30 INFO - mozversion platform_changeset: c9facac780945244c621f0417354187ea9247475 12:57:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:57:30 INFO - mozversion platform_version: 48.0a1 12:57:30 INFO - using testdate: 1461095850 12:57:30 INFO - actual date: 1461095850 12:57:30 INFO - starting webserver on 'localhost:50564' 12:57:30 INFO - SUITE-START | Running 2 tests 12:57:30 INFO - TEST-START | dromaeo_css 12:57:30 INFO - operating with platform_type : linux_ 12:57:30 INFO - Initialising browser for dromaeo_css test... 12:57:30 INFO - TEST-INFO | started process 18744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSoiyrs/profile http://localhost:50564/getInfo.html) 12:57:34 INFO - PROCESS | 18744 | __metrics Screen width/height:1600/1200 12:57:34 INFO - PROCESS | 18744 | colorDepth:24 12:57:34 INFO - PROCESS | 18744 | Browser inner width/height: 1024/697 12:57:34 INFO - PROCESS | 18744 | __metrics 12:57:35 ERROR - PROCESS | 18744 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 12:57:35 INFO - TEST-INFO | 18744: exit 0 12:57:35 INFO - Browser initialized. 12:57:35 INFO - Running cycle 1/1 for dromaeo_css test... 12:57:35 INFO - TEST-INFO | started process 18827 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSoiyrs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:57:47 INFO - PROCESS | 18827 | RSS: Main: 152997888 12:57:47 INFO - PROCESS | 18827 | 12:58:38 INFO - PROCESS | 18827 | 1461095918314 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] 13:00:45 INFO - PROCESS | 18827 | Cycle 1(1): loaded http://localhost:50564/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50564/tests/dromaeo/cssquery-ext.html) 13:00:46 INFO - PROCESS | 18827 | RSS: Main: 261296128 13:00:46 INFO - PROCESS | 18827 | 13:03:49 INFO - PROCESS | 18827 | Cycle 1(1): loaded http://localhost:50564/tests/dromaeo/cssquery-ext.html (next: http://localhost:50564/tests/dromaeo/cssquery-jquery.html) 13:03:49 INFO - PROCESS | 18827 | RSS: Main: 238628864 13:03:49 INFO - PROCESS | 18827 | 13:06:51 INFO - PROCESS | 18827 | Cycle 1(1): loaded http://localhost:50564/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50564/tests/dromaeo/cssquery-mootools.html) 13:06:52 INFO - PROCESS | 18827 | RSS: Main: 232591360 13:06:52 INFO - PROCESS | 18827 | 13:09:54 INFO - PROCESS | 18827 | Cycle 1(1): loaded http://localhost:50564/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50564/tests/dromaeo/cssquery-prototype.html) 13:09:54 INFO - PROCESS | 18827 | RSS: Main: 229494784 13:09:54 INFO - PROCESS | 18827 | 13:12:57 INFO - PROCESS | 18827 | Cycle 1(1): loaded http://localhost:50564/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50564/tests/dromaeo/cssquery-yui.html) 13:12:57 INFO - PROCESS | 18827 | RSS: Main: 219602944 13:12:57 INFO - PROCESS | 18827 | 13:16:00 INFO - PROCESS | 18827 | Cycle 1(1): loaded http://localhost:50564/tests/dromaeo/cssquery-yui.html (next: http://localhost:50564/tests/dromaeo/cssquery-dojo.html) 13:16:00 INFO - PROCESS | 18827 | RSS: Main: 268419072 13:16:00 INFO - PROCESS | 18827 | 13:16:00 INFO - PROCESS | 18827 | __start_tp_report 13:16:00 INFO - PROCESS | 18827 | _x_x_mozilla_page_load 13:16:00 INFO - PROCESS | 18827 | _x_x_mozilla_page_load_details 13:16:00 INFO - PROCESS | 18827 | |i|pagename|runs| 13:16:00 INFO - PROCESS | 18827 | |0;dojo.html;3103.4103520331137;3127.061881435569;3137.105924811428;3164.778465507414;3197.3285610021894;5098.4901509849;5137.511936366049;5227.634065615409;5255.632105752599;5306.761195746191;5196.558292545129;5278.1291086970605;5284.577233821295;5294.629375943676;5296.311479507668;4707.223308154167;4752.904941901169;4838.612910967132;4871.707697538159;4882.438519570242;4710.952890471103;4810.110129626013;4851.054044461332;4855.56299933006;4871.732054736988;4710.246360582308;4716.151092803294;4724.5984091352275;4751.382320298374;4785.042991401716;4690.273007683814;4697.224957881946;4704.929426058612;4716.127516409475;4737.147313483571;4642.628589712815;4685.718856868599;4696.812127514895;4717.127331443694;4767.451743049559;5141.794328226866;5167.586593072545;5171.172612382001;5178.275041494194;5186.325777648882;5588.636738611977;5589.105743081128;5589.944100559023;5630.859228519279;5639.971800140973;5448.128299472065;5631;5657.2928383952;5716;5735.799247026334;5191.844244672666;5221.895562088775;5224.268602395668;5227.059129356714;5228.2941802856885;5671.404502527175;5673.744681489343;5677.063284558084;5678.0915053591225;5679.176519404663;5431.619786614978;5449.618526703092;5472.343318801769;5497.670139791625;5510.090835012258;5506.091494903376;5507.449255074541;5508.889822203533;5510.448955104538;5515.944840551543;5419.810306639249;5496.725163741797;5502.147167189092;5506.366767821752;5546.473085056913;5558.749856256478;5579.46995035471;5592.049351610236;5612.354579223442;5631.099024156198;4255.3829694694095;4265.87202383929;4270.423492828429;4286.7856607169515;4308.418363520947;3832.80835958201;3841.4045822897497;3872.6320999505;3887.591802860659;3893.7079719021185;5350.732463376893;5368.624196306221;5369.221462887859;5374.596905232123;5414.972925135428;5664.745086471119;5680.0627896397455;5708.771649133988;5709.029464990961;5711;5155.304033955443;5194.6104042196985;5293.894122117536;5347.358317001985;5418.02475554404;4833.492483289274;4852.1508735971065;4856.223004319292;4877.317175595348;4888.315635810989;5780.855478613068;5781.768729250783;5782.855428614318;5785.652860828363;5788.363280039192;5415.566754659697;5528.55771538284;5581.330240371181;5600.551955843604;5601.5238704710555;5726.770929162787;5746.856328591819;5747.770089196385;5751.051076572318;5774.1338799178775;5437.619366644455;5452.7546260417585;5459.508644222039;5460.099083651153;5464.071107911744;5466.590005749665;5615.747291371979;5661.433856614306;5672.234248376416;5699.7435115419075;5454.154606036071;5454.509094181542;5454.699991500505;5460.890782184255;5463.918041229305;5270.420253772006;5447.319085114361;5450.291462110059;5450.672959622435;5492.5605951524585;5353.785848566014;5387.0572649785345;5413.512783849473;5429.972850135724;5442.836714898559;5386.434424385383;5418.241446197614;5420.241166236809;5420.620556561003;5422.810201642924;5264.763085661231;5332.920006199987;5348.7593058311695;5380.031594313061;5391.29913111293 13:16:00 INFO - PROCESS | 18827 | |1;ext.html;601.4016054026245;621.7761605821906;646.0567571345834;657.5528640524443;665.3845193196295;29652.555211671814;30378.54432183516;30442.69557304429;37465.62534374656;38533;39652.40521392181;40057.39913901294;40227.79886100573;40242.79878600603;40264.79867600665;8451.154884511545;8675.132486751307;8675.609597568093;8677.1756683115;8681.652733890636;8476.406651534395;8576.69981550646;8585.785355366103;8590.957045214765;8604.225619694227;8573.699920502784;8574.69988550401;8638.697645582406;8842.336824738139;8850.291976641885;8673.609687564074;8762.167594078552;8764.824703505894;8766.868496972551;8778.824423511558;8688.435251708619;8789.25291350236;8799.076097009785;8801.339899507562;8802.735917922473;40080.19839603221;40328;40666.1866762666;40717;40748;3397.8810741623925;3509.31568344173;3534.823258837048;3577.695895848856;3944.7320914915977;31262.37475250505;31857;32059.839700801345;32115.51826722601;32120.678793212002;4024.1146947671464;4085.1216988347646;4095.467589213413;4164.4102406136735;4194.3918131870705;282692;283339;284127.57936210395;284163;284522;56524.71737641285;57075;57137.71431142818;57193.714031429576;57272;54818.451815482134;60173.69913150494;61682.69158654178;61767.6911615439;61851;13523.932380338036;13648.590542283748;13671.111377760413;13696.589102326947;13712.24582647944;10303.793924121475;10361.067503924683;10373.170146388271;10376.429296388771;10391.792164156826;16318.265678044516;16685.49943501697;16702.4154154604;16822.41121560764;16849.915750421416;6309.526785491106;6404.327545607737;6434.8391290218115;6435.581687190412;6547.770828020996;1007.1338648762058;1023.698009087321;1054.1988089052375;1069.2585679679069;1173.501261963662;31290;32560.837195814343;32695.50956735651;32965.36237356179;33040.50439243413;1145.9484323205477;1155.7977353963022;1183.1741741295632;1257.0320852943182;1258.6475786779715;16624.916875415547;17035.01564358607;17174.484765457055;17236.655266894842;17560.824391756174;375259;380118;382455;383269;385024;56598.71700641471;57140.71429642908;57217.42782572204;57240.713796430755;57307.140392894136;1174.671092094215;1265.8354413926131;1314.822498962647;1346.2864681718704;1379.92410417428;28601.713982859907;29906.401871962003;30137;30215.848920755256;30661;42165.367519486615;42525.36211956761;42593.78703106465;42617.57382426136;42642.78678606587;261179;262888;263937;264043;264527;38540.72403845705;39574.60425395709;40032;40092.59907401005;40147;45498;45585.316220256056;46126.769366152956;46609;46771;37976;38556.614433855306;38912.41631375475;38979.805100974314;39128.2174356517;36875.81562092173;37478.62521374752;38079;38339.424908625835;38639.22721545609;38589.61410385973;39228.803855980535;39290.2141957165;40013.79993100016;40118.39822402608;34097;34690.47964280588;35138.29723405466;35270;35270.29459410849;26764.732352676223;27041;27208.455830883668;27293;27863.721362786113 13:16:00 INFO - PROCESS | 18827 | |2;jquery.html;375.99624003759965;379.1828609346857;379.35698990211586;382.12493390136586;386.92648396804606;17512.912435437836;18911.338103166392;19024.14391352389;19805.900970495146;19809.40571782849;17498;17879.910600447012;18069.548261293443;18096.457106286798;18458.261669533236;5523.28197334346;5613.326400831886;5759.251297331362;5801.854953626172;5810.1865738796605;5598.804041858536;5608.327000759915;5662.886742265152;5668.093105103184;5668.518175955049;5380.784768609251;5602.327720673505;5610.24261724668;5617.859553511174;5618.747156377953;5576.414476479952;5606.915896261539;5609.242752228438;5610.130429783369;5611.158326251054;4869.123557759602;4918.877028074291;4930.975345123252;4958.132326842788;4970.105381031413;21742.347729568137;21877;22194.88902555493;22666.88666556673;22733;2275.306031660343;2364.231624721955;2386.0575072846127;2418.8548687078655;2475.554400207962;9302.767430814216;9764.804703905882;9780.119789219005;9856.605735770561;9960.053794889474;1928.9614207715767;1998.8300994415492;2003.278819624934;2035.297822251321;2100.6008858316873;63997;67804;77742.61128694376;79437.60281198558;81041.18958810455;10363.792724145474;10481.947590262;10686.771021332646;10752;10902.454877256265;15238.238088095552;15314.310856011507;15334.233288335761;15343.309551070228;15367.231638418034;6451.161349024596;6503.382178693017;6722.495812813961;6858.897116543256;6867.759628413081;6039.456448919618;6275.1842260506755;6286.748530058747;6352.2694890087305;6396.840078998062;4511.616512596466;4513.210188217049;4545.727256364563;4571.81712731487;4643.094596553639;1839.2826797548967;1883.5385330594092;1889.952751181204;1923.6056608395245;1990.8208261256266;457.3825335796714;958.1459875141484;1006.00405598457;1071.483390522024;1084.6908631040117;10527.526261318259;11047.337159770439;11159.27464714791;11166.944165279285;11211.159163062803;462.32500549198545;465.3438651501367;469.7439895257093;474.8646635708806;477.99522004780204;5959.523238140939;6087.360827113178;6141.938580614226;6190.2571691397325;6197.628142311476;451840;455849;474730;479615;480122;55426.16860747092;92905.52014864265;93033.5348323254;93066.14224191634;94540.52729736308;445.9130469558405;454.5000499450578;480.4474853918022;480.67554400779335;483.32576056401126;11229.887701122883;11246.1565382595;11270.267432616854;11272.718182045515;11294.548218071513;36655.81672091623;37569.43645845369;38802;38938.309177539304;39396.60603393929;52335.73832130815;54118;54321.72839135779;54351.72824136012;54459;7988.720394786154;8134.959325203336;8342.09951769443;8403.495790252604;8543.829123417621;11991;12768.936155319165;12794.232346059267;12808.615741527768;13005.47978080904;10819.459027048773;11225.831612525655;11426.400303957287;11442.656720298404;11530.654080377602;10910;11051.226414151253;11099.223054386439;11409.144314176305;11447.942760286145;11434.771304574027;11469.483873225558;11508.59719909799;11586;11681.766364672829;8170.754877353689;8189.344852411912;8309.293710034473;8361.665533378597;8413.032501262433;10849.403282819521;11106.888931110585;11194.66416007521;11285.605003825156;11416 13:16:00 INFO - PROCESS | 18827 | |3;mootools.html;1353.9864601353984;1502.8046353973984;1507.3819733909097;1672.665466906619;1823.4894229615695;7227.783166505007;8133.755987320383;8384.8742268866;8385.622646980884;8389.58052097395;8277.461964972272;8345.290650294717;8353.749387518385;8375.748727538183;8401.41190116692;1960.4412742368427;2236.284388995522;2271.2391348898054;2278.305116939337;2292.977070229293;2269.273832373641;2289.0271634555247;2290.5189910118893;2290.541891621674;2290.9083636654514;2235.105957616958;2246.9775302247012;2278.316505048487;2278.943026424336;2283.805876500491;1917.0606402862636;2174.630312846804;2229.3980625231097;2231.0295021665547;2244.3267019893965;2135.338045205991;2139.6362618354915;2151.9139234430604;2153.558520503309;2155.1918030738475;7966.32286255669;7983.920160798376;8044.034715834079;8060.758177254692;8091.474054186459;4699.224627936386;4919.557239848431;4920.655554111214;4924.507549245082;4929.2359684248995;3248.4964830451318;3266.738660907122;3313.0557791029682;3341;3349.966500335014;1147.122451324729;1147.351746263367;1151.6199654114123;1157.1552766480431;1187.7446349034913;11344.489497972529;11348.659540213806;11349;11389.316641001484;11424.657260282122;4269.530351661315;4279.614834664895;4440.4671439427475;4442.977785111054;4533.365328853963;9738.36700614472;9768.26737994639;9770.951145244228;9775.266854985905;9786.608535658635;4973.5523802857915;4988.700677959334;4993.775280112403;4998.550130488274;5016.297718319438;3938.940915886264;4521.457425109008;4609.124266389375;4618.076384723002;4618.168729628632;3611.963880361163;3694.7967861767324;3711;3862.4399462078404;3880.3209438348176;1221.5968730318973;1222.975540489203;1231.6181983585118;1234.8765123487578;1248.3446190749928;934.6681927915628;934.948577828226;941.8792781580585;948.7343543807744;957.9329446938787;5550.087188532075;5646.830595082154;5660.490555849911;5777.913331300034;5854.092615644582;434.7217780620405;440.45603679456485;443.3991940920071;443.7892001299357;453.580438094761;3763.7741735495956;3836.290286297044;3854.49891514107;3871.8838434847;3914.0606254498716;9941.254405919584;10191.439470829027;10312.639057632947;10402.115820155372;10416.218783591261;10098.242631802645;10160.898391016142;10237.897621023843;10290.331128476626;10372.27394082407;7762.728304509315;7805.102413222438;7808.5314881107315;7893.881591776128;7911.960440197878;5346.705931173823;5480.835574932758;5511.311086114236;5561.527270181918;5566.944330556805;9129.726108216764;9279;9286.535673216176;9309;9342.346035777431;9017.413868098552;9388.67139650109;9509.524523773645;9558.091981261769;9632.036796320312;7302.2697730226555;7376.631168441664;7451.068616422947;7490.5131166476185;7500.737474188377;7827.334676552557;7830.334421574002;7918.129005809241;8079.83840323202;8094.109647938604;7274.090738657668;7425;7448.366888814295;7506.512076714996;7533.020707308015;7147.392471639969;7266.600336981517;7272.200057993722;7342.229065948212;7481.887771683538;6803.727850886107;6820.35206655367;6863.485238607024;6866.588004719732;6882.139732533434;4799.640026997919;4844.636652251166;5011.899762004812;5025.045241404122;5057.165567681439;5000.724960127082;5026.4973502649445;5085.872853178552;5090.694558326364;5113.565346945403 13:16:00 INFO - PROCESS | 18827 | |4;prototype.html;313.8164173958234;314.47796657548474;314.50465516811016;315.5503407644108;319.5302904730046;5678.48893599576;5680.375158732541;5690.4594063564;5719.857003574913;5721.971390143043;5639.492445679888;5662.405447428023;5667.149927510875;5671.404502527237;5673.375928647845;4005.7796821174825;4091.9386209206887;4257.531671516131;4259.424977628011;4263.296556068245;4286.914261714764;4292.97853510732;4304.182205380983;4314.503832059322;4344.522102568715;4252.596003379674;4291.806868690916;4305.052888364555;4318.611324980751;4330;4134.669226461906;4170.623694180913;4282.293421585435;4310.633596144332;4318.762468064271;3764.7741135531955;3779.0741268389147;3782.9432558511644;3784.448376165786;3790.4882840816413;5410.945890541123;5417.322834645669;5420.620556561043;5427.755750991176;5453.182022696587;4810.903781924377;4933.260010998343;4943.6539442239055;4967.403911530603;4971.751412429364;5839.7736475340225;5861.6483011019045;5870.823875283749;5897.115432685088;5903.852403689899;4156.875293741193;4157.276983575763;4171.144915292388;4172.561881002512;4182.059036716714;5812.360640329561;5939.613925094855;5946.226990491295;6146.723397447081;6166.506679465632;4066.776327302027;4109.404136400205;4133.532595928462;4134;4136.73111247768;4139.337705967031;4184.644305234028;4185.576903852705;4194.951262184454;4219.831206751757;4729;4879.56083952446;4891.217405215149;4894.070126675992;4910.950890491121;5961.880762384728;5990.580659353891;6002.669853158118;6004.639721616717;6010.939890601126;1499.4002399040253;1501.9549413517611;1512.4933147395745;1521.9391224350902;1522.5812901451968;997.1524204426324;1007.3804610164696;1022.3559157730582;1034.043509753475;1039.9376037437778;5559.360673522516;5562.860928476821;5586.329640443091;5650.491455768918;5654.604177707603;6011.939880601226;6022.789202377896;6043.305019922677;6043.307873795345;6064.362002528914;5511.090670039479;5604.719764011783;5624.55003599711;5661.122526008476;5687.090065589486;3234.094453553009;3234.8677962712864;3236.12624591359;3246.7077962983444;3263.592050993626;6090.147379366892;6279.340669229757;6284.340144284875;6298.874022519524;6299.181106456132;6124.908126378108;6153.692315384303;6164.568480206342;6173.753049878044;6180.690965451709;6202.2867370253;6252.781152659635;6254.530910181664;6272.968635156795;6294.370562943761;5841.561882858718;6088.786892458743;6183.114150184237;6218.720157593009;6234.906476402948;6082.756689732538;6096.481799046954;6108.816735497942;6111.180512179888;6135.11040899076;5987.730552125077;6060.787872424444;6256.186695729708;6266.37336266388;6283.842903927439;3942.5071866016747;4064.4716186895516;4072.3484242521054;4078.0620457294394;4083.1425400666194;6076.908846367396;6085.847853803691;6086.60437071589;6145.754169833335;6171.876562468815;5781.624194427349;5971.790987315423;5988.700564971821;6024.216851809412;6028.819135425944;5945.613535120204;5948.2862056553495;5996.220491336098;5997.250343707036;6010.579259451972;5697.57268204878;5809.302883653989;5812.9709351452975;5824.271966004249;5902.468777809846;5986.311574169026;6012.789552365646;6015.5488338373925;6018.458338749533;6027.879442411039;5859.94140058611;5869.853253668522;5872.060470324727;5877.441643043904;5890.617109887844 13:16:00 INFO - PROCESS | 18827 | |5;yui.html;753.9660715267812;831.401390998481;837.572837852695;861.5950503263468;884.1423818895671;14541.491047813328;14665.780013299782;14814.999999999987;14834.925825370858;14923.104613723171;13601.251931143808;13854.445822167101;13872.583822485316;13875.30623468825;13894.096883702552;664.6211659354146;799.1968072087544;814.4624547798454;829.1666874790827;831.8793774902636;814.1776805426503;815.9428839981204;816.0819078536646;816.1675091406762;816.1919699497485;864.6800683747023;866.6576702202626;867.3061550759398;867.3841572483544;868.2923417414818;692.9584224946494;831.6673330667721;852.2840813716508;854.406187699549;854.9529775862325;617.9042248451452;620.4478014567039;623.9625622462667;624.2041397218537;624.5347216323868;14193.432262709479;14295.57113286603;14307.499237526637;14313.06965047279;14334.068285561509;13156.6710832229;13463.730725385438;13508.527201547899;13531.32343382827;14181.078229915023;10774.5690172393;10852.67441976742;10857.185711071623;10881.945590272077;10882.564697412094;3938.3107956107565;3966.5636779954184;3980.980095099506;3995.1610161866042;4076.9388459172837;57682.42317576813;57956.71021644865;57971.420285797445;58043;58048.70975645179;10329.225308101923;10589.57641694339;10778.730531736612;10803.081738052197;10825.296355736851;18141.818581814277;18317.90841045813;18391.26434942614;18395.448136555926;18892.149853256637;8232.382571307056;8269.710560130367;8322.70870519529;8403.369747268856;8435.915640843636;4588.908221835544;4613.086345981449;4617.8383756568355;4712.128256272601;4712.5994290485005;3231.74146068314;3323.567936168283;3326.6340702522702;3330.8334583271226;3334.1997920498907;592.8577141486098;593.4273426143792;596.2040675697991;597.4085655201319;600.7566935391086;671.9563228390236;685.9965700171467;740.0564280542352;740.2042803985737;754.2269174096485;9692.079252471003;9786.902130978742;10053;10199;10270.178385729123;738.6491416577082;754.4492520460095;758.1963119093779;763.8014116329795;779.7699678594828;4284;4304.268274393298;4555.157295900269;4556.635469162459;4655.162070827216;61077.69461152755;61423.38576614266;62520.687396562724;62738.372616274166;62884.37115628877;53842.46157538453;53864.730676346364;53920.19119713207;55000.17499737507;55720.72139639357;49484.257736133986;49487.505124949006;50293.49706502888;50324;50795.74602126966;8456.613159392946;8503.23470887623;8717.869231961653;8756.79479111426;8787.34094942869;30414.543781842847;30632.693673062982;31080.689193108683;31134.532982004836;31587;42897.35653965131;45190.548094518635;45278.54721452743;45338.773306133255;45445.318320224564;11025.117990560897;11052.447377631248;11056.502457389597;11104.333739975627;11328;11852.525898963944;11895.643130706092;12066.276023438622;12526.561570344995;12555.93722031384;11633.6509904703;11740.354280514654;11858.288502689866;12031.578894738643;12279.570215042431;11343.886561134283;11453.370064646524;11730.589429369931;11828.645140645795;12159.635210943687;11580.247283926517;11785.116116291141;11958.701032474257;12018.939905300418;12375.443105060114;9587.137157655845;9612.18296444782;9621.326507144713;9630.807383852423;10027.548760305657;9840.753981150528;9913.206943444364;9959.651412200537;9969.800603988024;10275.126614237874 13:16:00 INFO - PROCESS | 18827 | __end_tp_report 13:16:00 INFO - PROCESS | 18827 | __start_cc_report 13:16:00 INFO - PROCESS | 18827 | _x_x_mozilla_cycle_collect,825 13:16:00 INFO - PROCESS | 18827 | __end_cc_report 13:16:00 INFO - PROCESS | 18827 | __startTimestamp1461096960682__endTimestamp 13:16:00 INFO - PROCESS | 18827 | 13:16:00 INFO - PROCESS | 18827 | ------- Summary: start ------- 13:16:00 INFO - PROCESS | 18827 | Number of tests: 6 13:16:00 INFO - PROCESS | 18827 | 13:16:00 INFO - PROCESS | 18827 | [#0] dojo.html Cycles:165 Average:5192.01 Median:5413.51 stddev:566.99 (10.5%) stddev-sans-first:544.54 13:16:00 INFO - PROCESS | 18827 | Values: 3103.4 3127.1 3137.1 3164.8 3197.3 5098.5 5137.5 5227.6 5255.6 5306.8 5196.6 5278.1 5284.6 5294.6 5296.3 4707.2 4752.9 4838.6 4871.7 4882.4 4711.0 4810.1 4851.1 4855.6 4871.7 4710.2 4716.2 4724.6 4751.4 4785.0 4690.3 4697.2 4704.9 4716.1 4737.1 4642.6 4685.7 4696.8 4717.1 4767.5 5141.8 5167.6 5171.2 5178.3 5186.3 5588.6 5589.1 5589.9 5630.9 5640.0 5448.1 5631.0 5657.3 5716.0 5735.8 5191.8 5221.9 5224.3 5227.1 5228.3 5671.4 5673.7 5677.1 5678.1 5679.2 5431.6 5449.6 5472.3 5497.7 5510.1 5506.1 5507.4 5508.9 5510.4 5515.9 5419.8 5496.7 5502.1 5506.4 5546.5 5558.7 5579.5 5592.0 5612.4 5631.1 4255.4 4265.9 4270.4 4286.8 4308.4 3832.8 3841.4 3872.6 3887.6 3893.7 5350.7 5368.6 5369.2 5374.6 5415.0 5664.7 5680.1 5708.8 5709.0 5711.0 5155.3 5194.6 5293.9 5347.4 5418.0 4833.5 4852.2 4856.2 4877.3 4888.3 5780.9 5781.8 5782.9 5785.7 5788.4 5415.6 5528.6 5581.3 5600.6 5601.5 5726.8 5746.9 5747.8 5751.1 5774.1 5437.6 5452.8 5459.5 5460.1 5464.1 5466.6 5615.7 5661.4 5672.2 5699.7 5454.2 5454.5 5454.7 5460.9 5463.9 5270.4 5447.3 5450.3 5450.7 5492.6 5353.8 5387.1 5413.5 5430.0 5442.8 5386.4 5418.2 5420.2 5420.6 5422.8 5264.8 5332.9 5348.8 5380.0 5391.3 13:16:00 INFO - PROCESS | 18827 | 13:16:00 INFO - PROCESS | 18827 | [#1] ext.html Cycles:180 Average:48242.71 Median:38573.11 stddev:82246.11 (213.2%) stddev-sans-first:82399.05 13:16:00 INFO - PROCESS | 18827 | Values: 601.4 621.8 646.1 657.6 665.4 29652.6 30378.5 30442.7 37465.6 38533.0 39652.4 40057.4 40227.8 40242.8 40264.8 8451.2 8675.1 8675.6 8677.2 8681.7 8476.4 8576.7 8585.8 8591.0 8604.2 8573.7 8574.7 8638.7 8842.3 8850.3 8673.6 8762.2 8764.8 8766.9 8778.8 8688.4 8789.3 8799.1 8801.3 8802.7 40080.2 40328.0 40666.2 40717.0 40748.0 3397.9 3509.3 3534.8 3577.7 3944.7 31262.4 31857.0 32059.8 32115.5 32120.7 4024.1 4085.1 4095.5 4164.4 4194.4 282692.0 283339.0 284127.6 284163.0 284522.0 56524.7 57075.0 57137.7 57193.7 57272.0 54818.5 60173.7 61682.7 61767.7 61851.0 13523.9 13648.6 13671.1 13696.6 13712.2 10303.8 10361.1 10373.2 10376.4 10391.8 16318.3 16685.5 16702.4 16822.4 16849.9 6309.5 6404.3 6434.8 6435.6 6547.8 1007.1 1023.7 1054.2 1069.3 1173.5 31290.0 32560.8 32695.5 32965.4 33040.5 1145.9 1155.8 1183.2 1257.0 1258.6 16624.9 17035.0 17174.5 17236.7 17560.8 375259.0 380118.0 382455.0 383269.0 385024.0 56598.7 57140.7 57217.4 57240.7 57307.1 1174.7 1265.8 1314.8 1346.3 1379.9 28601.7 29906.4 30137.0 30215.8 30661.0 42165.4 42525.4 42593.8 42617.6 42642.8 261179.0 262888.0 263937.0 264043.0 264527.0 38540.7 39574.6 40032.0 40092.6 40147.0 45498.0 45585.3 46126.8 46609.0 46771.0 37976.0 38556.6 38912.4 38979.8 39128.2 36875.8 37478.6 38079.0 38339.4 38639.2 38589.6 39228.8 39290.2 40013.8 40118.4 34097.0 34690.5 35138.3 35270.0 35270.3 26764.7 27041.0 27208.5 27293.0 27863.7 13:16:00 INFO - PROCESS | 18827 | 13:16:00 INFO - PROCESS | 18827 | [#2] jquery.html Cycles:180 Average:26991.04 Median:228176.61 stddev:77283.71 (33.9%) stddev-sans-first:77474.67 13:16:00 INFO - PROCESS | 18827 | Values: 376.0 379.2 379.4 382.1 386.9 17512.9 18911.3 19024.1 19805.9 19809.4 17498.0 17879.9 18069.5 18096.5 18458.3 5523.3 5613.3 5759.3 5801.9 5810.2 5598.8 5608.3 5662.9 5668.1 5668.5 5380.8 5602.3 5610.2 5617.9 5618.7 5576.4 5606.9 5609.2 5610.1 5611.2 4869.1 4918.9 4931.0 4958.1 4970.1 21742.3 21877.0 22194.9 22666.9 22733.0 2275.3 2364.2 2386.1 2418.9 2475.6 9302.8 9764.8 9780.1 9856.6 9960.1 1929.0 1998.8 2003.3 2035.3 2100.6 63997.0 67804.0 77742.6 79437.6 81041.2 10363.8 10481.9 10686.8 10752.0 10902.5 15238.2 15314.3 15334.2 15343.3 15367.2 6451.2 6503.4 6722.5 6858.9 6867.8 6039.5 6275.2 6286.7 6352.3 6396.8 4511.6 4513.2 4545.7 4571.8 4643.1 1839.3 1883.5 1890.0 1923.6 1990.8 457.4 958.1 1006.0 1071.5 1084.7 10527.5 11047.3 11159.3 11166.9 11211.2 462.3 465.3 469.7 474.9 478.0 5959.5 6087.4 6141.9 6190.3 6197.6 451840.0 455849.0 474730.0 479615.0 480122.0 55426.2 92905.5 93033.5 93066.1 94540.5 445.9 454.5 480.4 480.7 483.3 11229.9 11246.2 11270.3 11272.7 11294.5 36655.8 37569.4 38802.0 38938.3 39396.6 52335.7 54118.0 54321.7 54351.7 54459.0 7988.7 8135.0 8342.1 8403.5 8543.8 11991.0 12768.9 12794.2 12808.6 13005.5 10819.5 11225.8 11426.4 11442.7 11530.7 10910.0 11051.2 11099.2 11409.1 11447.9 11434.8 11469.5 11508.6 11586.0 11681.8 8170.8 8189.3 8309.3 8361.7 8413.0 10849.4 11106.9 11194.7 11285.6 11416.0 13:16:00 INFO - PROCESS | 18827 | 13:16:00 INFO - PROCESS | 18827 | [#3] mootools.html Cycles:180 Average:5467.88 Median:4951.39 stddev:3081.69 (62.2%) stddev-sans-first:3074.83 13:16:00 INFO - PROCESS | 18827 | Values: 1354.0 1502.8 1507.4 1672.7 1823.5 7227.8 8133.8 8384.9 8385.6 8389.6 8277.5 8345.3 8353.7 8375.7 8401.4 1960.4 2236.3 2271.2 2278.3 2293.0 2269.3 2289.0 2290.5 2290.5 2290.9 2235.1 2247.0 2278.3 2278.9 2283.8 1917.1 2174.6 2229.4 2231.0 2244.3 2135.3 2139.6 2151.9 2153.6 2155.2 7966.3 7983.9 8044.0 8060.8 8091.5 4699.2 4919.6 4920.7 4924.5 4929.2 3248.5 3266.7 3313.1 3341.0 3350.0 1147.1 1147.4 1151.6 1157.2 1187.7 11344.5 11348.7 11349.0 11389.3 11424.7 4269.5 4279.6 4440.5 4443.0 4533.4 9738.4 9768.3 9771.0 9775.3 9786.6 4973.6 4988.7 4993.8 4998.6 5016.3 3938.9 4521.5 4609.1 4618.1 4618.2 3612.0 3694.8 3711.0 3862.4 3880.3 1221.6 1223.0 1231.6 1234.9 1248.3 934.7 934.9 941.9 948.7 957.9 5550.1 5646.8 5660.5 5777.9 5854.1 434.7 440.5 443.4 443.8 453.6 3763.8 3836.3 3854.5 3871.9 3914.1 9941.3 10191.4 10312.6 10402.1 10416.2 10098.2 10160.9 10237.9 10290.3 10372.3 7762.7 7805.1 7808.5 7893.9 7912.0 5346.7 5480.8 5511.3 5561.5 5566.9 9129.7 9279.0 9286.5 9309.0 9342.3 9017.4 9388.7 9509.5 9558.1 9632.0 7302.3 7376.6 7451.1 7490.5 7500.7 7827.3 7830.3 7918.1 8079.8 8094.1 7274.1 7425.0 7448.4 7506.5 7533.0 7147.4 7266.6 7272.2 7342.2 7481.9 6803.7 6820.4 6863.5 6866.6 6882.1 4799.6 4844.6 5011.9 5025.0 5057.2 5000.7 5026.5 5085.9 5090.7 5113.6 13:16:00 INFO - PROCESS | 18827 | 13:16:00 INFO - PROCESS | 18827 | [#4] prototype.html Cycles:180 Average:4942.25 Median:5669.28 stddev:1489.07 (26.3%) stddev-sans-first:1452.15 13:16:00 INFO - PROCESS | 18827 | Values: 313.8 314.5 314.5 315.6 319.5 5678.5 5680.4 5690.5 5719.9 5722.0 5639.5 5662.4 5667.1 5671.4 5673.4 4005.8 4091.9 4257.5 4259.4 4263.3 4286.9 4293.0 4304.2 4314.5 4344.5 4252.6 4291.8 4305.1 4318.6 4330.0 4134.7 4170.6 4282.3 4310.6 4318.8 3764.8 3779.1 3782.9 3784.4 3790.5 5410.9 5417.3 5420.6 5427.8 5453.2 4810.9 4933.3 4943.7 4967.4 4971.8 5839.8 5861.6 5870.8 5897.1 5903.9 4156.9 4157.3 4171.1 4172.6 4182.1 5812.4 5939.6 5946.2 6146.7 6166.5 4066.8 4109.4 4133.5 4134.0 4136.7 4139.3 4184.6 4185.6 4195.0 4219.8 4729.0 4879.6 4891.2 4894.1 4911.0 5961.9 5990.6 6002.7 6004.6 6010.9 1499.4 1502.0 1512.5 1521.9 1522.6 997.2 1007.4 1022.4 1034.0 1039.9 5559.4 5562.9 5586.3 5650.5 5654.6 6011.9 6022.8 6043.3 6043.3 6064.4 5511.1 5604.7 5624.6 5661.1 5687.1 3234.1 3234.9 3236.1 3246.7 3263.6 6090.1 6279.3 6284.3 6298.9 6299.2 6124.9 6153.7 6164.6 6173.8 6180.7 6202.3 6252.8 6254.5 6273.0 6294.4 5841.6 6088.8 6183.1 6218.7 6234.9 6082.8 6096.5 6108.8 6111.2 6135.1 5987.7 6060.8 6256.2 6266.4 6283.8 3942.5 4064.5 4072.3 4078.1 4083.1 6076.9 6085.8 6086.6 6145.8 6171.9 5781.6 5971.8 5988.7 6024.2 6028.8 5945.6 5948.3 5996.2 5997.3 6010.6 5697.6 5809.3 5813.0 5824.3 5902.5 5986.3 6012.8 6015.5 6018.5 6027.9 5859.9 5869.9 5872.1 5877.4 5890.6 13:16:00 INFO - PROCESS | 18827 | 13:16:00 INFO - PROCESS | 18827 | [#5] yui.html Cycles:180 Average:14598.41 Median:4615.46 stddev:17178.66 (372.2%) stddev-sans-first:17195.39 13:16:00 INFO - PROCESS | 18827 | Values: 754.0 831.4 837.6 861.6 884.1 14541.5 14665.8 14815.0 14834.9 14923.1 13601.3 13854.4 13872.6 13875.3 13894.1 664.6 799.2 814.5 829.2 831.9 814.2 815.9 816.1 816.2 816.2 864.7 866.7 867.3 867.4 868.3 693.0 831.7 852.3 854.4 855.0 617.9 620.4 624.0 624.2 624.5 14193.4 14295.6 14307.5 14313.1 14334.1 13156.7 13463.7 13508.5 13531.3 14181.1 10774.6 10852.7 10857.2 10881.9 10882.6 3938.3 3966.6 3981.0 3995.2 4076.9 57682.4 57956.7 57971.4 58043.0 58048.7 10329.2 10589.6 10778.7 10803.1 10825.3 18141.8 18317.9 18391.3 18395.4 18892.1 8232.4 8269.7 8322.7 8403.4 8435.9 4588.9 4613.1 4617.8 4712.1 4712.6 3231.7 3323.6 3326.6 3330.8 3334.2 592.9 593.4 596.2 597.4 600.8 672.0 686.0 740.1 740.2 754.2 9692.1 9786.9 10053.0 10199.0 10270.2 738.6 754.4 758.2 763.8 779.8 4284.0 4304.3 4555.2 4556.6 4655.2 61077.7 61423.4 62520.7 62738.4 62884.4 53842.5 53864.7 53920.2 55000.2 55720.7 49484.3 49487.5 50293.5 50324.0 50795.7 8456.6 8503.2 8717.9 8756.8 8787.3 30414.5 30632.7 31080.7 31134.5 31587.0 42897.4 45190.5 45278.5 45338.8 45445.3 11025.1 11052.4 11056.5 11104.3 11328.0 11852.5 11895.6 12066.3 12526.6 12555.9 11633.7 11740.4 11858.3 12031.6 12279.6 11343.9 11453.4 11730.6 11828.6 12159.6 11580.2 11785.1 11958.7 12018.9 12375.4 9587.1 9612.2 9621.3 9630.8 10027.5 9840.8 9913.2 9959.7 9969.8 10275.1 13:16:00 INFO - PROCESS | 18827 | -------- Summary: end -------- 13:16:00 INFO - PROCESS | 18827 | 13:16:01 INFO - TEST-INFO | 18827: exit 0 13:16:01 INFO - TEST-OK | dromaeo_css | took 1111302ms 13:16:01 INFO - TEST-START | kraken 13:16:01 INFO - operating with platform_type : linux_ 13:16:01 INFO - Initialising browser for kraken test... 13:16:01 INFO - TEST-INFO | started process 19005 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp46fmXz/profile http://localhost:50564/getInfo.html) 13:16:05 INFO - PROCESS | 19005 | __metrics Screen width/height:1600/1200 13:16:05 INFO - PROCESS | 19005 | colorDepth:24 13:16:05 INFO - PROCESS | 19005 | Browser inner width/height: 1024/697 13:16:05 INFO - PROCESS | 19005 | __metrics 13:16:05 ERROR - PROCESS | 19005 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:16:06 INFO - TEST-INFO | 19005: exit 0 13:16:06 INFO - Browser initialized. 13:16:06 INFO - Running cycle 1/1 for kraken test... 13:16:06 INFO - TEST-INFO | started process 19085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp46fmXz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:16:18 INFO - PROCESS | 19085 | RSS: Main: 153391104 13:16:18 INFO - PROCESS | 19085 | 13:16:20 INFO - PROCESS | 19085 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50564/tests/kraken/driver.html?testName=audio-beat-detection) 13:16:21 INFO - PROCESS | 19085 | RSS: Main: 207962112 13:16:21 INFO - PROCESS | 19085 | 13:16:24 INFO - PROCESS | 19085 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50564/tests/kraken/driver.html?testName=audio-dft) 13:16:24 INFO - PROCESS | 19085 | RSS: Main: 193998848 13:16:24 INFO - PROCESS | 19085 | 13:16:28 INFO - PROCESS | 19085 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50564/tests/kraken/driver.html?testName=audio-fft) 13:16:28 INFO - PROCESS | 19085 | RSS: Main: 263598080 13:16:28 INFO - PROCESS | 19085 | 13:16:30 INFO - PROCESS | 19085 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50564/tests/kraken/driver.html?testName=audio-oscillator) 13:16:31 INFO - PROCESS | 19085 | RSS: Main: 173215744 13:16:31 INFO - PROCESS | 19085 | 13:16:33 INFO - PROCESS | 19085 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50564/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:16:34 INFO - PROCESS | 19085 | RSS: Main: 177799168 13:16:34 INFO - PROCESS | 19085 | 13:16:37 INFO - PROCESS | 19085 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50564/tests/kraken/driver.html?testName=imaging-darkroom) 13:16:37 INFO - PROCESS | 19085 | RSS: Main: 213581824 13:16:37 INFO - PROCESS | 19085 | 13:16:41 INFO - PROCESS | 19085 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50564/tests/kraken/driver.html?testName=imaging-desaturate) 13:16:41 INFO - PROCESS | 19085 | RSS: Main: 214245376 13:16:41 INFO - PROCESS | 19085 | 13:16:44 INFO - PROCESS | 19085 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50564/tests/kraken/driver.html?testName=json-parse-financial) 13:16:45 INFO - PROCESS | 19085 | RSS: Main: 213721088 13:16:45 INFO - PROCESS | 19085 | 13:16:46 INFO - PROCESS | 19085 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50564/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:16:47 INFO - PROCESS | 19085 | RSS: Main: 204718080 13:16:47 INFO - PROCESS | 19085 | 13:16:48 INFO - PROCESS | 19085 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50564/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:16:49 INFO - PROCESS | 19085 | RSS: Main: 204795904 13:16:49 INFO - PROCESS | 19085 | 13:16:51 INFO - PROCESS | 19085 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50564/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:16:52 INFO - PROCESS | 19085 | RSS: Main: 219361280 13:16:52 INFO - PROCESS | 19085 | 13:16:54 INFO - PROCESS | 19085 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50564/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:16:55 INFO - PROCESS | 19085 | RSS: Main: 223629312 13:16:55 INFO - PROCESS | 19085 | 13:16:58 INFO - PROCESS | 19085 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50564/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:16:58 INFO - PROCESS | 19085 | RSS: Main: 216662016 13:16:58 INFO - PROCESS | 19085 | 13:17:00 INFO - PROCESS | 19085 | Cycle 1(1): loaded http://localhost:50564/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50564/tests/kraken/driver.html?testName=ai-astar) 13:17:00 INFO - PROCESS | 19085 | RSS: Main: 279986176 13:17:00 INFO - PROCESS | 19085 | 13:17:00 INFO - PROCESS | 19085 | __start_tp_report 13:17:00 INFO - PROCESS | 19085 | _x_x_mozilla_page_load 13:17:00 INFO - PROCESS | 19085 | _x_x_mozilla_page_load_details 13:17:00 INFO - PROCESS | 19085 | |i|pagename|runs| 13:17:00 INFO - PROCESS | 19085 | |0;ai-astar;111;111;105;109;110;110;100;111;110;110 13:17:00 INFO - PROCESS | 19085 | |1;audio-beat-detection;152;127;153;178;137;148;158;133;181;129 13:17:00 INFO - PROCESS | 19085 | |2;audio-dft;161;162;161;160;160;160;161;161;161;161 13:17:00 INFO - PROCESS | 19085 | |3;audio-fft;72;88;101;119;77;73;73;128;111;74 13:17:00 INFO - PROCESS | 19085 | |4;audio-oscillator;93;94;151;92;92;93;150;93;92;151 13:17:00 INFO - PROCESS | 19085 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;117;116;117 13:17:00 INFO - PROCESS | 19085 | |6;imaging-darkroom;145;146;145;147;145;145;145;146;145;146 13:17:00 INFO - PROCESS | 19085 | |7;imaging-desaturate;94;95;94;94;94;94;95;94;94;95 13:17:00 INFO - PROCESS | 19085 | |8;json-parse-financial;59;59;59;58;59;57;58;78;57;56 13:17:00 INFO - PROCESS | 19085 | |9;json-stringify-tinderbox;60;60;60;61;61;61;61;61;61;61 13:17:00 INFO - PROCESS | 19085 | |10;stanford-crypto-aes;77;79;78;77;78;79;78;86;78;78 13:17:00 INFO - PROCESS | 19085 | |11;stanford-crypto-ccm;131;129;126;134;125;132;131;124;158;133 13:17:00 INFO - PROCESS | 19085 | |12;stanford-crypto-pbkdf2;169;176;171;173;167;168;171;168;172;167 13:17:00 INFO - PROCESS | 19085 | |13;stanford-crypto-sha256-iterative;71;68;69;69;69;69;69;71;69;71 13:17:00 INFO - PROCESS | 19085 | __end_tp_report 13:17:00 INFO - PROCESS | 19085 | __start_cc_report 13:17:00 INFO - PROCESS | 19085 | _x_x_mozilla_cycle_collect,1615 13:17:00 INFO - PROCESS | 19085 | __end_cc_report 13:17:00 INFO - PROCESS | 19085 | __startTimestamp1461097020873__endTimestamp 13:17:00 INFO - PROCESS | 19085 | 13:17:00 INFO - PROCESS | 19085 | ------- Summary: start ------- 13:17:00 INFO - PROCESS | 19085 | Number of tests: 14 13:17:00 INFO - PROCESS | 19085 | 13:17:00 INFO - PROCESS | 19085 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:3.53 (3.2%) stddev-sans-first:3.64 13:17:00 INFO - PROCESS | 19085 | Values: 111.0 111.0 105.0 109.0 110.0 110.0 100.0 111.0 110.0 110.0 13:17:00 INFO - PROCESS | 19085 | 13:17:00 INFO - PROCESS | 19085 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:152.50 stddev:19.01 (12.5%) stddev-sans-first:20.14 13:17:00 INFO - PROCESS | 19085 | Values: 152.0 127.0 153.0 178.0 137.0 148.0 158.0 133.0 181.0 129.0 13:17:00 INFO - PROCESS | 19085 | 13:17:00 INFO - PROCESS | 19085 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 13:17:00 INFO - PROCESS | 19085 | Values: 161.0 162.0 161.0 160.0 160.0 160.0 161.0 161.0 161.0 161.0 13:17:00 INFO - PROCESS | 19085 | 13:17:00 INFO - PROCESS | 19085 | [#3] audio-fft Cycles:10 Average:91.60 Median:73.00 stddev:21.48 (29.4%) stddev-sans-first:21.58 13:17:00 INFO - PROCESS | 19085 | Values: 72.0 88.0 101.0 119.0 77.0 73.0 73.0 128.0 111.0 74.0 13:17:00 INFO - PROCESS | 19085 | 13:17:00 INFO - PROCESS | 19085 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:92.50 stddev:28.00 (30.3%) stddev-sans-first:29.01 13:17:00 INFO - PROCESS | 19085 | Values: 93.0 94.0 151.0 92.0 92.0 93.0 150.0 93.0 92.0 151.0 13:17:00 INFO - PROCESS | 19085 | 13:17:00 INFO - PROCESS | 19085 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 13:17:00 INFO - PROCESS | 19085 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 13:17:00 INFO - PROCESS | 19085 | 13:17:00 INFO - PROCESS | 19085 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 13:17:00 INFO - PROCESS | 19085 | Values: 145.0 146.0 145.0 147.0 145.0 145.0 145.0 146.0 145.0 146.0 13:17:00 INFO - PROCESS | 19085 | 13:17:00 INFO - PROCESS | 19085 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:17:00 INFO - PROCESS | 19085 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 95.0 13:17:00 INFO - PROCESS | 19085 | 13:17:00 INFO - PROCESS | 19085 | [#8] json-parse-financial Cycles:10 Average:60.00 Median:59.00 stddev:6.41 (10.9%) stddev-sans-first:6.79 13:17:00 INFO - PROCESS | 19085 | Values: 59.0 59.0 59.0 58.0 59.0 57.0 58.0 78.0 57.0 56.0 13:17:00 INFO - PROCESS | 19085 | 13:17:00 INFO - PROCESS | 19085 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 13:17:00 INFO - PROCESS | 19085 | Values: 60.0 60.0 60.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 13:17:00 INFO - PROCESS | 19085 | 13:17:00 INFO - PROCESS | 19085 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.00 stddev:2.62 (3.4%) stddev-sans-first:2.69 13:17:00 INFO - PROCESS | 19085 | Values: 77.0 79.0 78.0 77.0 78.0 79.0 78.0 86.0 78.0 78.0 13:17:00 INFO - PROCESS | 19085 | 13:17:00 INFO - PROCESS | 19085 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:131.50 stddev:9.66 (7.3%) stddev-sans-first:10.24 13:17:00 INFO - PROCESS | 19085 | Values: 131.0 129.0 126.0 134.0 125.0 132.0 131.0 124.0 158.0 133.0 13:17:00 INFO - PROCESS | 19085 | 13:17:00 INFO - PROCESS | 19085 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:171.00 stddev:2.94 (1.7%) stddev-sans-first:3.08 13:17:00 INFO - PROCESS | 19085 | Values: 169.0 176.0 171.0 173.0 167.0 168.0 171.0 168.0 172.0 167.0 13:17:00 INFO - PROCESS | 19085 | 13:17:00 INFO - PROCESS | 19085 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.00 stddev:1.08 (1.6%) stddev-sans-first:1.00 13:17:00 INFO - PROCESS | 19085 | Values: 71.0 68.0 69.0 69.0 69.0 69.0 69.0 71.0 69.0 71.0 13:17:00 INFO - PROCESS | 19085 | -------- Summary: end -------- 13:17:00 INFO - PROCESS | 19085 | 13:17:01 INFO - TEST-INFO | 19085: exit 0 13:17:01 INFO - TEST-OK | kraken | took 60454ms 13:17:01 INFO - SUITE-END | took 1171s 13:17:02 INFO - Completed test suite (00:19:31) 13:17:02 INFO - javascript benchmark 13:17:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.4103520331137, 3127.061881435569, 3137.105924811428, 3164.778465507414, 3197.3285610021894, 5098.4901509849, 5137.511936366049, 5227.634065615409, 5255.632105752599, 5306.761195746191, 5196.558292545129, 5278.1291086970605, 5284.577233821295, 5294.629375943676, 5296.311479507668, 4707.223308154167, 4752.904941901169, 4838.612910967132, 4871.707697538159, 4882.438519570242, 4710.952890471103, 4810.110129626013, 4851.054044461332, 4855.56299933006, 4871.732054736988, 4710.246360582308, 4716.151092803294, 4724.5984091352275, 4751.382320298374, 4785.042991401716, 4690.273007683814, 4697.224957881946, 4704.929426058612, 4716.127516409475, 4737.147313483571, 4642.628589712815, 4685.718856868599, 4696.812127514895, 4717.127331443694, 4767.451743049559, 5141.794328226866, 5167.586593072545, 5171.172612382001, 5178.275041494194, 5186.325777648882, 5588.636738611977, 5589.105743081128, 5589.944100559023, 5630.859228519279, 5639.971800140973, 5448.128299472065, 5631.0, 5657.2928383952, 5716.0, 5735.799247026334, 5191.844244672666, 5221.895562088775, 5224.268602395668, 5227.059129356714, 5228.2941802856885, 5671.404502527175, 5673.744681489343, 5677.063284558084, 5678.0915053591225, 5679.176519404663, 5431.619786614978, 5449.618526703092, 5472.343318801769, 5497.670139791625, 5510.090835012258, 5506.091494903376, 5507.449255074541, 5508.889822203533, 5510.448955104538, 5515.944840551543, 5419.810306639249, 5496.725163741797, 5502.147167189092, 5506.366767821752, 5546.473085056913, 5558.749856256478, 5579.46995035471, 5592.049351610236, 5612.354579223442, 5631.099024156198, 4255.3829694694095, 4265.87202383929, 4270.423492828429, 4286.7856607169515, 4308.418363520947, 3832.80835958201, 3841.4045822897497, 3872.6320999505, 3887.591802860659, 3893.7079719021185, 5350.732463376893, 5368.624196306221, 5369.221462887859, 5374.596905232123, 5414.972925135428, 5664.745086471119, 5680.0627896397455, 5708.771649133988, 5709.029464990961, 5711.0, 5155.304033955443, 5194.6104042196985, 5293.894122117536, 5347.358317001985, 5418.02475554404, 4833.492483289274, 4852.1508735971065, 4856.223004319292, 4877.317175595348, 4888.315635810989, 5780.855478613068, 5781.768729250783, 5782.855428614318, 5785.652860828363, 5788.363280039192, 5415.566754659697, 5528.55771538284, 5581.330240371181, 5600.551955843604, 5601.5238704710555, 5726.770929162787, 5746.856328591819, 5747.770089196385, 5751.051076572318, 5774.1338799178775, 5437.619366644455, 5452.7546260417585, 5459.508644222039, 5460.099083651153, 5464.071107911744, 5466.590005749665, 5615.747291371979, 5661.433856614306, 5672.234248376416, 5699.7435115419075, 5454.154606036071, 5454.509094181542, 5454.699991500505, 5460.890782184255, 5463.918041229305, 5270.420253772006, 5447.319085114361, 5450.291462110059, 5450.672959622435, 5492.5605951524585, 5353.785848566014, 5387.0572649785345, 5413.512783849473, 5429.972850135724, 5442.836714898559, 5386.434424385383, 5418.241446197614, 5420.241166236809, 5420.620556561003, 5422.810201642924, 5264.763085661231, 5332.920006199987, 5348.7593058311695, 5380.031594313061, 5391.29913111293], "value": 5155.751500043352, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.4016054026245, 621.7761605821906, 646.0567571345834, 657.5528640524443, 665.3845193196295, 29652.555211671814, 30378.54432183516, 30442.69557304429, 37465.62534374656, 38533.0, 39652.40521392181, 40057.39913901294, 40227.79886100573, 40242.79878600603, 40264.79867600665, 8451.154884511545, 8675.132486751307, 8675.609597568093, 8677.1756683115, 8681.652733890636, 8476.406651534395, 8576.69981550646, 8585.785355366103, 8590.957045214765, 8604.225619694227, 8573.699920502784, 8574.69988550401, 8638.697645582406, 8842.336824738139, 8850.291976641885, 8673.609687564074, 8762.167594078552, 8764.824703505894, 8766.868496972551, 8778.824423511558, 8688.435251708619, 8789.25291350236, 8799.076097009785, 8801.339899507562, 8802.735917922473, 40080.19839603221, 40328.0, 40666.1866762666, 40717.0, 40748.0, 3397.8810741623925, 3509.31568344173, 3534.823258837048, 3577.695895848856, 3944.7320914915977, 31262.37475250505, 31857.0, 32059.839700801345, 32115.51826722601, 32120.678793212002, 4024.1146947671464, 4085.1216988347646, 4095.467589213413, 4164.4102406136735, 4194.3918131870705, 282692.0, 283339.0, 284127.57936210395, 284163.0, 284522.0, 56524.71737641285, 57075.0, 57137.71431142818, 57193.714031429576, 57272.0, 54818.451815482134, 60173.69913150494, 61682.69158654178, 61767.6911615439, 61851.0, 13523.932380338036, 13648.590542283748, 13671.111377760413, 13696.589102326947, 13712.24582647944, 10303.793924121475, 10361.067503924683, 10373.170146388271, 10376.429296388771, 10391.792164156826, 16318.265678044516, 16685.49943501697, 16702.4154154604, 16822.41121560764, 16849.915750421416, 6309.526785491106, 6404.327545607737, 6434.8391290218115, 6435.581687190412, 6547.770828020996, 1007.1338648762058, 1023.698009087321, 1054.1988089052375, 1069.2585679679069, 1173.501261963662, 31290.0, 32560.837195814343, 32695.50956735651, 32965.36237356179, 33040.50439243413, 1145.9484323205477, 1155.7977353963022, 1183.1741741295632, 1257.0320852943182, 1258.6475786779715, 16624.916875415547, 17035.01564358607, 17174.484765457055, 17236.655266894842, 17560.824391756174, 375259.0, 380118.0, 382455.0, 383269.0, 385024.0, 56598.71700641471, 57140.71429642908, 57217.42782572204, 57240.713796430755, 57307.140392894136, 1174.671092094215, 1265.8354413926131, 1314.822498962647, 1346.2864681718704, 1379.92410417428, 28601.713982859907, 29906.401871962003, 30137.0, 30215.848920755256, 30661.0, 42165.367519486615, 42525.36211956761, 42593.78703106465, 42617.57382426136, 42642.78678606587, 261179.0, 262888.0, 263937.0, 264043.0, 264527.0, 38540.72403845705, 39574.60425395709, 40032.0, 40092.59907401005, 40147.0, 45498.0, 45585.316220256056, 46126.769366152956, 46609.0, 46771.0, 37976.0, 38556.614433855306, 38912.41631375475, 38979.805100974314, 39128.2174356517, 36875.81562092173, 37478.62521374752, 38079.0, 38339.424908625835, 38639.22721545609, 38589.61410385973, 39228.803855980535, 39290.2141957165, 40013.79993100016, 40118.39822402608, 34097.0, 34690.47964280588, 35138.29723405466, 35270.0, 35270.29459410849, 26764.732352676223, 27041.0, 27208.455830883668, 27293.0, 27863.721362786113], "value": 18842.6968602716, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.99624003759965, 379.1828609346857, 379.35698990211586, 382.12493390136586, 386.92648396804606, 17512.912435437836, 18911.338103166392, 19024.14391352389, 19805.900970495146, 19809.40571782849, 17498.0, 17879.910600447012, 18069.548261293443, 18096.457106286798, 18458.261669533236, 5523.28197334346, 5613.326400831886, 5759.251297331362, 5801.854953626172, 5810.1865738796605, 5598.804041858536, 5608.327000759915, 5662.886742265152, 5668.093105103184, 5668.518175955049, 5380.784768609251, 5602.327720673505, 5610.24261724668, 5617.859553511174, 5618.747156377953, 5576.414476479952, 5606.915896261539, 5609.242752228438, 5610.130429783369, 5611.158326251054, 4869.123557759602, 4918.877028074291, 4930.975345123252, 4958.132326842788, 4970.105381031413, 21742.347729568137, 21877.0, 22194.88902555493, 22666.88666556673, 22733.0, 2275.306031660343, 2364.231624721955, 2386.0575072846127, 2418.8548687078655, 2475.554400207962, 9302.767430814216, 9764.804703905882, 9780.119789219005, 9856.605735770561, 9960.053794889474, 1928.9614207715767, 1998.8300994415492, 2003.278819624934, 2035.297822251321, 2100.6008858316873, 63997.0, 67804.0, 77742.61128694376, 79437.60281198558, 81041.18958810455, 10363.792724145474, 10481.947590262, 10686.771021332646, 10752.0, 10902.454877256265, 15238.238088095552, 15314.310856011507, 15334.233288335761, 15343.309551070228, 15367.231638418034, 6451.161349024596, 6503.382178693017, 6722.495812813961, 6858.897116543256, 6867.759628413081, 6039.456448919618, 6275.1842260506755, 6286.748530058747, 6352.2694890087305, 6396.840078998062, 4511.616512596466, 4513.210188217049, 4545.727256364563, 4571.81712731487, 4643.094596553639, 1839.2826797548967, 1883.5385330594092, 1889.952751181204, 1923.6056608395245, 1990.8208261256266, 457.3825335796714, 958.1459875141484, 1006.00405598457, 1071.483390522024, 1084.6908631040117, 10527.526261318259, 11047.337159770439, 11159.27464714791, 11166.944165279285, 11211.159163062803, 462.32500549198545, 465.3438651501367, 469.7439895257093, 474.8646635708806, 477.99522004780204, 5959.523238140939, 6087.360827113178, 6141.938580614226, 6190.2571691397325, 6197.628142311476, 451840.0, 455849.0, 474730.0, 479615.0, 480122.0, 55426.16860747092, 92905.52014864265, 93033.5348323254, 93066.14224191634, 94540.52729736308, 445.9130469558405, 454.5000499450578, 480.4474853918022, 480.67554400779335, 483.32576056401126, 11229.887701122883, 11246.1565382595, 11270.267432616854, 11272.718182045515, 11294.548218071513, 36655.81672091623, 37569.43645845369, 38802.0, 38938.309177539304, 39396.60603393929, 52335.73832130815, 54118.0, 54321.72839135779, 54351.72824136012, 54459.0, 7988.720394786154, 8134.959325203336, 8342.09951769443, 8403.495790252604, 8543.829123417621, 11991.0, 12768.936155319165, 12794.232346059267, 12808.615741527768, 13005.47978080904, 10819.459027048773, 11225.831612525655, 11426.400303957287, 11442.656720298404, 11530.654080377602, 10910.0, 11051.226414151253, 11099.223054386439, 11409.144314176305, 11447.942760286145, 11434.771304574027, 11469.483873225558, 11508.59719909799, 11586.0, 11681.766364672829, 8170.754877353689, 8189.344852411912, 8309.293710034473, 8361.665533378597, 8413.032501262433, 10849.403282819521, 11106.888931110585, 11194.66416007521, 11285.605003825156, 11416.0], "value": 8110.771042324224, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.9864601353984, 1502.8046353973984, 1507.3819733909097, 1672.665466906619, 1823.4894229615695, 7227.783166505007, 8133.755987320383, 8384.8742268866, 8385.622646980884, 8389.58052097395, 8277.461964972272, 8345.290650294717, 8353.749387518385, 8375.748727538183, 8401.41190116692, 1960.4412742368427, 2236.284388995522, 2271.2391348898054, 2278.305116939337, 2292.977070229293, 2269.273832373641, 2289.0271634555247, 2290.5189910118893, 2290.541891621674, 2290.9083636654514, 2235.105957616958, 2246.9775302247012, 2278.316505048487, 2278.943026424336, 2283.805876500491, 1917.0606402862636, 2174.630312846804, 2229.3980625231097, 2231.0295021665547, 2244.3267019893965, 2135.338045205991, 2139.6362618354915, 2151.9139234430604, 2153.558520503309, 2155.1918030738475, 7966.32286255669, 7983.920160798376, 8044.034715834079, 8060.758177254692, 8091.474054186459, 4699.224627936386, 4919.557239848431, 4920.655554111214, 4924.507549245082, 4929.2359684248995, 3248.4964830451318, 3266.738660907122, 3313.0557791029682, 3341.0, 3349.966500335014, 1147.122451324729, 1147.351746263367, 1151.6199654114123, 1157.1552766480431, 1187.7446349034913, 11344.489497972529, 11348.659540213806, 11349.0, 11389.316641001484, 11424.657260282122, 4269.530351661315, 4279.614834664895, 4440.4671439427475, 4442.977785111054, 4533.365328853963, 9738.36700614472, 9768.26737994639, 9770.951145244228, 9775.266854985905, 9786.608535658635, 4973.5523802857915, 4988.700677959334, 4993.775280112403, 4998.550130488274, 5016.297718319438, 3938.940915886264, 4521.457425109008, 4609.124266389375, 4618.076384723002, 4618.168729628632, 3611.963880361163, 3694.7967861767324, 3711.0, 3862.4399462078404, 3880.3209438348176, 1221.5968730318973, 1222.975540489203, 1231.6181983585118, 1234.8765123487578, 1248.3446190749928, 934.6681927915628, 934.948577828226, 941.8792781580585, 948.7343543807744, 957.9329446938787, 5550.087188532075, 5646.830595082154, 5660.490555849911, 5777.913331300034, 5854.092615644582, 434.7217780620405, 440.45603679456485, 443.3991940920071, 443.7892001299357, 453.580438094761, 3763.7741735495956, 3836.290286297044, 3854.49891514107, 3871.8838434847, 3914.0606254498716, 9941.254405919584, 10191.439470829027, 10312.639057632947, 10402.115820155372, 10416.218783591261, 10098.242631802645, 10160.898391016142, 10237.897621023843, 10290.331128476626, 10372.27394082407, 7762.728304509315, 7805.102413222438, 7808.5314881107315, 7893.881591776128, 7911.960440197878, 5346.705931173823, 5480.835574932758, 5511.311086114236, 5561.527270181918, 5566.944330556805, 9129.726108216764, 9279.0, 9286.535673216176, 9309.0, 9342.346035777431, 9017.413868098552, 9388.67139650109, 9509.524523773645, 9558.091981261769, 9632.036796320312, 7302.2697730226555, 7376.631168441664, 7451.068616422947, 7490.5131166476185, 7500.737474188377, 7827.334676552557, 7830.334421574002, 7918.129005809241, 8079.83840323202, 8094.109647938604, 7274.090738657668, 7425.0, 7448.366888814295, 7506.512076714996, 7533.020707308015, 7147.392471639969, 7266.600336981517, 7272.200057993722, 7342.229065948212, 7481.887771683538, 6803.727850886107, 6820.35206655367, 6863.485238607024, 6866.588004719732, 6882.139732533434, 4799.640026997919, 4844.636652251166, 5011.899762004812, 5025.045241404122, 5057.165567681439, 5000.724960127082, 5026.4973502649445, 5085.872853178552, 5090.694558326364, 5113.565346945403], "value": 4334.06098803687, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.8164173958234, 314.47796657548474, 314.50465516811016, 315.5503407644108, 319.5302904730046, 5678.48893599576, 5680.375158732541, 5690.4594063564, 5719.857003574913, 5721.971390143043, 5639.492445679888, 5662.405447428023, 5667.149927510875, 5671.404502527237, 5673.375928647845, 4005.7796821174825, 4091.9386209206887, 4257.531671516131, 4259.424977628011, 4263.296556068245, 4286.914261714764, 4292.97853510732, 4304.182205380983, 4314.503832059322, 4344.522102568715, 4252.596003379674, 4291.806868690916, 4305.052888364555, 4318.611324980751, 4330.0, 4134.669226461906, 4170.623694180913, 4282.293421585435, 4310.633596144332, 4318.762468064271, 3764.7741135531955, 3779.0741268389147, 3782.9432558511644, 3784.448376165786, 3790.4882840816413, 5410.945890541123, 5417.322834645669, 5420.620556561043, 5427.755750991176, 5453.182022696587, 4810.903781924377, 4933.260010998343, 4943.6539442239055, 4967.403911530603, 4971.751412429364, 5839.7736475340225, 5861.6483011019045, 5870.823875283749, 5897.115432685088, 5903.852403689899, 4156.875293741193, 4157.276983575763, 4171.144915292388, 4172.561881002512, 4182.059036716714, 5812.360640329561, 5939.613925094855, 5946.226990491295, 6146.723397447081, 6166.506679465632, 4066.776327302027, 4109.404136400205, 4133.532595928462, 4134.0, 4136.73111247768, 4139.337705967031, 4184.644305234028, 4185.576903852705, 4194.951262184454, 4219.831206751757, 4729.0, 4879.56083952446, 4891.217405215149, 4894.070126675992, 4910.950890491121, 5961.880762384728, 5990.580659353891, 6002.669853158118, 6004.639721616717, 6010.939890601126, 1499.4002399040253, 1501.9549413517611, 1512.4933147395745, 1521.9391224350902, 1522.5812901451968, 997.1524204426324, 1007.3804610164696, 1022.3559157730582, 1034.043509753475, 1039.9376037437778, 5559.360673522516, 5562.860928476821, 5586.329640443091, 5650.491455768918, 5654.604177707603, 6011.939880601226, 6022.789202377896, 6043.305019922677, 6043.307873795345, 6064.362002528914, 5511.090670039479, 5604.719764011783, 5624.55003599711, 5661.122526008476, 5687.090065589486, 3234.094453553009, 3234.8677962712864, 3236.12624591359, 3246.7077962983444, 3263.592050993626, 6090.147379366892, 6279.340669229757, 6284.340144284875, 6298.874022519524, 6299.181106456132, 6124.908126378108, 6153.692315384303, 6164.568480206342, 6173.753049878044, 6180.690965451709, 6202.2867370253, 6252.781152659635, 6254.530910181664, 6272.968635156795, 6294.370562943761, 5841.561882858718, 6088.786892458743, 6183.114150184237, 6218.720157593009, 6234.906476402948, 6082.756689732538, 6096.481799046954, 6108.816735497942, 6111.180512179888, 6135.11040899076, 5987.730552125077, 6060.787872424444, 6256.186695729708, 6266.37336266388, 6283.842903927439, 3942.5071866016747, 4064.4716186895516, 4072.3484242521054, 4078.0620457294394, 4083.1425400666194, 6076.908846367396, 6085.847853803691, 6086.60437071589, 6145.754169833335, 6171.876562468815, 5781.624194427349, 5971.790987315423, 5988.700564971821, 6024.216851809412, 6028.819135425944, 5945.613535120204, 5948.2862056553495, 5996.220491336098, 5997.250343707036, 6010.579259451972, 5697.57268204878, 5809.302883653989, 5812.9709351452975, 5824.271966004249, 5902.468777809846, 5986.311574169026, 6012.789552365646, 6015.5488338373925, 6018.458338749533, 6027.879442411039, 5859.94140058611, 5869.853253668522, 5872.060470324727, 5877.441643043904, 5890.617109887844], "value": 4460.34194852888, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.9660715267812, 831.401390998481, 837.572837852695, 861.5950503263468, 884.1423818895671, 14541.491047813328, 14665.780013299782, 14814.999999999987, 14834.925825370858, 14923.104613723171, 13601.251931143808, 13854.445822167101, 13872.583822485316, 13875.30623468825, 13894.096883702552, 664.6211659354146, 799.1968072087544, 814.4624547798454, 829.1666874790827, 831.8793774902636, 814.1776805426503, 815.9428839981204, 816.0819078536646, 816.1675091406762, 816.1919699497485, 864.6800683747023, 866.6576702202626, 867.3061550759398, 867.3841572483544, 868.2923417414818, 692.9584224946494, 831.6673330667721, 852.2840813716508, 854.406187699549, 854.9529775862325, 617.9042248451452, 620.4478014567039, 623.9625622462667, 624.2041397218537, 624.5347216323868, 14193.432262709479, 14295.57113286603, 14307.499237526637, 14313.06965047279, 14334.068285561509, 13156.6710832229, 13463.730725385438, 13508.527201547899, 13531.32343382827, 14181.078229915023, 10774.5690172393, 10852.67441976742, 10857.185711071623, 10881.945590272077, 10882.564697412094, 3938.3107956107565, 3966.5636779954184, 3980.980095099506, 3995.1610161866042, 4076.9388459172837, 57682.42317576813, 57956.71021644865, 57971.420285797445, 58043.0, 58048.70975645179, 10329.225308101923, 10589.57641694339, 10778.730531736612, 10803.081738052197, 10825.296355736851, 18141.818581814277, 18317.90841045813, 18391.26434942614, 18395.448136555926, 18892.149853256637, 8232.382571307056, 8269.710560130367, 8322.70870519529, 8403.369747268856, 8435.915640843636, 4588.908221835544, 4613.086345981449, 4617.8383756568355, 4712.128256272601, 4712.5994290485005, 3231.74146068314, 3323.567936168283, 3326.6340702522702, 3330.8334583271226, 3334.1997920498907, 592.8577141486098, 593.4273426143792, 596.2040675697991, 597.4085655201319, 600.7566935391086, 671.9563228390236, 685.9965700171467, 740.0564280542352, 740.2042803985737, 754.2269174096485, 9692.079252471003, 9786.902130978742, 10053.0, 10199.0, 10270.178385729123, 738.6491416577082, 754.4492520460095, 758.1963119093779, 763.8014116329795, 779.7699678594828, 4284.0, 4304.268274393298, 4555.157295900269, 4556.635469162459, 4655.162070827216, 61077.69461152755, 61423.38576614266, 62520.687396562724, 62738.372616274166, 62884.37115628877, 53842.46157538453, 53864.730676346364, 53920.19119713207, 55000.17499737507, 55720.72139639357, 49484.257736133986, 49487.505124949006, 50293.49706502888, 50324.0, 50795.74602126966, 8456.613159392946, 8503.23470887623, 8717.869231961653, 8756.79479111426, 8787.34094942869, 30414.543781842847, 30632.693673062982, 31080.689193108683, 31134.532982004836, 31587.0, 42897.35653965131, 45190.548094518635, 45278.54721452743, 45338.773306133255, 45445.318320224564, 11025.117990560897, 11052.447377631248, 11056.502457389597, 11104.333739975627, 11328.0, 11852.525898963944, 11895.643130706092, 12066.276023438622, 12526.561570344995, 12555.93722031384, 11633.6509904703, 11740.354280514654, 11858.288502689866, 12031.578894738643, 12279.570215042431, 11343.886561134283, 11453.370064646524, 11730.589429369931, 11828.645140645795, 12159.635210943687, 11580.247283926517, 11785.116116291141, 11958.701032474257, 12018.939905300418, 12375.443105060114, 9587.137157655845, 9612.18296444782, 9621.326507144713, 9630.807383852423, 10027.548760305657, 9840.753981150528, 9913.206943444364, 9959.651412200537, 9969.800603988024, 10275.126614237874], "value": 6634.405570513866, "unit": "score"}], "name": "dromaeo_css", "value": 6824.969848134222, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 105.0, 109.0, 110.0, 110.0, 100.0, 111.0, 110.0, 110.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 153.0, 178.0, 137.0, 148.0, 158.0, 133.0, 181.0, 129.0], "value": 149.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 160.0, 160.0, 160.0, 161.0, 161.0, 161.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 88.0, 101.0, 119.0, 77.0, 73.0, 73.0, 128.0, 111.0, 74.0], "value": 91.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 151.0, 92.0, 92.0, 93.0, 150.0, 93.0, 92.0, 151.0], "value": 110.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 147.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 58.0, 59.0, 57.0, 58.0, 78.0, 57.0, 56.0], "value": 60.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 78.0, 77.0, 78.0, 79.0, 78.0, 86.0, 78.0, 78.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 129.0, 126.0, 134.0, 125.0, 132.0, 131.0, 124.0, 158.0, 133.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 176.0, 171.0, 173.0, 167.0, 168.0, 171.0, 168.0, 172.0, 167.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 71.0, 69.0, 71.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1548.8000000000002, "alertThreshold": 2.0}]} 13:17:02 INFO - Return code: 0 13:17:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:17:02 ERROR - # TBPL SUCCESS # 13:17:02 INFO - Running post-action listener: _resource_record_post_action 13:17:02 INFO - Running post-run listener: _resource_record_post_run 13:17:03 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537776128; Read time: 8; Write time: 470396 13:17:03 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 244428800; Read time: 0; Write time: 261480 13:17:03 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293347328; Read time: 8; Write time: 208916 13:17:03 INFO - Running post-run listener: _upload_blobber_files 13:17:03 INFO - Blob upload gear active. 13:17:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:17:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:17:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:17:03 INFO - (blobuploader) - INFO - Open directory for files ... 13:17:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:17:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:17:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:17:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:17:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:17:04 INFO - (blobuploader) - INFO - Done attempting. 13:17:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:17:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:17:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:17:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:17:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:17:05 INFO - (blobuploader) - INFO - Done attempting. 13:17:05 INFO - (blobuploader) - INFO - Iteration through files over. 13:17:05 INFO - Return code: 0 13:17:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:17:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:17:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/975eba522368fccac73bc2c88794a6cb24aff0c7c328d4bba441c480c26ed2bad05a46b8f6256c989344122f7cee6ef4f5a3a6b6da47b445bdafa9b72b26fb19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/40d05f8793d4658cd410a38371fe3fb75c38d3396d5e49ae008d17e14438204e700259cc808b44988528092d92c4607533ad602d6432c29ce2d86e90f11b361b"} 13:17:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:17:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:17:05 INFO - Contents: 13:17:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/975eba522368fccac73bc2c88794a6cb24aff0c7c328d4bba441c480c26ed2bad05a46b8f6256c989344122f7cee6ef4f5a3a6b6da47b445bdafa9b72b26fb19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/40d05f8793d4658cd410a38371fe3fb75c38d3396d5e49ae008d17e14438204e700259cc808b44988528092d92c4607533ad602d6432c29ce2d86e90f11b361b"} 13:17:05 INFO - Running post-run listener: copy_logs_to_upload_dir 13:17:05 INFO - Copying logs to upload dir... 13:17:05 INFO - mkdir: /builds/slave/test/build/upload/logs 13:17:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.767365 ========= master_lag: 1.50 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-04-19 13:17:06.814007) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:06.819125) ========= 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=ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416 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/975eba522368fccac73bc2c88794a6cb24aff0c7c328d4bba441c480c26ed2bad05a46b8f6256c989344122f7cee6ef4f5a3a6b6da47b445bdafa9b72b26fb19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/40d05f8793d4658cd410a38371fe3fb75c38d3396d5e49ae008d17e14438204e700259cc808b44988528092d92c4607533ad602d6432c29ce2d86e90f11b361b"} build_url:https://queue.taskcluster.net/v1/task/DDneeYQIQKe05ILqHEnutQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/DDneeYQIQKe05ILqHEnutQ/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/975eba522368fccac73bc2c88794a6cb24aff0c7c328d4bba441c480c26ed2bad05a46b8f6256c989344122f7cee6ef4f5a3a6b6da47b445bdafa9b72b26fb19", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/40d05f8793d4658cd410a38371fe3fb75c38d3396d5e49ae008d17e14438204e700259cc808b44988528092d92c4607533ad602d6432c29ce2d86e90f11b361b"}' ========= master_lag: 0.34 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:07.168481) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:07.168928) ========= 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=ed14279e38b05397cf4aa391000001a4-1461092848.500047-1058161416 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-19 13:17:07.189475) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 13:17:07.189942) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-19 13:17:07.193643) ========= ========= Total master_lag: 1.92 =========