builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1465124412.17 results: success (0) buildid: 20160605013013 builduid: c01353401bba4020b7bed5b2414784b2 revision: 4a08f1841ee0422cd2b4f4a0eb2de16f93576757 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:12.170100) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:12.170557) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:12.170840) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:12.223306) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:12.223621) ========= 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=eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-05 04:00:12-- 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% 23.8M=0s 2016-06-05 04:00:12 (23.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084622 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:12.321844) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:12.322130) ========= 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=eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013953 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:12.371107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:12.371482) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4a08f1841ee0422cd2b4f4a0eb2de16f93576757 --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 4a08f1841ee0422cd2b4f4a0eb2de16f93576757 --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=eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-05 04:00:12,710 truncating revision to first 12 chars 2016-06-05 04:00:12,711 Setting DEBUG logging. 2016-06-05 04:00:12,711 attempt 1/10 2016-06-05 04:00:12,711 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/4a08f1841ee0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-05 04:00:13,047 unpacking tar archive at: mozilla-inbound-4a08f1841ee0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.680467 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:13.065356) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:13.065678) ========= script_repo_revision: 4a08f1841ee0422cd2b4f4a0eb2de16f93576757 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:13.066076) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:13.066344) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 04:00:13.074603) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-05 04:00:13.074930) ========= /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=eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:00:13 INFO - MultiFileLogger online at 20160605 04:00:13 in /builds/slave/test 04:00:13 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 04:00:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:00:13 INFO - {'append_to_log': False, 04:00:13 INFO - 'base_work_dir': '/builds/slave/test', 04:00:13 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:00:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:00:13 INFO - 'branch': 'Mozilla-Inbound', 04:00:13 INFO - 'buildbot_json_path': 'buildprops.json', 04:00:13 INFO - 'config_files': ('talos/linux_config.py',), 04:00:13 INFO - 'default_actions': ('clobber', 04:00:13 INFO - 'read-buildbot-config', 04:00:13 INFO - 'download-and-extract', 04:00:13 INFO - 'populate-webroot', 04:00:13 INFO - 'create-virtualenv', 04:00:13 INFO - 'install', 04:00:13 INFO - 'run-tests'), 04:00:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:00:13 INFO - 'download_minidump_stackwalk': True, 04:00:13 INFO - 'download_symbols': 'ondemand', 04:00:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:00:13 INFO - 'tooltool.py': '/tools/tooltool.py', 04:00:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:00:13 INFO - '/tools/misc-python/virtualenv.py')}, 04:00:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:00:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:00:13 INFO - 'installer_path': 'installer.exe', 04:00:13 INFO - 'log_level': 'info', 04:00:13 INFO - 'log_name': 'talos', 04:00:13 INFO - 'log_to_console': True, 04:00:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:00:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:00:13 INFO - 'opt_config_files': (), 04:00:13 INFO - 'pip_index': False, 04:00:13 INFO - 'sps_profile': False, 04:00:13 INFO - 'sps_profile_interval': 0, 04:00:13 INFO - 'suite': 'dromaeojs', 04:00:13 INFO - 'system_bits': '32', 04:00:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:00:13 INFO - 'title': 'talos-linux64-ix-010', 04:00:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:00:13 INFO - 'use_talos_json': True, 04:00:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:00:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:00:13 INFO - 'work_dir': 'build'} 04:00:13 INFO - ##### 04:00:13 INFO - ##### Running clobber step. 04:00:13 INFO - ##### 04:00:13 INFO - Running pre-action listener: _resource_record_pre_action 04:00:13 INFO - Running main action method: clobber 04:00:13 INFO - rmtree: /builds/slave/test/build 04:00:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:00:14 INFO - Running post-action listener: _resource_record_post_action 04:00:14 INFO - ##### 04:00:14 INFO - ##### Finished clobber step (success) 04:00:14 INFO - ##### 04:00:14 INFO - ##### 04:00:14 INFO - ##### Running read-buildbot-config step. 04:00:14 INFO - ##### 04:00:14 INFO - Running pre-action listener: _resource_record_pre_action 04:00:14 INFO - Running main action method: read_buildbot_config 04:00:14 INFO - Using buildbot properties: 04:00:14 INFO - { 04:00:14 INFO - "project": "", 04:00:14 INFO - "product": "firefox", 04:00:14 INFO - "script_repo_revision": "production", 04:00:14 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:00:14 INFO - "repository": "", 04:00:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:00:14 INFO - "buildid": "20160605013013", 04:00:14 INFO - "pgo_build": "True", 04:00:14 INFO - "basedir": "/builds/slave/test", 04:00:14 INFO - "buildnumber": 1049, 04:00:14 INFO - "slavename": "talos-linux64-ix-010", 04:00:14 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:00:14 INFO - "platform": "ubuntu64_hw", 04:00:14 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:00:14 INFO - "branch": "mozilla-inbound", 04:00:14 INFO - "repo_path": "integration/mozilla-inbound", 04:00:14 INFO - "revision": "4a08f1841ee0422cd2b4f4a0eb2de16f93576757", 04:00:14 INFO - "stage_platform": "linux64-pgo", 04:00:14 INFO - "builduid": "c01353401bba4020b7bed5b2414784b2", 04:00:14 INFO - "slavebuilddir": "test" 04:00:14 INFO - } 04:00:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 04:00:14 INFO - Running post-action listener: _resource_record_post_action 04:00:14 INFO - ##### 04:00:14 INFO - ##### Finished read-buildbot-config step (success) 04:00:14 INFO - ##### 04:00:14 INFO - ##### 04:00:14 INFO - ##### Running download-and-extract step. 04:00:14 INFO - ##### 04:00:14 INFO - Running pre-action listener: _resource_record_pre_action 04:00:14 INFO - Running main action method: download_and_extract 04:00:14 INFO - mkdir: /builds/slave/test/build/tests 04:00:14 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')]} 04:00:14 INFO - https://queue.taskcluster.net/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:00:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:00:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:00:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:00:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:00:25 INFO - Downloaded 1361 bytes. 04:00:25 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 04:00:25 INFO - Using the following test package requirements: 04:00:25 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:00:25 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:00:25 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:00:25 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:25 INFO - u'jsshell-linux-x86_64.zip'], 04:00:25 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:00:25 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 04:00:25 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:00:25 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:00:25 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:00:25 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 04:00:25 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:00:25 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:25 INFO - https://queue.taskcluster.net/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:00:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:00:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:00:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:00:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:00:37 INFO - Downloaded 24442327 bytes. 04:00:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:00:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:00:38 INFO - Return code: 0 04:00:38 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:00:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:38 INFO - https://queue.taskcluster.net/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:00:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:00:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:00:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 04:00:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:00:40 INFO - Downloaded 24442327 bytes. 04:00:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:00:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:00:42 INFO - Return code: 0 04:00:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:42 INFO - https://queue.taskcluster.net/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:00:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:00:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:00:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 04:00:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:00:43 INFO - Downloaded 10833369 bytes. 04:00:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:00:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:00:43 INFO - Return code: 0 04:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:43 INFO - https://queue.taskcluster.net/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:00:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:00:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:00:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:00:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:00:44 INFO - Downloaded 59151950 bytes. 04:00:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:00:44 INFO - mkdir: /builds/slave/test/properties 04:00:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:00:44 INFO - Writing to file /builds/slave/test/properties/build_url 04:00:44 INFO - Contents: 04:00:44 INFO - build_url:https://queue.taskcluster.net/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 04:00:45 INFO - Running post-action listener: _resource_record_post_action 04:00:45 INFO - Running post-action listener: set_extra_try_arguments 04:00:45 INFO - ##### 04:00:45 INFO - ##### Finished download-and-extract step (success) 04:00:45 INFO - ##### 04:00:45 INFO - ##### 04:00:45 INFO - ##### Running populate-webroot step. 04:00:45 INFO - ##### 04:00:45 INFO - Running pre-action listener: _resource_record_pre_action 04:00:45 INFO - Running main action method: populate_webroot 04:00:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:00:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:00:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:00:45 INFO - '--tppagecycles', 04:00:45 INFO - '7'], 04:00:45 INFO - 'tests': ['tsvgm']}}, 04:00:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:00:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:00:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:00:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:00:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:00:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:00:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:45 INFO - 'talos_options': ['--disable-e10s'], 04:00:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:45 INFO - 'talos_options': ['--disable-e10s'], 04:00:45 INFO - 'tests': ['damp', 'tps']}, 04:00:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:45 INFO - 'tests': ['damp', 'tps']}, 04:00:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:00:45 INFO - 'tests': ['dromaeo_dom']}, 04:00:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:00:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:00:45 INFO - 'tests': ['a11yr', 04:00:45 INFO - 'ts_paint', 04:00:45 INFO - 'tpaint', 04:00:45 INFO - 'sessionrestore', 04:00:45 INFO - 'sessionrestore_no_auto_restore', 04:00:45 INFO - 'tabpaint']}, 04:00:45 INFO - 'other-e10s': {'tests': ['a11yr', 04:00:45 INFO - 'ts_paint', 04:00:45 INFO - 'tpaint', 04:00:45 INFO - 'sessionrestore', 04:00:45 INFO - 'sessionrestore_no_auto_restore', 04:00:45 INFO - 'tabpaint']}, 04:00:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:00:45 INFO - 'ts_paint', 04:00:45 INFO - 'tpaint', 04:00:45 INFO - 'sessionrestore', 04:00:45 INFO - 'sessionrestore_no_auto_restore', 04:00:45 INFO - 'tabpaint']}, 04:00:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:00:45 INFO - 'ts_paint', 04:00:45 INFO - 'tpaint', 04:00:45 INFO - 'sessionrestore', 04:00:45 INFO - 'sessionrestore_no_auto_restore', 04:00:45 INFO - 'tabpaint']}, 04:00:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:00:45 INFO - 'tests': ['a11yr', 04:00:45 INFO - 'ts_paint', 04:00:45 INFO - 'tpaint', 04:00:45 INFO - 'sessionrestore', 04:00:45 INFO - 'sessionrestore_no_auto_restore', 04:00:45 INFO - 'tabpaint']}, 04:00:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:00:45 INFO - 'tests': ['a11yr', 04:00:45 INFO - 'ts_paint', 04:00:45 INFO - 'tpaint', 04:00:45 INFO - 'sessionrestore', 04:00:45 INFO - 'sessionrestore_no_auto_restore', 04:00:45 INFO - 'tabpaint']}, 04:00:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:00:45 INFO - 'tests': ['tsvgx', 04:00:45 INFO - 'tsvgr_opacity', 04:00:45 INFO - 'tart', 04:00:45 INFO - 'tscrollx', 04:00:45 INFO - 'cart']}, 04:00:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:00:45 INFO - 'tsvgr_opacity', 04:00:45 INFO - 'tart', 04:00:45 INFO - 'tscrollx', 04:00:45 INFO - 'cart']}, 04:00:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:45 INFO - 'talos_options': ['--disable-e10s'], 04:00:45 INFO - 'tests': ['tp5o']}, 04:00:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:45 INFO - 'tests': ['tp5o']}, 04:00:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:45 INFO - 'talos_options': ['--disable-e10s', 04:00:45 INFO - '--xperf_path', 04:00:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:45 INFO - 'tests': ['tp5n']}, 04:00:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:00:45 INFO - 'talos_options': ['--xperf_path', 04:00:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:45 INFO - 'tests': ['tp5n']}}, 04:00:45 INFO - 'talos.zip': {'path': '', 04:00:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:00:45 INFO - Running post-action listener: _resource_record_post_action 04:00:45 INFO - ##### 04:00:45 INFO - ##### Finished populate-webroot step (success) 04:00:45 INFO - ##### 04:00:45 INFO - ##### 04:00:45 INFO - ##### Running create-virtualenv step. 04:00:45 INFO - ##### 04:00:45 INFO - Running pre-action listener: _resource_record_pre_action 04:00:45 INFO - Running main action method: create_virtualenv 04:00:45 INFO - Creating virtualenv /builds/slave/test/build/venv 04:00:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:00:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:00:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:00:45 INFO - Using real prefix '/usr' 04:00:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:00:46 INFO - Installing distribute.............................................................................................................................................................................................done. 04:00:48 INFO - Installing pip.................done. 04:00:48 INFO - Return code: 0 04:00:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f252ef98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e02e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dae20>, '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 0x22de3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22de830>, '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': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', '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 04:00:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:00:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:00:48 INFO - Using env: {'DISPLAY': ':0', 04:00:48 INFO - 'HOME': '/home/cltbld', 04:00:48 INFO - 'LANG': 'en_US.UTF-8', 04:00:48 INFO - 'LANGUAGE': 'en_US:en', 04:00:48 INFO - 'LOGNAME': 'cltbld', 04:00:48 INFO - 'MAIL': '/var/mail/cltbld', 04:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:48 INFO - 'MOZ_NO_REMOTE': '1', 04:00:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:48 INFO - 'NO_EM_RESTART': '1', 04:00:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:48 INFO - 'PWD': '/builds/slave/test', 04:00:48 INFO - 'SHELL': '/bin/bash', 04:00:48 INFO - 'SHLVL': '1', 04:00:48 INFO - 'TERM': 'linux', 04:00:48 INFO - 'TMOUT': '86400', 04:00:48 INFO - 'USER': 'cltbld', 04:00:48 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', 04:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:48 INFO - '_': '/tools/buildbot/bin/python'} 04:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:00:48 INFO - Cleaning up... 04:00:48 INFO - Return code: 0 04:00:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f252ef98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e02e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dae20>, '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 0x22de3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22de830>, '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': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', '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 04:00:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:00:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:00:48 INFO - Using env: {'DISPLAY': ':0', 04:00:48 INFO - 'HOME': '/home/cltbld', 04:00:48 INFO - 'LANG': 'en_US.UTF-8', 04:00:48 INFO - 'LANGUAGE': 'en_US:en', 04:00:48 INFO - 'LOGNAME': 'cltbld', 04:00:48 INFO - 'MAIL': '/var/mail/cltbld', 04:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:48 INFO - 'MOZ_NO_REMOTE': '1', 04:00:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:48 INFO - 'NO_EM_RESTART': '1', 04:00:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:48 INFO - 'PWD': '/builds/slave/test', 04:00:48 INFO - 'SHELL': '/bin/bash', 04:00:48 INFO - 'SHLVL': '1', 04:00:48 INFO - 'TERM': 'linux', 04:00:48 INFO - 'TMOUT': '86400', 04:00:48 INFO - 'USER': 'cltbld', 04:00:48 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', 04:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:48 INFO - '_': '/tools/buildbot/bin/python'} 04:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:48 INFO - Downloading/unpacking psutil>=3.1.1 04: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 04: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 04: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 04: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 04: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 04: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 04:00:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:00:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:50 INFO - Installing collected packages: psutil 04:00:50 INFO - Running setup.py install for psutil 04:00:50 INFO - building 'psutil._psutil_linux' extension 04:00:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:00:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:00:50 INFO - building 'psutil._psutil_posix' extension 04:00:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:00:51 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 04:00:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:51 INFO - Successfully installed psutil 04:00:51 INFO - Cleaning up... 04:00:51 INFO - Return code: 0 04:00:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:00:51 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')]} 04:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:51 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')]} 04:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:51 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 0x7f252ef98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e02e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dae20>, '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 0x22de3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22de830>, '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': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', '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 04:00:51 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 04:00:51 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 04:00:51 INFO - Using env: {'DISPLAY': ':0', 04:00:51 INFO - 'HOME': '/home/cltbld', 04:00:51 INFO - 'LANG': 'en_US.UTF-8', 04:00:51 INFO - 'LANGUAGE': 'en_US:en', 04:00:51 INFO - 'LOGNAME': 'cltbld', 04:00:51 INFO - 'MAIL': '/var/mail/cltbld', 04:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:51 INFO - 'MOZ_NO_REMOTE': '1', 04:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:51 INFO - 'NO_EM_RESTART': '1', 04:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:51 INFO - 'PWD': '/builds/slave/test', 04:00:51 INFO - 'SHELL': '/bin/bash', 04:00:51 INFO - 'SHLVL': '1', 04:00:51 INFO - 'TERM': 'linux', 04:00:51 INFO - 'TMOUT': '86400', 04:00:51 INFO - 'USER': 'cltbld', 04:00:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', 04:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:51 INFO - '_': '/tools/buildbot/bin/python'} 04:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 04: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 04: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 04: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 04: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 04: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 04: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 04:00:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:00:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:00:53 INFO - Installing collected packages: mozsystemmonitor 04:00:53 INFO - Running setup.py install for mozsystemmonitor 04:00:53 INFO - Successfully installed mozsystemmonitor 04:00:53 INFO - Cleaning up... 04:00:53 INFO - Return code: 0 04:00:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f252ef98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e02e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dae20>, '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 0x22de3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22de830>, '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': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', '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 04:00:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:00:53 INFO - Using env: {'DISPLAY': ':0', 04:00:53 INFO - 'HOME': '/home/cltbld', 04:00:53 INFO - 'LANG': 'en_US.UTF-8', 04:00:53 INFO - 'LANGUAGE': 'en_US:en', 04:00:53 INFO - 'LOGNAME': 'cltbld', 04:00:53 INFO - 'MAIL': '/var/mail/cltbld', 04:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:53 INFO - 'MOZ_NO_REMOTE': '1', 04:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:53 INFO - 'NO_EM_RESTART': '1', 04:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:53 INFO - 'PWD': '/builds/slave/test', 04:00:53 INFO - 'SHELL': '/bin/bash', 04:00:53 INFO - 'SHLVL': '1', 04:00:53 INFO - 'TERM': 'linux', 04:00:53 INFO - 'TMOUT': '86400', 04:00:53 INFO - 'USER': 'cltbld', 04:00:53 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', 04:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:53 INFO - '_': '/tools/buildbot/bin/python'} 04:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:53 INFO - Downloading/unpacking jsonschema==2.5.1 04:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:00:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:55 INFO - Downloading functools32-3.2.3-2.tar.gz 04:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:00:55 INFO - warning: no files found matching '*.txt' 04:00:55 INFO - no previously-included directories found matching 'build' 04:00:55 INFO - no previously-included directories found matching 'dist' 04:00:55 INFO - no previously-included directories found matching '.git*' 04:00:55 INFO - Installing collected packages: jsonschema, functools32 04:00:55 INFO - Running setup.py install for functools32 04:00:56 INFO - warning: no files found matching '*.txt' 04:00:56 INFO - no previously-included directories found matching 'build' 04:00:56 INFO - no previously-included directories found matching 'dist' 04:00:56 INFO - no previously-included directories found matching '.git*' 04:00:56 INFO - Successfully installed jsonschema functools32 04:00:56 INFO - Cleaning up... 04:00:56 INFO - Return code: 0 04:00:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04: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')]} 04:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04: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')]} 04:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:56 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 0x7f252ef98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e02e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dae20>, '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 0x22de3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22de830>, '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': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', '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 04:00:56 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 04:00:56 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 04:00:56 INFO - Using env: {'DISPLAY': ':0', 04:00:56 INFO - 'HOME': '/home/cltbld', 04:00:56 INFO - 'LANG': 'en_US.UTF-8', 04:00:56 INFO - 'LANGUAGE': 'en_US:en', 04:00:56 INFO - 'LOGNAME': 'cltbld', 04:00:56 INFO - 'MAIL': '/var/mail/cltbld', 04:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:56 INFO - 'MOZ_NO_REMOTE': '1', 04:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:56 INFO - 'NO_EM_RESTART': '1', 04:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:56 INFO - 'PWD': '/builds/slave/test', 04:00:56 INFO - 'SHELL': '/bin/bash', 04:00:56 INFO - 'SHLVL': '1', 04:00:56 INFO - 'TERM': 'linux', 04:00:56 INFO - 'TMOUT': '86400', 04:00:56 INFO - 'USER': 'cltbld', 04:00:56 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', 04:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:56 INFO - '_': '/tools/buildbot/bin/python'} 04:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:56 INFO - Downloading/unpacking blobuploader==1.2.4 04:00:56 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 04:00:56 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 04:00:56 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 04:00:56 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 04:00:56 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 04:00:56 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 04:00:58 INFO - Downloading blobuploader-1.2.4.tar.gz 04:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:00:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:00:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:58 INFO - Downloading docopt-0.6.1.tar.gz 04:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:00:58 INFO - Installing collected packages: blobuploader, requests, docopt 04:00:58 INFO - Running setup.py install for blobuploader 04:00:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:00:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:00:59 INFO - Running setup.py install for requests 04:00:59 INFO - Running setup.py install for docopt 04:00:59 INFO - Successfully installed blobuploader requests docopt 04:00:59 INFO - Cleaning up... 04:00:59 INFO - Return code: 0 04:00:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04: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')]} 04:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04: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')]} 04:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:00:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f252ef98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e02e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dae20>, '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 0x22de3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22de830>, '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': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', '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 04:00:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:00:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:00:59 INFO - Using env: {'DISPLAY': ':0', 04:00:59 INFO - 'HOME': '/home/cltbld', 04:00:59 INFO - 'LANG': 'en_US.UTF-8', 04:00:59 INFO - 'LANGUAGE': 'en_US:en', 04:00:59 INFO - 'LOGNAME': 'cltbld', 04:00:59 INFO - 'MAIL': '/var/mail/cltbld', 04:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:59 INFO - 'MOZ_NO_REMOTE': '1', 04:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:59 INFO - 'NO_EM_RESTART': '1', 04:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:59 INFO - 'PWD': '/builds/slave/test', 04:00:59 INFO - 'SHELL': '/bin/bash', 04:00:59 INFO - 'SHLVL': '1', 04:00:59 INFO - 'TERM': 'linux', 04:00:59 INFO - 'TMOUT': '86400', 04:00:59 INFO - 'USER': 'cltbld', 04:00:59 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', 04:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:59 INFO - '_': '/tools/buildbot/bin/python'} 04:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:00:59 INFO - Running setup.py (path:/tmp/pip-9HvV5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:00:59 INFO - Running setup.py (path:/tmp/pip-D3lpzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:00:59 INFO - Running setup.py (path:/tmp/pip-3ejmLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:00 INFO - Running setup.py (path:/tmp/pip-iV9vlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:00 INFO - Running setup.py (path:/tmp/pip-qDvqNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:00 INFO - Running setup.py (path:/tmp/pip-XwNmtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:00 INFO - Running setup.py (path:/tmp/pip-mcHxxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:00 INFO - Running setup.py (path:/tmp/pip-SQCDoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:00 INFO - Running setup.py (path:/tmp/pip-fv_hpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:00 INFO - Running setup.py (path:/tmp/pip-j3nDbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:00 INFO - Running setup.py (path:/tmp/pip-6I86M3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:00 INFO - Running setup.py (path:/tmp/pip-0uHkVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:00 INFO - Running setup.py (path:/tmp/pip-Sgr66V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:00 INFO - Running setup.py (path:/tmp/pip-6oqxxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:00 INFO - Running setup.py (path:/tmp/pip-G_EIrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:00 INFO - Running setup.py (path:/tmp/pip-Hd4syj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:00 INFO - Running setup.py (path:/tmp/pip-THDCB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:01:01 INFO - Running setup.py install for manifestparser 04:01:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:01:01 INFO - Running setup.py install for mozcrash 04:01:01 INFO - Running setup.py install for mozdebug 04:01:01 INFO - Running setup.py install for mozdevice 04:01:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:01:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:01:01 INFO - Running setup.py install for mozfile 04:01:01 INFO - Running setup.py install for mozhttpd 04:01:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:01:01 INFO - Running setup.py install for mozinfo 04:01:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:01:01 INFO - Running setup.py install for mozInstall 04:01:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:01:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:01:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:01:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:01:01 INFO - Running setup.py install for mozleak 04:01:01 INFO - Running setup.py install for mozlog 04:01:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:01:02 INFO - Running setup.py install for moznetwork 04:01:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:01:02 INFO - Running setup.py install for mozprocess 04:01:02 INFO - Running setup.py install for mozprofile 04:01:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:01:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:01:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:01:02 INFO - Running setup.py install for mozrunner 04:01:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:01:02 INFO - Running setup.py install for mozscreenshot 04:01:02 INFO - Running setup.py install for moztest 04:01:02 INFO - Running setup.py install for mozversion 04:01:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:01:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:01:02 INFO - Cleaning up... 04:01:02 INFO - Return code: 0 04:01:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f252ef98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e02e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dae20>, '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 0x22de3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22de830>, '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': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', '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 04:01:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:01:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:01:02 INFO - Using env: {'DISPLAY': ':0', 04:01:02 INFO - 'HOME': '/home/cltbld', 04:01:02 INFO - 'LANG': 'en_US.UTF-8', 04:01:02 INFO - 'LANGUAGE': 'en_US:en', 04:01:02 INFO - 'LOGNAME': 'cltbld', 04:01:02 INFO - 'MAIL': '/var/mail/cltbld', 04:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:02 INFO - 'MOZ_NO_REMOTE': '1', 04:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:02 INFO - 'NO_EM_RESTART': '1', 04:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:02 INFO - 'PWD': '/builds/slave/test', 04:01:02 INFO - 'SHELL': '/bin/bash', 04:01:02 INFO - 'SHLVL': '1', 04:01:02 INFO - 'TERM': 'linux', 04:01:02 INFO - 'TMOUT': '86400', 04:01:02 INFO - 'USER': 'cltbld', 04:01:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', 04:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:02 INFO - '_': '/tools/buildbot/bin/python'} 04:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:03 INFO - Running setup.py (path:/tmp/pip-fzN2lS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:03 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)) 04:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:03 INFO - Running setup.py (path:/tmp/pip-wFGYjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:03 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)) 04:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:03 INFO - Running setup.py (path:/tmp/pip-lneCwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:03 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)) 04:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:03 INFO - Running setup.py (path:/tmp/pip-RpB5ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:03 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)) 04:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:03 INFO - Running setup.py (path:/tmp/pip-RkSNwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:03 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)) 04:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:03 INFO - Running setup.py (path:/tmp/pip-v_Ue1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:03 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)) 04:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:03 INFO - Running setup.py (path:/tmp/pip-AHQV8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:03 INFO - Running setup.py (path:/tmp/pip-9KS8Kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:03 INFO - Running setup.py (path:/tmp/pip-4gczsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:03 INFO - Running setup.py (path:/tmp/pip-fm78JW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:03 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)) 04:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:03 INFO - Running setup.py (path:/tmp/pip-Jp7zIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:03 INFO - Running setup.py (path:/tmp/pip-kd6HDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:03 INFO - Running setup.py (path:/tmp/pip-Y_zj4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:03 INFO - Running setup.py (path:/tmp/pip-j7gwqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:04 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)) 04:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:04 INFO - Running setup.py (path:/tmp/pip-bOy1XX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:04 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)) 04:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:04 INFO - Running setup.py (path:/tmp/pip-ZVlYSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:04 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)) 04:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:04 INFO - Running setup.py (path:/tmp/pip-JafZeW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:04 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)) 04:01:04 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)) 04:01:04 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)) 04:01:04 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)) 04:01:04 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)) 04:01:04 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)) 04:01:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:06 INFO - Downloading blessings-1.6.tar.gz 04:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:01:06 INFO - Installing collected packages: blessings 04:01:06 INFO - Running setup.py install for blessings 04:01:06 INFO - Successfully installed blessings 04:01:06 INFO - Cleaning up... 04:01:06 INFO - Return code: 0 04:01:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:01:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:06 INFO - Reading from file tmpfile_stdout 04:01:06 INFO - Current package versions: 04:01:06 INFO - argparse == 1.2.1 04:01:06 INFO - blessings == 1.6 04:01:06 INFO - blobuploader == 1.2.4 04:01:06 INFO - docopt == 0.6.1 04:01:06 INFO - functools32 == 3.2.3-2 04:01:06 INFO - jsonschema == 2.5.1 04:01:06 INFO - manifestparser == 1.1 04:01:06 INFO - mozInstall == 1.12 04:01:06 INFO - mozcrash == 0.17 04:01:06 INFO - mozdebug == 0.1 04:01:06 INFO - mozdevice == 0.48 04:01:06 INFO - mozfile == 1.2 04:01:06 INFO - mozhttpd == 0.7 04:01:06 INFO - mozinfo == 0.9 04:01:06 INFO - mozleak == 0.1 04:01:06 INFO - mozlog == 3.2 04:01:06 INFO - moznetwork == 0.27 04:01:06 INFO - mozprocess == 0.22 04:01:06 INFO - mozprofile == 0.28 04:01:06 INFO - mozrunner == 6.11 04:01:06 INFO - mozscreenshot == 0.1 04:01:06 INFO - mozsystemmonitor == 0.3 04:01:06 INFO - moztest == 0.7 04:01:06 INFO - mozversion == 1.4 04:01:06 INFO - psutil == 3.1.1 04:01:06 INFO - requests == 1.2.3 04:01:06 INFO - wsgiref == 0.1.2 04:01:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f252ef98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e02e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dae20>, '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 0x22de3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22de830>, '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': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', '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 04:01:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:01:06 INFO - Using env: {'DISPLAY': ':0', 04:01:06 INFO - 'HOME': '/home/cltbld', 04:01:06 INFO - 'LANG': 'en_US.UTF-8', 04:01:06 INFO - 'LANGUAGE': 'en_US:en', 04:01:06 INFO - 'LOGNAME': 'cltbld', 04:01:06 INFO - 'MAIL': '/var/mail/cltbld', 04:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:06 INFO - 'MOZ_NO_REMOTE': '1', 04:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:06 INFO - 'NO_EM_RESTART': '1', 04:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:06 INFO - 'PWD': '/builds/slave/test', 04:01:06 INFO - 'SHELL': '/bin/bash', 04:01:06 INFO - 'SHLVL': '1', 04:01:06 INFO - 'TERM': 'linux', 04:01:06 INFO - 'TMOUT': '86400', 04:01:06 INFO - 'USER': 'cltbld', 04:01:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', 04:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:06 INFO - '_': '/tools/buildbot/bin/python'} 04:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:01:06 INFO - Cleaning up... 04:01:06 INFO - Return code: 0 04:01:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f252ef98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e02e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dae20>, '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 0x22de3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22de830>, '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': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', '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 04:01:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:01:06 INFO - Using env: {'DISPLAY': ':0', 04:01:06 INFO - 'HOME': '/home/cltbld', 04:01:06 INFO - 'LANG': 'en_US.UTF-8', 04:01:06 INFO - 'LANGUAGE': 'en_US:en', 04:01:06 INFO - 'LOGNAME': 'cltbld', 04:01:06 INFO - 'MAIL': '/var/mail/cltbld', 04:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:06 INFO - 'MOZ_NO_REMOTE': '1', 04:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:06 INFO - 'NO_EM_RESTART': '1', 04:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:06 INFO - 'PWD': '/builds/slave/test', 04:01:06 INFO - 'SHELL': '/bin/bash', 04:01:06 INFO - 'SHLVL': '1', 04:01:06 INFO - 'TERM': 'linux', 04:01:06 INFO - 'TMOUT': '86400', 04:01:06 INFO - 'USER': 'cltbld', 04:01:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', 04:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:06 INFO - '_': '/tools/buildbot/bin/python'} 04:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:01:07 INFO - Cleaning up... 04:01:07 INFO - Return code: 0 04:01:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:01:07 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')]} 04:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:07 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')]} 04:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:07 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 0x7f252ef98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e02e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dae20>, '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 0x22de3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22de830>, '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': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', '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 04:01:07 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 04:01:07 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 04:01:07 INFO - Using env: {'DISPLAY': ':0', 04:01:07 INFO - 'HOME': '/home/cltbld', 04:01:07 INFO - 'LANG': 'en_US.UTF-8', 04:01:07 INFO - 'LANGUAGE': 'en_US:en', 04:01:07 INFO - 'LOGNAME': 'cltbld', 04:01:07 INFO - 'MAIL': '/var/mail/cltbld', 04:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:07 INFO - 'MOZ_NO_REMOTE': '1', 04:01:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:07 INFO - 'NO_EM_RESTART': '1', 04:01:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:07 INFO - 'PWD': '/builds/slave/test', 04:01:07 INFO - 'SHELL': '/bin/bash', 04:01:07 INFO - 'SHLVL': '1', 04:01:07 INFO - 'TERM': 'linux', 04:01:07 INFO - 'TMOUT': '86400', 04:01:07 INFO - 'USER': 'cltbld', 04:01:07 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', 04:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:07 INFO - '_': '/tools/buildbot/bin/python'} 04:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:07 INFO - Downloading/unpacking flake8 04:01:07 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 04:01:07 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 04:01:07 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 04:01:07 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 04:01:07 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 04:01:07 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 04:01:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:01:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:01:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:01:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:01:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:01:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:01:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:01:09 INFO - no previously-included directories found matching 'docs/_build' 04:01:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:01:09 INFO - Running setup.py install for pep8 04:01:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:01:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:01:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:01:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:01:10 INFO - no previously-included directories found matching 'docs/_build' 04:01:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:01:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:01:10 INFO - Cleaning up... 04:01:10 INFO - Return code: 0 04:01:10 INFO - Running post-action listener: _resource_record_post_action 04:01:10 INFO - Running post-action listener: _start_resource_monitoring 04:01:10 INFO - Starting resource monitoring. 04:01:10 INFO - ##### 04:01:10 INFO - ##### Finished create-virtualenv step (success) 04:01:10 INFO - ##### 04:01:10 INFO - ##### 04:01:10 INFO - ##### Running install step. 04:01:10 INFO - ##### 04:01:10 INFO - Running pre-action listener: _resource_record_pre_action 04:01:10 INFO - Running main action method: install 04:01:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:10 INFO - Reading from file tmpfile_stdout 04:01:10 INFO - Detecting whether we're running mozinstall >=1.0... 04:01:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:01:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:01:10 INFO - Reading from file tmpfile_stdout 04:01:10 INFO - Output received: 04:01:10 INFO - Usage: mozinstall [options] installer 04:01:10 INFO - Options: 04:01:10 INFO - -h, --help show this help message and exit 04:01:10 INFO - -d DEST, --destination=DEST 04:01:10 INFO - Directory to install application into. [default: 04:01:10 INFO - "/builds/slave/test"] 04:01:10 INFO - --app=APP Application being installed. [default: firefox] 04:01:10 INFO - mkdir: /builds/slave/test/build/application 04:01:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:01:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:01:27 INFO - Reading from file tmpfile_stdout 04:01:27 INFO - Output received: 04:01:27 INFO - /builds/slave/test/build/application/firefox/firefox 04:01:27 INFO - Running post-action listener: _resource_record_post_action 04:01:27 INFO - ##### 04:01:27 INFO - ##### Finished install step (success) 04:01:27 INFO - ##### 04:01:27 INFO - ##### 04:01:27 INFO - ##### Running run-tests step. 04:01:27 INFO - ##### 04:01:27 INFO - Running pre-action listener: _resource_record_pre_action 04:01:27 INFO - Running main action method: run_tests 04:01:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:01:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:01:27 INFO - Python 2.7.3 04:01:27 INFO - Return code: 0 04:01:27 INFO - grabbing minidump binary from tooltool 04:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:27 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 0x22dae20>, '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 0x22de3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22de830>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:01:27 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 04:01:27 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 04:01:27 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 04:01:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:01:27 INFO - Return code: 0 04:01:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:01:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:01:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:01:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:01:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:01:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:01:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:01:28 INFO - Return code: 0 04:01:28 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/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 04:01:28 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/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 04:01:28 INFO - Using env: {'DISPLAY': ':0', 04:01:28 INFO - 'HOME': '/home/cltbld', 04:01:28 INFO - 'LANG': 'en_US.UTF-8', 04:01:28 INFO - 'LANGUAGE': 'en_US:en', 04:01:28 INFO - 'LOGNAME': 'cltbld', 04:01:28 INFO - 'MAIL': '/var/mail/cltbld', 04:01:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:01:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:01:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:28 INFO - 'MOZ_NO_REMOTE': '1', 04:01:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:01:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:01:28 INFO - 'NO_EM_RESTART': '1', 04:01:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:01:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:28 INFO - 'PWD': '/builds/slave/test', 04:01:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:01:28 INFO - 'SHELL': '/bin/bash', 04:01:28 INFO - 'SHLVL': '1', 04:01:28 INFO - 'TERM': 'linux', 04:01:28 INFO - 'TMOUT': '86400', 04:01:28 INFO - 'USER': 'cltbld', 04:01:28 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289', 04:01:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:28 INFO - '_': '/tools/buildbot/bin/python'} 04:01:28 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/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 04:01:28 INFO - mozversion application_buildid: 20160605013013 04:01:28 INFO - mozversion application_changeset: 4a08f1841ee0422cd2b4f4a0eb2de16f93576757 04:01:28 INFO - mozversion application_display_name: Nightly 04:01:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:01:28 INFO - mozversion application_name: Firefox 04:01:28 INFO - mozversion application_remotingname: firefox 04:01:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:01:28 INFO - mozversion application_vendor: Mozilla 04:01:28 INFO - mozversion application_version: 49.0a1 04:01:28 INFO - mozversion platform_buildid: 20160605013013 04:01:28 INFO - mozversion platform_changeset: 4a08f1841ee0422cd2b4f4a0eb2de16f93576757 04:01:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:01:28 INFO - mozversion platform_version: 49.0a1 04:01:28 INFO - using testdate: 1465124488 04:01:28 INFO - actual date: 1465124488 04:01:28 INFO - starting webserver on 'localhost:51878' 04:01:28 INFO - SUITE-START | Running 2 tests 04:01:28 INFO - TEST-START | dromaeo_css 04:01:28 INFO - operating with platform_type : linux_ 04:01:28 INFO - Initialising browser for dromaeo_css test... 04:01:28 INFO - TEST-INFO | started process 26664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWlyQbU/profile http://localhost:51878/getInfo.html) 04:01:32 INFO - PROCESS | 26664 | __metrics Screen width/height:1600/1200 04:01:32 INFO - PROCESS | 26664 | colorDepth:24 04:01:32 INFO - PROCESS | 26664 | Browser inner width/height: 1024/697 04:01:32 INFO - PROCESS | 26664 | __metrics 04:01:34 ERROR - PROCESS | 26664 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:01:34 INFO - TEST-INFO | 26664: exit 0 04:01:34 INFO - Browser initialized. 04:01:34 INFO - Running cycle 1/1 for dromaeo_css test... 04:01:34 INFO - TEST-INFO | started process 26749 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWlyQbU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:01:46 INFO - PROCESS | 26749 | RSS: Main: 156680192 04:01:46 INFO - PROCESS | 26749 | 04:02:37 INFO - PROCESS | 26749 | 1465124557799 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] 04:04:45 INFO - PROCESS | 26749 | Cycle 1(1): loaded http://localhost:51878/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51878/tests/dromaeo/cssquery-ext.html) 04:04:46 INFO - PROCESS | 26749 | RSS: Main: 260165632 04:04:46 INFO - PROCESS | 26749 | 04:07:49 INFO - PROCESS | 26749 | Cycle 1(1): loaded http://localhost:51878/tests/dromaeo/cssquery-ext.html (next: http://localhost:51878/tests/dromaeo/cssquery-jquery.html) 04:07:49 INFO - PROCESS | 26749 | RSS: Main: 246329344 04:07:49 INFO - PROCESS | 26749 | 04:10:51 INFO - PROCESS | 26749 | Cycle 1(1): loaded http://localhost:51878/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51878/tests/dromaeo/cssquery-mootools.html) 04:10:52 INFO - PROCESS | 26749 | RSS: Main: 249106432 04:10:52 INFO - PROCESS | 26749 | 04:13:54 INFO - PROCESS | 26749 | Cycle 1(1): loaded http://localhost:51878/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51878/tests/dromaeo/cssquery-prototype.html) 04:13:54 INFO - PROCESS | 26749 | RSS: Main: 243929088 04:13:54 INFO - PROCESS | 26749 | 04:16:57 INFO - PROCESS | 26749 | Cycle 1(1): loaded http://localhost:51878/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51878/tests/dromaeo/cssquery-yui.html) 04:16:58 INFO - PROCESS | 26749 | RSS: Main: 225484800 04:16:58 INFO - PROCESS | 26749 | 04:20:01 INFO - PROCESS | 26749 | Cycle 1(1): loaded http://localhost:51878/tests/dromaeo/cssquery-yui.html (next: http://localhost:51878/tests/dromaeo/cssquery-dojo.html) 04:20:01 INFO - PROCESS | 26749 | RSS: Main: 273788928 04:20:01 INFO - PROCESS | 26749 | 04:20:01 INFO - PROCESS | 26749 | __start_tp_report 04:20:01 INFO - PROCESS | 26749 | _x_x_mozilla_page_load 04:20:01 INFO - PROCESS | 26749 | _x_x_mozilla_page_load_details 04:20:01 INFO - PROCESS | 26749 | |i|pagename|runs| 04:20:01 INFO - PROCESS | 26749 | |0;dojo.html;3167.2873603439225;3168.9524657130146;3188.2188863728384;3205.423023855708;3223.6937490938367;5407.540359069474;5504.504594586487;5520.585956053302;5594.160875868622;5599.720013999304;5485.862853428666;5497.285352904127;5520.503154716075;5553.527950124234;5587.245721827552;4948.777305021274;5049.24261360797;5052.065367906931;5060.519250671199;5207.557357624606;5033.84898453047;5046.7224302663335;5066.847994560169;5097.184450487923;5109.156989096795;4897.436794768611;4985.6260780441435;5027.170516864713;5048.29323894655;5068.087744206023;5039.168537191359;5055.545000949932;5132.538071573539;5135.563477104413;5166.044281807877;4991.750412479398;5082.4663410341755;5103.055934652101;5109.131447653907;5116.437191908887;5438.945610543883;5505.889882202374;5531.280933478622;5574.944250557483;5624.831255062355;5995.46040856325;6037.094435834616;6064.423879731418;6065.575409721321;6066.514678825683;5668.858278543028;5881.794137205177;6040.395960403968;6088.726007329637;6092.817215483498;5578.972105139489;5635.605507614428;5659.632123911973;5661.037623603997;5664.40523745005;6137.171481849982;6147.96926015376;6148.231471066117;6153.753849845956;6153.753849845956;5744.827655170351;5749;5812.88374232513;5957.76168953237;5970.6417614942375;5957.672328022;6018.067199583984;6024.518038556905;6024.759009639653;6031.42701443371;5863.2670916135485;5873.882522349529;5901.321348044944;5902.763889444374;5930.495907847795;5706.229658995982;5863.442972917651;5879.559033072536;5928.970355148197;5956.463918247292;4501.594856462934;4503.279475284005;4504.662150338738;4508.481524624644;4541.205289074399;3968.3849003404516;3994.6005399460405;4004.6596039336982;4034.3948407738485;4045.170739998352;5509;5554.361248456398;5562.860928476821;5599.44005599445;5637.915431268534;5996.430339117776;6009.36901625323;6019.638821670714;6027.246594175728;6076.058210977306;5631.971840140855;5639.492445679908;5643.887122257532;5646.830595082154;5657.915131273035;4785.665003449794;4847.660663753503;4928.137575924199;4930.876728081755;4945.901081978341;6115.327313995457;6120.44915957566;6122.938770612326;6125.601835880653;6144.907826382608;5707.7716891325545;5930.43660852227;5931.288245410578;5935.792247271497;5936.347001829881;6089.756409743561;6095.952232173902;6126.816195514141;6186.072089186658;6198.2252218472695;5851.444112809277;5886.764529418947;5891.3224979127945;5892.6759028253855;5936.406359364202;5751.568632352507;5776.104703770754;5987.2815262168815;6000.51995840323;6002.069679199731;5679.829605111853;5736.971315143398;5738.282714660668;5741.081426971665;5788.913166302593;5713.600047996601;5721.141828725725;5724.4561766632105;5726.455986681425;5732.082866741302;5626.409227031103;5626.718664066699;5627.549796016391;5634.661920284632;5696.515796157373;5904.114382842608;5906.320773111147;5942.10868369748;5945.940540594712;5951.7619295227705;5762;5762.538996880324;5764.36591974874;5767.365589785037;5797.391273916178 04:20:01 INFO - PROCESS | 26749 | |1;ext.html;591.5001823459178;623.5011990407672;632.411856973015;644.3556443556444;644.5810223354819;32030.35939281213;35104.29791404174;35348.469772953395;43245;43900.56099439005;45008.849380543375;45549.54450455494;45572.3164152538;45589.31616025754;45660.77169614156;8742.694005709785;8853.73438796837;8928.19646231839;8934.55327233639;8952.283817294601;8698.956505217497;8807.119288071173;8812.691555795549;8836.646534138627;8844.11558844117;8907.331950103768;8955.238804701608;8960.103989601053;8961.283097352229;8964.775880602972;8893.77765555863;8942.329325300629;8943.195112439878;8947.239484643813;8953.910460895373;8831.69089081879;8933.19601235892;8937.25723483921;8947.821043579092;8947.865782013276;42315.78842105801;42799.144017119484;42849.78575107136;42859.7857010713;42908;3758.830852611639;3818.713596480275;3840.423936409533;3849.6920246380223;4318.654507639413;32810.835945820356;33094.16458205403;34177;34197.31605367904;34252.61914569446;4281.250781113293;4297.59172878576;4317.913641727179;4336.978315108404;4399.626031787302;347207;348080;348956;349095;349613;59742.40257597368;59935.700321498116;60096.699516502136;60138.699306503186;60149.699251503465;36645.63354366476;37581.62418375836;37608;39296.2140757189;62759.37240627626;16070.75893861593;16257;16303.103329317002;16306.021638701715;16311.59221019484;13101.803472947913;13382.46470141203;13389;13389.263590502616;13394.397252123483;19671;20091.899540502203;20189.495262618257;20270;20305;7105.573665580082;7276.527025743309;7279.199288078307;7314.195438501761;7463.738769143054;965.8020105878278;1035.1046344911597;1077.6345920704136;1108.5510368300852;1150.1546363422879;32872.50691239633;33162.66837331596;33227.83386083102;33300;33841.15397115092;1110.5946329589642;1140.703417111557;1162.2387336294742;1168.2756690851727;1248.057716424094;17169.48491545256;17755.383600264024;17904.820951790574;17928.193231304624;18404;430617;814668;830057;836625;837837;60588.69705651532;60900.69549652312;61119.69440152771;61206;61234;1298.6104168749337;1401.6846209602759;1404.3189053309136;1408.936597853099;1413.6465883529117;32065.67934320627;33678.49482257817;34039.829800850835;34074;34154.48768268528;50395;51007;51020.74489627528;51078.48921510737;51113.88861113859;410765;413690;413747;416114;419126;28418.147455576367;29486.410271794015;29539.113826585235;29621.5556766653;29628.40743185081;46308.53691463042;48575.75712121417;48905.755471222416;49006.50993490162;49494.50505494899;40434.79782601068;40701.79649101854;40719;41779;42093.36859947164;40480;40922.79538602288;41053;41797;41890.162196755286;40966.18067638571;41408;41551.376729349686;41922.161556768086;42542;35594.28811423809;35963;37029.44455833111;37038.44442333313;37182.8140859294;27924.44151117007;28099.859500702365;28326.291842703275;28386.716132838406;28555.571666424607 04:20:01 INFO - PROCESS | 26749 | |2;jquery.html;397.29480172693474;402.1634999201661;405.5457887166372;414.83406637345064;423.1494695661721;13316.467341306361;18342.908285458572;19819.10814013371;19822.008899555036;19958.800411995875;14643.92678036611;19228.327008554705;19314.22743090278;19524.902375488102;19533.511662208417;5597.412271711462;5790.449907258825;5793.131030345461;5805.796797112102;5827.096799995987;5705.971470142644;5763.942360576382;5772.30732312121;5821.301443826746;5822.854428639297;4183.2470155372175;4306.1172459645695;5197.194434862602;6272.843178920518;6276.497880169575;6285.842853928665;6295.968520157416;6377.71300291488;6380.617162970237;6432.678366081677;5516.365617953947;5569.888602227973;5641.830745077655;5649.265595472562;5661.2923384576925;23146.76853231463;23288.883555582284;23608;23768.40578985522;24000.159994400114;2174.3476956912864;2360.7403185649564;2435.5128974205054;2622.265765585639;2825.4349130174046;10125.797484050352;10317.9484102579;10454.111400530965;10509.421981790998;10510.737231569272;1796.7664203653571;1806.115003648216;1821.6903126468533;1829.743835862967;1982.0089955022488;82878.58560707218;83047.52572268526;83981.16018839795;87078;89070.55464722699;10898.346099234072;11003.724906877393;11147.331160130256;11226.831597526043;12168.2699038058;15911.840881591035;15982.961107527974;15983.520494385188;16037.117958512394;16079.839201608069;7933.801654958672;8260.8347833043;8274.338052955869;8411.621477033548;8479;7776.377889768805;7783.688652453951;7787.29914307715;7905.960470197612;8050.798730031679;4472.686911916199;4726.692764970266;4760.476347601761;4966.279889416014;5046.21783623539;1843.8383818194452;1884.3875740384156;2012.4604677421785;2052.722882410885;2074.91700331985;905.6875377994581;966.840471322238;979.2019504104132;987.9971828593983;1057.6721216422934;18220.544486387946;19102.426927192206;19559.511012224524;19635.705464418046;19929.701054484194;987.9654212102541;1006.059334522224;1032.8037672842136;1041.2398948767443;1083.1659622091104;10302.278840481094;11009.119270458345;11096.833547496793;11097;11131.053860421793;465196;465740;466463;470117;484208;89829.10170898207;90539;92163;92906.53546732223;93197.5340123295;895.7044175422226;902.2556390977338;909.2680392284143;983.8425851863667;1038.776663017455;17351.913240433718;17551;17787.555311117325;17987.820121799137;18298.725519116957;39235;39262.8589712828;39479.21041579095;40856.182876341714;42671;57038.714806427364;59169.40830591639;60409.69795150996;60472.39527604844;60532;8605.139486051345;8962.14859588338;8994;9055.68305109318;9334.299927505328;8452.450590711584;9768.344739474469;10715;12179.269243845398;12827.294498802656;11323.15076369259;11809.940950295193;11820.349880756641;12089.818652720392;12127.575534856238;11910.702232444259;11948;11956.48913728092;12131.878681213075;12151.210171338835;12161.33112678811;12235.93882030584;12449.93775031119;12458.439370228543;12465.314407707301;8790.252828509649;8971.730848074569;9059.320550958573;9092.408993415407;9113.179813816789;11593.478293476983;11896.405179740805;11923.284602923852;11986.820197697216;12519.311437871005 04:20:01 INFO - PROCESS | 26749 | |3;mootools.html;1368.1927662679018;1524.4222229991958;1564.319521008361;1726.559727269546;1859.0294288054663;8666.86999695005;8957.507337096456;8961.372703910722;9198.770030749218;9206.125418085272;9088.363814532986;9329;9340.813183736338;9341.205997490204;9349.906500934989;2396.257160280314;2421.2010036687852;2426.296374051532;2426.696662917135;2428.781409673129;2446.7920226780657;2466.469709012562;2488.9004439822384;2497.962530562043;2502.124256510225;2413.1795189635523;2419.2984034629935;2461.396957745355;2468.123816045305;2471.666325046114;2349.1308215960034;2355.670206171129;2357.174988753931;2377.643353496972;2390.4262976885598;2303.3205204464725;2357.988210058939;2361.716594008713;2363.929082127539;2365.9881700591386;7675.5010924289745;7864.567448790314;9064.274858011344;9132.589033493508;9141.542922853898;4817.951820481785;4948.134076536592;4952.925706114411;5076;5186.377634683824;3317.20387107095;3434.3989801784587;3446.2418267981257;3465.7920524768597;3500.3524347995703;933.570557543524;1055.4511653939985;1095.1403148528368;1163.941802909851;1175.629676651852;12403.813942790865;12809.807852882213;12827.294498802656;12836.229826210458;12841.229526228457;4550.453945526492;4688.601468875116;4698.459677137104;4721.197396442613;4746.501617330199;10748;10806.729831754268;10811.243212975016;10817.080548153337;10848.132149428184;5378.435264297271;5384.515393614593;5385.461453854661;5386.542143917733;5395.298611180521;4907.2393778964315;4940.8764780880765;5054.898902021939;5152.845414637567;5156.535911767959;4076.9399956011057;4106.6624465896175;4216.093539888939;4240.448741663564;4273.829046838092;1188.0911103006208;1208.2448469706433;1267;1268.7208814060891;1287.4270949427414;981.3277904635205;981.8379967305315;983.9803203935882;993.4933184076028;1001.4542074569378;6057.606255593372;6279.434850863444;6285.937140628626;6289.8742025159245;6504.869902601921;476.0526552161243;496.4092729651703;983.9163671088038;1006.9395836249848;1091.4270008245576;4176.227397931392;4264.850730224427;4292.613664770123;4304.268274393361;4324.870253892325;10897.509612067475;11443;11458.140639452075;11800.52797888075;11829.52681892732;11510.36692981894;11602.129840261845;11657.417129143509;11675.88324116765;11695.356755378536;8293.585320733939;8686.522241276663;8724.912750872538;8726.127387261224;8732.519711415933;6063.575549711478;6201.472874805692;6263.874722505433;6446.548741588043;6553.4101930826455;10447.268691191544;10508.21188410857;10836;10875.510602023087;10929.83605245906;10601.463679524828;10839.187060970617;10866.67399978002;10942.835857461985;10963.342199468058;8039.075506316848;8227.13615070433;8244.587770611566;8275.172482751677;8293.295069919124;8674.219320260954;8796.296296296408;8858.424202426822;8872.822543549222;8934.910650893407;8008.559529225716;8023.197680232163;8086.7169649062;8193.46742461762;8196.713115040944;7949.364050875801;7954.880676789969;7985.800354991172;8057.234562716532;8143.83712325762;7301.707931682673;7328.193898671036;7368.1526624438875;7369.631518424165;7388;4754.548317909793;5329.946700532945;5361.142217245222;5521.861953451196;5555.666660000413;4908.337374454546;5304.496072873071;5342.3856256531;5518.696471694096;5637.182608521824 04:20:01 INFO - PROCESS | 26749 | |4;prototype.html;327.2326394604653;334.1479227968681;335.304243694334;338.24233716475095;348.79421141526495;5390.326209223852;5429.701366424845;5434.538064264538;5454.209139674745;5506.669599824013;5325.281087053247;5329.188076054141;5366.436524164956;5385.461453854613;5391.973040134803;3985.9402108968316;4043.555208927016;4178.268802959486;4187.350960601112;4223.21870453967;4168.270552653289;4185.874423767276;4187.623113919746;4188.371744238373;4213.936790948138;4012.498437695288;4172.977620482986;4184.849166479212;4195.979020104895;4200.411942328076;4111.444954931076;4157.771322577257;4169.56219596944;4179.456670632799;4199.139176468817;3727.8881633551036;3728.266356144406;3732.992092135108;3747.2880152770886;3761.9247615047548;5124.6932032331515;5146.511081447294;5147.7349966014835;5182.300389447414;5211.296474975868;4546.431696037996;4718.127146477913;4740.573348398626;4765.237561990065;4778.737169455713;5535.169724541311;5536.809585939042;5559.527440167591;5581.190727344512;5620.85947851307;4045.554988951213;4067.1662309226535;4069.97965010176;4080.510338759338;4112.157007813391;5627.774889004435;5744.425557444222;5745.540356771448;5762.279715035621;5792.507636850873;4067.8169482373364;4092.263392589303;4094.7133700641266;4119.546849846514;4134.586541345841;4147.605977432139;4155.854545090907;4159.480064991876;4171.249175148502;4175.31107367287;4503.211937910853;4692;4697.107549565571;4699;4772.5943294819635;5524.806631767869;5534.557235421156;5564.86087847799;5572.749226284827;5587;1413.5688614972325;1418.212891845036;1424.173979092124;1439.5681295611275;1446.2479510654612;915.54680433186;918.4489306416096;922.2529750901791;924.2790623313826;940.5250348574064;4803.327534145223;4835.0022985749065;4852.684575502581;4895.751583346224;4910.189818679878;4964.950350496449;5049.823256186016;5061.620378471629;5115.2071428928575;5145.3568303962;4834.347363105936;4836.927446088312;4860.975695121572;5068.797248110034;5452.263944367539;3054.053243494524;3059.7552195824724;3069.8004629699444;3086.7221950024605;3087.336222712128;5917.881642367129;5959.791407300723;5969.552283578749;6010.3088144863905;6019.819405417845;5639.971800140973;5897.852553686106;5899.941000590025;5912;5932.822015339547;6002.39976002405;6003.729832157564;6013.849653758691;6019.939800601938;6049.395060494004;5612.7754889803955;5701.458361455655;5766.682832444256;5850.869784665184;5868.354481007001;5626.831195064155;5676.858078548069;5692.772289108555;5697.4587414195585;5707;5938.346781854079;5968.985272503772;5974.253218347707;5993.61041532299;6005.1892994446935;4019.5578486367062;4243.278642630698;4248.490181178278;4268.786560672016;4282.721623094489;5524.447555244444;5707.229524014205;5735.9139612905;5775.393583673654;5798.82603521895;5530.557555395479;5556.249906262603;5569.220309156641;5571.270077661836;5704.258446401941;5588.636738611977;5593.161025846156;5634.873025394855;5636.351819540805;5637.746301416364;5313.176457648916;5542.334919809648;5570.359408667893;5570.470805273492;5607.467290607386;5621.578381621476;5681.346645135863;5684.436779885565;5685.943140568706;5713.8285851424525;5258.710770907637;5480.588955828249;5529.198266251451;5533.944660553343;5573.27547418833 04:20:01 INFO - PROCESS | 26749 | |5;yui.html;754.8716718157916;781.3202513812984;817.7301490508133;821.5194111444805;871.6513394642141;14600.853991460082;15689.215539223036;15846.28691708873;15854.841451585466;15881.047137171778;14113.788293175585;15018.699626007474;15040.323185456653;15063.849361506382;15071.849281507182;691.0774116554406;800.747764454198;806.1857523900873;825.3562221467236;829.6100832608664;835.5446281776447;836.8702851058096;837.8491871463134;838.6226198210799;839.1776059461731;884.6594061286419;885.3094586222757;885.6988623867884;886.5301390263171;886.7871710789428;700.5271441776806;839.2069494327862;856.9657213711444;858.1718641510972;858.4720396955889;628.1206311164361;629.5058379172374;629.5309994054413;629.7323637454109;630.4105661206786;13867.722645547032;13875.583732488041;13887.652808679763;13903.79144312836;13947.02370834042;13609.591712248648;13966.581002569837;14088.2955852208;14147.504837330644;14151.433942642281;12885.87114128856;12937.54718584845;13040.56553779093;13106.606801795866;13670.52153174644;4474.7986340614425;4477.261251893434;4539.137563862889;4689.413823272091;4741.146593613148;70552.2944770556;71264.28735712629;71828;72303;72797;11159;11203.94398028021;11356.318620882774;11418.086553075735;11734.413279335999;20983.265585704426;21068.57862842765;21175.68236476454;21181.57636847285;21204.681929771064;8409.159084091541;8424.15758424165;8484.533350665773;8547.615357308936;8646.52444115567;4580.473245576734;4694.483606803249;4711;4804.783784729696;5000.874978125576;3510.8069056202153;3643.216708407705;3649.251903359805;3650.7079433645245;3655.8720444784303;549.7581064331681;618.8731310081422;658.4271683635268;717.4654882112859;729.0194688144437;713.2297119111347;739.2607392607392;743.9107307123072;759.2710997442407;767.6622286194169;10545.367277963192;10658.78682426347;10826.458677066115;10893.183011274028;10975.231733778719;755.9962200188963;757.571971835911;764.5947647746592;772.2817779465151;780.7852840468917;4690.413698287714;5059.2916991621205;5096.719680417613;5097.719625420637;5164.7934082636275;71826.281737183;72329;76674;77060;118317.4084129591;64104;64577.67711161508;66314.78454717723;81497;100052;72465.27534724586;92473.5376323114;92500.53749731208;92509;92660.53669731609;9811.072581609493;10051.547680354548;10112.747181320232;10270.415472779418;10626.562913345186;47562.76218618885;49955;50172.74913625408;51481.22778158406;52759.20861187162;66154;72413;73703.6314818444;74696.25303746892;75119.62440187763;13106.344682766014;13146.21122732639;13165.144265622705;13308.733825323632;13455.798163027759;14902.478413255918;14918.179500127597;14997.850021499646;15257.6185595361;15441.922790385976;12841.29372884463;13498.392572334466;13506;13575.660608484866;13965;13324.467021319038;13428.798568021683;13571.117877337942;13627;14021.228832414316;13208.339583021003;13282.734345312847;13388.330583470983;13610.251436171106;13684.3842027111;10849.891501084889;10873.728156796144;11314.773704526027;11392.601258955896;11540.192186547198;11178.776424471627;11414.14393920476;11505.597304094317;11564.190506664452;11596.246243994114 04:20:01 INFO - PROCESS | 26749 | __end_tp_report 04:20:01 INFO - PROCESS | 26749 | __start_cc_report 04:20:01 INFO - PROCESS | 26749 | _x_x_mozilla_cycle_collect,887 04:20:01 INFO - PROCESS | 26749 | __end_cc_report 04:20:01 INFO - PROCESS | 26749 | __startTimestamp1465125601288__endTimestamp 04:20:01 INFO - PROCESS | 26749 | 04:20:01 INFO - PROCESS | 26749 | ------- Summary: start ------- 04:20:01 INFO - PROCESS | 26749 | Number of tests: 6 04:20:01 INFO - PROCESS | 26749 | 04:20:01 INFO - PROCESS | 26749 | [#0] dojo.html Cycles:165 Average:5512.67 Median:5706.23 stddev:642.32 (11.3%) stddev-sans-first:617.38 04:20:01 INFO - PROCESS | 26749 | Values: 3167.3 3169.0 3188.2 3205.4 3223.7 5407.5 5504.5 5520.6 5594.2 5599.7 5485.9 5497.3 5520.5 5553.5 5587.2 4948.8 5049.2 5052.1 5060.5 5207.6 5033.8 5046.7 5066.8 5097.2 5109.2 4897.4 4985.6 5027.2 5048.3 5068.1 5039.2 5055.5 5132.5 5135.6 5166.0 4991.8 5082.5 5103.1 5109.1 5116.4 5438.9 5505.9 5531.3 5574.9 5624.8 5995.5 6037.1 6064.4 6065.6 6066.5 5668.9 5881.8 6040.4 6088.7 6092.8 5579.0 5635.6 5659.6 5661.0 5664.4 6137.2 6148.0 6148.2 6153.8 6153.8 5744.8 5749.0 5812.9 5957.8 5970.6 5957.7 6018.1 6024.5 6024.8 6031.4 5863.3 5873.9 5901.3 5902.8 5930.5 5706.2 5863.4 5879.6 5929.0 5956.5 4501.6 4503.3 4504.7 4508.5 4541.2 3968.4 3994.6 4004.7 4034.4 4045.2 5509.0 5554.4 5562.9 5599.4 5637.9 5996.4 6009.4 6019.6 6027.2 6076.1 5632.0 5639.5 5643.9 5646.8 5657.9 4785.7 4847.7 4928.1 4930.9 4945.9 6115.3 6120.4 6122.9 6125.6 6144.9 5707.8 5930.4 5931.3 5935.8 5936.3 6089.8 6096.0 6126.8 6186.1 6198.2 5851.4 5886.8 5891.3 5892.7 5936.4 5751.6 5776.1 5987.3 6000.5 6002.1 5679.8 5737.0 5738.3 5741.1 5788.9 5713.6 5721.1 5724.5 5726.5 5732.1 5626.4 5626.7 5627.5 5634.7 5696.5 5904.1 5906.3 5942.1 5945.9 5951.8 5762.0 5762.5 5764.4 5767.4 5797.4 04:20:01 INFO - PROCESS | 26749 | 04:20:01 INFO - PROCESS | 26749 | [#1] ext.html Cycles:180 Average:65365.41 Median:41479.69 stddev:145738.98 (351.4%) stddev-sans-first:146066.67 04:20:01 INFO - PROCESS | 26749 | Values: 591.5 623.5 632.4 644.4 644.6 32030.4 35104.3 35348.5 43245.0 43900.6 45008.8 45549.5 45572.3 45589.3 45660.8 8742.7 8853.7 8928.2 8934.6 8952.3 8699.0 8807.1 8812.7 8836.6 8844.1 8907.3 8955.2 8960.1 8961.3 8964.8 8893.8 8942.3 8943.2 8947.2 8953.9 8831.7 8933.2 8937.3 8947.8 8947.9 42315.8 42799.1 42849.8 42859.8 42908.0 3758.8 3818.7 3840.4 3849.7 4318.7 32810.8 33094.2 34177.0 34197.3 34252.6 4281.3 4297.6 4317.9 4337.0 4399.6 347207.0 348080.0 348956.0 349095.0 349613.0 59742.4 59935.7 60096.7 60138.7 60149.7 36645.6 37581.6 37608.0 39296.2 62759.4 16070.8 16257.0 16303.1 16306.0 16311.6 13101.8 13382.5 13389.0 13389.3 13394.4 19671.0 20091.9 20189.5 20270.0 20305.0 7105.6 7276.5 7279.2 7314.2 7463.7 965.8 1035.1 1077.6 1108.6 1150.2 32872.5 33162.7 33227.8 33300.0 33841.2 1110.6 1140.7 1162.2 1168.3 1248.1 17169.5 17755.4 17904.8 17928.2 18404.0 430617.0 814668.0 830057.0 836625.0 837837.0 60588.7 60900.7 61119.7 61206.0 61234.0 1298.6 1401.7 1404.3 1408.9 1413.6 32065.7 33678.5 34039.8 34074.0 34154.5 50395.0 51007.0 51020.7 51078.5 51113.9 410765.0 413690.0 413747.0 416114.0 419126.0 28418.1 29486.4 29539.1 29621.6 29628.4 46308.5 48575.8 48905.8 49006.5 49494.5 40434.8 40701.8 40719.0 41779.0 42093.4 40480.0 40922.8 41053.0 41797.0 41890.2 40966.2 41408.0 41551.4 41922.2 42542.0 35594.3 35963.0 37029.4 37038.4 37182.8 27924.4 28099.9 28326.3 28386.7 28555.6 04:20:01 INFO - PROCESS | 26749 | 04:20:01 INFO - PROCESS | 26749 | [#2] jquery.html Cycles:180 Average:28593.80 Median:39371.03 stddev:77753.46 (197.5%) stddev-sans-first:77942.75 04:20:01 INFO - PROCESS | 26749 | Values: 397.3 402.2 405.5 414.8 423.1 13316.5 18342.9 19819.1 19822.0 19958.8 14643.9 19228.3 19314.2 19524.9 19533.5 5597.4 5790.4 5793.1 5805.8 5827.1 5706.0 5763.9 5772.3 5821.3 5822.9 4183.2 4306.1 5197.2 6272.8 6276.5 6285.8 6296.0 6377.7 6380.6 6432.7 5516.4 5569.9 5641.8 5649.3 5661.3 23146.8 23288.9 23608.0 23768.4 24000.2 2174.3 2360.7 2435.5 2622.3 2825.4 10125.8 10317.9 10454.1 10509.4 10510.7 1796.8 1806.1 1821.7 1829.7 1982.0 82878.6 83047.5 83981.2 87078.0 89070.6 10898.3 11003.7 11147.3 11226.8 12168.3 15911.8 15983.0 15983.5 16037.1 16079.8 7933.8 8260.8 8274.3 8411.6 8479.0 7776.4 7783.7 7787.3 7906.0 8050.8 4472.7 4726.7 4760.5 4966.3 5046.2 1843.8 1884.4 2012.5 2052.7 2074.9 905.7 966.8 979.2 988.0 1057.7 18220.5 19102.4 19559.5 19635.7 19929.7 988.0 1006.1 1032.8 1041.2 1083.2 10302.3 11009.1 11096.8 11097.0 11131.1 465196.0 465740.0 466463.0 470117.0 484208.0 89829.1 90539.0 92163.0 92906.5 93197.5 895.7 902.3 909.3 983.8 1038.8 17351.9 17551.0 17787.6 17987.8 18298.7 39235.0 39262.9 39479.2 40856.2 42671.0 57038.7 59169.4 60409.7 60472.4 60532.0 8605.1 8962.1 8994.0 9055.7 9334.3 8452.5 9768.3 10715.0 12179.3 12827.3 11323.2 11809.9 11820.3 12089.8 12127.6 11910.7 11948.0 11956.5 12131.9 12151.2 12161.3 12235.9 12449.9 12458.4 12465.3 8790.3 8971.7 9059.3 9092.4 9113.2 11593.5 11896.4 11923.3 11986.8 12519.3 04:20:01 INFO - PROCESS | 26749 | 04:20:01 INFO - PROCESS | 26749 | [#3] mootools.html Cycles:180 Average:6035.19 Median:4733.85 stddev:3482.57 (73.6%) stddev-sans-first:3474.68 04:20:01 INFO - PROCESS | 26749 | Values: 1368.2 1524.4 1564.3 1726.6 1859.0 8666.9 8957.5 8961.4 9198.8 9206.1 9088.4 9329.0 9340.8 9341.2 9349.9 2396.3 2421.2 2426.3 2426.7 2428.8 2446.8 2466.5 2488.9 2498.0 2502.1 2413.2 2419.3 2461.4 2468.1 2471.7 2349.1 2355.7 2357.2 2377.6 2390.4 2303.3 2358.0 2361.7 2363.9 2366.0 7675.5 7864.6 9064.3 9132.6 9141.5 4818.0 4948.1 4952.9 5076.0 5186.4 3317.2 3434.4 3446.2 3465.8 3500.4 933.6 1055.5 1095.1 1163.9 1175.6 12403.8 12809.8 12827.3 12836.2 12841.2 4550.5 4688.6 4698.5 4721.2 4746.5 10748.0 10806.7 10811.2 10817.1 10848.1 5378.4 5384.5 5385.5 5386.5 5395.3 4907.2 4940.9 5054.9 5152.8 5156.5 4076.9 4106.7 4216.1 4240.4 4273.8 1188.1 1208.2 1267.0 1268.7 1287.4 981.3 981.8 984.0 993.5 1001.5 6057.6 6279.4 6285.9 6289.9 6504.9 476.1 496.4 983.9 1006.9 1091.4 4176.2 4264.9 4292.6 4304.3 4324.9 10897.5 11443.0 11458.1 11800.5 11829.5 11510.4 11602.1 11657.4 11675.9 11695.4 8293.6 8686.5 8724.9 8726.1 8732.5 6063.6 6201.5 6263.9 6446.5 6553.4 10447.3 10508.2 10836.0 10875.5 10929.8 10601.5 10839.2 10866.7 10942.8 10963.3 8039.1 8227.1 8244.6 8275.2 8293.3 8674.2 8796.3 8858.4 8872.8 8934.9 8008.6 8023.2 8086.7 8193.5 8196.7 7949.4 7954.9 7985.8 8057.2 8143.8 7301.7 7328.2 7368.2 7369.6 7388.0 4754.5 5329.9 5361.1 5521.9 5555.7 4908.3 5304.5 5342.4 5518.7 5637.2 04:20:01 INFO - PROCESS | 26749 | 04:20:01 INFO - PROCESS | 26749 | [#4] prototype.html Cycles:180 Average:4685.47 Median:5319.23 stddev:1373.10 (25.8%) stddev-sans-first:1337.41 04:20:01 INFO - PROCESS | 26749 | Values: 327.2 334.1 335.3 338.2 348.8 5390.3 5429.7 5434.5 5454.2 5506.7 5325.3 5329.2 5366.4 5385.5 5392.0 3985.9 4043.6 4178.3 4187.4 4223.2 4168.3 4185.9 4187.6 4188.4 4213.9 4012.5 4173.0 4184.8 4196.0 4200.4 4111.4 4157.8 4169.6 4179.5 4199.1 3727.9 3728.3 3733.0 3747.3 3761.9 5124.7 5146.5 5147.7 5182.3 5211.3 4546.4 4718.1 4740.6 4765.2 4778.7 5535.2 5536.8 5559.5 5581.2 5620.9 4045.6 4067.2 4070.0 4080.5 4112.2 5627.8 5744.4 5745.5 5762.3 5792.5 4067.8 4092.3 4094.7 4119.5 4134.6 4147.6 4155.9 4159.5 4171.2 4175.3 4503.2 4692.0 4697.1 4699.0 4772.6 5524.8 5534.6 5564.9 5572.7 5587.0 1413.6 1418.2 1424.2 1439.6 1446.2 915.5 918.4 922.3 924.3 940.5 4803.3 4835.0 4852.7 4895.8 4910.2 4965.0 5049.8 5061.6 5115.2 5145.4 4834.3 4836.9 4861.0 5068.8 5452.3 3054.1 3059.8 3069.8 3086.7 3087.3 5917.9 5959.8 5969.6 6010.3 6019.8 5640.0 5897.9 5899.9 5912.0 5932.8 6002.4 6003.7 6013.8 6019.9 6049.4 5612.8 5701.5 5766.7 5850.9 5868.4 5626.8 5676.9 5692.8 5697.5 5707.0 5938.3 5969.0 5974.3 5993.6 6005.2 4019.6 4243.3 4248.5 4268.8 4282.7 5524.4 5707.2 5735.9 5775.4 5798.8 5530.6 5556.2 5569.2 5571.3 5704.3 5588.6 5593.2 5634.9 5636.4 5637.7 5313.2 5542.3 5570.4 5570.5 5607.5 5621.6 5681.3 5684.4 5685.9 5713.8 5258.7 5480.6 5529.2 5533.9 5573.3 04:20:01 INFO - PROCESS | 26749 | 04:20:01 INFO - PROCESS | 26749 | [#5] yui.html Cycles:180 Average:19207.00 Median:4689.91 stddev:25816.17 (550.5%) stddev-sans-first:25851.40 04:20:01 INFO - PROCESS | 26749 | Values: 754.9 781.3 817.7 821.5 871.7 14600.9 15689.2 15846.3 15854.8 15881.0 14113.8 15018.7 15040.3 15063.8 15071.8 691.1 800.7 806.2 825.4 829.6 835.5 836.9 837.8 838.6 839.2 884.7 885.3 885.7 886.5 886.8 700.5 839.2 857.0 858.2 858.5 628.1 629.5 629.5 629.7 630.4 13867.7 13875.6 13887.7 13903.8 13947.0 13609.6 13966.6 14088.3 14147.5 14151.4 12885.9 12937.5 13040.6 13106.6 13670.5 4474.8 4477.3 4539.1 4689.4 4741.1 70552.3 71264.3 71828.0 72303.0 72797.0 11159.0 11203.9 11356.3 11418.1 11734.4 20983.3 21068.6 21175.7 21181.6 21204.7 8409.2 8424.2 8484.5 8547.6 8646.5 4580.5 4694.5 4711.0 4804.8 5000.9 3510.8 3643.2 3649.3 3650.7 3655.9 549.8 618.9 658.4 717.5 729.0 713.2 739.3 743.9 759.3 767.7 10545.4 10658.8 10826.5 10893.2 10975.2 756.0 757.6 764.6 772.3 780.8 4690.4 5059.3 5096.7 5097.7 5164.8 71826.3 72329.0 76674.0 77060.0 118317.4 64104.0 64577.7 66314.8 81497.0 100052.0 72465.3 92473.5 92500.5 92509.0 92660.5 9811.1 10051.5 10112.7 10270.4 10626.6 47562.8 49955.0 50172.7 51481.2 52759.2 66154.0 72413.0 73703.6 74696.3 75119.6 13106.3 13146.2 13165.1 13308.7 13455.8 14902.5 14918.2 14997.9 15257.6 15441.9 12841.3 13498.4 13506.0 13575.7 13965.0 13324.5 13428.8 13571.1 13627.0 14021.2 13208.3 13282.7 13388.3 13610.3 13684.4 10849.9 10873.7 11314.8 11392.6 11540.2 11178.8 11414.1 11505.6 11564.2 11596.2 04:20:01 INFO - PROCESS | 26749 | -------- Summary: end -------- 04:20:01 INFO - PROCESS | 26749 | 04:20:02 INFO - TEST-INFO | 26749: exit 0 04:20:02 INFO - TEST-OK | dromaeo_css | took 1113547ms 04:20:02 INFO - TEST-START | kraken 04:20:02 INFO - operating with platform_type : linux_ 04:20:02 INFO - Initialising browser for kraken test... 04:20:02 INFO - TEST-INFO | started process 26929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx1TyGh/profile http://localhost:51878/getInfo.html) 04:20:06 INFO - PROCESS | 26929 | __metrics Screen width/height:1600/1200 04:20:06 INFO - PROCESS | 26929 | colorDepth:24 04:20:06 INFO - PROCESS | 26929 | Browser inner width/height: 1024/697 04:20:06 INFO - PROCESS | 26929 | __metrics 04:20:07 ERROR - PROCESS | 26929 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:20:08 INFO - TEST-INFO | 26929: exit 0 04:20:08 INFO - Browser initialized. 04:20:08 INFO - Running cycle 1/1 for kraken test... 04:20:08 INFO - TEST-INFO | started process 27011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx1TyGh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:20:20 INFO - PROCESS | 27011 | RSS: Main: 156585984 04:20:20 INFO - PROCESS | 27011 | 04:20:22 INFO - PROCESS | 27011 | Cycle 1(1): loaded http://localhost:51878/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51878/tests/kraken/driver.html?testName=audio-beat-detection) 04:20:23 INFO - PROCESS | 27011 | RSS: Main: 214671360 04:20:23 INFO - PROCESS | 27011 | 04:20:26 INFO - PROCESS | 27011 | Cycle 1(1): loaded http://localhost:51878/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51878/tests/kraken/driver.html?testName=audio-dft) 04:20:26 INFO - PROCESS | 27011 | RSS: Main: 201166848 04:20:26 INFO - PROCESS | 27011 | 04:20:29 INFO - PROCESS | 27011 | Cycle 1(1): loaded http://localhost:51878/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51878/tests/kraken/driver.html?testName=audio-fft) 04:20:30 INFO - PROCESS | 27011 | RSS: Main: 268656640 04:20:30 INFO - PROCESS | 27011 | 04:20:32 INFO - PROCESS | 27011 | Cycle 1(1): loaded http://localhost:51878/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51878/tests/kraken/driver.html?testName=audio-oscillator) 04:20:33 INFO - PROCESS | 27011 | RSS: Main: 179433472 04:20:33 INFO - PROCESS | 27011 | 04:20:35 INFO - PROCESS | 27011 | Cycle 1(1): loaded http://localhost:51878/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51878/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:20:35 INFO - PROCESS | 27011 | RSS: Main: 183357440 04:20:35 INFO - PROCESS | 27011 | 04:20:38 INFO - PROCESS | 27011 | Cycle 1(1): loaded http://localhost:51878/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51878/tests/kraken/driver.html?testName=imaging-darkroom) 04:20:39 INFO - PROCESS | 27011 | RSS: Main: 219385856 04:20:39 INFO - PROCESS | 27011 | 04:20:42 INFO - PROCESS | 27011 | Cycle 1(1): loaded http://localhost:51878/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51878/tests/kraken/driver.html?testName=imaging-desaturate) 04:20:43 INFO - PROCESS | 27011 | RSS: Main: 220254208 04:20:43 INFO - PROCESS | 27011 | 04:20:46 INFO - PROCESS | 27011 | Cycle 1(1): loaded http://localhost:51878/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51878/tests/kraken/driver.html?testName=json-parse-financial) 04:20:47 INFO - PROCESS | 27011 | RSS: Main: 220536832 04:20:47 INFO - PROCESS | 27011 | 04:20:48 INFO - PROCESS | 27011 | Cycle 1(1): loaded http://localhost:51878/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51878/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:20:49 INFO - PROCESS | 27011 | RSS: Main: 206704640 04:20:49 INFO - PROCESS | 27011 | 04:20:50 INFO - PROCESS | 27011 | Cycle 1(1): loaded http://localhost:51878/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51878/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:20:51 INFO - PROCESS | 27011 | RSS: Main: 211374080 04:20:51 INFO - PROCESS | 27011 | 04:20:53 INFO - PROCESS | 27011 | Cycle 1(1): loaded http://localhost:51878/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51878/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:20:54 INFO - PROCESS | 27011 | RSS: Main: 218628096 04:20:54 INFO - PROCESS | 27011 | 04:20:56 INFO - PROCESS | 27011 | Cycle 1(1): loaded http://localhost:51878/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51878/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:20:57 INFO - PROCESS | 27011 | RSS: Main: 222904320 04:20:57 INFO - PROCESS | 27011 | 04:21:00 INFO - PROCESS | 27011 | Cycle 1(1): loaded http://localhost:51878/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51878/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:21:00 INFO - PROCESS | 27011 | RSS: Main: 220979200 04:21:00 INFO - PROCESS | 27011 | 04:21:02 INFO - PROCESS | 27011 | Cycle 1(1): loaded http://localhost:51878/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51878/tests/kraken/driver.html?testName=ai-astar) 04:21:02 INFO - PROCESS | 27011 | RSS: Main: 263745536 04:21:02 INFO - PROCESS | 27011 | 04:21:02 INFO - PROCESS | 27011 | __start_tp_report 04:21:02 INFO - PROCESS | 27011 | _x_x_mozilla_page_load 04:21:02 INFO - PROCESS | 27011 | _x_x_mozilla_page_load_details 04:21:02 INFO - PROCESS | 27011 | |i|pagename|runs| 04:21:02 INFO - PROCESS | 27011 | |0;ai-astar;111;103;109;111;111;111;109;108;109;108 04:21:02 INFO - PROCESS | 27011 | |1;audio-beat-detection;154;138;130;179;128;135;167;127;192;131 04:21:02 INFO - PROCESS | 27011 | |2;audio-dft;160;162;161;160;161;161;162;161;160;161 04:21:02 INFO - PROCESS | 27011 | |3;audio-fft;75;75;75;131;75;76;74;75;98;75 04:21:02 INFO - PROCESS | 27011 | |4;audio-oscillator;84;85;124;85;85;86;123;85;85;133 04:21:02 INFO - PROCESS | 27011 | |5;imaging-gaussian-blur;117;118;117;116;117;116;117;116;116;118 04:21:02 INFO - PROCESS | 27011 | |6;imaging-darkroom;145;147;146;146;153;146;147;145;145;146 04:21:02 INFO - PROCESS | 27011 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;95;95 04:21:02 INFO - PROCESS | 27011 | |8;json-parse-financial;55;54;55;54;54;55;53;54;55;55 04:21:02 INFO - PROCESS | 27011 | |9;json-stringify-tinderbox;61;61;62;61;61;63;61;62;61;62 04:21:02 INFO - PROCESS | 27011 | |10;stanford-crypto-aes;78;78;78;80;83;80;81;80;115;86 04:21:02 INFO - PROCESS | 27011 | |11;stanford-crypto-ccm;132;139;121;120;120;120;128;131;133;123 04:21:02 INFO - PROCESS | 27011 | |12;stanford-crypto-pbkdf2;159;160;164;163;158;160;162;159;169;160 04:21:02 INFO - PROCESS | 27011 | |13;stanford-crypto-sha256-iterative;63;64;64;62;63;62;64;62;62;61 04:21:02 INFO - PROCESS | 27011 | __end_tp_report 04:21:02 INFO - PROCESS | 27011 | __start_cc_report 04:21:02 INFO - PROCESS | 27011 | _x_x_mozilla_cycle_collect,1624 04:21:02 INFO - PROCESS | 27011 | __end_cc_report 04:21:02 INFO - PROCESS | 27011 | __startTimestamp1465125662598__endTimestamp 04:21:02 INFO - PROCESS | 27011 | 04:21:02 INFO - PROCESS | 27011 | ------- Summary: start ------- 04:21:02 INFO - PROCESS | 27011 | Number of tests: 14 04:21:02 INFO - PROCESS | 27011 | 04:21:02 INFO - PROCESS | 27011 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:2.45 (2.2%) stddev-sans-first:2.49 04:21:02 INFO - PROCESS | 27011 | Values: 111.0 103.0 109.0 111.0 111.0 111.0 109.0 108.0 109.0 108.0 04:21:02 INFO - PROCESS | 27011 | 04:21:02 INFO - PROCESS | 27011 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:146.00 stddev:23.61 (16.2%) stddev-sans-first:24.95 04:21:02 INFO - PROCESS | 27011 | Values: 154.0 138.0 130.0 179.0 128.0 135.0 167.0 127.0 192.0 131.0 04:21:02 INFO - PROCESS | 27011 | 04:21:02 INFO - PROCESS | 27011 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 04:21:02 INFO - PROCESS | 27011 | Values: 160.0 162.0 161.0 160.0 161.0 161.0 162.0 161.0 160.0 161.0 04:21:02 INFO - PROCESS | 27011 | 04:21:02 INFO - PROCESS | 27011 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.00 stddev:18.39 (24.5%) stddev-sans-first:19.28 04:21:02 INFO - PROCESS | 27011 | Values: 75.0 75.0 75.0 131.0 75.0 76.0 74.0 75.0 98.0 75.0 04:21:02 INFO - PROCESS | 27011 | 04:21:02 INFO - PROCESS | 27011 | [#4] audio-oscillator Cycles:10 Average:97.50 Median:85.00 stddev:20.30 (23.9%) stddev-sans-first:20.93 04:21:02 INFO - PROCESS | 27011 | Values: 84.0 85.0 124.0 85.0 85.0 86.0 123.0 85.0 85.0 133.0 04:21:02 INFO - PROCESS | 27011 | 04:21:02 INFO - PROCESS | 27011 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 04:21:02 INFO - PROCESS | 27011 | Values: 117.0 118.0 117.0 116.0 117.0 116.0 117.0 116.0 116.0 118.0 04:21:02 INFO - PROCESS | 27011 | 04:21:02 INFO - PROCESS | 27011 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.00 stddev:2.37 (1.6%) stddev-sans-first:2.44 04:21:02 INFO - PROCESS | 27011 | Values: 145.0 147.0 146.0 146.0 153.0 146.0 147.0 145.0 145.0 146.0 04:21:02 INFO - PROCESS | 27011 | 04:21:02 INFO - PROCESS | 27011 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:21:02 INFO - PROCESS | 27011 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 04:21:02 INFO - PROCESS | 27011 | 04:21:02 INFO - PROCESS | 27011 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 04:21:02 INFO - PROCESS | 27011 | Values: 55.0 54.0 55.0 54.0 54.0 55.0 53.0 54.0 55.0 55.0 04:21:02 INFO - PROCESS | 27011 | 04:21:02 INFO - PROCESS | 27011 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 04:21:02 INFO - PROCESS | 27011 | Values: 61.0 61.0 62.0 61.0 61.0 63.0 61.0 62.0 61.0 62.0 04:21:02 INFO - PROCESS | 27011 | 04:21:02 INFO - PROCESS | 27011 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:80.00 stddev:11.21 (14.0%) stddev-sans-first:11.68 04:21:02 INFO - PROCESS | 27011 | Values: 78.0 78.0 78.0 80.0 83.0 80.0 81.0 80.0 115.0 86.0 04:21:02 INFO - PROCESS | 27011 | 04:21:02 INFO - PROCESS | 27011 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:129.50 stddev:6.83 (5.3%) stddev-sans-first:6.97 04:21:02 INFO - PROCESS | 27011 | Values: 132.0 139.0 121.0 120.0 120.0 120.0 128.0 131.0 133.0 123.0 04:21:02 INFO - PROCESS | 27011 | 04:21:02 INFO - PROCESS | 27011 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:161.00 stddev:3.27 (2.0%) stddev-sans-first:3.35 04:21:02 INFO - PROCESS | 27011 | Values: 159.0 160.0 164.0 163.0 158.0 160.0 162.0 159.0 169.0 160.0 04:21:02 INFO - PROCESS | 27011 | 04:21:02 INFO - PROCESS | 27011 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.06 (1.7%) stddev-sans-first:1.12 04:21:02 INFO - PROCESS | 27011 | Values: 63.0 64.0 64.0 62.0 63.0 62.0 64.0 62.0 62.0 61.0 04:21:02 INFO - PROCESS | 27011 | -------- Summary: end -------- 04:21:02 INFO - PROCESS | 27011 | 04:21:03 INFO - TEST-INFO | 27011: exit 0 04:21:03 INFO - TEST-OK | kraken | took 61544ms 04:21:03 INFO - SUITE-END | took 1175s 04:21:03 INFO - Completed test suite (00:19:35) 04:21:03 INFO - javascript benchmark 04:21:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3167.2873603439225, 3168.9524657130146, 3188.2188863728384, 3205.423023855708, 3223.6937490938367, 5407.540359069474, 5504.504594586487, 5520.585956053302, 5594.160875868622, 5599.720013999304, 5485.862853428666, 5497.285352904127, 5520.503154716075, 5553.527950124234, 5587.245721827552, 4948.777305021274, 5049.24261360797, 5052.065367906931, 5060.519250671199, 5207.557357624606, 5033.84898453047, 5046.7224302663335, 5066.847994560169, 5097.184450487923, 5109.156989096795, 4897.436794768611, 4985.6260780441435, 5027.170516864713, 5048.29323894655, 5068.087744206023, 5039.168537191359, 5055.545000949932, 5132.538071573539, 5135.563477104413, 5166.044281807877, 4991.750412479398, 5082.4663410341755, 5103.055934652101, 5109.131447653907, 5116.437191908887, 5438.945610543883, 5505.889882202374, 5531.280933478622, 5574.944250557483, 5624.831255062355, 5995.46040856325, 6037.094435834616, 6064.423879731418, 6065.575409721321, 6066.514678825683, 5668.858278543028, 5881.794137205177, 6040.395960403968, 6088.726007329637, 6092.817215483498, 5578.972105139489, 5635.605507614428, 5659.632123911973, 5661.037623603997, 5664.40523745005, 6137.171481849982, 6147.96926015376, 6148.231471066117, 6153.753849845956, 6153.753849845956, 5744.827655170351, 5749.0, 5812.88374232513, 5957.76168953237, 5970.6417614942375, 5957.672328022, 6018.067199583984, 6024.518038556905, 6024.759009639653, 6031.42701443371, 5863.2670916135485, 5873.882522349529, 5901.321348044944, 5902.763889444374, 5930.495907847795, 5706.229658995982, 5863.442972917651, 5879.559033072536, 5928.970355148197, 5956.463918247292, 4501.594856462934, 4503.279475284005, 4504.662150338738, 4508.481524624644, 4541.205289074399, 3968.3849003404516, 3994.6005399460405, 4004.6596039336982, 4034.3948407738485, 4045.170739998352, 5509.0, 5554.361248456398, 5562.860928476821, 5599.44005599445, 5637.915431268534, 5996.430339117776, 6009.36901625323, 6019.638821670714, 6027.246594175728, 6076.058210977306, 5631.971840140855, 5639.492445679908, 5643.887122257532, 5646.830595082154, 5657.915131273035, 4785.665003449794, 4847.660663753503, 4928.137575924199, 4930.876728081755, 4945.901081978341, 6115.327313995457, 6120.44915957566, 6122.938770612326, 6125.601835880653, 6144.907826382608, 5707.7716891325545, 5930.43660852227, 5931.288245410578, 5935.792247271497, 5936.347001829881, 6089.756409743561, 6095.952232173902, 6126.816195514141, 6186.072089186658, 6198.2252218472695, 5851.444112809277, 5886.764529418947, 5891.3224979127945, 5892.6759028253855, 5936.406359364202, 5751.568632352507, 5776.104703770754, 5987.2815262168815, 6000.51995840323, 6002.069679199731, 5679.829605111853, 5736.971315143398, 5738.282714660668, 5741.081426971665, 5788.913166302593, 5713.600047996601, 5721.141828725725, 5724.4561766632105, 5726.455986681425, 5732.082866741302, 5626.409227031103, 5626.718664066699, 5627.549796016391, 5634.661920284632, 5696.515796157373, 5904.114382842608, 5906.320773111147, 5942.10868369748, 5945.940540594712, 5951.7619295227705, 5762.0, 5762.538996880324, 5764.36591974874, 5767.365589785037, 5797.391273916178], "value": 5468.248100759516, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.5001823459178, 623.5011990407672, 632.411856973015, 644.3556443556444, 644.5810223354819, 32030.35939281213, 35104.29791404174, 35348.469772953395, 43245.0, 43900.56099439005, 45008.849380543375, 45549.54450455494, 45572.3164152538, 45589.31616025754, 45660.77169614156, 8742.694005709785, 8853.73438796837, 8928.19646231839, 8934.55327233639, 8952.283817294601, 8698.956505217497, 8807.119288071173, 8812.691555795549, 8836.646534138627, 8844.11558844117, 8907.331950103768, 8955.238804701608, 8960.103989601053, 8961.283097352229, 8964.775880602972, 8893.77765555863, 8942.329325300629, 8943.195112439878, 8947.239484643813, 8953.910460895373, 8831.69089081879, 8933.19601235892, 8937.25723483921, 8947.821043579092, 8947.865782013276, 42315.78842105801, 42799.144017119484, 42849.78575107136, 42859.7857010713, 42908.0, 3758.830852611639, 3818.713596480275, 3840.423936409533, 3849.6920246380223, 4318.654507639413, 32810.835945820356, 33094.16458205403, 34177.0, 34197.31605367904, 34252.61914569446, 4281.250781113293, 4297.59172878576, 4317.913641727179, 4336.978315108404, 4399.626031787302, 347207.0, 348080.0, 348956.0, 349095.0, 349613.0, 59742.40257597368, 59935.700321498116, 60096.699516502136, 60138.699306503186, 60149.699251503465, 36645.63354366476, 37581.62418375836, 37608.0, 39296.2140757189, 62759.37240627626, 16070.75893861593, 16257.0, 16303.103329317002, 16306.021638701715, 16311.59221019484, 13101.803472947913, 13382.46470141203, 13389.0, 13389.263590502616, 13394.397252123483, 19671.0, 20091.899540502203, 20189.495262618257, 20270.0, 20305.0, 7105.573665580082, 7276.527025743309, 7279.199288078307, 7314.195438501761, 7463.738769143054, 965.8020105878278, 1035.1046344911597, 1077.6345920704136, 1108.5510368300852, 1150.1546363422879, 32872.50691239633, 33162.66837331596, 33227.83386083102, 33300.0, 33841.15397115092, 1110.5946329589642, 1140.703417111557, 1162.2387336294742, 1168.2756690851727, 1248.057716424094, 17169.48491545256, 17755.383600264024, 17904.820951790574, 17928.193231304624, 18404.0, 430617.0, 814668.0, 830057.0, 836625.0, 837837.0, 60588.69705651532, 60900.69549652312, 61119.69440152771, 61206.0, 61234.0, 1298.6104168749337, 1401.6846209602759, 1404.3189053309136, 1408.936597853099, 1413.6465883529117, 32065.67934320627, 33678.49482257817, 34039.829800850835, 34074.0, 34154.48768268528, 50395.0, 51007.0, 51020.74489627528, 51078.48921510737, 51113.88861113859, 410765.0, 413690.0, 413747.0, 416114.0, 419126.0, 28418.147455576367, 29486.410271794015, 29539.113826585235, 29621.5556766653, 29628.40743185081, 46308.53691463042, 48575.75712121417, 48905.755471222416, 49006.50993490162, 49494.50505494899, 40434.79782601068, 40701.79649101854, 40719.0, 41779.0, 42093.36859947164, 40480.0, 40922.79538602288, 41053.0, 41797.0, 41890.162196755286, 40966.18067638571, 41408.0, 41551.376729349686, 41922.161556768086, 42542.0, 35594.28811423809, 35963.0, 37029.44455833111, 37038.44442333313, 37182.8140859294, 27924.44151117007, 28099.859500702365, 28326.291842703275, 28386.716132838406, 28555.571666424607], "value": 20419.147075283992, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.29480172693474, 402.1634999201661, 405.5457887166372, 414.83406637345064, 423.1494695661721, 13316.467341306361, 18342.908285458572, 19819.10814013371, 19822.008899555036, 19958.800411995875, 14643.92678036611, 19228.327008554705, 19314.22743090278, 19524.902375488102, 19533.511662208417, 5597.412271711462, 5790.449907258825, 5793.131030345461, 5805.796797112102, 5827.096799995987, 5705.971470142644, 5763.942360576382, 5772.30732312121, 5821.301443826746, 5822.854428639297, 4183.2470155372175, 4306.1172459645695, 5197.194434862602, 6272.843178920518, 6276.497880169575, 6285.842853928665, 6295.968520157416, 6377.71300291488, 6380.617162970237, 6432.678366081677, 5516.365617953947, 5569.888602227973, 5641.830745077655, 5649.265595472562, 5661.2923384576925, 23146.76853231463, 23288.883555582284, 23608.0, 23768.40578985522, 24000.159994400114, 2174.3476956912864, 2360.7403185649564, 2435.5128974205054, 2622.265765585639, 2825.4349130174046, 10125.797484050352, 10317.9484102579, 10454.111400530965, 10509.421981790998, 10510.737231569272, 1796.7664203653571, 1806.115003648216, 1821.6903126468533, 1829.743835862967, 1982.0089955022488, 82878.58560707218, 83047.52572268526, 83981.16018839795, 87078.0, 89070.55464722699, 10898.346099234072, 11003.724906877393, 11147.331160130256, 11226.831597526043, 12168.2699038058, 15911.840881591035, 15982.961107527974, 15983.520494385188, 16037.117958512394, 16079.839201608069, 7933.801654958672, 8260.8347833043, 8274.338052955869, 8411.621477033548, 8479.0, 7776.377889768805, 7783.688652453951, 7787.29914307715, 7905.960470197612, 8050.798730031679, 4472.686911916199, 4726.692764970266, 4760.476347601761, 4966.279889416014, 5046.21783623539, 1843.8383818194452, 1884.3875740384156, 2012.4604677421785, 2052.722882410885, 2074.91700331985, 905.6875377994581, 966.840471322238, 979.2019504104132, 987.9971828593983, 1057.6721216422934, 18220.544486387946, 19102.426927192206, 19559.511012224524, 19635.705464418046, 19929.701054484194, 987.9654212102541, 1006.059334522224, 1032.8037672842136, 1041.2398948767443, 1083.1659622091104, 10302.278840481094, 11009.119270458345, 11096.833547496793, 11097.0, 11131.053860421793, 465196.0, 465740.0, 466463.0, 470117.0, 484208.0, 89829.10170898207, 90539.0, 92163.0, 92906.53546732223, 93197.5340123295, 895.7044175422226, 902.2556390977338, 909.2680392284143, 983.8425851863667, 1038.776663017455, 17351.913240433718, 17551.0, 17787.555311117325, 17987.820121799137, 18298.725519116957, 39235.0, 39262.8589712828, 39479.21041579095, 40856.182876341714, 42671.0, 57038.714806427364, 59169.40830591639, 60409.69795150996, 60472.39527604844, 60532.0, 8605.139486051345, 8962.14859588338, 8994.0, 9055.68305109318, 9334.299927505328, 8452.450590711584, 9768.344739474469, 10715.0, 12179.269243845398, 12827.294498802656, 11323.15076369259, 11809.940950295193, 11820.349880756641, 12089.818652720392, 12127.575534856238, 11910.702232444259, 11948.0, 11956.48913728092, 12131.878681213075, 12151.210171338835, 12161.33112678811, 12235.93882030584, 12449.93775031119, 12458.439370228543, 12465.314407707301, 8790.252828509649, 8971.730848074569, 9059.320550958573, 9092.408993415407, 9113.179813816789, 11593.478293476983, 11896.405179740805, 11923.284602923852, 11986.820197697216, 12519.311437871005], "value": 9258.389746504969, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.1927662679018, 1524.4222229991958, 1564.319521008361, 1726.559727269546, 1859.0294288054663, 8666.86999695005, 8957.507337096456, 8961.372703910722, 9198.770030749218, 9206.125418085272, 9088.363814532986, 9329.0, 9340.813183736338, 9341.205997490204, 9349.906500934989, 2396.257160280314, 2421.2010036687852, 2426.296374051532, 2426.696662917135, 2428.781409673129, 2446.7920226780657, 2466.469709012562, 2488.9004439822384, 2497.962530562043, 2502.124256510225, 2413.1795189635523, 2419.2984034629935, 2461.396957745355, 2468.123816045305, 2471.666325046114, 2349.1308215960034, 2355.670206171129, 2357.174988753931, 2377.643353496972, 2390.4262976885598, 2303.3205204464725, 2357.988210058939, 2361.716594008713, 2363.929082127539, 2365.9881700591386, 7675.5010924289745, 7864.567448790314, 9064.274858011344, 9132.589033493508, 9141.542922853898, 4817.951820481785, 4948.134076536592, 4952.925706114411, 5076.0, 5186.377634683824, 3317.20387107095, 3434.3989801784587, 3446.2418267981257, 3465.7920524768597, 3500.3524347995703, 933.570557543524, 1055.4511653939985, 1095.1403148528368, 1163.941802909851, 1175.629676651852, 12403.813942790865, 12809.807852882213, 12827.294498802656, 12836.229826210458, 12841.229526228457, 4550.453945526492, 4688.601468875116, 4698.459677137104, 4721.197396442613, 4746.501617330199, 10748.0, 10806.729831754268, 10811.243212975016, 10817.080548153337, 10848.132149428184, 5378.435264297271, 5384.515393614593, 5385.461453854661, 5386.542143917733, 5395.298611180521, 4907.2393778964315, 4940.8764780880765, 5054.898902021939, 5152.845414637567, 5156.535911767959, 4076.9399956011057, 4106.6624465896175, 4216.093539888939, 4240.448741663564, 4273.829046838092, 1188.0911103006208, 1208.2448469706433, 1267.0, 1268.7208814060891, 1287.4270949427414, 981.3277904635205, 981.8379967305315, 983.9803203935882, 993.4933184076028, 1001.4542074569378, 6057.606255593372, 6279.434850863444, 6285.937140628626, 6289.8742025159245, 6504.869902601921, 476.0526552161243, 496.4092729651703, 983.9163671088038, 1006.9395836249848, 1091.4270008245576, 4176.227397931392, 4264.850730224427, 4292.613664770123, 4304.268274393361, 4324.870253892325, 10897.509612067475, 11443.0, 11458.140639452075, 11800.52797888075, 11829.52681892732, 11510.36692981894, 11602.129840261845, 11657.417129143509, 11675.88324116765, 11695.356755378536, 8293.585320733939, 8686.522241276663, 8724.912750872538, 8726.127387261224, 8732.519711415933, 6063.575549711478, 6201.472874805692, 6263.874722505433, 6446.548741588043, 6553.4101930826455, 10447.268691191544, 10508.21188410857, 10836.0, 10875.510602023087, 10929.83605245906, 10601.463679524828, 10839.187060970617, 10866.67399978002, 10942.835857461985, 10963.342199468058, 8039.075506316848, 8227.13615070433, 8244.587770611566, 8275.172482751677, 8293.295069919124, 8674.219320260954, 8796.296296296408, 8858.424202426822, 8872.822543549222, 8934.910650893407, 8008.559529225716, 8023.197680232163, 8086.7169649062, 8193.46742461762, 8196.713115040944, 7949.364050875801, 7954.880676789969, 7985.800354991172, 8057.234562716532, 8143.83712325762, 7301.707931682673, 7328.193898671036, 7368.1526624438875, 7369.631518424165, 7388.0, 4754.548317909793, 5329.946700532945, 5361.142217245222, 5521.861953451196, 5555.666660000413, 4908.337374454546, 5304.496072873071, 5342.3856256531, 5518.696471694096, 5637.182608521824], "value": 4778.932394261167, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.2326394604653, 334.1479227968681, 335.304243694334, 338.24233716475095, 348.79421141526495, 5390.326209223852, 5429.701366424845, 5434.538064264538, 5454.209139674745, 5506.669599824013, 5325.281087053247, 5329.188076054141, 5366.436524164956, 5385.461453854613, 5391.973040134803, 3985.9402108968316, 4043.555208927016, 4178.268802959486, 4187.350960601112, 4223.21870453967, 4168.270552653289, 4185.874423767276, 4187.623113919746, 4188.371744238373, 4213.936790948138, 4012.498437695288, 4172.977620482986, 4184.849166479212, 4195.979020104895, 4200.411942328076, 4111.444954931076, 4157.771322577257, 4169.56219596944, 4179.456670632799, 4199.139176468817, 3727.8881633551036, 3728.266356144406, 3732.992092135108, 3747.2880152770886, 3761.9247615047548, 5124.6932032331515, 5146.511081447294, 5147.7349966014835, 5182.300389447414, 5211.296474975868, 4546.431696037996, 4718.127146477913, 4740.573348398626, 4765.237561990065, 4778.737169455713, 5535.169724541311, 5536.809585939042, 5559.527440167591, 5581.190727344512, 5620.85947851307, 4045.554988951213, 4067.1662309226535, 4069.97965010176, 4080.510338759338, 4112.157007813391, 5627.774889004435, 5744.425557444222, 5745.540356771448, 5762.279715035621, 5792.507636850873, 4067.8169482373364, 4092.263392589303, 4094.7133700641266, 4119.546849846514, 4134.586541345841, 4147.605977432139, 4155.854545090907, 4159.480064991876, 4171.249175148502, 4175.31107367287, 4503.211937910853, 4692.0, 4697.107549565571, 4699.0, 4772.5943294819635, 5524.806631767869, 5534.557235421156, 5564.86087847799, 5572.749226284827, 5587.0, 1413.5688614972325, 1418.212891845036, 1424.173979092124, 1439.5681295611275, 1446.2479510654612, 915.54680433186, 918.4489306416096, 922.2529750901791, 924.2790623313826, 940.5250348574064, 4803.327534145223, 4835.0022985749065, 4852.684575502581, 4895.751583346224, 4910.189818679878, 4964.950350496449, 5049.823256186016, 5061.620378471629, 5115.2071428928575, 5145.3568303962, 4834.347363105936, 4836.927446088312, 4860.975695121572, 5068.797248110034, 5452.263944367539, 3054.053243494524, 3059.7552195824724, 3069.8004629699444, 3086.7221950024605, 3087.336222712128, 5917.881642367129, 5959.791407300723, 5969.552283578749, 6010.3088144863905, 6019.819405417845, 5639.971800140973, 5897.852553686106, 5899.941000590025, 5912.0, 5932.822015339547, 6002.39976002405, 6003.729832157564, 6013.849653758691, 6019.939800601938, 6049.395060494004, 5612.7754889803955, 5701.458361455655, 5766.682832444256, 5850.869784665184, 5868.354481007001, 5626.831195064155, 5676.858078548069, 5692.772289108555, 5697.4587414195585, 5707.0, 5938.346781854079, 5968.985272503772, 5974.253218347707, 5993.61041532299, 6005.1892994446935, 4019.5578486367062, 4243.278642630698, 4248.490181178278, 4268.786560672016, 4282.721623094489, 5524.447555244444, 5707.229524014205, 5735.9139612905, 5775.393583673654, 5798.82603521895, 5530.557555395479, 5556.249906262603, 5569.220309156641, 5571.270077661836, 5704.258446401941, 5588.636738611977, 5593.161025846156, 5634.873025394855, 5636.351819540805, 5637.746301416364, 5313.176457648916, 5542.334919809648, 5570.359408667893, 5570.470805273492, 5607.467290607386, 5621.578381621476, 5681.346645135863, 5684.436779885565, 5685.943140568706, 5713.8285851424525, 5258.710770907637, 5480.588955828249, 5529.198266251451, 5533.944660553343, 5573.27547418833], "value": 4247.993511257247, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.8716718157916, 781.3202513812984, 817.7301490508133, 821.5194111444805, 871.6513394642141, 14600.853991460082, 15689.215539223036, 15846.28691708873, 15854.841451585466, 15881.047137171778, 14113.788293175585, 15018.699626007474, 15040.323185456653, 15063.849361506382, 15071.849281507182, 691.0774116554406, 800.747764454198, 806.1857523900873, 825.3562221467236, 829.6100832608664, 835.5446281776447, 836.8702851058096, 837.8491871463134, 838.6226198210799, 839.1776059461731, 884.6594061286419, 885.3094586222757, 885.6988623867884, 886.5301390263171, 886.7871710789428, 700.5271441776806, 839.2069494327862, 856.9657213711444, 858.1718641510972, 858.4720396955889, 628.1206311164361, 629.5058379172374, 629.5309994054413, 629.7323637454109, 630.4105661206786, 13867.722645547032, 13875.583732488041, 13887.652808679763, 13903.79144312836, 13947.02370834042, 13609.591712248648, 13966.581002569837, 14088.2955852208, 14147.504837330644, 14151.433942642281, 12885.87114128856, 12937.54718584845, 13040.56553779093, 13106.606801795866, 13670.52153174644, 4474.7986340614425, 4477.261251893434, 4539.137563862889, 4689.413823272091, 4741.146593613148, 70552.2944770556, 71264.28735712629, 71828.0, 72303.0, 72797.0, 11159.0, 11203.94398028021, 11356.318620882774, 11418.086553075735, 11734.413279335999, 20983.265585704426, 21068.57862842765, 21175.68236476454, 21181.57636847285, 21204.681929771064, 8409.159084091541, 8424.15758424165, 8484.533350665773, 8547.615357308936, 8646.52444115567, 4580.473245576734, 4694.483606803249, 4711.0, 4804.783784729696, 5000.874978125576, 3510.8069056202153, 3643.216708407705, 3649.251903359805, 3650.7079433645245, 3655.8720444784303, 549.7581064331681, 618.8731310081422, 658.4271683635268, 717.4654882112859, 729.0194688144437, 713.2297119111347, 739.2607392607392, 743.9107307123072, 759.2710997442407, 767.6622286194169, 10545.367277963192, 10658.78682426347, 10826.458677066115, 10893.183011274028, 10975.231733778719, 755.9962200188963, 757.571971835911, 764.5947647746592, 772.2817779465151, 780.7852840468917, 4690.413698287714, 5059.2916991621205, 5096.719680417613, 5097.719625420637, 5164.7934082636275, 71826.281737183, 72329.0, 76674.0, 77060.0, 118317.4084129591, 64104.0, 64577.67711161508, 66314.78454717723, 81497.0, 100052.0, 72465.27534724586, 92473.5376323114, 92500.53749731208, 92509.0, 92660.53669731609, 9811.072581609493, 10051.547680354548, 10112.747181320232, 10270.415472779418, 10626.562913345186, 47562.76218618885, 49955.0, 50172.74913625408, 51481.22778158406, 52759.20861187162, 66154.0, 72413.0, 73703.6314818444, 74696.25303746892, 75119.62440187763, 13106.344682766014, 13146.21122732639, 13165.144265622705, 13308.733825323632, 13455.798163027759, 14902.478413255918, 14918.179500127597, 14997.850021499646, 15257.6185595361, 15441.922790385976, 12841.29372884463, 13498.392572334466, 13506.0, 13575.660608484866, 13965.0, 13324.467021319038, 13428.798568021683, 13571.117877337942, 13627.0, 14021.228832414316, 13208.339583021003, 13282.734345312847, 13388.330583470983, 13610.251436171106, 13684.3842027111, 10849.891501084889, 10873.728156796144, 11314.773704526027, 11392.601258955896, 11540.192186547198, 11178.776424471627, 11414.14393920476, 11505.597304094317, 11564.190506664452, 11596.246243994114], "value": 7571.05566998492, "unit": "score"}], "name": "dromaeo_css", "value": 7359.631556524096, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 103.0, 109.0, 111.0, 111.0, 111.0, 109.0, 108.0, 109.0, 108.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 138.0, 130.0, 179.0, 128.0, 135.0, 167.0, 127.0, 192.0, 131.0], "value": 148.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 160.0, 161.0, 161.0, 162.0, 161.0, 160.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 131.0, 75.0, 76.0, 74.0, 75.0, 98.0, 75.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 124.0, 85.0, 85.0, 86.0, 123.0, 85.0, 85.0, 133.0], "value": 97.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 116.0, 118.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 146.0, 153.0, 146.0, 147.0, 145.0, 145.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 54.0, 54.0, 55.0, 53.0, 54.0, 55.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 61.0, 61.0, 63.0, 61.0, 62.0, 61.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 80.0, 83.0, 80.0, 81.0, 80.0, 115.0, 86.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 139.0, 121.0, 120.0, 120.0, 120.0, 128.0, 131.0, 133.0, 123.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 164.0, 163.0, 158.0, 160.0, 162.0, 159.0, 169.0, 160.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 62.0, 63.0, 62.0, 64.0, 62.0, 62.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1507.3000000000002, "alertThreshold": 2.0}]} 04:21:03 INFO - Return code: 0 04:21:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:21:03 ERROR - # TBPL SUCCESS # 04:21:03 INFO - Running post-action listener: _resource_record_post_action 04:21:03 INFO - ##### 04:21:03 INFO - ##### Finished run-tests step (success) 04:21:03 INFO - ##### 04:21:03 INFO - Running post-run listener: _resource_record_post_run 04:21:03 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540127232; Read time: 12; Write time: 493204 04:21:03 INFO - TinderboxPrint: CPU usage
13.2% 04:21:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:21:03 INFO - TinderboxPrint: I/O write bytes / time
540,127,232 / 493,204 04:21:03 INFO - TinderboxPrint: CPU idle
8,265.9 (86.8%) 04:21:03 INFO - TinderboxPrint: CPU user
1,210.3 (12.7%) 04:21:03 INFO - TinderboxPrint: Swap in / out
0 / 0 04:21:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247902208; Read time: 0; Write time: 234284 04:21:03 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292225024; Read time: 12; Write time: 258920 04:21:04 INFO - Running post-run listener: _upload_blobber_files 04:21:04 INFO - Blob upload gear active. 04:21:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:21:04 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 04:21:04 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'] 04:21:04 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 04:21:04 INFO - (blobuploader) - INFO - Open directory for files ... 04:21:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:21:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:21:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:05 INFO - (blobuploader) - INFO - Done attempting. 04:21:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:21:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:21:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:09 INFO - (blobuploader) - INFO - Done attempting. 04:21:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:21:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:21:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:10 INFO - (blobuploader) - INFO - Done attempting. 04:21:10 INFO - (blobuploader) - INFO - Iteration through files over. 04:21:10 INFO - Return code: 0 04:21:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:21:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:21:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/afa041cf9e7b687253b9311ec7251d4e00c42ccc0db7c4f062df2def9468b82148628ef5c7bbc07251244e1e8796840ad0cc4a4cc8a2f7e915d53d6e1104e1b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ebce3db9d817a5016667770b919b5007b40f246688f5a999d309546c04e3b480e6024b68c0b9d773172722b3c6f5128fcca54baa889d9c3fd128c7089a273079", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c494539d6ee8b0d3748cc1fd63a57accb6fd05ed3f23c28a9001b6b511f8adfbd8c01623957c7d011419c6b806e94638696d89b9c75ac340aafb3d7485f3749c"} 04:21:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:21:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:21:10 INFO - Contents: 04:21:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/afa041cf9e7b687253b9311ec7251d4e00c42ccc0db7c4f062df2def9468b82148628ef5c7bbc07251244e1e8796840ad0cc4a4cc8a2f7e915d53d6e1104e1b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ebce3db9d817a5016667770b919b5007b40f246688f5a999d309546c04e3b480e6024b68c0b9d773172722b3c6f5128fcca54baa889d9c3fd128c7089a273079", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c494539d6ee8b0d3748cc1fd63a57accb6fd05ed3f23c28a9001b6b511f8adfbd8c01623957c7d011419c6b806e94638696d89b9c75ac340aafb3d7485f3749c"} 04:21:10 INFO - Running post-run listener: copy_logs_to_upload_dir 04:21:10 INFO - Copying logs to upload dir... 04:21:10 INFO - mkdir: /builds/slave/test/build/upload/logs 04:21:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.336034 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-05 04:21:10.447409) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 04:21:10.448706) ========= 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=eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289 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/afa041cf9e7b687253b9311ec7251d4e00c42ccc0db7c4f062df2def9468b82148628ef5c7bbc07251244e1e8796840ad0cc4a4cc8a2f7e915d53d6e1104e1b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ebce3db9d817a5016667770b919b5007b40f246688f5a999d309546c04e3b480e6024b68c0b9d773172722b3c6f5128fcca54baa889d9c3fd128c7089a273079", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c494539d6ee8b0d3748cc1fd63a57accb6fd05ed3f23c28a9001b6b511f8adfbd8c01623957c7d011419c6b806e94638696d89b9c75ac340aafb3d7485f3749c"} build_url:https://queue.taskcluster.net/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011257 build_url: 'https://queue.taskcluster.net/v1/task/HwwH5gDLRsG2h59tuz6pvA/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/afa041cf9e7b687253b9311ec7251d4e00c42ccc0db7c4f062df2def9468b82148628ef5c7bbc07251244e1e8796840ad0cc4a4cc8a2f7e915d53d6e1104e1b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ebce3db9d817a5016667770b919b5007b40f246688f5a999d309546c04e3b480e6024b68c0b9d773172722b3c6f5128fcca54baa889d9c3fd128c7089a273079", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c494539d6ee8b0d3748cc1fd63a57accb6fd05ed3f23c28a9001b6b511f8adfbd8c01623957c7d011419c6b806e94638696d89b9c75ac340aafb3d7485f3749c"}' ========= master_lag: 0.96 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 04:21:11.415904) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:21:11.416300) ========= 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=eca2ab57546de7b41f256b19000001ef-1465123010.431197-78554289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 04:21:11.440375) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 04:21:11.440701) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 04:21:11.440987) ========= ========= Total master_lag: 1.07 =========