builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1465308014.23 results: success (0) buildid: 20160607043100 builduid: 962fdadb644544b294d473df38702ffe revision: 448365b11e377ebf1c572d54e45bbd36c45af03a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:14.229186) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:14.229874) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:14.230163) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:14.245441) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-06-07 07:00:14.245755) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 07:00: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 22.4M=0.001s 2016-06-07 07:00:14 (22.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.091617 ========= master_lag: 7.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 7 secs) (at 2016-06-07 07:00:21.611131) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:21.611522) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019727 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:21.677251) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 07:00:21.677582) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 448365b11e377ebf1c572d54e45bbd36c45af03a --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 448365b11e377ebf1c572d54e45bbd36c45af03a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 07:00:21,998 truncating revision to first 12 chars 2016-06-07 07:00:21,998 Setting DEBUG logging. 2016-06-07 07:00:21,998 attempt 1/10 2016-06-07 07:00:21,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/448365b11e37?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 07:00:22,585 unpacking tar archive at: mozilla-inbound-448365b11e37/testing/mozharness/ program finished with exit code 0 elapsedTime=0.997383 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 07:00:22.701739) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:22.702059) ========= script_repo_revision: 448365b11e377ebf1c572d54e45bbd36c45af03a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:22.702456) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:22.704806) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 07:00:22.715690) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 37 secs) (at 2016-06-07 07:00:22.716016) ========= /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=33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:00:23 INFO - MultiFileLogger online at 20160607 07:00:23 in /builds/slave/test 07:00:23 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 07:00:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:00:23 INFO - {'append_to_log': False, 07:00:23 INFO - 'base_work_dir': '/builds/slave/test', 07:00:23 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:00:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:00:23 INFO - 'branch': 'Mozilla-Inbound', 07:00:23 INFO - 'buildbot_json_path': 'buildprops.json', 07:00:23 INFO - 'config_files': ('talos/linux_config.py',), 07:00:23 INFO - 'default_actions': ('clobber', 07:00:23 INFO - 'read-buildbot-config', 07:00:23 INFO - 'download-and-extract', 07:00:23 INFO - 'populate-webroot', 07:00:23 INFO - 'create-virtualenv', 07:00:23 INFO - 'install', 07:00:23 INFO - 'run-tests'), 07:00:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:00:23 INFO - 'download_minidump_stackwalk': True, 07:00:23 INFO - 'download_symbols': 'ondemand', 07:00:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:00:23 INFO - 'tooltool.py': '/tools/tooltool.py', 07:00:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:00:23 INFO - '/tools/misc-python/virtualenv.py')}, 07:00:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:00:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:00:23 INFO - 'installer_path': 'installer.exe', 07:00:23 INFO - 'log_level': 'info', 07:00:23 INFO - 'log_name': 'talos', 07:00:23 INFO - 'log_to_console': True, 07:00:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:00:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:00:23 INFO - 'opt_config_files': (), 07:00:23 INFO - 'pip_index': False, 07:00:23 INFO - 'sps_profile': False, 07:00:23 INFO - 'sps_profile_interval': 0, 07:00:23 INFO - 'suite': 'dromaeojs', 07:00:23 INFO - 'system_bits': '32', 07:00:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:00:23 INFO - 'title': 'talos-linux64-ix-063', 07:00:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:00:23 INFO - 'use_talos_json': True, 07:00:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:00:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:00:23 INFO - 'work_dir': 'build'} 07:00:23 INFO - ##### 07:00:23 INFO - ##### Running clobber step. 07:00:23 INFO - ##### 07:00:23 INFO - Running pre-action listener: _resource_record_pre_action 07:00:23 INFO - Running main action method: clobber 07:00:23 INFO - rmtree: /builds/slave/test/build 07:00:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:00:23 INFO - Running post-action listener: _resource_record_post_action 07:00:23 INFO - ##### 07:00:23 INFO - ##### Finished clobber step (success) 07:00:23 INFO - ##### 07:00:23 INFO - ##### 07:00:23 INFO - ##### Running read-buildbot-config step. 07:00:23 INFO - ##### 07:00:23 INFO - Running pre-action listener: _resource_record_pre_action 07:00:23 INFO - Running main action method: read_buildbot_config 07:00:23 INFO - Using buildbot properties: 07:00:23 INFO - { 07:00:23 INFO - "project": "", 07:00:23 INFO - "product": "firefox", 07:00:23 INFO - "script_repo_revision": "production", 07:00:23 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 07:00:23 INFO - "repository": "", 07:00:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 07:00:23 INFO - "buildid": "20160607043100", 07:00:23 INFO - "pgo_build": "True", 07:00:23 INFO - "basedir": "/builds/slave/test", 07:00:23 INFO - "buildnumber": 1067, 07:00:23 INFO - "slavename": "talos-linux64-ix-063", 07:00:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:00:23 INFO - "platform": "ubuntu64_hw", 07:00:23 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:00:23 INFO - "branch": "mozilla-inbound", 07:00:23 INFO - "repo_path": "integration/mozilla-inbound", 07:00:23 INFO - "revision": "448365b11e377ebf1c572d54e45bbd36c45af03a", 07:00:23 INFO - "stage_platform": "linux64-pgo", 07:00:23 INFO - "builduid": "962fdadb644544b294d473df38702ffe", 07:00:23 INFO - "slavebuilddir": "test" 07:00:23 INFO - } 07:00:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:00:23 INFO - Running post-action listener: _resource_record_post_action 07:00:23 INFO - ##### 07:00:23 INFO - ##### Finished read-buildbot-config step (success) 07:00:23 INFO - ##### 07:00:23 INFO - ##### 07:00:23 INFO - ##### Running download-and-extract step. 07:00:23 INFO - ##### 07:00:23 INFO - Running pre-action listener: _resource_record_pre_action 07:00:23 INFO - Running main action method: download_and_extract 07:00:23 INFO - mkdir: /builds/slave/test/build/tests 07:00:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:23 INFO - https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:00:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:00:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:00:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:00:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:00:24 INFO - Downloaded 1361 bytes. 07:00:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:00:24 INFO - Using the following test package requirements: 07:00:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:00:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:00:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:00:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:24 INFO - u'jsshell-linux-x86_64.zip'], 07:00:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:00:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:00:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:00:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:00:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:00:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:00:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:00:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:24 INFO - https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:00:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:00:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:00:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:00:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:00:26 INFO - Downloaded 24440428 bytes. 07:00:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:00:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:00:28 INFO - Return code: 0 07:00:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:00: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')]} 07:00:28 INFO - https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:00:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:00:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:00:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:00:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:00:30 INFO - Downloaded 24440428 bytes. 07:00:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:00:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:00:32 INFO - Return code: 0 07:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:32 INFO - https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:00:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:00:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:00:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:00:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:00:34 INFO - Downloaded 10833369 bytes. 07:00:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:00:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:00:34 INFO - Return code: 0 07:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:34 INFO - https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:00:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:00:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:00:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:00:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:00:38 INFO - Downloaded 59188444 bytes. 07:00:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:00:38 INFO - mkdir: /builds/slave/test/properties 07:00:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:00:38 INFO - Writing to file /builds/slave/test/properties/build_url 07:00:38 INFO - Contents: 07:00:38 INFO - build_url:https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:00:38 INFO - Running post-action listener: _resource_record_post_action 07:00:38 INFO - Running post-action listener: set_extra_try_arguments 07:00:38 INFO - ##### 07:00:38 INFO - ##### Finished download-and-extract step (success) 07:00:38 INFO - ##### 07:00:38 INFO - ##### 07:00:38 INFO - ##### Running populate-webroot step. 07:00:38 INFO - ##### 07:00:38 INFO - Running pre-action listener: _resource_record_pre_action 07:00:38 INFO - Running main action method: populate_webroot 07:00:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:00:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:00:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:00:38 INFO - '--tppagecycles', 07:00:38 INFO - '7'], 07:00:38 INFO - 'tests': ['tsvgm']}}, 07:00:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:00:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:00:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:00:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:00:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:00:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:00:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:38 INFO - 'talos_options': ['--disable-e10s'], 07:00:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:00:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:38 INFO - 'talos_options': ['--disable-e10s'], 07:00:38 INFO - 'tests': ['damp', 'tps']}, 07:00:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:38 INFO - 'tests': ['damp', 'tps']}, 07:00:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:00:38 INFO - 'tests': ['dromaeo_dom']}, 07:00:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:00:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:00:38 INFO - 'tests': ['a11yr', 07:00:38 INFO - 'ts_paint', 07:00:38 INFO - 'tpaint', 07:00:38 INFO - 'sessionrestore', 07:00:38 INFO - 'sessionrestore_no_auto_restore', 07:00:38 INFO - 'tabpaint']}, 07:00:38 INFO - 'other-e10s': {'tests': ['a11yr', 07:00:38 INFO - 'ts_paint', 07:00:38 INFO - 'tpaint', 07:00:38 INFO - 'sessionrestore', 07:00:38 INFO - 'sessionrestore_no_auto_restore', 07:00:38 INFO - 'tabpaint']}, 07:00:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:00:38 INFO - 'ts_paint', 07:00:38 INFO - 'tpaint', 07:00:38 INFO - 'sessionrestore', 07:00:38 INFO - 'sessionrestore_no_auto_restore', 07:00:38 INFO - 'tabpaint']}, 07:00:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:00:38 INFO - 'ts_paint', 07:00:38 INFO - 'tpaint', 07:00:38 INFO - 'sessionrestore', 07:00:38 INFO - 'sessionrestore_no_auto_restore', 07:00:38 INFO - 'tabpaint']}, 07:00:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:00:38 INFO - 'tests': ['a11yr', 07:00:38 INFO - 'ts_paint', 07:00:38 INFO - 'tpaint', 07:00:38 INFO - 'sessionrestore', 07:00:38 INFO - 'sessionrestore_no_auto_restore', 07:00:38 INFO - 'tabpaint']}, 07:00:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:00:38 INFO - 'tests': ['a11yr', 07:00:38 INFO - 'ts_paint', 07:00:38 INFO - 'tpaint', 07:00:38 INFO - 'sessionrestore', 07:00:38 INFO - 'sessionrestore_no_auto_restore', 07:00:38 INFO - 'tabpaint']}, 07:00:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:00:38 INFO - 'tests': ['tsvgx', 07:00:38 INFO - 'tsvgr_opacity', 07:00:38 INFO - 'tart', 07:00:38 INFO - 'tscrollx', 07:00:38 INFO - 'cart']}, 07:00:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:00:38 INFO - 'tsvgr_opacity', 07:00:38 INFO - 'tart', 07:00:38 INFO - 'tscrollx', 07:00:38 INFO - 'cart']}, 07:00:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:38 INFO - 'talos_options': ['--disable-e10s'], 07:00:38 INFO - 'tests': ['tp5o']}, 07:00:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:38 INFO - 'tests': ['tp5o']}, 07:00:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:38 INFO - 'talos_options': ['--disable-e10s', 07:00:38 INFO - '--xperf_path', 07:00:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:38 INFO - 'tests': ['tp5n']}, 07:00:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:00:38 INFO - 'talos_options': ['--xperf_path', 07:00:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:00:38 INFO - 'tests': ['tp5n']}}, 07:00:38 INFO - 'talos.zip': {'path': '', 07:00:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:00:38 INFO - Running post-action listener: _resource_record_post_action 07:00:38 INFO - ##### 07:00:38 INFO - ##### Finished populate-webroot step (success) 07:00:38 INFO - ##### 07:00:38 INFO - ##### 07:00:38 INFO - ##### Running create-virtualenv step. 07:00:38 INFO - ##### 07:00:38 INFO - Running pre-action listener: _resource_record_pre_action 07:00:38 INFO - Running main action method: create_virtualenv 07:00:38 INFO - Creating virtualenv /builds/slave/test/build/venv 07:00:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:00:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:00:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:00:39 INFO - Using real prefix '/usr' 07:00:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:00:39 INFO - Installing distribute.............................................................................................................................................................................................done. 07:00:41 INFO - Installing pip.................done. 07:00:41 INFO - Return code: 0 07:00:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:41 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 0x7f0745685f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2214020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a62e0>, '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 0x2212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22125d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:00:41 INFO - Using env: {'DISPLAY': ':0', 07:00:41 INFO - 'HOME': '/home/cltbld', 07:00:41 INFO - 'LANG': 'en_US.UTF-8', 07:00:41 INFO - 'LANGUAGE': 'en_US:en', 07:00:41 INFO - 'LOGNAME': 'cltbld', 07:00:41 INFO - 'MAIL': '/var/mail/cltbld', 07:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:41 INFO - 'MOZ_NO_REMOTE': '1', 07:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:41 INFO - 'NO_EM_RESTART': '1', 07:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:41 INFO - 'PWD': '/builds/slave/test', 07:00:41 INFO - 'SHELL': '/bin/bash', 07:00:41 INFO - 'SHLVL': '1', 07:00:41 INFO - 'TERM': 'linux', 07:00:41 INFO - 'TMOUT': '86400', 07:00:41 INFO - 'USER': 'cltbld', 07:00:41 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 07:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:41 INFO - '_': '/tools/buildbot/bin/python'} 07:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:00:41 INFO - Cleaning up... 07:00:41 INFO - Return code: 0 07:00:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0745685f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2214020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a62e0>, '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 0x2212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22125d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:00:41 INFO - Using env: {'DISPLAY': ':0', 07:00:41 INFO - 'HOME': '/home/cltbld', 07:00:41 INFO - 'LANG': 'en_US.UTF-8', 07:00:41 INFO - 'LANGUAGE': 'en_US:en', 07:00:41 INFO - 'LOGNAME': 'cltbld', 07:00:41 INFO - 'MAIL': '/var/mail/cltbld', 07:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:41 INFO - 'MOZ_NO_REMOTE': '1', 07:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:41 INFO - 'NO_EM_RESTART': '1', 07:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:41 INFO - 'PWD': '/builds/slave/test', 07:00:41 INFO - 'SHELL': '/bin/bash', 07:00:41 INFO - 'SHLVL': '1', 07:00:41 INFO - 'TERM': 'linux', 07:00:41 INFO - 'TMOUT': '86400', 07:00:41 INFO - 'USER': 'cltbld', 07:00:41 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 07:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:41 INFO - '_': '/tools/buildbot/bin/python'} 07:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:41 INFO - Downloading/unpacking psutil>=3.1.1 07:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:00:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:43 INFO - Installing collected packages: psutil 07:00:43 INFO - Running setup.py install for psutil 07:00:44 INFO - building 'psutil._psutil_linux' extension 07:00:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:00:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:00:44 INFO - building 'psutil._psutil_posix' extension 07:00:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:00:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:00:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:00:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:00:44 INFO - Successfully installed psutil 07:00:44 INFO - Cleaning up... 07:00:44 INFO - Return code: 0 07:00:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0745685f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2214020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a62e0>, '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 0x2212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22125d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:00:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:00:44 INFO - Using env: {'DISPLAY': ':0', 07:00:44 INFO - 'HOME': '/home/cltbld', 07:00:44 INFO - 'LANG': 'en_US.UTF-8', 07:00:44 INFO - 'LANGUAGE': 'en_US:en', 07:00:44 INFO - 'LOGNAME': 'cltbld', 07:00:44 INFO - 'MAIL': '/var/mail/cltbld', 07:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:44 INFO - 'MOZ_NO_REMOTE': '1', 07:00:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:44 INFO - 'NO_EM_RESTART': '1', 07:00:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:44 INFO - 'PWD': '/builds/slave/test', 07:00:44 INFO - 'SHELL': '/bin/bash', 07:00:44 INFO - 'SHLVL': '1', 07:00:44 INFO - 'TERM': 'linux', 07:00:44 INFO - 'TMOUT': '86400', 07:00:44 INFO - 'USER': 'cltbld', 07:00:44 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 07:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:44 INFO - '_': '/tools/buildbot/bin/python'} 07:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:00:46 INFO - Installing collected packages: mozsystemmonitor 07:00:46 INFO - Running setup.py install for mozsystemmonitor 07:00:46 INFO - Successfully installed mozsystemmonitor 07:00:46 INFO - Cleaning up... 07:00:46 INFO - Return code: 0 07:00:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0745685f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2214020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a62e0>, '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 0x2212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22125d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:00:46 INFO - Using env: {'DISPLAY': ':0', 07:00:46 INFO - 'HOME': '/home/cltbld', 07:00:46 INFO - 'LANG': 'en_US.UTF-8', 07:00:46 INFO - 'LANGUAGE': 'en_US:en', 07:00:46 INFO - 'LOGNAME': 'cltbld', 07:00:46 INFO - 'MAIL': '/var/mail/cltbld', 07:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:46 INFO - 'MOZ_NO_REMOTE': '1', 07:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:46 INFO - 'NO_EM_RESTART': '1', 07:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:46 INFO - 'PWD': '/builds/slave/test', 07:00:46 INFO - 'SHELL': '/bin/bash', 07:00:46 INFO - 'SHLVL': '1', 07:00:46 INFO - 'TERM': 'linux', 07:00:46 INFO - 'TMOUT': '86400', 07:00:46 INFO - 'USER': 'cltbld', 07:00:46 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 07:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:46 INFO - '_': '/tools/buildbot/bin/python'} 07:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:47 INFO - Downloading/unpacking jsonschema==2.5.1 07:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:00:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:49 INFO - Downloading functools32-3.2.3-2.tar.gz 07:00:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:00:49 INFO - warning: no files found matching '*.txt' 07:00:49 INFO - no previously-included directories found matching 'build' 07:00:49 INFO - no previously-included directories found matching 'dist' 07:00:49 INFO - no previously-included directories found matching '.git*' 07:00:49 INFO - Installing collected packages: jsonschema, functools32 07:00:49 INFO - Running setup.py install for functools32 07:00:49 INFO - warning: no files found matching '*.txt' 07:00:49 INFO - no previously-included directories found matching 'build' 07:00:49 INFO - no previously-included directories found matching 'dist' 07:00:49 INFO - no previously-included directories found matching '.git*' 07:00:49 INFO - Successfully installed jsonschema functools32 07:00:49 INFO - Cleaning up... 07:00:49 INFO - Return code: 0 07:00:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0745685f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2214020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a62e0>, '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 0x2212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22125d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:00:49 INFO - Using env: {'DISPLAY': ':0', 07:00:49 INFO - 'HOME': '/home/cltbld', 07:00:49 INFO - 'LANG': 'en_US.UTF-8', 07:00:49 INFO - 'LANGUAGE': 'en_US:en', 07:00:49 INFO - 'LOGNAME': 'cltbld', 07:00:49 INFO - 'MAIL': '/var/mail/cltbld', 07:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:49 INFO - 'MOZ_NO_REMOTE': '1', 07:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:49 INFO - 'NO_EM_RESTART': '1', 07:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:49 INFO - 'PWD': '/builds/slave/test', 07:00:49 INFO - 'SHELL': '/bin/bash', 07:00:49 INFO - 'SHLVL': '1', 07:00:49 INFO - 'TERM': 'linux', 07:00:49 INFO - 'TMOUT': '86400', 07:00:49 INFO - 'USER': 'cltbld', 07:00:49 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 07:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:49 INFO - '_': '/tools/buildbot/bin/python'} 07:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:49 INFO - Downloading/unpacking blobuploader==1.2.4 07:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:51 INFO - Downloading blobuploader-1.2.4.tar.gz 07:00:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:00:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:00:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:00:52 INFO - Downloading docopt-0.6.1.tar.gz 07:00:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:00:52 INFO - Installing collected packages: blobuploader, requests, docopt 07:00:52 INFO - Running setup.py install for blobuploader 07:00:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:00:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:00:52 INFO - Running setup.py install for requests 07:00:52 INFO - Running setup.py install for docopt 07:00:52 INFO - Successfully installed blobuploader requests docopt 07:00:52 INFO - Cleaning up... 07:00:52 INFO - Return code: 0 07:00:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0745685f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2214020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a62e0>, '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 0x2212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22125d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:00:52 INFO - Using env: {'DISPLAY': ':0', 07:00:52 INFO - 'HOME': '/home/cltbld', 07:00:52 INFO - 'LANG': 'en_US.UTF-8', 07:00:52 INFO - 'LANGUAGE': 'en_US:en', 07:00:52 INFO - 'LOGNAME': 'cltbld', 07:00:52 INFO - 'MAIL': '/var/mail/cltbld', 07:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:52 INFO - 'MOZ_NO_REMOTE': '1', 07:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:52 INFO - 'NO_EM_RESTART': '1', 07:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:52 INFO - 'PWD': '/builds/slave/test', 07:00:52 INFO - 'SHELL': '/bin/bash', 07:00:52 INFO - 'SHLVL': '1', 07:00:52 INFO - 'TERM': 'linux', 07:00:52 INFO - 'TMOUT': '86400', 07:00:52 INFO - 'USER': 'cltbld', 07:00:52 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 07:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:52 INFO - '_': '/tools/buildbot/bin/python'} 07:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:00:53 INFO - Running setup.py (path:/tmp/pip-t3Tc8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:00:53 INFO - Running setup.py (path:/tmp/pip-oJOMjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:00:53 INFO - Running setup.py (path:/tmp/pip-coFOJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:00:53 INFO - Running setup.py (path:/tmp/pip-6k2y17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:00:53 INFO - Running setup.py (path:/tmp/pip-oz9kAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:00:53 INFO - Running setup.py (path:/tmp/pip-ncfLqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:00:53 INFO - Running setup.py (path:/tmp/pip-tSfdtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:00:53 INFO - Running setup.py (path:/tmp/pip-GiAwtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:00:53 INFO - Running setup.py (path:/tmp/pip-J9C8eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:00:53 INFO - Running setup.py (path:/tmp/pip-RnlvnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:00:53 INFO - Running setup.py (path:/tmp/pip-ayBdGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:00:53 INFO - Running setup.py (path:/tmp/pip-Df_BY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:00:53 INFO - Running setup.py (path:/tmp/pip-TNs_t5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:00:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:00:53 INFO - Running setup.py (path:/tmp/pip-11yKZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:54 INFO - Running setup.py (path:/tmp/pip-4SS9Nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:00:54 INFO - Running setup.py (path:/tmp/pip-6z2IGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:00:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:00:54 INFO - Running setup.py (path:/tmp/pip-Y46IbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:00:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:00:54 INFO - Running setup.py install for manifestparser 07:00:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:00:54 INFO - Running setup.py install for mozcrash 07:00:54 INFO - Running setup.py install for mozdebug 07:00:54 INFO - Running setup.py install for mozdevice 07:00:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:00:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:00:54 INFO - Running setup.py install for mozfile 07:00:54 INFO - Running setup.py install for mozhttpd 07:00:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:00:54 INFO - Running setup.py install for mozinfo 07:00:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:00:55 INFO - Running setup.py install for mozInstall 07:00:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:00:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:00:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:00:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:00:55 INFO - Running setup.py install for mozleak 07:00:55 INFO - Running setup.py install for mozlog 07:00:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:00:55 INFO - Running setup.py install for moznetwork 07:00:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:00:55 INFO - Running setup.py install for mozprocess 07:00:55 INFO - Running setup.py install for mozprofile 07:00:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:00:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:00:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:00:55 INFO - Running setup.py install for mozrunner 07:00:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:00:55 INFO - Running setup.py install for mozscreenshot 07:00:55 INFO - Running setup.py install for moztest 07:00:55 INFO - Running setup.py install for mozversion 07:00:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:00:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:00:56 INFO - Cleaning up... 07:00:56 INFO - Return code: 0 07:00:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:56 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 0x7f0745685f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2214020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a62e0>, '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 0x2212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22125d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:00:56 INFO - Using env: {'DISPLAY': ':0', 07:00:56 INFO - 'HOME': '/home/cltbld', 07:00:56 INFO - 'LANG': 'en_US.UTF-8', 07:00:56 INFO - 'LANGUAGE': 'en_US:en', 07:00:56 INFO - 'LOGNAME': 'cltbld', 07:00:56 INFO - 'MAIL': '/var/mail/cltbld', 07:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:56 INFO - 'MOZ_NO_REMOTE': '1', 07:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:56 INFO - 'NO_EM_RESTART': '1', 07:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:56 INFO - 'PWD': '/builds/slave/test', 07:00:56 INFO - 'SHELL': '/bin/bash', 07:00:56 INFO - 'SHLVL': '1', 07:00:56 INFO - 'TERM': 'linux', 07:00:56 INFO - 'TMOUT': '86400', 07:00:56 INFO - 'USER': 'cltbld', 07:00:56 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 07:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:56 INFO - '_': '/tools/buildbot/bin/python'} 07:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:00:56 INFO - Running setup.py (path:/tmp/pip-Flm9iT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:00:56 INFO - Running setup.py (path:/tmp/pip-wgXjY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:00:56 INFO - Running setup.py (path:/tmp/pip-Vm1Sd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:00:56 INFO - Running setup.py (path:/tmp/pip-7kuSIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:00:56 INFO - Running setup.py (path:/tmp/pip-HWPwt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:00:56 INFO - Running setup.py (path:/tmp/pip-FEuA4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:00:56 INFO - Running setup.py (path:/tmp/pip-uL63gH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:00:56 INFO - Running setup.py (path:/tmp/pip-GuDi5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:00:56 INFO - Running setup.py (path:/tmp/pip-Talxbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:00:56 INFO - Running setup.py (path:/tmp/pip-pNsnAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:00:57 INFO - Running setup.py (path:/tmp/pip-hB_1y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:00:57 INFO - Running setup.py (path:/tmp/pip-fGaW8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:00:57 INFO - Running setup.py (path:/tmp/pip-VutgBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:00:57 INFO - Running setup.py (path:/tmp/pip-vSbHZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:57 INFO - Running setup.py (path:/tmp/pip-HyvDzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:00:57 INFO - Running setup.py (path:/tmp/pip-BlxHrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:00:57 INFO - Running setup.py (path:/tmp/pip-2XkzRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:00:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00: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 07:00:59 INFO - Downloading blessings-1.6.tar.gz 07:00:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:00:59 INFO - Installing collected packages: blessings 07:00:59 INFO - Running setup.py install for blessings 07:00:59 INFO - Successfully installed blessings 07:00:59 INFO - Cleaning up... 07:00:59 INFO - Return code: 0 07:00:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:00:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:59 INFO - Reading from file tmpfile_stdout 07:00:59 INFO - Current package versions: 07:00:59 INFO - argparse == 1.2.1 07:00:59 INFO - blessings == 1.6 07:00:59 INFO - blobuploader == 1.2.4 07:00:59 INFO - docopt == 0.6.1 07:00:59 INFO - functools32 == 3.2.3-2 07:00:59 INFO - jsonschema == 2.5.1 07:00:59 INFO - manifestparser == 1.1 07:00:59 INFO - mozInstall == 1.12 07:00:59 INFO - mozcrash == 0.17 07:00:59 INFO - mozdebug == 0.1 07:00:59 INFO - mozdevice == 0.48 07:00:59 INFO - mozfile == 1.2 07:00:59 INFO - mozhttpd == 0.7 07:00:59 INFO - mozinfo == 0.9 07:00:59 INFO - mozleak == 0.1 07:00:59 INFO - mozlog == 3.2 07:00:59 INFO - moznetwork == 0.27 07:00:59 INFO - mozprocess == 0.22 07:00:59 INFO - mozprofile == 0.28 07:00:59 INFO - mozrunner == 6.11 07:00:59 INFO - mozscreenshot == 0.1 07:00:59 INFO - mozsystemmonitor == 0.3 07:00:59 INFO - moztest == 0.7 07:00:59 INFO - mozversion == 1.4 07:00:59 INFO - psutil == 3.1.1 07:00:59 INFO - requests == 1.2.3 07:00:59 INFO - wsgiref == 0.1.2 07:00:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:00: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')]} 07:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00: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')]} 07:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:00:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0745685f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2214020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a62e0>, '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 0x2212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22125d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:00:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:00:59 INFO - Using env: {'DISPLAY': ':0', 07:00:59 INFO - 'HOME': '/home/cltbld', 07:00:59 INFO - 'LANG': 'en_US.UTF-8', 07:00:59 INFO - 'LANGUAGE': 'en_US:en', 07:00:59 INFO - 'LOGNAME': 'cltbld', 07:00:59 INFO - 'MAIL': '/var/mail/cltbld', 07:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:59 INFO - 'MOZ_NO_REMOTE': '1', 07:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:00:59 INFO - 'NO_EM_RESTART': '1', 07:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:59 INFO - 'PWD': '/builds/slave/test', 07:00:59 INFO - 'SHELL': '/bin/bash', 07:00:59 INFO - 'SHLVL': '1', 07:00:59 INFO - 'TERM': 'linux', 07:00:59 INFO - 'TMOUT': '86400', 07:00:59 INFO - 'USER': 'cltbld', 07:00:59 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 07:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:59 INFO - '_': '/tools/buildbot/bin/python'} 07:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:01:00 INFO - Cleaning up... 07:01:00 INFO - Return code: 0 07:01:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:00 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 0x7f0745685f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2214020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a62e0>, '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 0x2212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22125d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:01:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:01:00 INFO - Using env: {'DISPLAY': ':0', 07:01:00 INFO - 'HOME': '/home/cltbld', 07:01:00 INFO - 'LANG': 'en_US.UTF-8', 07:01:00 INFO - 'LANGUAGE': 'en_US:en', 07:01:00 INFO - 'LOGNAME': 'cltbld', 07:01:00 INFO - 'MAIL': '/var/mail/cltbld', 07:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:00 INFO - 'MOZ_NO_REMOTE': '1', 07:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:00 INFO - 'NO_EM_RESTART': '1', 07:01:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:00 INFO - 'PWD': '/builds/slave/test', 07:01:00 INFO - 'SHELL': '/bin/bash', 07:01:00 INFO - 'SHLVL': '1', 07:01:00 INFO - 'TERM': 'linux', 07:01:00 INFO - 'TMOUT': '86400', 07:01:00 INFO - 'USER': 'cltbld', 07:01:00 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 07:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:00 INFO - '_': '/tools/buildbot/bin/python'} 07:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:01:00 INFO - Cleaning up... 07:01:00 INFO - Return code: 0 07:01:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:00 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 0x7f0745685f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21478a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2214020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a62e0>, '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 0x2212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22125d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:01:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:01:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:01:00 INFO - Using env: {'DISPLAY': ':0', 07:01:00 INFO - 'HOME': '/home/cltbld', 07:01:00 INFO - 'LANG': 'en_US.UTF-8', 07:01:00 INFO - 'LANGUAGE': 'en_US:en', 07:01:00 INFO - 'LOGNAME': 'cltbld', 07:01:00 INFO - 'MAIL': '/var/mail/cltbld', 07:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:00 INFO - 'MOZ_NO_REMOTE': '1', 07:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:00 INFO - 'NO_EM_RESTART': '1', 07:01:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:00 INFO - 'PWD': '/builds/slave/test', 07:01:00 INFO - 'SHELL': '/bin/bash', 07:01:00 INFO - 'SHLVL': '1', 07:01:00 INFO - 'TERM': 'linux', 07:01:00 INFO - 'TMOUT': '86400', 07:01:00 INFO - 'USER': 'cltbld', 07:01:00 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 07:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:00 INFO - '_': '/tools/buildbot/bin/python'} 07:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:00 INFO - Downloading/unpacking flake8 07:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:01:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:01:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:01:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:01:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:01:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:01:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:01:03 INFO - no previously-included directories found matching 'docs/_build' 07:01:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:01:03 INFO - Running setup.py install for pep8 07:01:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:01:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:01:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:01:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:01:03 INFO - no previously-included directories found matching 'docs/_build' 07:01:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:01:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:01:03 INFO - Cleaning up... 07:01:03 INFO - Return code: 0 07:01:03 INFO - Running post-action listener: _resource_record_post_action 07:01:03 INFO - Running post-action listener: _start_resource_monitoring 07:01:03 INFO - Starting resource monitoring. 07:01:03 INFO - ##### 07:01:03 INFO - ##### Finished create-virtualenv step (success) 07:01:03 INFO - ##### 07:01:03 INFO - ##### 07:01:03 INFO - ##### Running install step. 07:01:03 INFO - ##### 07:01:03 INFO - Running pre-action listener: _resource_record_pre_action 07:01:03 INFO - Running main action method: install 07:01:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:01:03 INFO - Reading from file tmpfile_stdout 07:01:03 INFO - Detecting whether we're running mozinstall >=1.0... 07:01:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:01:03 INFO - Reading from file tmpfile_stdout 07:01:03 INFO - Output received: 07:01:03 INFO - Usage: mozinstall [options] installer 07:01:03 INFO - Options: 07:01:03 INFO - -h, --help show this help message and exit 07:01:03 INFO - -d DEST, --destination=DEST 07:01:03 INFO - Directory to install application into. [default: 07:01:03 INFO - "/builds/slave/test"] 07:01:03 INFO - --app=APP Application being installed. [default: firefox] 07:01:03 INFO - mkdir: /builds/slave/test/build/application 07:01:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:01:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:01:20 INFO - Reading from file tmpfile_stdout 07:01:20 INFO - Output received: 07:01:20 INFO - /builds/slave/test/build/application/firefox/firefox 07:01:20 INFO - Running post-action listener: _resource_record_post_action 07:01:20 INFO - ##### 07:01:20 INFO - ##### Finished install step (success) 07:01:20 INFO - ##### 07:01:20 INFO - ##### 07:01:20 INFO - ##### Running run-tests step. 07:01:20 INFO - ##### 07:01:20 INFO - Running pre-action listener: _resource_record_pre_action 07:01:20 INFO - Running main action method: run_tests 07:01:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:01:20 INFO - Python 2.7.3 07:01:20 INFO - Return code: 0 07:01:20 INFO - grabbing minidump binary from tooltool 07:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22a62e0>, '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 0x2212140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22125d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:01:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:01:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:01:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:01:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:01:20 INFO - Return code: 0 07:01:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:01:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:01:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:01:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:01:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:01:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:01:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:01:27 INFO - Return code: 0 07:01:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:01:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:01:27 INFO - Using env: {'DISPLAY': ':0', 07:01:27 INFO - 'HOME': '/home/cltbld', 07:01:27 INFO - 'LANG': 'en_US.UTF-8', 07:01:27 INFO - 'LANGUAGE': 'en_US:en', 07:01:27 INFO - 'LOGNAME': 'cltbld', 07:01:27 INFO - 'MAIL': '/var/mail/cltbld', 07:01:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:01:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:27 INFO - 'MOZ_NO_REMOTE': '1', 07:01:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:27 INFO - 'NO_EM_RESTART': '1', 07:01:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:27 INFO - 'PWD': '/builds/slave/test', 07:01:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:01:27 INFO - 'SHELL': '/bin/bash', 07:01:27 INFO - 'SHLVL': '1', 07:01:27 INFO - 'TERM': 'linux', 07:01:27 INFO - 'TMOUT': '86400', 07:01:27 INFO - 'USER': 'cltbld', 07:01:27 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747', 07:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:27 INFO - '_': '/tools/buildbot/bin/python'} 07:01:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:01:27 INFO - mozversion application_buildid: 20160607043100 07:01:27 INFO - mozversion application_changeset: 448365b11e377ebf1c572d54e45bbd36c45af03a 07:01:27 INFO - mozversion application_display_name: Nightly 07:01:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:01:27 INFO - mozversion application_name: Firefox 07:01:27 INFO - mozversion application_remotingname: firefox 07:01:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:01:27 INFO - mozversion application_vendor: Mozilla 07:01:27 INFO - mozversion application_version: 50.0a1 07:01:27 INFO - mozversion platform_buildid: 20160607043100 07:01:27 INFO - mozversion platform_changeset: 448365b11e377ebf1c572d54e45bbd36c45af03a 07:01:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:01:27 INFO - mozversion platform_version: 50.0a1 07:01:27 INFO - using testdate: 1465308087 07:01:27 INFO - actual date: 1465308087 07:01:27 INFO - starting webserver on 'localhost:54523' 07:01:27 INFO - SUITE-START | Running 2 tests 07:01:27 INFO - TEST-START | dromaeo_css 07:01:27 INFO - operating with platform_type : linux_ 07:01:27 INFO - Initialising browser for dromaeo_css test... 07:01:27 INFO - TEST-INFO | started process 29036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprPmgFn/profile http://localhost:54523/getInfo.html) 07:01:36 INFO - PROCESS | 29036 | __metrics Screen width/height:1600/1200 07:01:36 INFO - PROCESS | 29036 | colorDepth:24 07:01:36 INFO - PROCESS | 29036 | Browser inner width/height: 1024/697 07:01:36 INFO - PROCESS | 29036 | __metrics 07:01:38 ERROR - PROCESS | 29036 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:01:38 INFO - PROCESS | 29036 | console.error: PushService: 07:01:38 INFO - PROCESS | 29036 | stateChangeProcessEnqueue: Error transitioning state 07:01:38 INFO - PROCESS | 29036 | UnknownError 07:01:39 INFO - TEST-INFO | 29036: exit 0 07:01:39 INFO - Browser initialized. 07:01:39 INFO - Running cycle 1/1 for dromaeo_css test... 07:01:39 INFO - TEST-INFO | started process 29118 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprPmgFn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:01:51 INFO - PROCESS | 29118 | RSS: Main: 160055296 07:01:51 INFO - PROCESS | 29118 | 07:02:42 INFO - PROCESS | 29118 | 1465308162275 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:04:51 INFO - PROCESS | 29118 | Cycle 1(1): loaded http://localhost:54523/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54523/tests/dromaeo/cssquery-ext.html) 07:04:52 INFO - PROCESS | 29118 | RSS: Main: 286593024 07:04:52 INFO - PROCESS | 29118 | 07:07:54 INFO - PROCESS | 29118 | Cycle 1(1): loaded http://localhost:54523/tests/dromaeo/cssquery-ext.html (next: http://localhost:54523/tests/dromaeo/cssquery-jquery.html) 07:07:55 INFO - PROCESS | 29118 | RSS: Main: 242335744 07:07:55 INFO - PROCESS | 29118 | 07:10:57 INFO - PROCESS | 29118 | Cycle 1(1): loaded http://localhost:54523/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54523/tests/dromaeo/cssquery-mootools.html) 07:10:58 INFO - PROCESS | 29118 | RSS: Main: 246403072 07:10:58 INFO - PROCESS | 29118 | 07:14:00 INFO - PROCESS | 29118 | Cycle 1(1): loaded http://localhost:54523/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54523/tests/dromaeo/cssquery-prototype.html) 07:14:00 INFO - PROCESS | 29118 | RSS: Main: 244908032 07:14:00 INFO - PROCESS | 29118 | 07:17:03 INFO - PROCESS | 29118 | Cycle 1(1): loaded http://localhost:54523/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54523/tests/dromaeo/cssquery-yui.html) 07:17:04 INFO - PROCESS | 29118 | RSS: Main: 224591872 07:17:04 INFO - PROCESS | 29118 | 07:20:07 INFO - PROCESS | 29118 | Cycle 1(1): loaded http://localhost:54523/tests/dromaeo/cssquery-yui.html (next: http://localhost:54523/tests/dromaeo/cssquery-dojo.html) 07:20:07 INFO - PROCESS | 29118 | RSS: Main: 271925248 07:20:07 INFO - PROCESS | 29118 | 07:20:07 INFO - PROCESS | 29118 | __start_tp_report 07:20:07 INFO - PROCESS | 29118 | _x_x_mozilla_page_load 07:20:07 INFO - PROCESS | 29118 | _x_x_mozilla_page_load_details 07:20:07 INFO - PROCESS | 29118 | |i|pagename|runs| 07:20:07 INFO - PROCESS | 29118 | |0;dojo.html;3109.891153809616;3121.172889184366;3137.733292670123;3162.320101178246;3175.222070592704;5163.3545806774155;5234.241035049916;5239.764210610522;5315.415304316527;5368.060589396855;5345.1447768357075;5379.462053794618;5407.459254074591;5498.1752737089455;5498.80754173604;4793.928091078619;4839.685420447659;4846.563809257166;4877.487863774306;4893.999999999991;4949.8020079196785;4967.875803104916;4982.9252561211615;5017.147084995541;5018.447970723218;4741.407324084489;4915.3364295819965;4943.8516844494725;4963.503649635026;4976.054549635575;4753.762311884427;4777.06847164803;4799.400074990626;4817.56641902227;4821.300911367867;4761.262004389325;4811.711297322172;4849.806007759686;4852.2479015752615;4904.60763138948;5096.643234973553;5297.12597421425;5307.442718514578;5310.62825602208;5357.276767636358;5633.718314084279;5686.914696279559;5690.800821971211;5727.055035919068;5760.481556659879;5667.829965101012;5731.083026715747;5777.19119323295;5789.536837053026;5790.073588225863;5209.713465759344;5306.787728490817;5443.836684899459;5445.292112025451;5450.591205659592;5816.243888294494;5913.142594323799;5915.260592425947;5916.556258280646;5921.970390148022;5653.773849045992;5662.433756624305;5666.178404131378;5669.858253543694;5672.8865422691315;5526.613137080366;5628.324601047819;5657.745401456862;5727.140928860621;5728.112142617901;5672.829815105553;5689.68706721126;5689.9146512802345;5693.3168019837885;5732.398098199629;5630.85922851932;5668.631538949955;5676.318841739017;5677.347105082886;5682.715864206773;4267.850625228102;4298.978505107454;4381.737095774264;4398.956010439919;4416.757078360657;3845.576986531479;3861.9806900965314;3886.067343837459;3887.6501114899793;3913.3542965410957;5418.593605479605;5419.593530485229;5424.403315635277;5425.891482170335;5431.21247419122;5600.411956744565;5676.77292908279;5693.373728889819;5715.114157305624;5729.369769325371;5391.757370918318;5400.027994960867;5410.1614249790555;5411.729413529308;5412.485813847678;4927.827526036572;4943.332650092191;4948.876278093005;4982.277569752366;4991.450940396553;5789.623674461147;5855.443732845373;5913.29040515141;5926.377730338339;5938.198343223696;5708.942910570841;5726.169705392778;5738.598298119092;5738.9139162913425;5751.281089863767;5718.199452076629;5914.260717410324;5916.852078698067;5925.614835035709;5925.970370148121;5553.666779993213;5569.136783798518;5590.664560126405;5614.326280846324;5616.354119276336;5675.290588676416;5685.175649530877;5688.11834165705;5690.032694442038;5693.829185124453;5431.83704488866;5538.972305138448;5547.611667183259;5555.805546806004;5556.527695145796;5562.2490963721;5612.550995920398;5620.26936498269;5620.915686264628;5664.915026274527;5463.644863083887;5485.17722341636;5489.58828087887;5522.641028333145;5534.252875861707;5505.256790333254;5563.58273129525;5605.80379686709;5658.85852853682;5719.8570035749435;5293.311869456946;5336.78652853897;5459.945400545944;5460.344758628831;5481.75332110048 07:20:07 INFO - PROCESS | 29118 | |1;ext.html;587.6415386614165;615.1295916278466;637.2066776862804;641.964691941943;649.133406901786;31137.68862311376;43920.341194882065;44376.556234437645;44410.11179776407;44477.7776111119;45378.54621453785;46023.53976460234;46103.76948115263;46182.76908615461;46188.538114618845;8108.918910810905;8759.430637008605;8949.105089491064;10526.526306316196;10775.191860610446;10598.205134614935;10741;10745.301555398913;10756.838647420294;10757.677269681883;10744.355338679665;10840.945795271013;10841.783164336708;10845.295055821385;10850;7987.121416644164;10722.303050301745;10972.792992770788;10972.890271097267;10980.396078215696;10296.536655850505;10419.958004199596;10424.270301078928;10745.731356716145;10752.193585481042;42836.57163428388;43427;43487;43497;43507.56492435098;3560.3992747703783;3682.5212722345923;3872.3610604250266;4017.4978127734034;4207.43199668044;33028.3394332112;33081.50377744336;33303.16742081467;33351.332973340395;33375.49936750951;4141.461609990682;4196.622303992624;4299;4328.891777705582;4436.9556304436865;373180;375956;378369;378715;379145;64189.35810641927;64680.35319646837;64727;64910.67544662247;64955.67522162359;69715;69965.3003469969;70106;70139.64930175418;70198;15242.695146097238;17243.3964811231;17485.65028699419;17504.21231044606;17504.562385940455;12005.339706316236;12632.557860474839;12645.430955606837;12905.483780648668;13250;20351;20416.039674247448;20633.17467301321;20646.380608581767;20847.8957605211;7308.744193953186;7416.441327741921;7551.546907185587;7555.622218889033;7643.235676432312;763.107164617399;1072.8766191888033;1081.8809930907594;1140.1278022312938;1180.2505409065304;31867.521987169748;31900.840495797373;32134.839325803223;32507.18732031718;32661.51007734886;1119.0879433261866;1119.9552017919355;1137.5734099712608;1217.9208351457128;1227.061298106931;16699.499015029567;16723.91638041802;16993.83006169947;17001.659966800595;17071.31714731397;511996;517119;519232;520620;521453;56932.14601780977;57839.421605783406;58263.417365826645;58284.41715582875;58468;1273.070658419359;1317.6047185844209;1380.7997840313099;1413.2862904233502;1425.1449130521605;31506.692026977707;33174.502382464765;33926.491102633976;34028;34166.487502687974;51667;51740.48259517357;52304;52320;52460;387231;389545;390379;390555;390822;36976.63023369839;45685.54314456813;46114.308285375075;46641.53358466372;50419.97480151203;46117.53882461132;46648.766756166006;47379.289310659675;51465.7426712864;52888.471115289896;42916.78541607272;43085.56914430815;43559.34660980025;44173.779131105424;44610;41986.37020444635;42251.15497689968;42524.78737606292;42573.78713106415;43768.34347484854;41948.580514194466;42416.36375454433;43154.56845431631;43664.78167609269;43707.56292437035;36414.27171456503;37956;38163;38580.228395432496;38615.613843862324;28525.714742852306;28877.27806804847;29028.854855725585;29280.560791587715;29329.85335073311 07:20:07 INFO - PROCESS | 29118 | |2;jquery.html;375.66002767495416;391.990200244994;397.14811728841636;404.1774987899625;407.96124368185014;14825.627581823946;16879.49361519153;18632.534186645342;19486;19500.219991200353;18194.909025454886;19075.332363367284;19109.904450477763;19542.31601893934;19563.21747130113;5527.640703354279;5565.276514053167;5692.487676109149;5696.572757043217;5702.686352250625;4055.513338399396;5471.7264136793;5635.21107045014;5649.0396632572565;5931.169636250928;6295.338989406115;6297.244330680325;6315.557910946236;6315.936840631581;6324.083007963843;6160.4455598995855;6233.2208473940755;6277.968610156943;6281.214848143982;6328.525360597973;5487.506124448779;5529.391766905637;5558.86102847428;5569.331680198402;5570.637908535932;22156.22453214146;22940.655890161663;23187;23300;23346.883265583732;2355.281639100074;2504.6618706474574;3065.049834551296;3066.9846650766826;3114.5951026366656;13577.59267221985;13886;14128.576142715736;14592.489262875748;14717.779233311509;1824.9178786954485;1882.8776129551536;1959.1967293409634;1962.656535106365;1998.580298137393;72743.27256727418;75226.62386688087;76210;76415.61792191003;77185.61407192984;9726.2705297103;10416.32293900894;10572.894271057345;10851.78296434067;11127.276727012719;12764.872351276554;13464.124831885896;14313.28433578317;14716.264186790617;14719.484818031318;8126.715564955198;8184.099749027602;8201.71294004707;8263.917360826435;8537.871931921027;8011.399145064143;8149.633266503021;8158.469699469515;8365.707200247962;8366;6552.934470655233;6586.506012049115;6645.734170633217;6682.3317668232785;6738.157730283715;1835.917383717736;1862.9347972820885;1891.564940063793;1940.9417717468498;1956.9412917612494;967.8596603492595;1069.641670040545;1078.009401590737;1127.9904485485608;1154.8383226348317;18432.07839608041;18725.625487490175;19538.413847584594;19617.803821961883;19722.802771972096;1015.9898401016043;1041.7603951091291;1061.7027232374946;1072.340510585984;1125.3697929159532;10727.83908241377;11176.27354221973;11188.496517656726;11248.493817778219;11295.152863535268;379705;384274.02218855685;385033;545875;546395;84877.57561212154;87600;88391.11608883829;91890;97601.51199243958;1032.8554002439664;1046.4506134279563;1059.5285098131412;1062.612146566513;1065.1106326217541;17538.912305438393;17676.469705908843;17971.820281797016;17973.191206396004;18344.72482912784;40922.59077409307;41090.79454602708;41142.58857411388;41569.79215104026;41733;56014;58020.70989645194;58421.70789146027;58935.410645894706;59059.40940590539;5294.867628309323;5521.944780552143;8145.877811832709;8308.83382332362;8556.358273129665;10941.726456838644;12670;12771.233725976472;12775.87224127784;12792.552260670831;10800.24398292112;11083.168762343017;11190.32858028521;11384.203105782515;11625.709357266136;10852.945735271272;10965.945170274097;11040.447977601249;11160.10719142483;11219.270747401393;11089.401068665815;11128.721781955515;11182.105431565293;11355.432228388712;11803.645890623295;8203.384746143944;8300.252977232078;8561.48631082137;8625;8659.090795466385;10999.34003959765;11331.943340283246;11498;11550.88449115498;11596.710082248012 07:20:07 INFO - PROCESS | 29118 | |3;mootools.html;1332.3737843213698;1487.5834766265443;1521.4750910935727;1645.9177041147939;1759.4985429152687;7950.880736788953;8266.504009759412;8273.875891861628;8488.490690558556;8530.189631984951;8271.462354946923;8431.70489032884;8459.154084591537;8465.068842427328;8475.237228649421;1956.7651881774136;2219.1678120704737;2257.27767114523;2283.3264187064856;2293.5642227976714;2257.2776711452343;2257.7403598586125;2260.7513173550897;2267.6031694453404;2268.1947908492493;2219.7669244729314;2271.3299576624936;2273.4089136824464;2274.2949685597437;2274.6701728249395;1981.6928376101728;2196.9670454943107;2274.0903638544714;2279.282026161754;2292.2206449806977;2241.9775802242093;2254.639257718757;2256.424611724;2260.276711452336;2274.2608652188105;8451.830963380698;8499.702510412168;8515.957420212859;8526.658933642648;8527.062023177445;4936.358273424467;5063.392392912837;5073.137566613685;5078.568321692661;5090.694558326475;3280.3603297357026;3361.2941282330494;3362.1762668146216;3385.4244778387733;3474.8610055597746;1134.1323887226279;1150.511032811052;1155.8959693627614;1164.2548768787983;1177.6996865799251;11709.355985420798;11734.354610496504;11735.823962640567;11748.588799392066;11755.529778808923;4325.2214601371425;4490.685652004394;4527.298268768346;4553.33976573395;4562.703424277412;9830.311878168603;9844.80310393788;10002.399856008662;10008.44953527563;10025.849612255823;4439.267520859086;5062.620303477254;5068.910184310391;5069.138246498104;5069.923951140736;4588.357629931812;4720.362751028636;4729.810807567659;4775.474697783241;4782.593479554207;3751.9624803751612;3828.1769419574925;3891.630295121959;3894.6884249259992;3927.3716205407;1216.2155409760655;1219.9573014944435;1227.257509206917;1228.441059318026;1236.4683186229827;983.3018556824735;988.8665030220972;1001.2640709078821;1010.1565193063727;1018.1651046142092;5821.38875418075;5843;5879.2944846618675;5901.645901245939;5964.284285885635;472;475.9976200118977;478.8730986288636;1028.3264461777549;1037.419045334615;4079.326911059701;4096.569860164699;4122.711410201257;4127.2570937231585;4164.729292596032;10359.378437293786;10507.369557826401;10576.365418074785;10608.416537090534;10643.84034239487;10478.214133939984;10511.106555942677;10551.577936882592;10576.471176441148;10601.469926503643;7993.920060799318;8095.959520202361;8105.75682729519;8117.756467305872;8120.106788253287;5905.527557795452;6051;6121.47967422774;6179.227596550431;6229.200187885477;9379.343445958717;9876.308658393844;9876.604935802487;9913.355631883904;9929.503524823875;9525.047495250697;9872.654457093968;10101;10137.746556336151;10167.491625418552;7473.290037446434;7476.962615186889;7496.7750967471065;7527.698892044257;7528.962355188408;7878.684852606061;7896.052473702963;7900.130985591695;7920.801979950547;7996.280334769898;7269.963650181927;7387.519811212254;7396.3343299103335;7499.775006749806;7551.773446796605;7017.438604911493;7157.320054594805;7161.57030578167;7402.814929626802;7545.471816972759;6811.727530898708;6852.109225800813;6860.759873404407;6860.897086543606;6922.411595014481;4990.4261009982865;5074.644774865724;5136.383633963948;5154.845354639367;5208.583313334849;4984.093848789196;5041.168207245763;5045.62157838171;5081.64428490017;5180.559652429435 07:20:07 INFO - PROCESS | 29118 | |4;prototype.html;322.23629996907334;329.95050742388645;335.97312215022816;337.23784247600423;338.6748721227621;5313.38896026957;5352.652077614952;5362.27609272748;5375;5382.327209098863;5206.973965130179;5292.629515933886;5307.336582927134;5308.973455132728;5329.467053294678;3941.586133455989;4038.4749982502235;4181.184668989548;4181.28918083925;4194.97902510487;4154.631859839892;4155.563665815092;4160.251154792136;4164.9583504164875;4173.770442625654;3930.2925473414775;4138.710290279667;4143.606357396043;4146.295129827921;4179.24471721876;4003.2994226010333;4092.202020605983;4097.713160078795;4114.897127571805;4117.752934823905;3627.4014787560022;3629.4192929131214;3645.1069487975615;3652.7443078984484;3667.468217108504;5008.1486147355035;5041.697498150123;5044.8234311798915;5059.015181043165;5145.742712864342;4569.725816451024;4748.881277968044;4751.524847515256;4757.357756702835;4759.762011899391;5507.2550665547415;5519.834404967857;5555.972220138873;5560.55245747635;5565.690238550997;3816.694664426839;3979.5025621797276;4032.6370626643447;4035.8385664573384;4041.6766658667234;5713.3429655589725;5720.771169153188;5770.19217309577;5812.128180772876;5815.894979953795;4067.820332103716;4079.4696689430184;4080.326746086922;4083.4691490106097;4105.486814148231;3861.4593956846065;4087.5912408758886;4142.1301526679135;4142.668586513072;4148.071146916698;4666.020135771458;4670.299455081697;4693.178693728584;4711.340412342275;4743.4859524452095;5549.72251387429;5617.157426385993;5618.43815618443;5627;5645.774169033192;1352.8985326100583;1409.8801601863752;1416.5891891351393;1419.5528408551274;1432.0834665813888;909.6225066597289;913.127962795542;918.8116436130578;1024.9897501025043;1051.9737006574744;5319.601029922771;5323.813666521731;5374.6506477078865;5375.731213439312;5383.596230282745;5650.29371328584;5658.463460337289;5673.631213971079;5683;5720.42795720433;5272.578193744568;5361.195820626859;5387.81142660005;5390.326209223847;5414.566834653218;2983.3287510310006;3000.534917087855;3006.2033561106323;3019.4715924713087;3045.512717965115;5555.77776888928;5831.912521312183;5849.3858144894175;5852.795152169739;5860.681346696959;5773.3072031356505;5774.978757434864;5832.591718579743;5834.154047663065;5850.707464626837;5798.681072540966;5824.854378640398;5861.736221870026;5885.823425297248;5899.203607512931;5409.486098820606;5625.662460252398;5628.577856660685;5732.054211055296;5765.509931655856;5667.542798892755;5679.204911312337;5685.71571421419;5709.34342550612;5724.627899186539;5760.884782304247;5983.222181116427;5983.965451746427;6014.556506438511;6030.39696030411;4055.7160998729805;4074.7962601869194;4087.325591277406;4103.097318589906;4105.58944105587;5743.253377060955;5750.453706897838;5754.395788442153;5806.938536819368;5807.506361959281;5484.533814625642;5573.554115670818;5610.242617246619;5654.773809047592;5678.74445649955;5535.861603459945;5541.6120871540215;5547.528460080938;5592.133219351007;5609.382967873449;5226.790928362975;5307.708076055854;5470.8905821882545;5500.257465242301;5555.3611334697025;5505.935274272148;5528.640638358494;5540.343373373554;5545.279113715353;5581.348859291804;5420.295361602966;5426.213199086032;5444.591655625764;5462.890742185214;5482.656749096497 07:20:07 INFO - PROCESS | 29118 | |5;yui.html;751.8345963887946;778.3734094054288;786.5123623353514;810.9878351824722;831.4263158420689;15451.768223476643;15828.287727052297;16243.83756162438;16261.10563918984;16274.51176464705;14705.264736763173;14923.253837308119;15380.384784608603;15400.460983865567;15461.768073478906;683.6445048574739;806.8830019647147;824.2046425199682;833.125218520551;836.1513064239801;818.9877151842697;828.4449418889328;831.2560258568577;832.662771577509;832.6669332267081;847.9194476524721;848.1687945813106;848.6181218451691;848.9830203395928;850.6852464588111;703.4196787650158;828.4201059258543;845.6110189312924;847.8855354527121;854.3421565394611;628.1990462160736;628.8302158417248;630;630.0297541785644;630.9558330916838;15471;15518;15522.379104835793;15522.5343239703;15539.611509712235;13990.440382384693;14351.641208969755;14373.496927607588;14419.855801442061;14650.267486625626;12616.74766504674;12799.936000320033;12901.935490322488;12939.41772620225;13033.739325213537;4303.376010478463;4364.10535840152;4426.114777044604;4549;4569.314602809572;67058;67914;68398;68668.6566567164;69215;11240.437978101063;11532.481038353295;11569.76860462786;11709.414529273503;11747.412629368497;21511.354659360244;21547.784522154892;21615.027323770468;21620.027098780592;21635;8019.236609298639;8092.9190708092165;8210.384221183434;8254.42219044673;8591.613377398033;4474.351219073216;4502.4371953505815;4567.931481027787;4617.076584683077;4676.836310729108;3371.9662803372144;3467.8729412940893;3472.7221822254664;3476.878309259164;3485.477178423206;573.3607028163567;595.7200115945499;604.7943699142313;611.3916652930274;614.4070971512512;598.86525531755;641.6278558436096;661.3617858766314;669.5380187670492;673.4141297071482;8562.443441176303;9134.086591340812;9219.492927888896;9251.90748092524;9516.857247141299;644.6712176789871;648.1832890557931;677.4208052115371;679.8238007700002;703.8456930633764;4268.914621707549;4308.504521980012;4366.257736184856;4449.28811390176;4531.252343363374;78974.605126974;102704.48647756713;104979;105998.47000764946;107250.46374768077;82488.58755706184;91501.99999999866;91724.54137729268;91867;92709;79198.6040069796;79765.20234797578;80403;81104.59447702841;81196;7763.72826951054;7861.921380786119;7863.764087077397;8225.424220304521;8391.58042097905;46493.76753116213;47023.29465058095;47732.2840157391;48253.75873120612;48741.75629121832;48261.5173848257;71827.28172718205;71987.16165189288;74995.62502187454;75205;13087.149335293176;13304.201747895157;13419.396127174105;13432.858102560353;13517.459301628218;13412.329383530589;13895.166290022227;14238.928805355907;14430.134191948096;14663.63340916443;12728.745425091261;13020;13114.868851311365;13195.20828750278;13202.537911173064;12666.556670516487;12722.491100356252;12797.552085676956;12988.740225195632;13192.538261160813;12722.173058751152;12921.612351629467;13018.869811301765;13450.12574182675;13461.730765384442;10564.947175264075;10865.348079115278;11135.443227838414;11143.2199746017;11282.717932051764;9565.90434095678;9714.902850971399;10031.247656425652;10340.948295258475;10591.417472039111 07:20:07 INFO - PROCESS | 29118 | __end_tp_report 07:20:07 INFO - PROCESS | 29118 | __start_cc_report 07:20:07 INFO - PROCESS | 29118 | _x_x_mozilla_cycle_collect,1097 07:20:07 INFO - PROCESS | 29118 | __end_cc_report 07:20:07 INFO - PROCESS | 29118 | __startTimestamp1465309207445__endTimestamp 07:20:07 INFO - PROCESS | 29118 | 07:20:07 INFO - PROCESS | 29118 | ------- Summary: start ------- 07:20:07 INFO - PROCESS | 29118 | Number of tests: 6 07:20:07 INFO - PROCESS | 29118 | 07:20:07 INFO - PROCESS | 29118 | [#0] dojo.html Cycles:165 Average:5303.48 Median:5498.18 stddev:593.76 (10.8%) stddev-sans-first:570.10 07:20:07 INFO - PROCESS | 29118 | Values: 3109.9 3121.2 3137.7 3162.3 3175.2 5163.4 5234.2 5239.8 5315.4 5368.1 5345.1 5379.5 5407.5 5498.2 5498.8 4793.9 4839.7 4846.6 4877.5 4894.0 4949.8 4967.9 4982.9 5017.1 5018.4 4741.4 4915.3 4943.9 4963.5 4976.1 4753.8 4777.1 4799.4 4817.6 4821.3 4761.3 4811.7 4849.8 4852.2 4904.6 5096.6 5297.1 5307.4 5310.6 5357.3 5633.7 5686.9 5690.8 5727.1 5760.5 5667.8 5731.1 5777.2 5789.5 5790.1 5209.7 5306.8 5443.8 5445.3 5450.6 5816.2 5913.1 5915.3 5916.6 5922.0 5653.8 5662.4 5666.2 5669.9 5672.9 5526.6 5628.3 5657.7 5727.1 5728.1 5672.8 5689.7 5689.9 5693.3 5732.4 5630.9 5668.6 5676.3 5677.3 5682.7 4267.9 4299.0 4381.7 4399.0 4416.8 3845.6 3862.0 3886.1 3887.7 3913.4 5418.6 5419.6 5424.4 5425.9 5431.2 5600.4 5676.8 5693.4 5715.1 5729.4 5391.8 5400.0 5410.2 5411.7 5412.5 4927.8 4943.3 4948.9 4982.3 4991.5 5789.6 5855.4 5913.3 5926.4 5938.2 5708.9 5726.2 5738.6 5738.9 5751.3 5718.2 5914.3 5916.9 5925.6 5926.0 5553.7 5569.1 5590.7 5614.3 5616.4 5675.3 5685.2 5688.1 5690.0 5693.8 5431.8 5539.0 5547.6 5555.8 5556.5 5562.2 5612.6 5620.3 5620.9 5664.9 5463.6 5485.2 5489.6 5522.6 5534.3 5505.3 5563.6 5605.8 5658.9 5719.9 5293.3 5336.8 5459.9 5460.3 5481.8 07:20:07 INFO - PROCESS | 29118 | 07:20:07 INFO - PROCESS | 29118 | [#1] ext.html Cycles:180 Average:60793.01 Median:388388.00 stddev:114301.20 (29.4%) stddev-sans-first:114532.47 07:20:07 INFO - PROCESS | 29118 | Values: 587.6 615.1 637.2 642.0 649.1 31137.7 43920.3 44376.6 44410.1 44477.8 45378.5 46023.5 46103.8 46182.8 46188.5 8108.9 8759.4 8949.1 10526.5 10775.2 10598.2 10741.0 10745.3 10756.8 10757.7 10744.4 10840.9 10841.8 10845.3 10850.0 7987.1 10722.3 10972.8 10972.9 10980.4 10296.5 10420.0 10424.3 10745.7 10752.2 42836.6 43427.0 43487.0 43497.0 43507.6 3560.4 3682.5 3872.4 4017.5 4207.4 33028.3 33081.5 33303.2 33351.3 33375.5 4141.5 4196.6 4299.0 4328.9 4437.0 373180.0 375956.0 378369.0 378715.0 379145.0 64189.4 64680.4 64727.0 64910.7 64955.7 69715.0 69965.3 70106.0 70139.6 70198.0 15242.7 17243.4 17485.7 17504.2 17504.6 12005.3 12632.6 12645.4 12905.5 13250.0 20351.0 20416.0 20633.2 20646.4 20847.9 7308.7 7416.4 7551.5 7555.6 7643.2 763.1 1072.9 1081.9 1140.1 1180.3 31867.5 31900.8 32134.8 32507.2 32661.5 1119.1 1120.0 1137.6 1217.9 1227.1 16699.5 16723.9 16993.8 17001.7 17071.3 511996.0 517119.0 519232.0 520620.0 521453.0 56932.1 57839.4 58263.4 58284.4 58468.0 1273.1 1317.6 1380.8 1413.3 1425.1 31506.7 33174.5 33926.5 34028.0 34166.5 51667.0 51740.5 52304.0 52320.0 52460.0 387231.0 389545.0 390379.0 390555.0 390822.0 36976.6 45685.5 46114.3 46641.5 50420.0 46117.5 46648.8 47379.3 51465.7 52888.5 42916.8 43085.6 43559.3 44173.8 44610.0 41986.4 42251.2 42524.8 42573.8 43768.3 41948.6 42416.4 43154.6 43664.8 43707.6 36414.3 37956.0 38163.0 38580.2 38615.6 28525.7 28877.3 29028.9 29280.6 29329.9 07:20:07 INFO - PROCESS | 29118 | 07:20:07 INFO - PROCESS | 29118 | [#2] jquery.html Cycles:180 Average:27655.78 Median:23243.50 stddev:75191.86 (323.5%) stddev-sans-first:75374.90 07:20:07 INFO - PROCESS | 29118 | Values: 375.7 392.0 397.1 404.2 408.0 14825.6 16879.5 18632.5 19486.0 19500.2 18194.9 19075.3 19109.9 19542.3 19563.2 5527.6 5565.3 5692.5 5696.6 5702.7 4055.5 5471.7 5635.2 5649.0 5931.2 6295.3 6297.2 6315.6 6315.9 6324.1 6160.4 6233.2 6278.0 6281.2 6328.5 5487.5 5529.4 5558.9 5569.3 5570.6 22156.2 22940.7 23187.0 23300.0 23346.9 2355.3 2504.7 3065.0 3067.0 3114.6 13577.6 13886.0 14128.6 14592.5 14717.8 1824.9 1882.9 1959.2 1962.7 1998.6 72743.3 75226.6 76210.0 76415.6 77185.6 9726.3 10416.3 10572.9 10851.8 11127.3 12764.9 13464.1 14313.3 14716.3 14719.5 8126.7 8184.1 8201.7 8263.9 8537.9 8011.4 8149.6 8158.5 8365.7 8366.0 6552.9 6586.5 6645.7 6682.3 6738.2 1835.9 1862.9 1891.6 1940.9 1956.9 967.9 1069.6 1078.0 1128.0 1154.8 18432.1 18725.6 19538.4 19617.8 19722.8 1016.0 1041.8 1061.7 1072.3 1125.4 10727.8 11176.3 11188.5 11248.5 11295.2 379705.0 384274.0 385033.0 545875.0 546395.0 84877.6 87600.0 88391.1 91890.0 97601.5 1032.9 1046.5 1059.5 1062.6 1065.1 17538.9 17676.5 17971.8 17973.2 18344.7 40922.6 41090.8 41142.6 41569.8 41733.0 56014.0 58020.7 58421.7 58935.4 59059.4 5294.9 5521.9 8145.9 8308.8 8556.4 10941.7 12670.0 12771.2 12775.9 12792.6 10800.2 11083.2 11190.3 11384.2 11625.7 10852.9 10965.9 11040.4 11160.1 11219.3 11089.4 11128.7 11182.1 11355.4 11803.6 8203.4 8300.3 8561.5 8625.0 8659.1 10999.3 11331.9 11498.0 11550.9 11596.7 07:20:07 INFO - PROCESS | 29118 | 07:20:07 INFO - PROCESS | 29118 | [#3] mootools.html Cycles:180 Average:5619.99 Median:2602.90 stddev:3169.76 (121.8%) stddev-sans-first:3162.27 07:20:07 INFO - PROCESS | 29118 | Values: 1332.4 1487.6 1521.5 1645.9 1759.5 7950.9 8266.5 8273.9 8488.5 8530.2 8271.5 8431.7 8459.2 8465.1 8475.2 1956.8 2219.2 2257.3 2283.3 2293.6 2257.3 2257.7 2260.8 2267.6 2268.2 2219.8 2271.3 2273.4 2274.3 2274.7 1981.7 2197.0 2274.1 2279.3 2292.2 2242.0 2254.6 2256.4 2260.3 2274.3 8451.8 8499.7 8516.0 8526.7 8527.1 4936.4 5063.4 5073.1 5078.6 5090.7 3280.4 3361.3 3362.2 3385.4 3474.9 1134.1 1150.5 1155.9 1164.3 1177.7 11709.4 11734.4 11735.8 11748.6 11755.5 4325.2 4490.7 4527.3 4553.3 4562.7 9830.3 9844.8 10002.4 10008.4 10025.8 4439.3 5062.6 5068.9 5069.1 5069.9 4588.4 4720.4 4729.8 4775.5 4782.6 3752.0 3828.2 3891.6 3894.7 3927.4 1216.2 1220.0 1227.3 1228.4 1236.5 983.3 988.9 1001.3 1010.2 1018.2 5821.4 5843.0 5879.3 5901.6 5964.3 472.0 476.0 478.9 1028.3 1037.4 4079.3 4096.6 4122.7 4127.3 4164.7 10359.4 10507.4 10576.4 10608.4 10643.8 10478.2 10511.1 10551.6 10576.5 10601.5 7993.9 8096.0 8105.8 8117.8 8120.1 5905.5 6051.0 6121.5 6179.2 6229.2 9379.3 9876.3 9876.6 9913.4 9929.5 9525.0 9872.7 10101.0 10137.7 10167.5 7473.3 7477.0 7496.8 7527.7 7529.0 7878.7 7896.1 7900.1 7920.8 7996.3 7270.0 7387.5 7396.3 7499.8 7551.8 7017.4 7157.3 7161.6 7402.8 7545.5 6811.7 6852.1 6860.8 6860.9 6922.4 4990.4 5074.6 5136.4 5154.8 5208.6 4984.1 5041.2 5045.6 5081.6 5180.6 07:20:07 INFO - PROCESS | 29118 | 07:20:07 INFO - PROCESS | 29118 | [#4] prototype.html Cycles:180 Average:4682.23 Median:5368.46 stddev:1379.03 (25.7%) stddev-sans-first:1343.51 07:20:07 INFO - PROCESS | 29118 | Values: 322.2 330.0 336.0 337.2 338.7 5313.4 5352.7 5362.3 5375.0 5382.3 5207.0 5292.6 5307.3 5309.0 5329.5 3941.6 4038.5 4181.2 4181.3 4195.0 4154.6 4155.6 4160.3 4165.0 4173.8 3930.3 4138.7 4143.6 4146.3 4179.2 4003.3 4092.2 4097.7 4114.9 4117.8 3627.4 3629.4 3645.1 3652.7 3667.5 5008.1 5041.7 5044.8 5059.0 5145.7 4569.7 4748.9 4751.5 4757.4 4759.8 5507.3 5519.8 5556.0 5560.6 5565.7 3816.7 3979.5 4032.6 4035.8 4041.7 5713.3 5720.8 5770.2 5812.1 5815.9 4067.8 4079.5 4080.3 4083.5 4105.5 3861.5 4087.6 4142.1 4142.7 4148.1 4666.0 4670.3 4693.2 4711.3 4743.5 5549.7 5617.2 5618.4 5627.0 5645.8 1352.9 1409.9 1416.6 1419.6 1432.1 909.6 913.1 918.8 1025.0 1052.0 5319.6 5323.8 5374.7 5375.7 5383.6 5650.3 5658.5 5673.6 5683.0 5720.4 5272.6 5361.2 5387.8 5390.3 5414.6 2983.3 3000.5 3006.2 3019.5 3045.5 5555.8 5831.9 5849.4 5852.8 5860.7 5773.3 5775.0 5832.6 5834.2 5850.7 5798.7 5824.9 5861.7 5885.8 5899.2 5409.5 5625.7 5628.6 5732.1 5765.5 5667.5 5679.2 5685.7 5709.3 5724.6 5760.9 5983.2 5984.0 6014.6 6030.4 4055.7 4074.8 4087.3 4103.1 4105.6 5743.3 5750.5 5754.4 5806.9 5807.5 5484.5 5573.6 5610.2 5654.8 5678.7 5535.9 5541.6 5547.5 5592.1 5609.4 5226.8 5307.7 5470.9 5500.3 5555.4 5505.9 5528.6 5540.3 5545.3 5581.3 5420.3 5426.2 5444.6 5462.9 5482.7 07:20:07 INFO - PROCESS | 29118 | 07:20:07 INFO - PROCESS | 29118 | [#5] yui.html Cycles:180 Average:19395.33 Median:25555.42 stddev:26931.06 (105.4%) stddev-sans-first:26970.22 07:20:07 INFO - PROCESS | 29118 | Values: 751.8 778.4 786.5 811.0 831.4 15451.8 15828.3 16243.8 16261.1 16274.5 14705.3 14923.3 15380.4 15400.5 15461.8 683.6 806.9 824.2 833.1 836.2 819.0 828.4 831.3 832.7 832.7 847.9 848.2 848.6 849.0 850.7 703.4 828.4 845.6 847.9 854.3 628.2 628.8 630.0 630.0 631.0 15471.0 15518.0 15522.4 15522.5 15539.6 13990.4 14351.6 14373.5 14419.9 14650.3 12616.7 12799.9 12901.9 12939.4 13033.7 4303.4 4364.1 4426.1 4549.0 4569.3 67058.0 67914.0 68398.0 68668.7 69215.0 11240.4 11532.5 11569.8 11709.4 11747.4 21511.4 21547.8 21615.0 21620.0 21635.0 8019.2 8092.9 8210.4 8254.4 8591.6 4474.4 4502.4 4567.9 4617.1 4676.8 3372.0 3467.9 3472.7 3476.9 3485.5 573.4 595.7 604.8 611.4 614.4 598.9 641.6 661.4 669.5 673.4 8562.4 9134.1 9219.5 9251.9 9516.9 644.7 648.2 677.4 679.8 703.8 4268.9 4308.5 4366.3 4449.3 4531.3 78974.6 102704.5 104979.0 105998.5 107250.5 82488.6 91502.0 91724.5 91867.0 92709.0 79198.6 79765.2 80403.0 81104.6 81196.0 7763.7 7861.9 7863.8 8225.4 8391.6 46493.8 47023.3 47732.3 48253.8 48741.8 48261.5 71827.3 71987.2 74995.6 75205.0 13087.1 13304.2 13419.4 13432.9 13517.5 13412.3 13895.2 14238.9 14430.1 14663.6 12728.7 13020.0 13114.9 13195.2 13202.5 12666.6 12722.5 12797.6 12988.7 13192.5 12722.2 12921.6 13018.9 13450.1 13461.7 10564.9 10865.3 11135.4 11143.2 11282.7 9565.9 9714.9 10031.2 10340.9 10591.4 07:20:07 INFO - PROCESS | 29118 | -------- Summary: end -------- 07:20:07 INFO - PROCESS | 29118 | 07:20:08 INFO - TEST-INFO | 29118: exit 0 07:20:08 INFO - TEST-OK | dromaeo_css | took 1120965ms 07:20:08 INFO - TEST-START | kraken 07:20:08 INFO - operating with platform_type : linux_ 07:20:08 INFO - Initialising browser for kraken test... 07:20:08 INFO - TEST-INFO | started process 29301 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppYOd11/profile http://localhost:54523/getInfo.html) 07:20:14 INFO - PROCESS | 29301 | __metrics Screen width/height:1600/1200 07:20:14 INFO - PROCESS | 29301 | colorDepth:24 07:20:14 INFO - PROCESS | 29301 | Browser inner width/height: 1024/697 07:20:14 INFO - PROCESS | 29301 | __metrics 07:20:16 ERROR - PROCESS | 29301 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:20:16 INFO - PROCESS | 29301 | console.error: PushService: 07:20:16 INFO - PROCESS | 29301 | stateChangeProcessEnqueue: Error transitioning state 07:20:16 INFO - PROCESS | 29301 | UnknownError 07:20:17 INFO - TEST-INFO | 29301: exit 0 07:20:17 INFO - Browser initialized. 07:20:17 INFO - Running cycle 1/1 for kraken test... 07:20:17 INFO - TEST-INFO | started process 29385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppYOd11/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:20:29 INFO - PROCESS | 29385 | RSS: Main: 160481280 07:20:29 INFO - PROCESS | 29385 | 07:20:32 INFO - PROCESS | 29385 | Cycle 1(1): loaded http://localhost:54523/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54523/tests/kraken/driver.html?testName=audio-beat-detection) 07:20:32 INFO - PROCESS | 29385 | RSS: Main: 218419200 07:20:32 INFO - PROCESS | 29385 | 07:20:35 INFO - PROCESS | 29385 | Cycle 1(1): loaded http://localhost:54523/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54523/tests/kraken/driver.html?testName=audio-dft) 07:20:36 INFO - PROCESS | 29385 | RSS: Main: 204341248 07:20:36 INFO - PROCESS | 29385 | 07:20:39 INFO - PROCESS | 29385 | Cycle 1(1): loaded http://localhost:54523/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54523/tests/kraken/driver.html?testName=audio-fft) 07:20:39 INFO - PROCESS | 29385 | RSS: Main: 271724544 07:20:39 INFO - PROCESS | 29385 | 07:20:42 INFO - PROCESS | 29385 | Cycle 1(1): loaded http://localhost:54523/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54523/tests/kraken/driver.html?testName=audio-oscillator) 07:20:42 INFO - PROCESS | 29385 | RSS: Main: 182571008 07:20:42 INFO - PROCESS | 29385 | 07:20:44 INFO - PROCESS | 29385 | Cycle 1(1): loaded http://localhost:54523/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54523/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:20:45 INFO - PROCESS | 29385 | RSS: Main: 187572224 07:20:45 INFO - PROCESS | 29385 | 07:20:48 INFO - PROCESS | 29385 | Cycle 1(1): loaded http://localhost:54523/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54523/tests/kraken/driver.html?testName=imaging-darkroom) 07:20:48 INFO - PROCESS | 29385 | RSS: Main: 221753344 07:20:48 INFO - PROCESS | 29385 | 07:20:52 INFO - PROCESS | 29385 | Cycle 1(1): loaded http://localhost:54523/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54523/tests/kraken/driver.html?testName=imaging-desaturate) 07:20:52 INFO - PROCESS | 29385 | RSS: Main: 223932416 07:20:52 INFO - PROCESS | 29385 | 07:20:55 INFO - PROCESS | 29385 | Cycle 1(1): loaded http://localhost:54523/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54523/tests/kraken/driver.html?testName=json-parse-financial) 07:20:56 INFO - PROCESS | 29385 | RSS: Main: 224653312 07:20:56 INFO - PROCESS | 29385 | 07:20:57 INFO - PROCESS | 29385 | Cycle 1(1): loaded http://localhost:54523/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54523/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:20:58 INFO - PROCESS | 29385 | RSS: Main: 211959808 07:20:58 INFO - PROCESS | 29385 | 07:21:00 INFO - PROCESS | 29385 | Cycle 1(1): loaded http://localhost:54523/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54523/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:21:00 INFO - PROCESS | 29385 | RSS: Main: 214601728 07:21:00 INFO - PROCESS | 29385 | 07:21:02 INFO - PROCESS | 29385 | Cycle 1(1): loaded http://localhost:54523/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54523/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:21:03 INFO - PROCESS | 29385 | RSS: Main: 216743936 07:21:03 INFO - PROCESS | 29385 | 07:21:06 INFO - PROCESS | 29385 | Cycle 1(1): loaded http://localhost:54523/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54523/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:21:06 INFO - PROCESS | 29385 | RSS: Main: 223838208 07:21:06 INFO - PROCESS | 29385 | 07:21:09 INFO - PROCESS | 29385 | Cycle 1(1): loaded http://localhost:54523/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54523/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:21:10 INFO - PROCESS | 29385 | RSS: Main: 222040064 07:21:10 INFO - PROCESS | 29385 | 07:21:11 INFO - PROCESS | 29385 | Cycle 1(1): loaded http://localhost:54523/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54523/tests/kraken/driver.html?testName=ai-astar) 07:21:12 INFO - PROCESS | 29385 | RSS: Main: 264183808 07:21:12 INFO - PROCESS | 29385 | 07:21:12 INFO - PROCESS | 29385 | __start_tp_report 07:21:12 INFO - PROCESS | 29385 | _x_x_mozilla_page_load 07:21:12 INFO - PROCESS | 29385 | _x_x_mozilla_page_load_details 07:21:12 INFO - PROCESS | 29385 | |i|pagename|runs| 07:21:12 INFO - PROCESS | 29385 | |0;ai-astar;112;104;110;110;113;112;112;111;111;111 07:21:12 INFO - PROCESS | 29385 | |1;audio-beat-detection;152;126;127;183;126;125;152;132;162;129 07:21:12 INFO - PROCESS | 29385 | |2;audio-dft;161;161;163;160;160;160;161;164;162;162 07:21:12 INFO - PROCESS | 29385 | |3;audio-fft;74;75;76;126;75;76;74;75;99;74 07:21:12 INFO - PROCESS | 29385 | |4;audio-oscillator;85;85;109;85;85;86;116;85;85;129 07:21:12 INFO - PROCESS | 29385 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 07:21:12 INFO - PROCESS | 29385 | |6;imaging-darkroom;146;147;146;146;146;146;146;146;146;147 07:21:12 INFO - PROCESS | 29385 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;96 07:21:12 INFO - PROCESS | 29385 | |8;json-parse-financial;55;55;57;56;56;56;55;55;55;58 07:21:12 INFO - PROCESS | 29385 | |9;json-stringify-tinderbox;61;60;61;60;61;61;60;61;61;61 07:21:12 INFO - PROCESS | 29385 | |10;stanford-crypto-aes;80;79;86;79;80;82;81;83;112;85 07:21:12 INFO - PROCESS | 29385 | |11;stanford-crypto-ccm;124;130;120;120;120;120;125;139;130;125 07:21:12 INFO - PROCESS | 29385 | |12;stanford-crypto-pbkdf2;161;161;158;163;163;160;158;164;161;157 07:21:12 INFO - PROCESS | 29385 | |13;stanford-crypto-sha256-iterative;64;62;66;63;64;63;64;63;64;62 07:21:12 INFO - PROCESS | 29385 | __end_tp_report 07:21:12 INFO - PROCESS | 29385 | __start_cc_report 07:21:12 INFO - PROCESS | 29385 | _x_x_mozilla_cycle_collect,1656 07:21:12 INFO - PROCESS | 29385 | __end_cc_report 07:21:12 INFO - PROCESS | 29385 | __startTimestamp1465309271999__endTimestamp 07:21:12 INFO - PROCESS | 29385 | 07:21:12 INFO - PROCESS | 29385 | ------- Summary: start ------- 07:21:12 INFO - PROCESS | 29385 | Number of tests: 14 07:21:12 INFO - PROCESS | 29385 | 07:21:12 INFO - PROCESS | 29385 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:2.50 (2.2%) stddev-sans-first:2.60 07:21:12 INFO - PROCESS | 29385 | Values: 112.0 104.0 110.0 110.0 113.0 112.0 112.0 111.0 111.0 111.0 07:21:12 INFO - PROCESS | 29385 | 07:21:12 INFO - PROCESS | 29385 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:142.00 stddev:19.92 (14.0%) stddev-sans-first:20.76 07:21:12 INFO - PROCESS | 29385 | Values: 152.0 126.0 127.0 183.0 126.0 125.0 152.0 132.0 162.0 129.0 07:21:12 INFO - PROCESS | 29385 | 07:21:12 INFO - PROCESS | 29385 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.35 (0.8%) stddev-sans-first:1.42 07:21:12 INFO - PROCESS | 29385 | Values: 161.0 161.0 163.0 160.0 160.0 160.0 161.0 164.0 162.0 162.0 07:21:12 INFO - PROCESS | 29385 | 07:21:12 INFO - PROCESS | 29385 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:17.11 (22.8%) stddev-sans-first:17.87 07:21:12 INFO - PROCESS | 29385 | Values: 74.0 75.0 76.0 126.0 75.0 76.0 74.0 75.0 99.0 74.0 07:21:12 INFO - PROCESS | 29385 | 07:21:12 INFO - PROCESS | 29385 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:85.00 stddev:16.58 (19.5%) stddev-sans-first:17.19 07:21:12 INFO - PROCESS | 29385 | Values: 85.0 85.0 109.0 85.0 85.0 86.0 116.0 85.0 85.0 129.0 07:21:12 INFO - PROCESS | 29385 | 07:21:12 INFO - PROCESS | 29385 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:21:12 INFO - PROCESS | 29385 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 07:21:12 INFO - PROCESS | 29385 | 07:21:12 INFO - PROCESS | 29385 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 07:21:12 INFO - PROCESS | 29385 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 07:21:12 INFO - PROCESS | 29385 | 07:21:12 INFO - PROCESS | 29385 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:21:12 INFO - PROCESS | 29385 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 07:21:12 INFO - PROCESS | 29385 | 07:21:12 INFO - PROCESS | 29385 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:1.03 (1.8%) stddev-sans-first:1.05 07:21:12 INFO - PROCESS | 29385 | Values: 55.0 55.0 57.0 56.0 56.0 56.0 55.0 55.0 55.0 58.0 07:21:12 INFO - PROCESS | 29385 | 07:21:12 INFO - PROCESS | 29385 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 07:21:12 INFO - PROCESS | 29385 | Values: 61.0 60.0 61.0 60.0 61.0 61.0 60.0 61.0 61.0 61.0 07:21:12 INFO - PROCESS | 29385 | 07:21:12 INFO - PROCESS | 29385 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:81.50 stddev:9.89 (12.1%) stddev-sans-first:10.34 07:21:12 INFO - PROCESS | 29385 | Values: 80.0 79.0 86.0 79.0 80.0 82.0 81.0 83.0 112.0 85.0 07:21:12 INFO - PROCESS | 29385 | 07:21:12 INFO - PROCESS | 29385 | [#11] stanford-crypto-ccm Cycles:10 Average:125.30 Median:125.00 stddev:6.20 (5.0%) stddev-sans-first:6.56 07:21:12 INFO - PROCESS | 29385 | Values: 124.0 130.0 120.0 120.0 120.0 120.0 125.0 139.0 130.0 125.0 07:21:12 INFO - PROCESS | 29385 | 07:21:12 INFO - PROCESS | 29385 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:161.00 stddev:2.37 (1.5%) stddev-sans-first:2.51 07:21:12 INFO - PROCESS | 29385 | Values: 161.0 161.0 158.0 163.0 163.0 160.0 158.0 164.0 161.0 157.0 07:21:12 INFO - PROCESS | 29385 | 07:21:12 INFO - PROCESS | 29385 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.18 (1.8%) stddev-sans-first:1.24 07:21:12 INFO - PROCESS | 29385 | Values: 64.0 62.0 66.0 63.0 64.0 63.0 64.0 63.0 64.0 62.0 07:21:12 INFO - PROCESS | 29385 | -------- Summary: end -------- 07:21:12 INFO - PROCESS | 29385 | 07:21:14 INFO - TEST-INFO | 29385: exit 0 07:21:14 INFO - TEST-OK | kraken | took 66009ms 07:21:14 INFO - SUITE-END | took 1186s 07:21:14 INFO - Completed test suite (00:19:47) 07:21:14 INFO - javascript benchmark 07:21:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3109.891153809616, 3121.172889184366, 3137.733292670123, 3162.320101178246, 3175.222070592704, 5163.3545806774155, 5234.241035049916, 5239.764210610522, 5315.415304316527, 5368.060589396855, 5345.1447768357075, 5379.462053794618, 5407.459254074591, 5498.1752737089455, 5498.80754173604, 4793.928091078619, 4839.685420447659, 4846.563809257166, 4877.487863774306, 4893.999999999991, 4949.8020079196785, 4967.875803104916, 4982.9252561211615, 5017.147084995541, 5018.447970723218, 4741.407324084489, 4915.3364295819965, 4943.8516844494725, 4963.503649635026, 4976.054549635575, 4753.762311884427, 4777.06847164803, 4799.400074990626, 4817.56641902227, 4821.300911367867, 4761.262004389325, 4811.711297322172, 4849.806007759686, 4852.2479015752615, 4904.60763138948, 5096.643234973553, 5297.12597421425, 5307.442718514578, 5310.62825602208, 5357.276767636358, 5633.718314084279, 5686.914696279559, 5690.800821971211, 5727.055035919068, 5760.481556659879, 5667.829965101012, 5731.083026715747, 5777.19119323295, 5789.536837053026, 5790.073588225863, 5209.713465759344, 5306.787728490817, 5443.836684899459, 5445.292112025451, 5450.591205659592, 5816.243888294494, 5913.142594323799, 5915.260592425947, 5916.556258280646, 5921.970390148022, 5653.773849045992, 5662.433756624305, 5666.178404131378, 5669.858253543694, 5672.8865422691315, 5526.613137080366, 5628.324601047819, 5657.745401456862, 5727.140928860621, 5728.112142617901, 5672.829815105553, 5689.68706721126, 5689.9146512802345, 5693.3168019837885, 5732.398098199629, 5630.85922851932, 5668.631538949955, 5676.318841739017, 5677.347105082886, 5682.715864206773, 4267.850625228102, 4298.978505107454, 4381.737095774264, 4398.956010439919, 4416.757078360657, 3845.576986531479, 3861.9806900965314, 3886.067343837459, 3887.6501114899793, 3913.3542965410957, 5418.593605479605, 5419.593530485229, 5424.403315635277, 5425.891482170335, 5431.21247419122, 5600.411956744565, 5676.77292908279, 5693.373728889819, 5715.114157305624, 5729.369769325371, 5391.757370918318, 5400.027994960867, 5410.1614249790555, 5411.729413529308, 5412.485813847678, 4927.827526036572, 4943.332650092191, 4948.876278093005, 4982.277569752366, 4991.450940396553, 5789.623674461147, 5855.443732845373, 5913.29040515141, 5926.377730338339, 5938.198343223696, 5708.942910570841, 5726.169705392778, 5738.598298119092, 5738.9139162913425, 5751.281089863767, 5718.199452076629, 5914.260717410324, 5916.852078698067, 5925.614835035709, 5925.970370148121, 5553.666779993213, 5569.136783798518, 5590.664560126405, 5614.326280846324, 5616.354119276336, 5675.290588676416, 5685.175649530877, 5688.11834165705, 5690.032694442038, 5693.829185124453, 5431.83704488866, 5538.972305138448, 5547.611667183259, 5555.805546806004, 5556.527695145796, 5562.2490963721, 5612.550995920398, 5620.26936498269, 5620.915686264628, 5664.915026274527, 5463.644863083887, 5485.17722341636, 5489.58828087887, 5522.641028333145, 5534.252875861707, 5505.256790333254, 5563.58273129525, 5605.80379686709, 5658.85852853682, 5719.8570035749435, 5293.311869456946, 5336.78652853897, 5459.945400545944, 5460.344758628831, 5481.75332110048], "value": 5264.122422264562, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.6415386614165, 615.1295916278466, 637.2066776862804, 641.964691941943, 649.133406901786, 31137.68862311376, 43920.341194882065, 44376.556234437645, 44410.11179776407, 44477.7776111119, 45378.54621453785, 46023.53976460234, 46103.76948115263, 46182.76908615461, 46188.538114618845, 8108.918910810905, 8759.430637008605, 8949.105089491064, 10526.526306316196, 10775.191860610446, 10598.205134614935, 10741.0, 10745.301555398913, 10756.838647420294, 10757.677269681883, 10744.355338679665, 10840.945795271013, 10841.783164336708, 10845.295055821385, 10850.0, 7987.121416644164, 10722.303050301745, 10972.792992770788, 10972.890271097267, 10980.396078215696, 10296.536655850505, 10419.958004199596, 10424.270301078928, 10745.731356716145, 10752.193585481042, 42836.57163428388, 43427.0, 43487.0, 43497.0, 43507.56492435098, 3560.3992747703783, 3682.5212722345923, 3872.3610604250266, 4017.4978127734034, 4207.43199668044, 33028.3394332112, 33081.50377744336, 33303.16742081467, 33351.332973340395, 33375.49936750951, 4141.461609990682, 4196.622303992624, 4299.0, 4328.891777705582, 4436.9556304436865, 373180.0, 375956.0, 378369.0, 378715.0, 379145.0, 64189.35810641927, 64680.35319646837, 64727.0, 64910.67544662247, 64955.67522162359, 69715.0, 69965.3003469969, 70106.0, 70139.64930175418, 70198.0, 15242.695146097238, 17243.3964811231, 17485.65028699419, 17504.21231044606, 17504.562385940455, 12005.339706316236, 12632.557860474839, 12645.430955606837, 12905.483780648668, 13250.0, 20351.0, 20416.039674247448, 20633.17467301321, 20646.380608581767, 20847.8957605211, 7308.744193953186, 7416.441327741921, 7551.546907185587, 7555.622218889033, 7643.235676432312, 763.107164617399, 1072.8766191888033, 1081.8809930907594, 1140.1278022312938, 1180.2505409065304, 31867.521987169748, 31900.840495797373, 32134.839325803223, 32507.18732031718, 32661.51007734886, 1119.0879433261866, 1119.9552017919355, 1137.5734099712608, 1217.9208351457128, 1227.061298106931, 16699.499015029567, 16723.91638041802, 16993.83006169947, 17001.659966800595, 17071.31714731397, 511996.0, 517119.0, 519232.0, 520620.0, 521453.0, 56932.14601780977, 57839.421605783406, 58263.417365826645, 58284.41715582875, 58468.0, 1273.070658419359, 1317.6047185844209, 1380.7997840313099, 1413.2862904233502, 1425.1449130521605, 31506.692026977707, 33174.502382464765, 33926.491102633976, 34028.0, 34166.487502687974, 51667.0, 51740.48259517357, 52304.0, 52320.0, 52460.0, 387231.0, 389545.0, 390379.0, 390555.0, 390822.0, 36976.63023369839, 45685.54314456813, 46114.308285375075, 46641.53358466372, 50419.97480151203, 46117.53882461132, 46648.766756166006, 47379.289310659675, 51465.7426712864, 52888.471115289896, 42916.78541607272, 43085.56914430815, 43559.34660980025, 44173.779131105424, 44610.0, 41986.37020444635, 42251.15497689968, 42524.78737606292, 42573.78713106415, 43768.34347484854, 41948.580514194466, 42416.36375454433, 43154.56845431631, 43664.78167609269, 43707.56292437035, 36414.27171456503, 37956.0, 38163.0, 38580.228395432496, 38615.613843862324, 28525.714742852306, 28877.27806804847, 29028.854855725585, 29280.560791587715, 29329.85335073311], "value": 21326.989464866587, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.66002767495416, 391.990200244994, 397.14811728841636, 404.1774987899625, 407.96124368185014, 14825.627581823946, 16879.49361519153, 18632.534186645342, 19486.0, 19500.219991200353, 18194.909025454886, 19075.332363367284, 19109.904450477763, 19542.31601893934, 19563.21747130113, 5527.640703354279, 5565.276514053167, 5692.487676109149, 5696.572757043217, 5702.686352250625, 4055.513338399396, 5471.7264136793, 5635.21107045014, 5649.0396632572565, 5931.169636250928, 6295.338989406115, 6297.244330680325, 6315.557910946236, 6315.936840631581, 6324.083007963843, 6160.4455598995855, 6233.2208473940755, 6277.968610156943, 6281.214848143982, 6328.525360597973, 5487.506124448779, 5529.391766905637, 5558.86102847428, 5569.331680198402, 5570.637908535932, 22156.22453214146, 22940.655890161663, 23187.0, 23300.0, 23346.883265583732, 2355.281639100074, 2504.6618706474574, 3065.049834551296, 3066.9846650766826, 3114.5951026366656, 13577.59267221985, 13886.0, 14128.576142715736, 14592.489262875748, 14717.779233311509, 1824.9178786954485, 1882.8776129551536, 1959.1967293409634, 1962.656535106365, 1998.580298137393, 72743.27256727418, 75226.62386688087, 76210.0, 76415.61792191003, 77185.61407192984, 9726.2705297103, 10416.32293900894, 10572.894271057345, 10851.78296434067, 11127.276727012719, 12764.872351276554, 13464.124831885896, 14313.28433578317, 14716.264186790617, 14719.484818031318, 8126.715564955198, 8184.099749027602, 8201.71294004707, 8263.917360826435, 8537.871931921027, 8011.399145064143, 8149.633266503021, 8158.469699469515, 8365.707200247962, 8366.0, 6552.934470655233, 6586.506012049115, 6645.734170633217, 6682.3317668232785, 6738.157730283715, 1835.917383717736, 1862.9347972820885, 1891.564940063793, 1940.9417717468498, 1956.9412917612494, 967.8596603492595, 1069.641670040545, 1078.009401590737, 1127.9904485485608, 1154.8383226348317, 18432.07839608041, 18725.625487490175, 19538.413847584594, 19617.803821961883, 19722.802771972096, 1015.9898401016043, 1041.7603951091291, 1061.7027232374946, 1072.340510585984, 1125.3697929159532, 10727.83908241377, 11176.27354221973, 11188.496517656726, 11248.493817778219, 11295.152863535268, 379705.0, 384274.02218855685, 385033.0, 545875.0, 546395.0, 84877.57561212154, 87600.0, 88391.11608883829, 91890.0, 97601.51199243958, 1032.8554002439664, 1046.4506134279563, 1059.5285098131412, 1062.612146566513, 1065.1106326217541, 17538.912305438393, 17676.469705908843, 17971.820281797016, 17973.191206396004, 18344.72482912784, 40922.59077409307, 41090.79454602708, 41142.58857411388, 41569.79215104026, 41733.0, 56014.0, 58020.70989645194, 58421.70789146027, 58935.410645894706, 59059.40940590539, 5294.867628309323, 5521.944780552143, 8145.877811832709, 8308.83382332362, 8556.358273129665, 10941.726456838644, 12670.0, 12771.233725976472, 12775.87224127784, 12792.552260670831, 10800.24398292112, 11083.168762343017, 11190.32858028521, 11384.203105782515, 11625.709357266136, 10852.945735271272, 10965.945170274097, 11040.447977601249, 11160.10719142483, 11219.270747401393, 11089.401068665815, 11128.721781955515, 11182.105431565293, 11355.432228388712, 11803.645890623295, 8203.384746143944, 8300.252977232078, 8561.48631082137, 8625.0, 8659.090795466385, 10999.34003959765, 11331.943340283246, 11498.0, 11550.88449115498, 11596.710082248012], "value": 9326.51506521728, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.3737843213698, 1487.5834766265443, 1521.4750910935727, 1645.9177041147939, 1759.4985429152687, 7950.880736788953, 8266.504009759412, 8273.875891861628, 8488.490690558556, 8530.189631984951, 8271.462354946923, 8431.70489032884, 8459.154084591537, 8465.068842427328, 8475.237228649421, 1956.7651881774136, 2219.1678120704737, 2257.27767114523, 2283.3264187064856, 2293.5642227976714, 2257.2776711452343, 2257.7403598586125, 2260.7513173550897, 2267.6031694453404, 2268.1947908492493, 2219.7669244729314, 2271.3299576624936, 2273.4089136824464, 2274.2949685597437, 2274.6701728249395, 1981.6928376101728, 2196.9670454943107, 2274.0903638544714, 2279.282026161754, 2292.2206449806977, 2241.9775802242093, 2254.639257718757, 2256.424611724, 2260.276711452336, 2274.2608652188105, 8451.830963380698, 8499.702510412168, 8515.957420212859, 8526.658933642648, 8527.062023177445, 4936.358273424467, 5063.392392912837, 5073.137566613685, 5078.568321692661, 5090.694558326475, 3280.3603297357026, 3361.2941282330494, 3362.1762668146216, 3385.4244778387733, 3474.8610055597746, 1134.1323887226279, 1150.511032811052, 1155.8959693627614, 1164.2548768787983, 1177.6996865799251, 11709.355985420798, 11734.354610496504, 11735.823962640567, 11748.588799392066, 11755.529778808923, 4325.2214601371425, 4490.685652004394, 4527.298268768346, 4553.33976573395, 4562.703424277412, 9830.311878168603, 9844.80310393788, 10002.399856008662, 10008.44953527563, 10025.849612255823, 4439.267520859086, 5062.620303477254, 5068.910184310391, 5069.138246498104, 5069.923951140736, 4588.357629931812, 4720.362751028636, 4729.810807567659, 4775.474697783241, 4782.593479554207, 3751.9624803751612, 3828.1769419574925, 3891.630295121959, 3894.6884249259992, 3927.3716205407, 1216.2155409760655, 1219.9573014944435, 1227.257509206917, 1228.441059318026, 1236.4683186229827, 983.3018556824735, 988.8665030220972, 1001.2640709078821, 1010.1565193063727, 1018.1651046142092, 5821.38875418075, 5843.0, 5879.2944846618675, 5901.645901245939, 5964.284285885635, 472.0, 475.9976200118977, 478.8730986288636, 1028.3264461777549, 1037.419045334615, 4079.326911059701, 4096.569860164699, 4122.711410201257, 4127.2570937231585, 4164.729292596032, 10359.378437293786, 10507.369557826401, 10576.365418074785, 10608.416537090534, 10643.84034239487, 10478.214133939984, 10511.106555942677, 10551.577936882592, 10576.471176441148, 10601.469926503643, 7993.920060799318, 8095.959520202361, 8105.75682729519, 8117.756467305872, 8120.106788253287, 5905.527557795452, 6051.0, 6121.47967422774, 6179.227596550431, 6229.200187885477, 9379.343445958717, 9876.308658393844, 9876.604935802487, 9913.355631883904, 9929.503524823875, 9525.047495250697, 9872.654457093968, 10101.0, 10137.746556336151, 10167.491625418552, 7473.290037446434, 7476.962615186889, 7496.7750967471065, 7527.698892044257, 7528.962355188408, 7878.684852606061, 7896.052473702963, 7900.130985591695, 7920.801979950547, 7996.280334769898, 7269.963650181927, 7387.519811212254, 7396.3343299103335, 7499.775006749806, 7551.773446796605, 7017.438604911493, 7157.320054594805, 7161.57030578167, 7402.814929626802, 7545.471816972759, 6811.727530898708, 6852.109225800813, 6860.759873404407, 6860.897086543606, 6922.411595014481, 4990.4261009982865, 5074.644774865724, 5136.383633963948, 5154.845354639367, 5208.583313334849, 4984.093848789196, 5041.168207245763, 5045.62157838171, 5081.64428490017, 5180.559652429435], "value": 4490.424376452582, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.23629996907334, 329.95050742388645, 335.97312215022816, 337.23784247600423, 338.6748721227621, 5313.38896026957, 5352.652077614952, 5362.27609272748, 5375.0, 5382.327209098863, 5206.973965130179, 5292.629515933886, 5307.336582927134, 5308.973455132728, 5329.467053294678, 3941.586133455989, 4038.4749982502235, 4181.184668989548, 4181.28918083925, 4194.97902510487, 4154.631859839892, 4155.563665815092, 4160.251154792136, 4164.9583504164875, 4173.770442625654, 3930.2925473414775, 4138.710290279667, 4143.606357396043, 4146.295129827921, 4179.24471721876, 4003.2994226010333, 4092.202020605983, 4097.713160078795, 4114.897127571805, 4117.752934823905, 3627.4014787560022, 3629.4192929131214, 3645.1069487975615, 3652.7443078984484, 3667.468217108504, 5008.1486147355035, 5041.697498150123, 5044.8234311798915, 5059.015181043165, 5145.742712864342, 4569.725816451024, 4748.881277968044, 4751.524847515256, 4757.357756702835, 4759.762011899391, 5507.2550665547415, 5519.834404967857, 5555.972220138873, 5560.55245747635, 5565.690238550997, 3816.694664426839, 3979.5025621797276, 4032.6370626643447, 4035.8385664573384, 4041.6766658667234, 5713.3429655589725, 5720.771169153188, 5770.19217309577, 5812.128180772876, 5815.894979953795, 4067.820332103716, 4079.4696689430184, 4080.326746086922, 4083.4691490106097, 4105.486814148231, 3861.4593956846065, 4087.5912408758886, 4142.1301526679135, 4142.668586513072, 4148.071146916698, 4666.020135771458, 4670.299455081697, 4693.178693728584, 4711.340412342275, 4743.4859524452095, 5549.72251387429, 5617.157426385993, 5618.43815618443, 5627.0, 5645.774169033192, 1352.8985326100583, 1409.8801601863752, 1416.5891891351393, 1419.5528408551274, 1432.0834665813888, 909.6225066597289, 913.127962795542, 918.8116436130578, 1024.9897501025043, 1051.9737006574744, 5319.601029922771, 5323.813666521731, 5374.6506477078865, 5375.731213439312, 5383.596230282745, 5650.29371328584, 5658.463460337289, 5673.631213971079, 5683.0, 5720.42795720433, 5272.578193744568, 5361.195820626859, 5387.81142660005, 5390.326209223847, 5414.566834653218, 2983.3287510310006, 3000.534917087855, 3006.2033561106323, 3019.4715924713087, 3045.512717965115, 5555.77776888928, 5831.912521312183, 5849.3858144894175, 5852.795152169739, 5860.681346696959, 5773.3072031356505, 5774.978757434864, 5832.591718579743, 5834.154047663065, 5850.707464626837, 5798.681072540966, 5824.854378640398, 5861.736221870026, 5885.823425297248, 5899.203607512931, 5409.486098820606, 5625.662460252398, 5628.577856660685, 5732.054211055296, 5765.509931655856, 5667.542798892755, 5679.204911312337, 5685.71571421419, 5709.34342550612, 5724.627899186539, 5760.884782304247, 5983.222181116427, 5983.965451746427, 6014.556506438511, 6030.39696030411, 4055.7160998729805, 4074.7962601869194, 4087.325591277406, 4103.097318589906, 4105.58944105587, 5743.253377060955, 5750.453706897838, 5754.395788442153, 5806.938536819368, 5807.506361959281, 5484.533814625642, 5573.554115670818, 5610.242617246619, 5654.773809047592, 5678.74445649955, 5535.861603459945, 5541.6120871540215, 5547.528460080938, 5592.133219351007, 5609.382967873449, 5226.790928362975, 5307.708076055854, 5470.8905821882545, 5500.257465242301, 5555.3611334697025, 5505.935274272148, 5528.640638358494, 5540.343373373554, 5545.279113715353, 5581.348859291804, 5420.295361602966, 5426.213199086032, 5444.591655625764, 5462.890742185214, 5482.656749096497], "value": 4243.4287016645685, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.8345963887946, 778.3734094054288, 786.5123623353514, 810.9878351824722, 831.4263158420689, 15451.768223476643, 15828.287727052297, 16243.83756162438, 16261.10563918984, 16274.51176464705, 14705.264736763173, 14923.253837308119, 15380.384784608603, 15400.460983865567, 15461.768073478906, 683.6445048574739, 806.8830019647147, 824.2046425199682, 833.125218520551, 836.1513064239801, 818.9877151842697, 828.4449418889328, 831.2560258568577, 832.662771577509, 832.6669332267081, 847.9194476524721, 848.1687945813106, 848.6181218451691, 848.9830203395928, 850.6852464588111, 703.4196787650158, 828.4201059258543, 845.6110189312924, 847.8855354527121, 854.3421565394611, 628.1990462160736, 628.8302158417248, 630.0, 630.0297541785644, 630.9558330916838, 15471.0, 15518.0, 15522.379104835793, 15522.5343239703, 15539.611509712235, 13990.440382384693, 14351.641208969755, 14373.496927607588, 14419.855801442061, 14650.267486625626, 12616.74766504674, 12799.936000320033, 12901.935490322488, 12939.41772620225, 13033.739325213537, 4303.376010478463, 4364.10535840152, 4426.114777044604, 4549.0, 4569.314602809572, 67058.0, 67914.0, 68398.0, 68668.6566567164, 69215.0, 11240.437978101063, 11532.481038353295, 11569.76860462786, 11709.414529273503, 11747.412629368497, 21511.354659360244, 21547.784522154892, 21615.027323770468, 21620.027098780592, 21635.0, 8019.236609298639, 8092.9190708092165, 8210.384221183434, 8254.42219044673, 8591.613377398033, 4474.351219073216, 4502.4371953505815, 4567.931481027787, 4617.076584683077, 4676.836310729108, 3371.9662803372144, 3467.8729412940893, 3472.7221822254664, 3476.878309259164, 3485.477178423206, 573.3607028163567, 595.7200115945499, 604.7943699142313, 611.3916652930274, 614.4070971512512, 598.86525531755, 641.6278558436096, 661.3617858766314, 669.5380187670492, 673.4141297071482, 8562.443441176303, 9134.086591340812, 9219.492927888896, 9251.90748092524, 9516.857247141299, 644.6712176789871, 648.1832890557931, 677.4208052115371, 679.8238007700002, 703.8456930633764, 4268.914621707549, 4308.504521980012, 4366.257736184856, 4449.28811390176, 4531.252343363374, 78974.605126974, 102704.48647756713, 104979.0, 105998.47000764946, 107250.46374768077, 82488.58755706184, 91501.99999999866, 91724.54137729268, 91867.0, 92709.0, 79198.6040069796, 79765.20234797578, 80403.0, 81104.59447702841, 81196.0, 7763.72826951054, 7861.921380786119, 7863.764087077397, 8225.424220304521, 8391.58042097905, 46493.76753116213, 47023.29465058095, 47732.2840157391, 48253.75873120612, 48741.75629121832, 48261.5173848257, 71827.28172718205, 71987.16165189288, 74995.62502187454, 75205.0, 13087.149335293176, 13304.201747895157, 13419.396127174105, 13432.858102560353, 13517.459301628218, 13412.329383530589, 13895.166290022227, 14238.928805355907, 14430.134191948096, 14663.63340916443, 12728.745425091261, 13020.0, 13114.868851311365, 13195.20828750278, 13202.537911173064, 12666.556670516487, 12722.491100356252, 12797.552085676956, 12988.740225195632, 13192.538261160813, 12722.173058751152, 12921.612351629467, 13018.869811301765, 13450.12574182675, 13461.730765384442, 10564.947175264075, 10865.348079115278, 11135.443227838414, 11143.2199746017, 11282.717932051764, 9565.90434095678, 9714.902850971399, 10031.247656425652, 10340.948295258475, 10591.417472039111], "value": 7335.930997397853, "unit": "score"}], "name": "dromaeo_css", "value": 7259.61964785073, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 104.0, 110.0, 110.0, 113.0, 112.0, 112.0, 111.0, 111.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 127.0, 183.0, 126.0, 125.0, 152.0, 132.0, 162.0, 129.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 160.0, 160.0, 160.0, 161.0, 164.0, 162.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 126.0, 75.0, 76.0, 74.0, 75.0, 99.0, 74.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 109.0, 85.0, 85.0, 86.0, 116.0, 85.0, 85.0, 129.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 57.0, 56.0, 56.0, 56.0, 55.0, 55.0, 55.0, 58.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 86.0, 79.0, 80.0, 82.0, 81.0, 83.0, 112.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 130.0, 120.0, 120.0, 120.0, 120.0, 125.0, 139.0, 130.0, 125.0], "value": 125.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 158.0, 163.0, 163.0, 160.0, 158.0, 164.0, 161.0, 157.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 66.0, 63.0, 64.0, 63.0, 64.0, 63.0, 64.0, 62.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1499.6999999999998, "alertThreshold": 2.0}]} 07:21:14 INFO - Return code: 0 07:21:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:21:14 ERROR - # TBPL SUCCESS # 07:21:14 INFO - Running post-action listener: _resource_record_post_action 07:21:14 INFO - ##### 07:21:14 INFO - ##### Finished run-tests step (success) 07:21:14 INFO - ##### 07:21:14 INFO - Running post-run listener: _resource_record_post_run 07:21:14 INFO - Total resource usage - Wall time: 1211s; CPU: 14.0%; Read bytes: 4096; Write bytes: 547414016; Read time: 628; Write time: 4181808 07:21:14 INFO - TinderboxPrint: CPU usage
13.6% 07:21:14 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 628 07:21:14 INFO - TinderboxPrint: I/O write bytes / time
547,414,016 / 4,181,808 07:21:14 INFO - TinderboxPrint: CPU idle
8,352.2 (86.4%) 07:21:14 INFO - TinderboxPrint: CPU user
1,207.4 (12.5%) 07:21:14 INFO - TinderboxPrint: Swap in / out
0 / 0 07:21:14 INFO - install - Wall time: 17s; CPU: 29.0%; Read bytes: 0; Write bytes: 159936512; Read time: 0; Write time: 1488716 07:21:14 INFO - run-tests - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 375070720; Read time: 628; Write time: 2533756 07:21:15 INFO - Running post-run listener: _upload_blobber_files 07:21:15 INFO - Blob upload gear active. 07:21:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:21:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:21:15 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'] 07:21:15 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 07:21:15 INFO - (blobuploader) - INFO - Open directory for files ... 07:21:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:21:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:21:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:21:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:21:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:21:16 INFO - (blobuploader) - INFO - Done attempting. 07:21:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:21:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:21:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:21:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:21:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:21:20 INFO - (blobuploader) - INFO - Done attempting. 07:21:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:21:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:21:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:21:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:21:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:21:21 INFO - (blobuploader) - INFO - Done attempting. 07:21:21 INFO - (blobuploader) - INFO - Iteration through files over. 07:21:21 INFO - Return code: 0 07:21:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:21:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:21:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f212ff9cf771388a1d979d4283c999c6b84101b394c8f523e7ac78c22c8b068c38def8034b5928fb87a943748543ef92cf7d8259aec05139d427d5af1cfe8b08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4e6dadf60368fcff8c5ee35231751a94721e0917302b2e79b2628658d061a262a693b90d5c801ddc14dc5cf37358993c1504defa45d08538b97fc20cd2c12717", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f2958b2076d6f4e41850d41d50b534cfec0e1cee46e4b6bd85820b5a7e8963630294d41766b7456e510b8adc8ef7bb7386fc8ce39201e7ac8b3cb4bc8e4b6b6f"} 07:21:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:21:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:21:21 INFO - Contents: 07:21:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f212ff9cf771388a1d979d4283c999c6b84101b394c8f523e7ac78c22c8b068c38def8034b5928fb87a943748543ef92cf7d8259aec05139d427d5af1cfe8b08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4e6dadf60368fcff8c5ee35231751a94721e0917302b2e79b2628658d061a262a693b90d5c801ddc14dc5cf37358993c1504defa45d08538b97fc20cd2c12717", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f2958b2076d6f4e41850d41d50b534cfec0e1cee46e4b6bd85820b5a7e8963630294d41766b7456e510b8adc8ef7bb7386fc8ce39201e7ac8b3cb4bc8e4b6b6f"} 07:21:21 INFO - Running post-run listener: copy_logs_to_upload_dir 07:21:21 INFO - Copying logs to upload dir... 07:21:21 INFO - mkdir: /builds/slave/test/build/upload/logs 07:21:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.389009 ========= master_lag: 99.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 37 secs) (at 2016-06-07 07:23:00.343969) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 07:23:00.348036) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747 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/f212ff9cf771388a1d979d4283c999c6b84101b394c8f523e7ac78c22c8b068c38def8034b5928fb87a943748543ef92cf7d8259aec05139d427d5af1cfe8b08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4e6dadf60368fcff8c5ee35231751a94721e0917302b2e79b2628658d061a262a693b90d5c801ddc14dc5cf37358993c1504defa45d08538b97fc20cd2c12717", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f2958b2076d6f4e41850d41d50b534cfec0e1cee46e4b6bd85820b5a7e8963630294d41766b7456e510b8adc8ef7bb7386fc8ce39201e7ac8b3cb4bc8e4b6b6f"} build_url:https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009574 build_url: 'https://queue.taskcluster.net/v1/task/fpcl35WPSNO7upkvoxwKoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f212ff9cf771388a1d979d4283c999c6b84101b394c8f523e7ac78c22c8b068c38def8034b5928fb87a943748543ef92cf7d8259aec05139d427d5af1cfe8b08", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4e6dadf60368fcff8c5ee35231751a94721e0917302b2e79b2628658d061a262a693b90d5c801ddc14dc5cf37358993c1504defa45d08538b97fc20cd2c12717", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f2958b2076d6f4e41850d41d50b534cfec0e1cee46e4b6bd85820b5a7e8963630294d41766b7456e510b8adc8ef7bb7386fc8ce39201e7ac8b3cb4bc8e4b6b6f"}' ========= master_lag: 0.58 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 07:23:00.941543) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 07:23:00.941901) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=33d5923976266a1c518c4bf7000001ab-1465307726.618564-1545013747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 1.43 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 07:23:02.381240) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 07:23:02.381578) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 07:23:02.601170) ========= ========= Total master_lag: 108.60 =========