builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1467025585.43 results: success (0) buildid: 20160627013018 builduid: b5b309a583d641fea5d34c2e9ba2f745 revision: f35504e8fc9de135eb1a697828dcec202d082ffb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:25.429979) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:25.430995) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:25.431661) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:25.448107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:25.448783) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 04:06:25-- 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.4M=0s 2016-06-27 04:06:25 (23.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096623 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:25.564616) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:25.565255) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015827 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:25.616697) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 04:06:25.617098) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev f35504e8fc9de135eb1a697828dcec202d082ffb --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 f35504e8fc9de135eb1a697828dcec202d082ffb --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 04:06:25,788 truncating revision to first 12 chars 2016-06-27 04:06:25,788 Setting DEBUG logging. 2016-06-27 04:06:25,788 attempt 1/10 2016-06-27 04:06:25,788 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/f35504e8fc9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 04:06:26,529 unpacking tar archive at: mozilla-inbound-f35504e8fc9d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.075855 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-27 04:06:26.707323) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:26.707756) ========= script_repo_revision: f35504e8fc9de135eb1a697828dcec202d082ffb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:26.708259) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:26.708631) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 04:06:26.718723) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-27 04:06:26.719198) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:06:26 INFO - MultiFileLogger online at 20160627 04:06:26 in /builds/slave/test 04:06:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:06:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:06:26 INFO - {'append_to_log': False, 04:06:26 INFO - 'base_work_dir': '/builds/slave/test', 04:06:26 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:06:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:06:26 INFO - 'branch': 'Mozilla-Inbound', 04:06:26 INFO - 'buildbot_json_path': 'buildprops.json', 04:06:26 INFO - 'config_files': ('talos/linux_config.py',), 04:06:26 INFO - 'default_actions': ('clobber', 04:06:26 INFO - 'read-buildbot-config', 04:06:26 INFO - 'download-and-extract', 04:06:26 INFO - 'populate-webroot', 04:06:26 INFO - 'create-virtualenv', 04:06:26 INFO - 'install', 04:06:26 INFO - 'run-tests'), 04:06:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:06:26 INFO - 'download_minidump_stackwalk': True, 04:06:26 INFO - 'download_symbols': 'ondemand', 04:06:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:06:26 INFO - 'tooltool.py': '/tools/tooltool.py', 04:06:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:06:26 INFO - '/tools/misc-python/virtualenv.py')}, 04:06:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:06:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:06:26 INFO - 'installer_path': 'installer.exe', 04:06:26 INFO - 'log_level': 'info', 04:06:26 INFO - 'log_name': 'talos', 04:06:26 INFO - 'log_to_console': True, 04:06:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:06:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:06:26 INFO - 'opt_config_files': (), 04:06:26 INFO - 'pip_index': False, 04:06:26 INFO - 'sps_profile': False, 04:06:26 INFO - 'sps_profile_interval': 0, 04:06:26 INFO - 'suite': 'dromaeojs-e10s', 04:06:26 INFO - 'system_bits': '32', 04:06:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:06:26 INFO - 'title': 'talos-linux64-ix-051', 04:06:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:06:26 INFO - 'use_talos_json': True, 04:06:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:06:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:06:26 INFO - 'work_dir': 'build'} 04:06:26 INFO - ##### 04:06:26 INFO - ##### Running clobber step. 04:06:26 INFO - ##### 04:06:26 INFO - Running pre-action listener: _resource_record_pre_action 04:06:26 INFO - Running main action method: clobber 04:06:26 INFO - rmtree: /builds/slave/test/build 04:06:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:06:27 INFO - Running post-action listener: _resource_record_post_action 04:06:27 INFO - ##### 04:06:27 INFO - ##### Finished clobber step (success) 04:06:27 INFO - ##### 04:06:27 INFO - ##### 04:06:27 INFO - ##### Running read-buildbot-config step. 04:06:27 INFO - ##### 04:06:27 INFO - Running pre-action listener: _resource_record_pre_action 04:06:27 INFO - Running main action method: read_buildbot_config 04:06:27 INFO - Using buildbot properties: 04:06:27 INFO - { 04:06:27 INFO - "project": "", 04:06:27 INFO - "product": "firefox", 04:06:27 INFO - "script_repo_revision": "production", 04:06:27 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 04:06:27 INFO - "repository": "", 04:06:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 04:06:27 INFO - "buildid": "20160627013018", 04:06:27 INFO - "pgo_build": "True", 04:06:27 INFO - "basedir": "/builds/slave/test", 04:06:27 INFO - "buildnumber": 775, 04:06:27 INFO - "slavename": "talos-linux64-ix-051", 04:06:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:06:27 INFO - "platform": "ubuntu64_hw", 04:06:27 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:06:27 INFO - "branch": "mozilla-inbound", 04:06:27 INFO - "repo_path": "integration/mozilla-inbound", 04:06:27 INFO - "revision": "f35504e8fc9de135eb1a697828dcec202d082ffb", 04:06:27 INFO - "stage_platform": "linux64-pgo", 04:06:27 INFO - "builduid": "b5b309a583d641fea5d34c2e9ba2f745", 04:06:27 INFO - "slavebuilddir": "test" 04:06:27 INFO - } 04:06:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:06:27 INFO - Running post-action listener: _resource_record_post_action 04:06:27 INFO - ##### 04:06:27 INFO - ##### Finished read-buildbot-config step (success) 04:06:27 INFO - ##### 04:06:27 INFO - ##### 04:06:27 INFO - ##### Running download-and-extract step. 04:06:27 INFO - ##### 04:06:27 INFO - Running pre-action listener: _resource_record_pre_action 04:06:27 INFO - Running main action method: download_and_extract 04:06:27 INFO - mkdir: /builds/slave/test/build/tests 04:06: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:06:27 INFO - https://queue.taskcluster.net/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:06:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:06:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:06:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:06:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:06:28 INFO - Downloaded 1361 bytes. 04:06:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:06:28 INFO - Using the following test package requirements: 04:06:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:06:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:06:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:06:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:28 INFO - u'jsshell-linux-x86_64.zip'], 04:06:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:06:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:06:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:06:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:06:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:06:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:06:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:06:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:28 INFO - https://queue.taskcluster.net/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:06:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:06:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:06:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:06:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:06:29 INFO - Downloaded 24279627 bytes. 04:06:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:06:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:06:31 INFO - Return code: 0 04:06:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:31 INFO - https://queue.taskcluster.net/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:06:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:06:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:06:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:06:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:06:32 INFO - Downloaded 24279627 bytes. 04:06:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:06:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:06:33 INFO - Return code: 0 04:06:33 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:06:33 INFO - https://queue.taskcluster.net/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:06:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:06:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:06:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:06:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:06:34 INFO - Downloaded 14405240 bytes. 04:06:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:06:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:06:35 INFO - Return code: 0 04:06:35 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:06:35 INFO - https://queue.taskcluster.net/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:06:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:06:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:06:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:06:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:06:39 INFO - Downloaded 60290769 bytes. 04:06:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:06:39 INFO - mkdir: /builds/slave/test/properties 04:06:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:06:39 INFO - Writing to file /builds/slave/test/properties/build_url 04:06:39 INFO - Contents: 04:06:39 INFO - build_url:https://queue.taskcluster.net/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:06:40 INFO - Running post-action listener: _resource_record_post_action 04:06:40 INFO - Running post-action listener: set_extra_try_arguments 04:06:40 INFO - ##### 04:06:40 INFO - ##### Finished download-and-extract step (success) 04:06:40 INFO - ##### 04:06:40 INFO - ##### 04:06:40 INFO - ##### Running populate-webroot step. 04:06:40 INFO - ##### 04:06:40 INFO - Running pre-action listener: _resource_record_pre_action 04:06:40 INFO - Running main action method: populate_webroot 04:06:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:06:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:06:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:06:40 INFO - '--tppagecycles', 04:06:40 INFO - '7'], 04:06:40 INFO - 'tests': ['tsvgm']}}, 04:06:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:06:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:06:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:06:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:06:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:06:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:06:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:40 INFO - 'talos_options': ['--disable-e10s'], 04:06:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:40 INFO - 'talos_options': ['--disable-e10s'], 04:06:40 INFO - 'tests': ['damp', 'tps']}, 04:06:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:40 INFO - 'tests': ['damp', 'tps']}, 04:06:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:06:40 INFO - 'tests': ['dromaeo_dom']}, 04:06:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:06:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:06:40 INFO - 'tests': ['basic_compositor_video']}, 04:06:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:06:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:06:40 INFO - 'tests': ['a11yr', 04:06:40 INFO - 'ts_paint', 04:06:40 INFO - 'tpaint', 04:06:40 INFO - 'sessionrestore', 04:06:40 INFO - 'sessionrestore_no_auto_restore', 04:06:40 INFO - 'tabpaint']}, 04:06:40 INFO - 'other-e10s': {'tests': ['a11yr', 04:06:40 INFO - 'ts_paint', 04:06:40 INFO - 'tpaint', 04:06:40 INFO - 'sessionrestore', 04:06:40 INFO - 'sessionrestore_no_auto_restore', 04:06:40 INFO - 'tabpaint']}, 04:06:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:06:40 INFO - 'ts_paint', 04:06:40 INFO - 'tpaint', 04:06:40 INFO - 'sessionrestore', 04:06:40 INFO - 'sessionrestore_no_auto_restore', 04:06:40 INFO - 'tabpaint']}, 04:06:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:06:40 INFO - 'ts_paint', 04:06:40 INFO - 'tpaint', 04:06:40 INFO - 'sessionrestore', 04:06:40 INFO - 'sessionrestore_no_auto_restore', 04:06:40 INFO - 'tabpaint']}, 04:06:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:06:40 INFO - 'tests': ['a11yr', 04:06:40 INFO - 'ts_paint', 04:06:40 INFO - 'tpaint', 04:06:40 INFO - 'sessionrestore', 04:06:40 INFO - 'sessionrestore_no_auto_restore', 04:06:40 INFO - 'tabpaint']}, 04:06:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:06:40 INFO - 'tests': ['a11yr', 04:06:40 INFO - 'ts_paint', 04:06:40 INFO - 'tpaint', 04:06:40 INFO - 'sessionrestore', 04:06:40 INFO - 'sessionrestore_no_auto_restore', 04:06:40 INFO - 'tabpaint']}, 04:06:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:06:40 INFO - 'tests': ['tsvgx', 04:06:40 INFO - 'tsvgr_opacity', 04:06:40 INFO - 'tart', 04:06:40 INFO - 'tscrollx', 04:06:40 INFO - 'cart']}, 04:06:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:06:40 INFO - 'tsvgr_opacity', 04:06:40 INFO - 'tart', 04:06:40 INFO - 'tscrollx', 04:06:40 INFO - 'cart']}, 04:06:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:40 INFO - 'talos_options': ['--disable-e10s'], 04:06:40 INFO - 'tests': ['tp5o']}, 04:06:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:40 INFO - 'tests': ['tp5o']}, 04:06:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:40 INFO - 'talos_options': ['--disable-e10s', 04:06:40 INFO - '--xperf_path', 04:06:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:40 INFO - 'tests': ['tp5n']}, 04:06:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:06:40 INFO - 'talos_options': ['--xperf_path', 04:06:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:40 INFO - 'tests': ['tp5n']}}, 04:06:40 INFO - 'talos.zip': {'path': '', 04:06:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:06:40 INFO - Running post-action listener: _resource_record_post_action 04:06:40 INFO - ##### 04:06:40 INFO - ##### Finished populate-webroot step (success) 04:06:40 INFO - ##### 04:06:40 INFO - ##### 04:06:40 INFO - ##### Running create-virtualenv step. 04:06:40 INFO - ##### 04:06:40 INFO - Running pre-action listener: _resource_record_pre_action 04:06:40 INFO - Running main action method: create_virtualenv 04:06:40 INFO - Creating virtualenv /builds/slave/test/build/venv 04:06:40 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:06:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:06:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:06:40 INFO - Using real prefix '/usr' 04:06:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:06:40 INFO - Installing distribute.............................................................................................................................................................................................done. 04:06:42 INFO - Installing pip.................done. 04:06:42 INFO - Return code: 0 04:06:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:06: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:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:42 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 0x7f19c3bd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26456f0>, '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 0x26465f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2646aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', '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:06:42 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:06:42 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:06:42 INFO - Using env: {'DISPLAY': ':0', 04:06:42 INFO - 'HOME': '/home/cltbld', 04:06:42 INFO - 'LANG': 'en_US.UTF-8', 04:06:42 INFO - 'LANGUAGE': 'en_US:en', 04:06:42 INFO - 'LOGNAME': 'cltbld', 04:06:42 INFO - 'MAIL': '/var/mail/cltbld', 04:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:42 INFO - 'MOZ_NO_REMOTE': '1', 04:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:42 INFO - 'NO_EM_RESTART': '1', 04:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:42 INFO - 'PWD': '/builds/slave/test', 04:06:42 INFO - 'SHELL': '/bin/bash', 04:06:42 INFO - 'SHLVL': '1', 04:06:42 INFO - 'TERM': 'linux', 04:06:42 INFO - 'TMOUT': '86400', 04:06:42 INFO - 'USER': 'cltbld', 04:06:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', 04:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:42 INFO - '_': '/tools/buildbot/bin/python'} 04:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:43 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:06:43 INFO - Cleaning up... 04:06:43 INFO - Return code: 0 04:06:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:06: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:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:43 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 0x7f19c3bd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26456f0>, '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 0x26465f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2646aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', '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:06:43 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:06:43 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:06:43 INFO - Using env: {'DISPLAY': ':0', 04:06:43 INFO - 'HOME': '/home/cltbld', 04:06:43 INFO - 'LANG': 'en_US.UTF-8', 04:06:43 INFO - 'LANGUAGE': 'en_US:en', 04:06:43 INFO - 'LOGNAME': 'cltbld', 04:06:43 INFO - 'MAIL': '/var/mail/cltbld', 04:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:43 INFO - 'MOZ_NO_REMOTE': '1', 04:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:43 INFO - 'NO_EM_RESTART': '1', 04:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:43 INFO - 'PWD': '/builds/slave/test', 04:06:43 INFO - 'SHELL': '/bin/bash', 04:06:43 INFO - 'SHLVL': '1', 04:06:43 INFO - 'TERM': 'linux', 04:06:43 INFO - 'TMOUT': '86400', 04:06:43 INFO - 'USER': 'cltbld', 04:06:43 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', 04:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:43 INFO - '_': '/tools/buildbot/bin/python'} 04:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:43 INFO - Downloading/unpacking psutil>=3.1.1 04:06:43 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:06:43 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:06:43 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:06:43 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:06:43 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:06:43 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:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:06:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:45 INFO - Installing collected packages: psutil 04:06:45 INFO - Running setup.py install for psutil 04:06:45 INFO - building 'psutil._psutil_linux' extension 04:06:45 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:06:45 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:06:45 INFO - building 'psutil._psutil_posix' extension 04:06:45 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:06:45 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:06:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:45 INFO - Successfully installed psutil 04:06:45 INFO - Cleaning up... 04:06:45 INFO - Return code: 0 04:06:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:45 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 0x7f19c3bd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26456f0>, '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 0x26465f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2646aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', '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:06:45 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:06:45 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:06:45 INFO - Using env: {'DISPLAY': ':0', 04:06:45 INFO - 'HOME': '/home/cltbld', 04:06:45 INFO - 'LANG': 'en_US.UTF-8', 04:06:45 INFO - 'LANGUAGE': 'en_US:en', 04:06:45 INFO - 'LOGNAME': 'cltbld', 04:06:45 INFO - 'MAIL': '/var/mail/cltbld', 04:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:45 INFO - 'MOZ_NO_REMOTE': '1', 04:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:45 INFO - 'NO_EM_RESTART': '1', 04:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:45 INFO - 'PWD': '/builds/slave/test', 04:06:45 INFO - 'SHELL': '/bin/bash', 04:06:45 INFO - 'SHLVL': '1', 04:06:45 INFO - 'TERM': 'linux', 04:06:45 INFO - 'TMOUT': '86400', 04:06:45 INFO - 'USER': 'cltbld', 04:06:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', 04:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:45 INFO - '_': '/tools/buildbot/bin/python'} 04:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:06:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:06:48 INFO - Installing collected packages: mozsystemmonitor 04:06:48 INFO - Running setup.py install for mozsystemmonitor 04:06:48 INFO - Successfully installed mozsystemmonitor 04:06:48 INFO - Cleaning up... 04:06:48 INFO - Return code: 0 04:06:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:06: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:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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', '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 0x7f19c3bd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26456f0>, '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 0x26465f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2646aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', '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:06: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:06: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 jsonschema==2.5.1 04:06:48 INFO - Using env: {'DISPLAY': ':0', 04:06:48 INFO - 'HOME': '/home/cltbld', 04:06:48 INFO - 'LANG': 'en_US.UTF-8', 04:06:48 INFO - 'LANGUAGE': 'en_US:en', 04:06:48 INFO - 'LOGNAME': 'cltbld', 04:06:48 INFO - 'MAIL': '/var/mail/cltbld', 04:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:48 INFO - 'MOZ_NO_REMOTE': '1', 04:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:48 INFO - 'NO_EM_RESTART': '1', 04:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:48 INFO - 'PWD': '/builds/slave/test', 04:06:48 INFO - 'SHELL': '/bin/bash', 04:06:48 INFO - 'SHLVL': '1', 04:06:48 INFO - 'TERM': 'linux', 04:06:48 INFO - 'TMOUT': '86400', 04:06:48 INFO - 'USER': 'cltbld', 04:06:48 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', 04:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:48 INFO - '_': '/tools/buildbot/bin/python'} 04:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:48 INFO - Downloading/unpacking jsonschema==2.5.1 04:06: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:06: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:06: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:06: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:06: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:06: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:06:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:06:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:50 INFO - Downloading functools32-3.2.3-2.tar.gz 04:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:06:50 INFO - warning: no files found matching '*.txt' 04:06:50 INFO - no previously-included directories found matching 'build' 04:06:50 INFO - no previously-included directories found matching 'dist' 04:06:50 INFO - no previously-included directories found matching '.git*' 04:06:50 INFO - Installing collected packages: jsonschema, functools32 04:06:50 INFO - Running setup.py install for functools32 04:06:50 INFO - warning: no files found matching '*.txt' 04:06:50 INFO - no previously-included directories found matching 'build' 04:06:50 INFO - no previously-included directories found matching 'dist' 04:06:50 INFO - no previously-included directories found matching '.git*' 04:06:50 INFO - Successfully installed jsonschema functools32 04:06:50 INFO - Cleaning up... 04:06:50 INFO - Return code: 0 04:06:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f19c3bd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26456f0>, '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 0x26465f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2646aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', '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:06:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:06:50 INFO - Using env: {'DISPLAY': ':0', 04:06:50 INFO - 'HOME': '/home/cltbld', 04:06:50 INFO - 'LANG': 'en_US.UTF-8', 04:06:50 INFO - 'LANGUAGE': 'en_US:en', 04:06:50 INFO - 'LOGNAME': 'cltbld', 04:06:50 INFO - 'MAIL': '/var/mail/cltbld', 04:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:50 INFO - 'MOZ_NO_REMOTE': '1', 04:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:50 INFO - 'NO_EM_RESTART': '1', 04:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:50 INFO - 'PWD': '/builds/slave/test', 04:06:50 INFO - 'SHELL': '/bin/bash', 04:06:50 INFO - 'SHLVL': '1', 04:06:50 INFO - 'TERM': 'linux', 04:06:50 INFO - 'TMOUT': '86400', 04:06:50 INFO - 'USER': 'cltbld', 04:06:50 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', 04:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:50 INFO - '_': '/tools/buildbot/bin/python'} 04:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:50 INFO - Downloading/unpacking blobuploader==1.2.4 04:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:52 INFO - Downloading blobuploader-1.2.4.tar.gz 04:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:06:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:06:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:06: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:06: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:06: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:06: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:06: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:06: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:06:53 INFO - Downloading docopt-0.6.1.tar.gz 04:06:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:06:53 INFO - Installing collected packages: blobuploader, requests, docopt 04:06:53 INFO - Running setup.py install for blobuploader 04:06:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:06:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:06:53 INFO - Running setup.py install for requests 04:06:54 INFO - Running setup.py install for docopt 04:06:54 INFO - Successfully installed blobuploader requests docopt 04:06:54 INFO - Cleaning up... 04:06:54 INFO - Return code: 0 04:06:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:54 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:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:54 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:06:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:54 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 0x7f19c3bd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26456f0>, '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 0x26465f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2646aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', '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:06:54 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:06:54 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:06:54 INFO - Using env: {'DISPLAY': ':0', 04:06:54 INFO - 'HOME': '/home/cltbld', 04:06:54 INFO - 'LANG': 'en_US.UTF-8', 04:06:54 INFO - 'LANGUAGE': 'en_US:en', 04:06:54 INFO - 'LOGNAME': 'cltbld', 04:06:54 INFO - 'MAIL': '/var/mail/cltbld', 04:06:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:54 INFO - 'MOZ_NO_REMOTE': '1', 04:06:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:54 INFO - 'NO_EM_RESTART': '1', 04:06:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:54 INFO - 'PWD': '/builds/slave/test', 04:06:54 INFO - 'SHELL': '/bin/bash', 04:06:54 INFO - 'SHLVL': '1', 04:06:54 INFO - 'TERM': 'linux', 04:06:54 INFO - 'TMOUT': '86400', 04:06:54 INFO - 'USER': 'cltbld', 04:06:54 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', 04:06:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:54 INFO - '_': '/tools/buildbot/bin/python'} 04:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:54 INFO - Running setup.py (path:/tmp/pip-UPIeoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:54 INFO - Running setup.py (path:/tmp/pip-h9XcIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:54 INFO - Running setup.py (path:/tmp/pip-CbYWFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:54 INFO - Running setup.py (path:/tmp/pip-Gmdq1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:54 INFO - Running setup.py (path:/tmp/pip-2ZGnav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:54 INFO - Running setup.py (path:/tmp/pip-8C2Qas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:54 INFO - Running setup.py (path:/tmp/pip-E5eFfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:54 INFO - Running setup.py (path:/tmp/pip-GCLL7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:55 INFO - Running setup.py (path:/tmp/pip-ErLgXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:55 INFO - Running setup.py (path:/tmp/pip-ayrO0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:55 INFO - Running setup.py (path:/tmp/pip-j3_hST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:55 INFO - Running setup.py (path:/tmp/pip-U3869r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:55 INFO - Running setup.py (path:/tmp/pip-Jeu4P3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:55 INFO - Running setup.py (path:/tmp/pip-x0hMyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:55 INFO - Running setup.py (path:/tmp/pip-eaGrx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:55 INFO - Running setup.py (path:/tmp/pip-dHqsdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:55 INFO - Running setup.py (path:/tmp/pip-M2lVkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:06:55 INFO - Running setup.py install for manifestparser 04:06:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:06:55 INFO - Running setup.py install for mozcrash 04:06:55 INFO - Running setup.py install for mozdebug 04:06:55 INFO - Running setup.py install for mozdevice 04:06:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:06:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:06:56 INFO - Running setup.py install for mozfile 04:06:56 INFO - Running setup.py install for mozhttpd 04:06:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:06:56 INFO - Running setup.py install for mozinfo 04:06:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:06:56 INFO - Running setup.py install for mozInstall 04:06:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:06:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:06:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:06:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:06:56 INFO - Running setup.py install for mozleak 04:06:56 INFO - Running setup.py install for mozlog 04:06:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:06:56 INFO - Running setup.py install for moznetwork 04:06:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:06:56 INFO - Running setup.py install for mozprocess 04:06:56 INFO - Running setup.py install for mozprofile 04:06:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:06:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:06:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:06:57 INFO - Running setup.py install for mozrunner 04:06:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:06:57 INFO - Running setup.py install for mozscreenshot 04:06:57 INFO - Running setup.py install for moztest 04:06:57 INFO - Running setup.py install for mozversion 04:06:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:06:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:06:57 INFO - Cleaning up... 04:06:57 INFO - Return code: 0 04:06:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:57 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:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:57 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:06:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:57 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 0x7f19c3bd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26456f0>, '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 0x26465f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2646aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', '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:06:57 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:06:57 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:06:57 INFO - Using env: {'DISPLAY': ':0', 04:06:57 INFO - 'HOME': '/home/cltbld', 04:06:57 INFO - 'LANG': 'en_US.UTF-8', 04:06:57 INFO - 'LANGUAGE': 'en_US:en', 04:06:57 INFO - 'LOGNAME': 'cltbld', 04:06:57 INFO - 'MAIL': '/var/mail/cltbld', 04:06:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:57 INFO - 'MOZ_NO_REMOTE': '1', 04:06:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:57 INFO - 'NO_EM_RESTART': '1', 04:06:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:57 INFO - 'PWD': '/builds/slave/test', 04:06:57 INFO - 'SHELL': '/bin/bash', 04:06:57 INFO - 'SHLVL': '1', 04:06:57 INFO - 'TERM': 'linux', 04:06:57 INFO - 'TMOUT': '86400', 04:06:57 INFO - 'USER': 'cltbld', 04:06:57 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', 04:06:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:57 INFO - '_': '/tools/buildbot/bin/python'} 04:06:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:57 INFO - Running setup.py (path:/tmp/pip-IyilFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:57 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:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:57 INFO - Running setup.py (path:/tmp/pip-qM7K73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:57 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:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:57 INFO - Running setup.py (path:/tmp/pip-6lAGbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:57 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:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:57 INFO - Running setup.py (path:/tmp/pip-WSGUJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:57 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:06:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:57 INFO - Running setup.py (path:/tmp/pip-6HTs1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:58 INFO - Running setup.py (path:/tmp/pip-VGBjsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:58 INFO - Running setup.py (path:/tmp/pip-Svxw3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:58 INFO - Running setup.py (path:/tmp/pip-KZAySN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:58 INFO - Running setup.py (path:/tmp/pip-rxlvyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:58 INFO - Running setup.py (path:/tmp/pip-JJkarK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:58 INFO - Running setup.py (path:/tmp/pip-q1IWgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:58 INFO - Running setup.py (path:/tmp/pip-j7Ehzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:58 INFO - Running setup.py (path:/tmp/pip-HsKD_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:58 INFO - Running setup.py (path:/tmp/pip-e550zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:58 INFO - Running setup.py (path:/tmp/pip-9RlnB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:58 INFO - Running setup.py (path:/tmp/pip-TnKQto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:58 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:06:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:58 INFO - Running setup.py (path:/tmp/pip-GaxJ1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:58 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:06:58 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:06:58 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:06:58 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:06:58 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:06:58 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:06:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06: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:06: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:06: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:06: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:06: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:06: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:07:00 INFO - Downloading blessings-1.6.tar.gz 04:07:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:07:00 INFO - Installing collected packages: blessings 04:07:00 INFO - Running setup.py install for blessings 04:07:00 INFO - Successfully installed blessings 04:07:00 INFO - Cleaning up... 04:07:01 INFO - Return code: 0 04:07:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:01 INFO - Reading from file tmpfile_stdout 04:07:01 INFO - Current package versions: 04:07:01 INFO - argparse == 1.2.1 04:07:01 INFO - blessings == 1.6 04:07:01 INFO - blobuploader == 1.2.4 04:07:01 INFO - docopt == 0.6.1 04:07:01 INFO - functools32 == 3.2.3-2 04:07:01 INFO - jsonschema == 2.5.1 04:07:01 INFO - manifestparser == 1.1 04:07:01 INFO - mozInstall == 1.12 04:07:01 INFO - mozcrash == 0.17 04:07:01 INFO - mozdebug == 0.1 04:07:01 INFO - mozdevice == 0.48 04:07:01 INFO - mozfile == 1.2 04:07:01 INFO - mozhttpd == 0.7 04:07:01 INFO - mozinfo == 0.9 04:07:01 INFO - mozleak == 0.1 04:07:01 INFO - mozlog == 3.2 04:07:01 INFO - moznetwork == 0.27 04:07:01 INFO - mozprocess == 0.22 04:07:01 INFO - mozprofile == 0.28 04:07:01 INFO - mozrunner == 6.11 04:07:01 INFO - mozscreenshot == 0.1 04:07:01 INFO - mozsystemmonitor == 0.3 04:07:01 INFO - moztest == 0.7 04:07:01 INFO - mozversion == 1.4 04:07:01 INFO - psutil == 3.1.1 04:07:01 INFO - requests == 1.2.3 04:07:01 INFO - wsgiref == 0.1.2 04:07:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:07:01 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:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:01 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:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:01 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 0x7f19c3bd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26456f0>, '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 0x26465f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2646aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', '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:07:01 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:07:01 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:07:01 INFO - Using env: {'DISPLAY': ':0', 04:07:01 INFO - 'HOME': '/home/cltbld', 04:07:01 INFO - 'LANG': 'en_US.UTF-8', 04:07:01 INFO - 'LANGUAGE': 'en_US:en', 04:07:01 INFO - 'LOGNAME': 'cltbld', 04:07:01 INFO - 'MAIL': '/var/mail/cltbld', 04:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:01 INFO - 'MOZ_NO_REMOTE': '1', 04:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:01 INFO - 'NO_EM_RESTART': '1', 04:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:01 INFO - 'PWD': '/builds/slave/test', 04:07:01 INFO - 'SHELL': '/bin/bash', 04:07:01 INFO - 'SHLVL': '1', 04:07:01 INFO - 'TERM': 'linux', 04:07:01 INFO - 'TMOUT': '86400', 04:07:01 INFO - 'USER': 'cltbld', 04:07:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', 04:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:01 INFO - '_': '/tools/buildbot/bin/python'} 04:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:01 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:07:01 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:07:01 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:07:01 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:07:01 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:07:01 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:07:01 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:07:01 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:07:01 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:07:01 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:07:01 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:07:01 INFO - Cleaning up... 04:07:01 INFO - Return code: 0 04:07:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:07:01 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:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:01 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:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:01 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 0x7f19c3bd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26456f0>, '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 0x26465f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2646aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', '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:07:01 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:07:01 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:07:01 INFO - Using env: {'DISPLAY': ':0', 04:07:01 INFO - 'HOME': '/home/cltbld', 04:07:01 INFO - 'LANG': 'en_US.UTF-8', 04:07:01 INFO - 'LANGUAGE': 'en_US:en', 04:07:01 INFO - 'LOGNAME': 'cltbld', 04:07:01 INFO - 'MAIL': '/var/mail/cltbld', 04:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:01 INFO - 'MOZ_NO_REMOTE': '1', 04:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:01 INFO - 'NO_EM_RESTART': '1', 04:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:01 INFO - 'PWD': '/builds/slave/test', 04:07:01 INFO - 'SHELL': '/bin/bash', 04:07:01 INFO - 'SHLVL': '1', 04:07:01 INFO - 'TERM': 'linux', 04:07:01 INFO - 'TMOUT': '86400', 04:07:01 INFO - 'USER': 'cltbld', 04:07:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', 04:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:01 INFO - '_': '/tools/buildbot/bin/python'} 04:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:07:01 INFO - Cleaning up... 04:07:01 INFO - Return code: 0 04:07:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:07:01 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:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:01 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:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:07:01 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 0x7f19c3bd6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b6480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26456f0>, '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 0x26465f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2646aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', '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:07:01 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:07:01 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:07:01 INFO - Using env: {'DISPLAY': ':0', 04:07:01 INFO - 'HOME': '/home/cltbld', 04:07:01 INFO - 'LANG': 'en_US.UTF-8', 04:07:01 INFO - 'LANGUAGE': 'en_US:en', 04:07:01 INFO - 'LOGNAME': 'cltbld', 04:07:01 INFO - 'MAIL': '/var/mail/cltbld', 04:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:01 INFO - 'MOZ_NO_REMOTE': '1', 04:07:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:01 INFO - 'NO_EM_RESTART': '1', 04:07:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:01 INFO - 'PWD': '/builds/slave/test', 04:07:01 INFO - 'SHELL': '/bin/bash', 04:07:01 INFO - 'SHLVL': '1', 04:07:01 INFO - 'TERM': 'linux', 04:07:01 INFO - 'TMOUT': '86400', 04:07:01 INFO - 'USER': 'cltbld', 04:07:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', 04:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:01 INFO - '_': '/tools/buildbot/bin/python'} 04:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:07:01 INFO - Downloading/unpacking flake8 04:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:07:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:07:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:07:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:07:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:07: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:07: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:07: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:07: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:07: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:07: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:07:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:07: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:07: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:07: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:07: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:07: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:07: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:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:07:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:07:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:07:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:07:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:07:04 INFO - no previously-included directories found matching 'docs/_build' 04:07:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:07:04 INFO - Running setup.py install for pep8 04:07:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:07:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:07:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:07:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:07:04 INFO - no previously-included directories found matching 'docs/_build' 04:07:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:07:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:07:04 INFO - Cleaning up... 04:07:04 INFO - Return code: 0 04:07:04 INFO - Running post-action listener: _resource_record_post_action 04:07:04 INFO - Running post-action listener: _start_resource_monitoring 04:07:04 INFO - Starting resource monitoring. 04:07:04 INFO - ##### 04:07:04 INFO - ##### Finished create-virtualenv step (success) 04:07:04 INFO - ##### 04:07:04 INFO - ##### 04:07:04 INFO - ##### Running install step. 04:07:04 INFO - ##### 04:07:04 INFO - Running pre-action listener: _resource_record_pre_action 04:07:04 INFO - Running main action method: install 04:07:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:07:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:07:05 INFO - Reading from file tmpfile_stdout 04:07:05 INFO - Detecting whether we're running mozinstall >=1.0... 04:07:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:07:05 INFO - Reading from file tmpfile_stdout 04:07:05 INFO - Output received: 04:07:05 INFO - Usage: mozinstall [options] installer 04:07:05 INFO - Options: 04:07:05 INFO - -h, --help show this help message and exit 04:07:05 INFO - -d DEST, --destination=DEST 04:07:05 INFO - Directory to install application into. [default: 04:07:05 INFO - "/builds/slave/test"] 04:07:05 INFO - --app=APP Application being installed. [default: firefox] 04:07:05 INFO - mkdir: /builds/slave/test/build/application 04:07:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:07:22 INFO - Reading from file tmpfile_stdout 04:07:22 INFO - Output received: 04:07:22 INFO - /builds/slave/test/build/application/firefox/firefox 04:07:22 INFO - Running post-action listener: _resource_record_post_action 04:07:22 INFO - ##### 04:07:22 INFO - ##### Finished install step (success) 04:07:22 INFO - ##### 04:07:22 INFO - ##### 04:07:22 INFO - ##### Running run-tests step. 04:07:22 INFO - ##### 04:07:22 INFO - Running pre-action listener: _resource_record_pre_action 04:07:22 INFO - Running main action method: run_tests 04:07:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:07:22 INFO - Python 2.7.3 04:07:22 INFO - Return code: 0 04:07:22 INFO - grabbing minidump binary from tooltool 04:07:22 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:07:22 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 0x26456f0>, '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 0x26465f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2646aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:07:22 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:07:22 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:07:22 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:07:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:07:22 INFO - Return code: 0 04:07:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:07:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:07:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:07:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:07:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:07:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:07:23 INFO - Return code: 0 04:07:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:07:23 INFO - Using env: {'DISPLAY': ':0', 04:07:23 INFO - 'HOME': '/home/cltbld', 04:07:23 INFO - 'LANG': 'en_US.UTF-8', 04:07:23 INFO - 'LANGUAGE': 'en_US:en', 04:07:23 INFO - 'LOGNAME': 'cltbld', 04:07:23 INFO - 'MAIL': '/var/mail/cltbld', 04:07:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:07:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:23 INFO - 'MOZ_NO_REMOTE': '1', 04:07:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:07:23 INFO - 'NO_EM_RESTART': '1', 04:07:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:23 INFO - 'PWD': '/builds/slave/test', 04:07:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:07:23 INFO - 'SHELL': '/bin/bash', 04:07:23 INFO - 'SHLVL': '1', 04:07:23 INFO - 'TERM': 'linux', 04:07:23 INFO - 'TMOUT': '86400', 04:07:23 INFO - 'USER': 'cltbld', 04:07:23 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433', 04:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:23 INFO - '_': '/tools/buildbot/bin/python'} 04:07:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:07:23 INFO - mozversion application_buildid: 20160627013018 04:07:23 INFO - mozversion application_changeset: f35504e8fc9de135eb1a697828dcec202d082ffb 04:07:23 INFO - mozversion application_display_name: Nightly 04:07:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:07:23 INFO - mozversion application_name: Firefox 04:07:23 INFO - mozversion application_remotingname: firefox 04:07:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:07:23 INFO - mozversion application_vendor: Mozilla 04:07:23 INFO - mozversion application_version: 50.0a1 04:07:23 INFO - mozversion platform_buildid: 20160627013018 04:07:23 INFO - mozversion platform_changeset: f35504e8fc9de135eb1a697828dcec202d082ffb 04:07:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:07:23 INFO - mozversion platform_version: 50.0a1 04:07:23 INFO - using testdate: 1467025643 04:07:23 INFO - actual date: 1467025643 04:07:23 INFO - starting webserver on 'localhost:49085' 04:07:23 INFO - SUITE-START | Running 2 tests 04:07:23 INFO - TEST-START | dromaeo_css 04:07:23 INFO - operating with platform_type : linux_ 04:07:23 INFO - Initialising browser for dromaeo_css test... 04:07:23 INFO - TEST-INFO | started process 14323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZEd1kR/profile http://localhost:49085/getInfo.html) 04:07:28 INFO - PROCESS | 14323 | __metrics Screen width/height:1600/1200 04:07:28 INFO - PROCESS | 14323 | colorDepth:24 04:07:28 INFO - PROCESS | 14323 | Browser inner width/height: 1024/697 04:07:28 INFO - PROCESS | 14323 | __metrics 04:07:28 ERROR - PROCESS | 14323 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 04:07:29 INFO - TEST-INFO | 14323: exit 0 04:07:29 INFO - Browser initialized. 04:07:29 INFO - Running cycle 1/1 for dromaeo_css test... 04:07:29 INFO - TEST-INFO | started process 14444 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZEd1kR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:07:41 INFO - PROCESS | 14444 | RSS: Main: 185499648 04:07:41 INFO - PROCESS | 14444 | 04:08:31 INFO - PROCESS | 14444 | 1467025711072 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:10:39 INFO - PROCESS | 14444 | Cycle 1(1): loaded http://localhost:49085/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49085/tests/dromaeo/cssquery-ext.html) 04:10:40 INFO - PROCESS | 14444 | RSS: Main: 188588032 04:10:40 INFO - PROCESS | 14444 | 04:13:42 INFO - PROCESS | 14444 | Cycle 1(1): loaded http://localhost:49085/tests/dromaeo/cssquery-ext.html (next: http://localhost:49085/tests/dromaeo/cssquery-jquery.html) 04:13:42 INFO - PROCESS | 14444 | RSS: Main: 187867136 04:13:42 INFO - PROCESS | 14444 | 04:16:44 INFO - PROCESS | 14444 | Cycle 1(1): loaded http://localhost:49085/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49085/tests/dromaeo/cssquery-mootools.html) 04:16:45 INFO - PROCESS | 14444 | RSS: Main: 189571072 04:16:45 INFO - PROCESS | 14444 | 04:19:46 INFO - PROCESS | 14444 | Cycle 1(1): loaded http://localhost:49085/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49085/tests/dromaeo/cssquery-prototype.html) 04:19:47 INFO - PROCESS | 14444 | RSS: Main: 186920960 04:19:47 INFO - PROCESS | 14444 | 04:22:50 INFO - PROCESS | 14444 | Cycle 1(1): loaded http://localhost:49085/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49085/tests/dromaeo/cssquery-yui.html) 04:22:50 INFO - PROCESS | 14444 | RSS: Main: 188641280 04:22:50 INFO - PROCESS | 14444 | 04:25:53 INFO - PROCESS | 14444 | Cycle 1(1): loaded http://localhost:49085/tests/dromaeo/cssquery-yui.html (next: http://localhost:49085/tests/dromaeo/cssquery-dojo.html) 04:25:53 INFO - PROCESS | 14444 | RSS: Main: 189820928 04:25:53 INFO - PROCESS | 14444 | 04:25:53 INFO - PROCESS | 14444 | __start_tp_report 04:25:53 INFO - PROCESS | 14444 | _x_x_mozilla_page_load 04:25:53 INFO - PROCESS | 14444 | _x_x_mozilla_page_load_details 04:25:53 INFO - PROCESS | 14444 | |i|pagename|runs| 04:25:53 INFO - PROCESS | 14444 | |0;dojo.html;3123.437781199383;3142.5757522734425;3151.322465669882;3164.193130751658;3183.952240716389;5518.613697041209;5523.917141242885;5540.778368865241;5544.445555444454;5567.638103523278;5458.5087342139195;5562.332520097594;5577.107662773957;5588.441155884409;5687.17535957287;5012.248162775594;5048.368953880765;5135.537801597856;5204.063268611649;5239.056969745444;23.125773024435365;4992.151334273182;5045.924311135336;5088.516590923857;5097.082525145473;4966;4999.32509111269;5003.524665156804;5017.096922553938;5026.698398096126;4946.925796113062;4976.377952755905;4996.150654388763;5015.122353588107;5050.974745126287;4896.314515967767;4933.062718083588;4944.258361245842;4965.528274813887;4971.925421118686;5468.7539060741965;5471.976621091692;5500.4224556421395;5508.03609368359;5593.049181639131;5775.913361299584;5858.091995740667;5878.647281163144;5895.734691938873;5910.261217347832;5957.285125784891;6038.667873266969;6039.214902062704;6054.212952316215;6054.757809687607;5579.804706835242;5582.553395728372;5582.7766889324375;5588.888222235573;5588.91616625751;5927.110933359944;6073.635581865014;6094.725737341831;6119.173911521888;6126.203593532812;5907.497862681635;5911.113333000085;5919.733611987471;5926.851828704317;5938.970305148533;5970.910436343458;5985.16207730918;5990.371011043778;6002.969985150046;6010.819675409744;5780.306363236438;5862.648241105462;5910.7931222407005;5959.463648271676;5972.581919265696;5740.569457290637;5867.559933005042;5887.2052272943465;5890.823275301748;5993.0710739835395;4475.977620111878;4493.056458143827;4527.977360113178;4536.070105628338;4557.225271703752;3919.470871432377;3944.6449819516383;3980.8407663693706;4011.8997025074023;4015.578364271768;5629.887402251932;5680;5681.886362272731;5684.9431505684415;5688.658680479101;5922.052471604523;5980.491658209014;5983.700814959235;5987.1318658794235;5988.9101663475085;5506.119020956708;5631.436856314336;5669;5693.202951586781;5697.515711164515;5114.5652619527755;5117.488251174927;5143.3570803649545;5146.794128234904;5176.896462070813;5903.0260007099205;6208.937910620926;6214.782482613177;6216.689165541705;6218.968905155445;5975.671338076448;6029.758809647565;6058.27300723916;6080.0575910733905;6084.665343406155;6173.135760993554;6207.883594728281;6242.313345531897;6246.718897649525;6254.906176407267;5752.482276595127;5871.7651293947765;5905.431137455221;5932.436418540232;5992.0712289595185;6021.096835474714;6024.789132380346;6039.577229594062;6063.302720187235;6091.086337049478;5854.970725146347;5862.208601838868;5916.023856063874;5919.6152250103605;5932.940670593412;5615.326160860723;5784.161296612052;5831.979403604268;5888.823335299948;5898.64608123514;5487.835364939058;5567.693776842312;5641.041023026178;5676.602637815478;5821.679807610622;5798.797042103675;5856.94143058564;5864.794732184353;5865.677387743715;5873.794417195378;5538.556915446674;5619.353774316006;5642.520385767091;5706.9714651426475;5717.942820571908 04:25:53 INFO - PROCESS | 14444 | |1;ext.html;577.3879687531218;617.5430181665567;622.3092367472105;625.6777759453879;639.3414782773743;41163.38254926175;42475.36286955694;42494.362584561255;45734;46341.30488042674;44248.33627495582;44658;44769.7761511192;44829.77585112078;44883.77558112213;8919.108089191077;8983.730488085368;9031.458112513237;9036.051214622468;9055.818883622323;8887.688930887389;8896.466212027266;8927;8993.505357205384;9036.819263614756;8979.865302020475;9003.819923601557;9062.139096785828;9078.774365460644;9083.591238394256;8974.28205743539;8982.146696063863;9022.278217742565;9057.728268151966;9066.77333066672;8912.777180570472;8983.775405614846;9030.142136497023;9032.50321232332;9066.501342426163;42292.57707422917;42349.153016939796;42434.151316973795;42540.57459425397;42557;3667.963320366789;3674.412094064937;3707.295613833363;3877.515310586177;3890.280298144852;31571.21071973196;32345.35309293801;32348.191295217573;32415.83792081048;32428.837855810805;4430.889227769299;4497.280435130396;4571.474280457756;4588.082383523309;4685.273782563708;322706;327062;327678;327927;327951.3602431996;33671.831640841636;34453.310933781184;34632.13419664478;35665;58009.709951450815;36094.458583121275;36121.638783612354;36213.27573448569;36241.63758362435;36263.27473450569;15421.84578154204;15658.217089145497;15714.764278535831;15740.527784166494;15750.976186547838;12974;13176.868231317756;13189.274589897648;13330;13414.932925335506;8241.011078670597;8305.086440491541;8359.247667709935;8419.621117049748;8447.66209351619;3246.4481038223557;3254.9837250813594;3273.672632736755;3285.2772390074147;3325.418051840918;998.8301988661945;1013.4729940430934;1019.3578045831078;1043.6921108273077;1118.0049755717419;31068.271647503996;32116.35767284641;32340.83829580837;32467.18832029171;32621.18447038843;1081.507913899174;1110.306058713304;1133.9149563782748;1157.7684463107412;1195.3425615911215;16484.752728709078;16895.746563801553;17157;17371.478855634352;17431.73852392215;539102;540397;542321;546117;555537;57677.134842977386;57797;57878;57887.42112578904;58063.709681452165;1276.5978716704208;1329.7473480038761;1352.7294541091821;1354.6681063139595;1355.1868878672717;30916.381672366875;31783.205419864687;31853.36293274168;32035;32580.51129233016;51040.74479627578;51370.22944655908;51676;51679.74160129175;51687.74156129346;456583;468869;470135;470554;472521;27885.721142789123;27971.86014069998;28342.43315133727;28374.716252837206;28443.146705598865;43090.56909430991;44063.77968110139;47561.04877902492;48564.75717621389;48623.5137648619;39738.801305993285;40822;41267.38098928458;41555.168896622505;41764.582354177284;36070.8196459016;36091.458628120075;36265.27469450649;36268.637313626525;36842.63157368392;40234.1953160941;40587.797061014506;40883.38674919938;40948.59051409567;41103.7944810286;34682;37128.25743485061;37474.250514989006;37615.6238437623;37720.62279377171;28283.303001819957;28853.85573072121;28879.711202888542;28905;28906.855465722536 04:25:53 INFO - PROCESS | 14444 | |2;jquery.html;390.28772490205364;395.7032225830627;397.3304981106833;401.5703197578591;412.3587820938441;18002.369917052907;19314.903425482888;19589.804101958976;19597.314094006713;19610.607787844234;18298.908505457486;19069.90465047676;19118.04409779509;19230.711539326887;19638.509037274038;5504.889902201953;5532.640378375393;5727.742251598688;5730.341010783751;5766.250387449647;5635.943640563603;5648.435156484339;5658.896515179542;5666.121751128581;5671.8014869479575;5441.809536666217;5607.327120745516;5636.126400407943;5641.68970706611;5644.096944488882;5618.522425593809;5634.690092044936;5654.660720356771;5654.717264136777;5668.121441176624;4915.803367865316;5061.620378471629;5088.592912566985;5097.158968770148;5100.336956195708;22395.21616743406;22494.10023599054;23102.19142330027;23213.76786232133;23396.64905026426;2497.4016629357225;2538.1750930947514;2542.186500319898;2871.454423659498;3126.718595326409;14132.22272774997;14629.487967921179;14759.18824464654;15217.467388641455;15356.308966096552;1912.4453908366556;1963.224526312113;1994.3618042226494;2045.3557129504159;2067.503799088208;52289;67161.66419167921;68886.31113688849;72837;74614;10227.488625568692;10594.629187978539;10686.465676716132;10738.194635402377;10987.175961802897;14751.63120921964;14952.327145278488;15010.924945375204;15031.173285469404;15079.472218472301;7982.361411087099;8044;8074.677012919535;8126.512409255463;8135.1051384347675;8046.517208967481;8051.2351326623875;8174.427790054639;8177.795555111051;8258.215469530385;6653.900191497131;6679.76620818269;6733.283012831696;6827;6835.58986460814;1935.816097470738;1946.6301402733436;1980.9702854457194;1981.0787983587702;2015.2644284835928;436.29320500788924;1007.8689770329956;1023.559869256227;1063.5107850388908;1065.4619417194422;11464.94267528657;12128.757424851454;12220.877791221974;12316.322602256783;12373.814392784116;456.1606643775469;460.43826531631356;480.57949294367427;490.7448126974025;493.45226798253907;5414.3232095988005;6530.085787989685;6670.366315200048;6682.565633233921;6731.798046058626;471158;472338;473105;479269;482549;73752.63123684455;92209;92653;93100.53449732708;95380.04619953712;454.7521600727611;462.58829641618985;463.8956234847132;464.0648495772636;472.84396149270657;10467.528961196613;10787.298825576312;11007.119430445706;11264.324140551593;11424.828627570427;37612.81193594124;40091;41929.580704192565;43152.56847431611;43239.56760432355;45349.773251133534;45581;58816;58954.70522647359;59652;8112.675492980215;10613.779415367331;12629.684257893627;12901.935490322488;13219.206847589176;14014.789778153132;14230.501932432315;14414.783778243125;14630.487932922297;14632;12408.317542534885;12423.503059877503;12450.875491245333;12557.623271301876;12759.61721148367;12195.817062743889;12546;12674.049446291749;12764.106512544033;12844.678883027998;12386.38976932993;12655.87344126547;12757.107002509736;12981.675458113623;13028.804567931678;12867.806982895452;12883.935580322039;12967.481300747864;13009.674758131123;13103.672408189872;12125.636230913087;12283.324417157142;12327.630171094881;12331.50673973031;12429.627111186679 04:25:53 INFO - PROCESS | 14444 | |3;mootools.html;1444.4366696988177;1484.9331780069895;1569.945051923183;1671.9498415047553;1714.1686282153162;7581.43139264556;8345.2072053155;8403.201695838901;8915.286777057836;8940.418872773273;8490.95754521228;8520.659173633063;8570.057293697704;8587.48475091495;8589.95705021474;2255.379770563092;2274.749777524471;2288.553732022256;2291.713535808024;2296.1045192374986;2253.549290141978;2258.4918393361527;2344.6131388320905;2345.1323010486144;2345.495718420539;2298.4598619324447;2315.606346921019;2325.6278995360744;2361.3034154924253;2370.146747171017;2223.5330580578097;2227.3652009177385;2235.1394713035515;2265.2411442166895;2273.761255068227;2275.7382900966436;2304.51605162916;2305.7463678995296;2314.6065168921323;2316.8262380321544;8959.462432254086;8979.19187273142;9020;9025.142611451902;9093.727188184364;5165.22521621756;5233.528982391603;5257.947420525784;5275.446078161776;5279.049771041211;3333.3833240850277;3386.8137252451106;3584.4085725855202;3588.372034893883;3593.82030898454;1083.0793825248477;1088.3306766338724;1096.3641088168922;1103.7461383881753;1107.6123356825128;12450.190737602117;12456.439460224221;12566.937165314206;12701.110922235355;12706.872931270662;4576.222042252825;4654.16225079489;4692.389989301437;4728.95271047292;4729.597984171315;10395.532201050972;10410.843837342445;10411.583536658449;10425.791484170426;10479.790404191874;5378.542823860016;5393.568514518829;5396.109641909041;5398.865028374244;5416.485433883775;4224.577542245812;4798.880027999328;4805;4958.380202474691;4981.601471882241;4017.598240175959;4027.7583344999393;4045.0696339842;4161.895952601149;4167.374893765959;1241.788895887683;1277.1315505456193;1284.8650891656428;1285.7299967007034;1291.4124073546702;911.1617312072909;920.8848893888264;950.064186776025;954.8138113067885;962.6582563189967;5684.033714268584;5695.316562012585;5814.883702325929;5906.173135760997;5936.940630593639;434.9956500434955;438.11938004610323;440.27354864473875;443.4146926057573;450.8129126412568;3825.84696612138;3827.1771569112775;3846.9615303846604;3877.96122038776;3891.922161556753;10833.079188269085;11149.498272577754;11169.94415027936;11248.606298779667;11281.774364512663;11004.614838480775;11334.319940803412;11376.431178441046;11395.715107122389;11408.600698975495;8218.794530136794;8248.257656810916;8382.371322150862;8401.03388110375;8408.831823363498;5622.5783066271015;5673.290838645169;5737.713114344349;5837.153612726046;5943.108533719977;10154.74613134648;10253.84619230727;10373.844392333971;10453.26827122094;10509.264351495627;10035.899641003496;10232.48837558134;10660.573577057141;10660.733481663021;10685.94657026741;7052.400545953651;7590.506617069873;7673.232676732282;7699.923000769921;7984.84030319402;8717.476951382938;8721.65113395457;8734.82530349402;8774.824503510023;8792.47245165292;7694.384449243935;7798.181190974866;7964.283214510722;8047.436679432383;8057.194280571896;7696.153423123564;7799.142094369501;7826.2173782621285;8010.559419231999;8065.758027259191;7023.22744498115;7053.153621565445;7109.182444019004;7145.82135446618;7157.892631610634;4996.450390457119;5124.436312005601;5127.256547800623;5170.819021334235;5200.063988482109;4920.040592084652;4923.507649235048;4965.503449655005;5001.224810154432;5013.598912086952 04:25:53 INFO - PROCESS | 14444 | |4;prototype.html;333.6863348452454;334.800793527851;336.07411581094084;339.38909962068277;341.4417427506028;5582.804601838937;5609;5610.719464026793;5645.15322701595;5659.801906933259;5611.607187496877;5617.4382561743805;5642.153676948449;5646.124850648146;5659.547236221103;4171.645410140134;4249.681273904454;4374.147041326943;4389.385486031958;4437.156940181355;4383.736975781463;4391.319345501436;4401.845935392262;4417.094495628388;4428.579284967939;4359.3896854440245;4407.250767369539;4411.955880441203;4415.763586195854;4442.51175856087;4338.284183109783;4359.280718681413;4369.934450983238;4381.78091095444;4384.232759267132;3804.714646401531;3832.616738326173;3833.7891415972113;3865.5747867734526;3875.476810630557;5424.528301886796;5457.154141108134;5519.558435325164;5546.944530554683;5551.250581171571;4853.757312134415;4986.950130498685;4990.975045124787;5002.124628190052;5035.169197082477;5833.941660583382;5864.824055278348;5892;5928.64428134309;5946.583739138262;4244.342126970325;4245.8513952011845;4261.296886013835;4263.701540892139;4273.337632666941;5893.675847828367;6079.240094988127;6095.817125486198;6112.63324200545;6117.204763380732;4340.240457919851;4352.891177720519;4360.9127817444105;4362.411074504965;4366.628836548865;4386.846460373871;4390.582894625006;4416.271315232951;4425;4440.955590444119;4895.7062576245535;4930.137225985438;4951.72765497901;4953.157963146274;4958.504149585013;5802.709864506758;5845.473907348274;5921.407859214044;5923.940760592339;5975.19334889793;1506.7091763256929;1512.691521833606;1552.7670849372685;1554.2772610736063;1560.968780624404;973.3235401396104;973.9805203896024;983.6508039645822;1028.876534815812;1040.8022475729588;5655.632383895034;5667.858303542362;5672.00739870521;5678.025382232454;5684.175794509855;5980.940190598125;6061.424164704346;6105.908411373833;6111.54163437744;6127.540434467343;5489;5702.173184888168;5807.622504537191;5812.738426770806;5820.3888591698105;3272.1001724525945;3283.1627934876933;3288.704016638514;3299.6040475143136;3321.5515905352468;6133.478654314434;6310.5267104967315;6383.872322553523;6408.61548307103;6432.774852880127;6294.874102518015;6306.747730090745;6313.968430157912;6321.1150438938585;6334.619922804646;6112.786052488231;6226.941419958618;6374.298827129012;6384.904226436607;6389.424951754364;6106.877862442638;6146;6153.569250152446;6194.845128871814;6205.5106774372925;6106.2902387331615;6138.662373569497;6140.754369825336;6173.6913154343;6213.782517611862;5986;6258.687065646791;6311.337309582428;6320.241571011508;6338.366163383625;4289.678274129516;4317.222899878052;4353.912921741484;4359.694821362475;4373.2128216921255;5790.420957904176;6179.536534760001;6197.318294987457;6198.597091189239;6211.844703882439;5943.692387674705;6008.8798224036145;6024.608400453956;6057.969710151421;6062.818115456544;5878.470937615635;5905.232319798399;5943.732532036155;5970.253718285215;6052.546059045501;5626.381098079126;5825.242718446575;5888.175655408332;5899.203607513103;5914.970425147847;6031.939680603138;6050.818475445743;6078.939210607838;6122.612181249227;6142.6314421134875;5639.407862174577;5841.9707901461925;5843.795467158629;5871.324797648325;5920.348761636131 04:25:53 INFO - PROCESS | 14444 | |5;yui.html;728.2899173306027;735.0407717928108;785.5208322923016;806.0926759309629;845.6532821543168;15319.770203446944;16318.91840540797;16380.180990950435;16434.7534786978;16446.342146314135;14823.407063717439;15028.323725432354;15038.548843534683;15094.698106037873;15127.168005759679;661.6856992928357;781.4646966827713;800.5396896784343;800.9907516529186;801.6472751989136;790.119017295714;793.0245797668871;796.8924195233657;797.4139007829269;799.0810567846964;843.3590471241839;844.3962566764762;845.1337379186352;845.3701992015957;845.530730444603;836.6946064686376;836.8493671139223;838.7316058861167;839.236294971579;840.0465471689615;615.9753609855601;616.7163104971719;619.5198720991223;620.0884699491739;620.4044117647064;14618.415263389452;14624.780628290584;14722.852771472255;14724.263786810616;14745.70508589833;14862.851371486364;14978.775318370233;15060.246987650684;15104.697906041927;15245.23773811305;12310.692232694255;12347.62957111288;12500.437480313316;12536.934360579362;12588.4335204916;3800.239952009609;3861.5366156061455;3971.3844354124867;3989.122393073519;4104.486939132608;72131;72310.63844680742;72668;72849.27150728478;73056.63471682607;10991.670249892515;11630.127740419333;11740.530378784924;11922.582709605122;12050.39748012596;19405.2237910482;19919.402417927486;20186.293479728138;21180.258690945742;21339.67990480113;8257;8670.479771213748;8699.695510657224;8822.823543529094;9173.44959302444;4862.82980095702;4874.902501949941;4875.585575226075;4891.364122664031;4984.37695288089;3532.152283452004;3623.1847834237087;3666.8816011116332;3696.963030369716;3699.130704284491;688.6453476459627;689.7034275261685;698.6087790837147;699.7655785311875;700.5901547594714;658.1082633032269;688.9655517224119;691.339770519153;728.1044315491974;746.9253074692488;9196.080391960884;9341.486218257925;9737.415755054719;10111.544980475895;10200.948995255125;627.8147946355836;656.3108735827362;725.8693435181718;735.2316828913798;761.7676608634309;4797.496262892416;4982.60139188864;4987.12725273083;5006.249062640561;5081.898362032813;106475;110319.44840275908;111773.44113279544;113931.43034284776;114076;62609;102392;103131.48434257781;104109;104862;88869.55565222133;89911.55044224738;90562;92263.53868230616;92367.53816230876;9582.760430989281;9596.704444900128;9604.423734575948;9628;9630.422174669542;52870;52905;53901;54080;56082.71958640181;73684.63157684177;78677.60661196658;80187.59906200432;80995;81887;11948.223365481215;11982.58060967862;12181.939090304491;12195.817062743889;12407.627771166879;12786.488540458278;12900.225986440844;13264.53574124901;13413.329333533089;13590.796138058135;11931.224470409396;12068.275903445821;12167.81748273759;12232.938835305766;12458.626241212778;11680.415979200836;11884.168108232341;12021.639350819489;12189;12632.873671263169;11303.886961130283;11708.414579271173;12124.393780311126;12247;12471.189372690746;10437.634682786065;10645.254832161674;10709.410982396043;10874.347539147677;11018;9670;10295.17638588896;10431.217658675478;10579.682609521727;10605.787884242427 04:25:53 INFO - PROCESS | 14444 | __end_tp_report 04:25:53 INFO - PROCESS | 14444 | __start_cc_report 04:25:53 INFO - PROCESS | 14444 | _x_x_mozilla_cycle_collect,361 04:25:53 INFO - PROCESS | 14444 | __end_cc_report 04:25:53 INFO - PROCESS | 14444 | __startTimestamp1467026753472__endTimestamp 04:25:53 INFO - PROCESS | 14444 | 04:25:53 INFO - PROCESS | 14444 | ------- Summary: start ------- 04:25:53 INFO - PROCESS | 14444 | Number of tests: 6 04:25:53 INFO - PROCESS | 14444 | 04:25:53 INFO - PROCESS | 14444 | [#0] dojo.html Cycles:165 Average:5492.18 Median:5697.52 stddev:780.74 (13.7%) stddev-sans-first:760.70 04:25:53 INFO - PROCESS | 14444 | Values: 3123.4 3142.6 3151.3 3164.2 3184.0 5518.6 5523.9 5540.8 5544.4 5567.6 5458.5 5562.3 5577.1 5588.4 5687.2 5012.2 5048.4 5135.5 5204.1 5239.1 23.1 4992.2 5045.9 5088.5 5097.1 4966.0 4999.3 5003.5 5017.1 5026.7 4946.9 4976.4 4996.2 5015.1 5051.0 4896.3 4933.1 4944.3 4965.5 4971.9 5468.8 5472.0 5500.4 5508.0 5593.0 5775.9 5858.1 5878.6 5895.7 5910.3 5957.3 6038.7 6039.2 6054.2 6054.8 5579.8 5582.6 5582.8 5588.9 5588.9 5927.1 6073.6 6094.7 6119.2 6126.2 5907.5 5911.1 5919.7 5926.9 5939.0 5970.9 5985.2 5990.4 6003.0 6010.8 5780.3 5862.6 5910.8 5959.5 5972.6 5740.6 5867.6 5887.2 5890.8 5993.1 4476.0 4493.1 4528.0 4536.1 4557.2 3919.5 3944.6 3980.8 4011.9 4015.6 5629.9 5680.0 5681.9 5684.9 5688.7 5922.1 5980.5 5983.7 5987.1 5988.9 5506.1 5631.4 5669.0 5693.2 5697.5 5114.6 5117.5 5143.4 5146.8 5176.9 5903.0 6208.9 6214.8 6216.7 6219.0 5975.7 6029.8 6058.3 6080.1 6084.7 6173.1 6207.9 6242.3 6246.7 6254.9 5752.5 5871.8 5905.4 5932.4 5992.1 6021.1 6024.8 6039.6 6063.3 6091.1 5855.0 5862.2 5916.0 5919.6 5932.9 5615.3 5784.2 5832.0 5888.8 5898.6 5487.8 5567.7 5641.0 5676.6 5821.7 5798.8 5856.9 5864.8 5865.7 5873.8 5538.6 5619.4 5642.5 5707.0 5717.9 04:25:53 INFO - PROCESS | 14444 | 04:25:53 INFO - PROCESS | 14444 | [#1] ext.html Cycles:180 Average:59006.96 Median:40704.90 stddev:121176.26 (297.7%) stddev-sans-first:121436.78 04:25:53 INFO - PROCESS | 14444 | Values: 577.4 617.5 622.3 625.7 639.3 41163.4 42475.4 42494.4 45734.0 46341.3 44248.3 44658.0 44769.8 44829.8 44883.8 8919.1 8983.7 9031.5 9036.1 9055.8 8887.7 8896.5 8927.0 8993.5 9036.8 8979.9 9003.8 9062.1 9078.8 9083.6 8974.3 8982.1 9022.3 9057.7 9066.8 8912.8 8983.8 9030.1 9032.5 9066.5 42292.6 42349.2 42434.2 42540.6 42557.0 3668.0 3674.4 3707.3 3877.5 3890.3 31571.2 32345.4 32348.2 32415.8 32428.8 4430.9 4497.3 4571.5 4588.1 4685.3 322706.0 327062.0 327678.0 327927.0 327951.4 33671.8 34453.3 34632.1 35665.0 58009.7 36094.5 36121.6 36213.3 36241.6 36263.3 15421.8 15658.2 15714.8 15740.5 15751.0 12974.0 13176.9 13189.3 13330.0 13414.9 8241.0 8305.1 8359.2 8419.6 8447.7 3246.4 3255.0 3273.7 3285.3 3325.4 998.8 1013.5 1019.4 1043.7 1118.0 31068.3 32116.4 32340.8 32467.2 32621.2 1081.5 1110.3 1133.9 1157.8 1195.3 16484.8 16895.7 17157.0 17371.5 17431.7 539102.0 540397.0 542321.0 546117.0 555537.0 57677.1 57797.0 57878.0 57887.4 58063.7 1276.6 1329.7 1352.7 1354.7 1355.2 30916.4 31783.2 31853.4 32035.0 32580.5 51040.7 51370.2 51676.0 51679.7 51687.7 456583.0 468869.0 470135.0 470554.0 472521.0 27885.7 27971.9 28342.4 28374.7 28443.1 43090.6 44063.8 47561.0 48564.8 48623.5 39738.8 40822.0 41267.4 41555.2 41764.6 36070.8 36091.5 36265.3 36268.6 36842.6 40234.2 40587.8 40883.4 40948.6 41103.8 34682.0 37128.3 37474.3 37615.6 37720.6 28283.3 28853.9 28879.7 28905.0 28906.9 04:25:53 INFO - PROCESS | 14444 | 04:25:53 INFO - PROCESS | 14444 | [#2] jquery.html Cycles:180 Average:27967.10 Median:2706.82 stddev:78214.77 (2889.5%) stddev-sans-first:78406.77 04:25:53 INFO - PROCESS | 14444 | Values: 390.3 395.7 397.3 401.6 412.4 18002.4 19314.9 19589.8 19597.3 19610.6 18298.9 19069.9 19118.0 19230.7 19638.5 5504.9 5532.6 5727.7 5730.3 5766.3 5635.9 5648.4 5658.9 5666.1 5671.8 5441.8 5607.3 5636.1 5641.7 5644.1 5618.5 5634.7 5654.7 5654.7 5668.1 4915.8 5061.6 5088.6 5097.2 5100.3 22395.2 22494.1 23102.2 23213.8 23396.6 2497.4 2538.2 2542.2 2871.5 3126.7 14132.2 14629.5 14759.2 15217.5 15356.3 1912.4 1963.2 1994.4 2045.4 2067.5 52289.0 67161.7 68886.3 72837.0 74614.0 10227.5 10594.6 10686.5 10738.2 10987.2 14751.6 14952.3 15010.9 15031.2 15079.5 7982.4 8044.0 8074.7 8126.5 8135.1 8046.5 8051.2 8174.4 8177.8 8258.2 6653.9 6679.8 6733.3 6827.0 6835.6 1935.8 1946.6 1981.0 1981.1 2015.3 436.3 1007.9 1023.6 1063.5 1065.5 11464.9 12128.8 12220.9 12316.3 12373.8 456.2 460.4 480.6 490.7 493.5 5414.3 6530.1 6670.4 6682.6 6731.8 471158.0 472338.0 473105.0 479269.0 482549.0 73752.6 92209.0 92653.0 93100.5 95380.0 454.8 462.6 463.9 464.1 472.8 10467.5 10787.3 11007.1 11264.3 11424.8 37612.8 40091.0 41929.6 43152.6 43239.6 45349.8 45581.0 58816.0 58954.7 59652.0 8112.7 10613.8 12629.7 12901.9 13219.2 14014.8 14230.5 14414.8 14630.5 14632.0 12408.3 12423.5 12450.9 12557.6 12759.6 12195.8 12546.0 12674.0 12764.1 12844.7 12386.4 12655.9 12757.1 12981.7 13028.8 12867.8 12883.9 12967.5 13009.7 13103.7 12125.6 12283.3 12327.6 12331.5 12429.6 04:25:53 INFO - PROCESS | 14444 | 04:25:53 INFO - PROCESS | 14444 | [#3] mootools.html Cycles:180 Average:5827.42 Median:2513.52 stddev:3396.53 (135.1%) stddev-sans-first:3390.09 04:25:53 INFO - PROCESS | 14444 | Values: 1444.4 1484.9 1569.9 1671.9 1714.2 7581.4 8345.2 8403.2 8915.3 8940.4 8491.0 8520.7 8570.1 8587.5 8590.0 2255.4 2274.7 2288.6 2291.7 2296.1 2253.5 2258.5 2344.6 2345.1 2345.5 2298.5 2315.6 2325.6 2361.3 2370.1 2223.5 2227.4 2235.1 2265.2 2273.8 2275.7 2304.5 2305.7 2314.6 2316.8 8959.5 8979.2 9020.0 9025.1 9093.7 5165.2 5233.5 5257.9 5275.4 5279.0 3333.4 3386.8 3584.4 3588.4 3593.8 1083.1 1088.3 1096.4 1103.7 1107.6 12450.2 12456.4 12566.9 12701.1 12706.9 4576.2 4654.2 4692.4 4729.0 4729.6 10395.5 10410.8 10411.6 10425.8 10479.8 5378.5 5393.6 5396.1 5398.9 5416.5 4224.6 4798.9 4805.0 4958.4 4981.6 4017.6 4027.8 4045.1 4161.9 4167.4 1241.8 1277.1 1284.9 1285.7 1291.4 911.2 920.9 950.1 954.8 962.7 5684.0 5695.3 5814.9 5906.2 5936.9 435.0 438.1 440.3 443.4 450.8 3825.8 3827.2 3847.0 3878.0 3891.9 10833.1 11149.5 11169.9 11248.6 11281.8 11004.6 11334.3 11376.4 11395.7 11408.6 8218.8 8248.3 8382.4 8401.0 8408.8 5622.6 5673.3 5737.7 5837.2 5943.1 10154.7 10253.8 10373.8 10453.3 10509.3 10035.9 10232.5 10660.6 10660.7 10685.9 7052.4 7590.5 7673.2 7699.9 7984.8 8717.5 8721.7 8734.8 8774.8 8792.5 7694.4 7798.2 7964.3 8047.4 8057.2 7696.2 7799.1 7826.2 8010.6 8065.8 7023.2 7053.2 7109.2 7145.8 7157.9 4996.5 5124.4 5127.3 5170.8 5200.1 4920.0 4923.5 4965.5 5001.2 5013.6 04:25:53 INFO - PROCESS | 14444 | 04:25:53 INFO - PROCESS | 14444 | [#4] prototype.html Cycles:180 Average:5005.50 Median:5663.83 stddev:1480.80 (26.1%) stddev-sans-first:1442.84 04:25:53 INFO - PROCESS | 14444 | Values: 333.7 334.8 336.1 339.4 341.4 5582.8 5609.0 5610.7 5645.2 5659.8 5611.6 5617.4 5642.2 5646.1 5659.5 4171.6 4249.7 4374.1 4389.4 4437.2 4383.7 4391.3 4401.8 4417.1 4428.6 4359.4 4407.3 4412.0 4415.8 4442.5 4338.3 4359.3 4369.9 4381.8 4384.2 3804.7 3832.6 3833.8 3865.6 3875.5 5424.5 5457.2 5519.6 5546.9 5551.3 4853.8 4987.0 4991.0 5002.1 5035.2 5833.9 5864.8 5892.0 5928.6 5946.6 4244.3 4245.9 4261.3 4263.7 4273.3 5893.7 6079.2 6095.8 6112.6 6117.2 4340.2 4352.9 4360.9 4362.4 4366.6 4386.8 4390.6 4416.3 4425.0 4441.0 4895.7 4930.1 4951.7 4953.2 4958.5 5802.7 5845.5 5921.4 5923.9 5975.2 1506.7 1512.7 1552.8 1554.3 1561.0 973.3 974.0 983.7 1028.9 1040.8 5655.6 5667.9 5672.0 5678.0 5684.2 5980.9 6061.4 6105.9 6111.5 6127.5 5489.0 5702.2 5807.6 5812.7 5820.4 3272.1 3283.2 3288.7 3299.6 3321.6 6133.5 6310.5 6383.9 6408.6 6432.8 6294.9 6306.7 6314.0 6321.1 6334.6 6112.8 6226.9 6374.3 6384.9 6389.4 6106.9 6146.0 6153.6 6194.8 6205.5 6106.3 6138.7 6140.8 6173.7 6213.8 5986.0 6258.7 6311.3 6320.2 6338.4 4289.7 4317.2 4353.9 4359.7 4373.2 5790.4 6179.5 6197.3 6198.6 6211.8 5943.7 6008.9 6024.6 6058.0 6062.8 5878.5 5905.2 5943.7 5970.3 6052.5 5626.4 5825.2 5888.2 5899.2 5915.0 6031.9 6050.8 6078.9 6122.6 6142.6 5639.4 5842.0 5843.8 5871.3 5920.3 04:25:53 INFO - PROCESS | 14444 | 04:25:53 INFO - PROCESS | 14444 | [#5] yui.html Cycles:180 Average:20653.45 Median:4830.16 stddev:29933.16 (619.7%) stddev-sans-first:29979.74 04:25:53 INFO - PROCESS | 14444 | Values: 728.3 735.0 785.5 806.1 845.7 15319.8 16318.9 16380.2 16434.8 16446.3 14823.4 15028.3 15038.5 15094.7 15127.2 661.7 781.5 800.5 801.0 801.6 790.1 793.0 796.9 797.4 799.1 843.4 844.4 845.1 845.4 845.5 836.7 836.8 838.7 839.2 840.0 616.0 616.7 619.5 620.1 620.4 14618.4 14624.8 14722.9 14724.3 14745.7 14862.9 14978.8 15060.2 15104.7 15245.2 12310.7 12347.6 12500.4 12536.9 12588.4 3800.2 3861.5 3971.4 3989.1 4104.5 72131.0 72310.6 72668.0 72849.3 73056.6 10991.7 11630.1 11740.5 11922.6 12050.4 19405.2 19919.4 20186.3 21180.3 21339.7 8257.0 8670.5 8699.7 8822.8 9173.4 4862.8 4874.9 4875.6 4891.4 4984.4 3532.2 3623.2 3666.9 3697.0 3699.1 688.6 689.7 698.6 699.8 700.6 658.1 689.0 691.3 728.1 746.9 9196.1 9341.5 9737.4 10111.5 10200.9 627.8 656.3 725.9 735.2 761.8 4797.5 4982.6 4987.1 5006.2 5081.9 106475.0 110319.4 111773.4 113931.4 114076.0 62609.0 102392.0 103131.5 104109.0 104862.0 88869.6 89911.6 90562.0 92263.5 92367.5 9582.8 9596.7 9604.4 9628.0 9630.4 52870.0 52905.0 53901.0 54080.0 56082.7 73684.6 78677.6 80187.6 80995.0 81887.0 11948.2 11982.6 12181.9 12195.8 12407.6 12786.5 12900.2 13264.5 13413.3 13590.8 11931.2 12068.3 12167.8 12232.9 12458.6 11680.4 11884.2 12021.6 12189.0 12632.9 11303.9 11708.4 12124.4 12247.0 12471.2 10437.6 10645.3 10709.4 10874.3 11018.0 9670.0 10295.2 10431.2 10579.7 10605.8 04:25:53 INFO - PROCESS | 14444 | -------- Summary: end -------- 04:25:53 INFO - PROCESS | 14444 | 04:25:54 INFO - TEST-INFO | 14444: exit 0 04:25:54 INFO - TEST-OK | dromaeo_css | took 1110845ms 04:25:54 INFO - TEST-START | kraken 04:25:54 INFO - operating with platform_type : linux_ 04:25:54 INFO - Initialising browser for kraken test... 04:25:54 INFO - TEST-INFO | started process 14679 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCNnfS6/profile http://localhost:49085/getInfo.html) 04:25:58 INFO - PROCESS | 14679 | __metrics Screen width/height:1600/1200 04:25:58 INFO - PROCESS | 14679 | colorDepth:24 04:25:58 INFO - PROCESS | 14679 | Browser inner width/height: 1024/697 04:25:58 INFO - PROCESS | 14679 | __metrics 04:25:59 ERROR - PROCESS | 14679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 04:26:00 INFO - TEST-INFO | 14679: exit 0 04:26:00 INFO - Browser initialized. 04:26:00 INFO - Running cycle 1/1 for kraken test... 04:26:00 INFO - TEST-INFO | started process 14800 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCNnfS6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:12 INFO - PROCESS | 14800 | RSS: Main: 185593856 04:26:12 INFO - PROCESS | 14800 | 04:26:14 INFO - PROCESS | 14800 | Cycle 1(1): loaded http://localhost:49085/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49085/tests/kraken/driver.html?testName=audio-beat-detection) 04:26:15 INFO - PROCESS | 14800 | RSS: Main: 190844928 04:26:15 INFO - PROCESS | 14800 | 04:26:18 INFO - PROCESS | 14800 | Cycle 1(1): loaded http://localhost:49085/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49085/tests/kraken/driver.html?testName=audio-dft) 04:26:19 INFO - PROCESS | 14800 | RSS: Main: 190423040 04:26:19 INFO - PROCESS | 14800 | 04:26:21 INFO - PROCESS | 14800 | Cycle 1(1): loaded http://localhost:49085/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49085/tests/kraken/driver.html?testName=audio-fft) 04:26:22 INFO - PROCESS | 14800 | RSS: Main: 185098240 04:26:22 INFO - PROCESS | 14800 | 04:26:24 INFO - PROCESS | 14800 | Cycle 1(1): loaded http://localhost:49085/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49085/tests/kraken/driver.html?testName=audio-oscillator) 04:26:25 INFO - PROCESS | 14800 | RSS: Main: 185966592 04:26:25 INFO - PROCESS | 14800 | 04:26:27 INFO - PROCESS | 14800 | Cycle 1(1): loaded http://localhost:49085/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49085/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:26:28 INFO - PROCESS | 14800 | RSS: Main: 186634240 04:26:28 INFO - PROCESS | 14800 | 04:26:31 INFO - PROCESS | 14800 | Cycle 1(1): loaded http://localhost:49085/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49085/tests/kraken/driver.html?testName=imaging-darkroom) 04:26:31 INFO - PROCESS | 14800 | RSS: Main: 186724352 04:26:31 INFO - PROCESS | 14800 | 04:26:35 INFO - PROCESS | 14800 | Cycle 1(1): loaded http://localhost:49085/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49085/tests/kraken/driver.html?testName=imaging-desaturate) 04:26:35 INFO - PROCESS | 14800 | RSS: Main: 186793984 04:26:35 INFO - PROCESS | 14800 | 04:26:38 INFO - PROCESS | 14800 | Cycle 1(1): loaded http://localhost:49085/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49085/tests/kraken/driver.html?testName=json-parse-financial) 04:26:39 INFO - PROCESS | 14800 | RSS: Main: 186605568 04:26:39 INFO - PROCESS | 14800 | 04:26:41 INFO - PROCESS | 14800 | Cycle 1(1): loaded http://localhost:49085/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49085/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:26:41 INFO - PROCESS | 14800 | RSS: Main: 186753024 04:26:41 INFO - PROCESS | 14800 | 04:26:43 INFO - PROCESS | 14800 | Cycle 1(1): loaded http://localhost:49085/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49085/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:26:44 INFO - PROCESS | 14800 | RSS: Main: 186966016 04:26:44 INFO - PROCESS | 14800 | 04:26:46 INFO - PROCESS | 14800 | Cycle 1(1): loaded http://localhost:49085/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49085/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:26:46 INFO - PROCESS | 14800 | RSS: Main: 187092992 04:26:46 INFO - PROCESS | 14800 | 04:26:49 INFO - PROCESS | 14800 | Cycle 1(1): loaded http://localhost:49085/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49085/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:26:50 INFO - PROCESS | 14800 | RSS: Main: 187228160 04:26:50 INFO - PROCESS | 14800 | 04:26:52 INFO - PROCESS | 14800 | Cycle 1(1): loaded http://localhost:49085/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49085/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:26:53 INFO - PROCESS | 14800 | RSS: Main: 186994688 04:26:53 INFO - PROCESS | 14800 | 04:26:55 INFO - PROCESS | 14800 | Cycle 1(1): loaded http://localhost:49085/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49085/tests/kraken/driver.html?testName=ai-astar) 04:26:55 INFO - PROCESS | 14800 | RSS: Main: 187842560 04:26:55 INFO - PROCESS | 14800 | 04:26:55 INFO - PROCESS | 14800 | __start_tp_report 04:26:55 INFO - PROCESS | 14800 | _x_x_mozilla_page_load 04:26:55 INFO - PROCESS | 14800 | _x_x_mozilla_page_load_details 04:26:55 INFO - PROCESS | 14800 | |i|pagename|runs| 04:26:55 INFO - PROCESS | 14800 | |0;ai-astar;101;111;105;109;110;110;112;111;112;111 04:26:55 INFO - PROCESS | 14800 | |1;audio-beat-detection;155;127;157;189;130;154;158;133;189;127 04:26:55 INFO - PROCESS | 14800 | |2;audio-dft;165;164;163;163;166;174;163;162;162;164 04:26:55 INFO - PROCESS | 14800 | |3;audio-fft;74;75;76;162;75;75;77;75;155;76 04:26:55 INFO - PROCESS | 14800 | |4;audio-oscillator;86;86;159;85;87;85;149;85;85;139 04:26:55 INFO - PROCESS | 14800 | |5;imaging-gaussian-blur;118;117;117;120;117;119;117;119;117;122 04:26:55 INFO - PROCESS | 14800 | |6;imaging-darkroom;148;147;148;148;148;147;149;147;147;146 04:26:55 INFO - PROCESS | 14800 | |7;imaging-desaturate;97;96;97;94;95;96;96;96;95;95 04:26:55 INFO - PROCESS | 14800 | |8;json-parse-financial;61;57;59;57;58;57;62;58;56;57 04:26:55 INFO - PROCESS | 14800 | |9;json-stringify-tinderbox;64;60;60;62;66;61;62;60;67;61 04:26:55 INFO - PROCESS | 14800 | |10;stanford-crypto-aes;86;79;79;79;81;80;81;81;135;80 04:26:55 INFO - PROCESS | 14800 | |11;stanford-crypto-ccm;141;126;128;121;127;122;123;124;127;123 04:26:55 INFO - PROCESS | 14800 | |12;stanford-crypto-pbkdf2;163;162;163;163;161;161;166;162;162;162 04:26:55 INFO - PROCESS | 14800 | |13;stanford-crypto-sha256-iterative;63;62;67;63;62;62;61;63;63;64 04:26:55 INFO - PROCESS | 14800 | __end_tp_report 04:26:55 INFO - PROCESS | 14800 | __start_cc_report 04:26:55 INFO - PROCESS | 14800 | _x_x_mozilla_cycle_collect,912 04:26:55 INFO - PROCESS | 14800 | __end_cc_report 04:26:55 INFO - PROCESS | 14800 | __startTimestamp1467026815419__endTimestamp 04:26:55 INFO - PROCESS | 14800 | 04:26:55 INFO - PROCESS | 14800 | ------- Summary: start ------- 04:26:55 INFO - PROCESS | 14800 | Number of tests: 14 04:26:55 INFO - PROCESS | 14800 | 04:26:55 INFO - PROCESS | 14800 | [#0] ai-astar Cycles:10 Average:109.20 Median:111.00 stddev:3.52 (3.2%) stddev-sans-first:2.15 04:26:55 INFO - PROCESS | 14800 | Values: 101.0 111.0 105.0 109.0 110.0 110.0 112.0 111.0 112.0 111.0 04:26:55 INFO - PROCESS | 14800 | 04:26:55 INFO - PROCESS | 14800 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:156.00 stddev:23.35 (15.0%) stddev-sans-first:24.74 04:26:55 INFO - PROCESS | 14800 | Values: 155.0 127.0 157.0 189.0 130.0 154.0 158.0 133.0 189.0 127.0 04:26:55 INFO - PROCESS | 14800 | 04:26:55 INFO - PROCESS | 14800 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:3.53 (2.2%) stddev-sans-first:3.75 04:26:55 INFO - PROCESS | 14800 | Values: 165.0 164.0 163.0 163.0 166.0 174.0 163.0 162.0 162.0 164.0 04:26:55 INFO - PROCESS | 14800 | 04:26:55 INFO - PROCESS | 14800 | [#3] audio-fft Cycles:10 Average:92.00 Median:75.00 stddev:35.10 (46.8%) stddev-sans-first:36.62 04:26:55 INFO - PROCESS | 14800 | Values: 74.0 75.0 76.0 162.0 75.0 75.0 77.0 75.0 155.0 76.0 04:26:55 INFO - PROCESS | 14800 | 04:26:55 INFO - PROCESS | 14800 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:85.00 stddev:31.01 (36.5%) stddev-sans-first:32.15 04:26:55 INFO - PROCESS | 14800 | Values: 86.0 86.0 159.0 85.0 87.0 85.0 149.0 85.0 85.0 139.0 04:26:55 INFO - PROCESS | 14800 | 04:26:55 INFO - PROCESS | 14800 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.50 stddev:1.70 (1.4%) stddev-sans-first:1.80 04:26:55 INFO - PROCESS | 14800 | Values: 118.0 117.0 117.0 120.0 117.0 119.0 117.0 119.0 117.0 122.0 04:26:55 INFO - PROCESS | 14800 | 04:26:55 INFO - PROCESS | 14800 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 04:26:55 INFO - PROCESS | 14800 | Values: 148.0 147.0 148.0 148.0 148.0 147.0 149.0 147.0 147.0 146.0 04:26:55 INFO - PROCESS | 14800 | 04:26:55 INFO - PROCESS | 14800 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.95 (1.0%) stddev-sans-first:0.88 04:26:55 INFO - PROCESS | 14800 | Values: 97.0 96.0 97.0 94.0 95.0 96.0 96.0 96.0 95.0 95.0 04:26:55 INFO - PROCESS | 14800 | 04:26:55 INFO - PROCESS | 14800 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:1.93 (3.3%) stddev-sans-first:1.76 04:26:55 INFO - PROCESS | 14800 | Values: 61.0 57.0 59.0 57.0 58.0 57.0 62.0 58.0 56.0 57.0 04:26:55 INFO - PROCESS | 14800 | 04:26:55 INFO - PROCESS | 14800 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:2.54 (4.1%) stddev-sans-first:2.62 04:26:55 INFO - PROCESS | 14800 | Values: 64.0 60.0 60.0 62.0 66.0 61.0 62.0 60.0 67.0 61.0 04:26:55 INFO - PROCESS | 14800 | 04:26:55 INFO - PROCESS | 14800 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:80.50 stddev:17.30 (21.5%) stddev-sans-first:18.35 04:26:55 INFO - PROCESS | 14800 | Values: 86.0 79.0 79.0 79.0 81.0 80.0 81.0 81.0 135.0 80.0 04:26:55 INFO - PROCESS | 14800 | 04:26:55 INFO - PROCESS | 14800 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:126.50 stddev:5.71 (4.5%) stddev-sans-first:2.51 04:26:55 INFO - PROCESS | 14800 | Values: 141.0 126.0 128.0 121.0 127.0 122.0 123.0 124.0 127.0 123.0 04:26:55 INFO - PROCESS | 14800 | 04:26:55 INFO - PROCESS | 14800 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:162.50 stddev:1.43 (0.9%) stddev-sans-first:1.51 04:26:55 INFO - PROCESS | 14800 | Values: 163.0 162.0 163.0 163.0 161.0 161.0 166.0 162.0 162.0 162.0 04:26:55 INFO - PROCESS | 14800 | 04:26:55 INFO - PROCESS | 14800 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.63 (2.6%) stddev-sans-first:1.73 04:26:55 INFO - PROCESS | 14800 | Values: 63.0 62.0 67.0 63.0 62.0 62.0 61.0 63.0 63.0 64.0 04:26:55 INFO - PROCESS | 14800 | -------- Summary: end -------- 04:26:55 INFO - PROCESS | 14800 | 04:26:56 INFO - TEST-INFO | 14800: exit 0 04:26:56 INFO - TEST-OK | kraken | took 62181ms 04:26:56 INFO - SUITE-END | took 1173s 04:26:56 INFO - Completed test suite (00:19:33) 04:26:56 INFO - javascript benchmark 04:26:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7202.166893007018, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3123.437781199383, 3142.5757522734425, 3151.322465669882, 3164.193130751658, 3183.952240716389, 5518.613697041209, 5523.917141242885, 5540.778368865241, 5544.445555444454, 5567.638103523278, 5458.5087342139195, 5562.332520097594, 5577.107662773957, 5588.441155884409, 5687.17535957287, 5012.248162775594, 5048.368953880765, 5135.537801597856, 5204.063268611649, 5239.056969745444, 23.125773024435365, 4992.151334273182, 5045.924311135336, 5088.516590923857, 5097.082525145473, 4966.0, 4999.32509111269, 5003.524665156804, 5017.096922553938, 5026.698398096126, 4946.925796113062, 4976.377952755905, 4996.150654388763, 5015.122353588107, 5050.974745126287, 4896.314515967767, 4933.062718083588, 4944.258361245842, 4965.528274813887, 4971.925421118686, 5468.7539060741965, 5471.976621091692, 5500.4224556421395, 5508.03609368359, 5593.049181639131, 5775.913361299584, 5858.091995740667, 5878.647281163144, 5895.734691938873, 5910.261217347832, 5957.285125784891, 6038.667873266969, 6039.214902062704, 6054.212952316215, 6054.757809687607, 5579.804706835242, 5582.553395728372, 5582.7766889324375, 5588.888222235573, 5588.91616625751, 5927.110933359944, 6073.635581865014, 6094.725737341831, 6119.173911521888, 6126.203593532812, 5907.497862681635, 5911.113333000085, 5919.733611987471, 5926.851828704317, 5938.970305148533, 5970.910436343458, 5985.16207730918, 5990.371011043778, 6002.969985150046, 6010.819675409744, 5780.306363236438, 5862.648241105462, 5910.7931222407005, 5959.463648271676, 5972.581919265696, 5740.569457290637, 5867.559933005042, 5887.2052272943465, 5890.823275301748, 5993.0710739835395, 4475.977620111878, 4493.056458143827, 4527.977360113178, 4536.070105628338, 4557.225271703752, 3919.470871432377, 3944.6449819516383, 3980.8407663693706, 4011.8997025074023, 4015.578364271768, 5629.887402251932, 5680.0, 5681.886362272731, 5684.9431505684415, 5688.658680479101, 5922.052471604523, 5980.491658209014, 5983.700814959235, 5987.1318658794235, 5988.9101663475085, 5506.119020956708, 5631.436856314336, 5669.0, 5693.202951586781, 5697.515711164515, 5114.5652619527755, 5117.488251174927, 5143.3570803649545, 5146.794128234904, 5176.896462070813, 5903.0260007099205, 6208.937910620926, 6214.782482613177, 6216.689165541705, 6218.968905155445, 5975.671338076448, 6029.758809647565, 6058.27300723916, 6080.0575910733905, 6084.665343406155, 6173.135760993554, 6207.883594728281, 6242.313345531897, 6246.718897649525, 6254.906176407267, 5752.482276595127, 5871.7651293947765, 5905.431137455221, 5932.436418540232, 5992.0712289595185, 6021.096835474714, 6024.789132380346, 6039.577229594062, 6063.302720187235, 6091.086337049478, 5854.970725146347, 5862.208601838868, 5916.023856063874, 5919.6152250103605, 5932.940670593412, 5615.326160860723, 5784.161296612052, 5831.979403604268, 5888.823335299948, 5898.64608123514, 5487.835364939058, 5567.693776842312, 5641.041023026178, 5676.602637815478, 5821.679807610622, 5798.797042103675, 5856.94143058564, 5864.794732184353, 5865.677387743715, 5873.794417195378, 5538.556915446674, 5619.353774316006, 5642.520385767091, 5706.9714651426475, 5717.942820571908], "value": 5439.738784097202, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.3879687531218, 617.5430181665567, 622.3092367472105, 625.6777759453879, 639.3414782773743, 41163.38254926175, 42475.36286955694, 42494.362584561255, 45734.0, 46341.30488042674, 44248.33627495582, 44658.0, 44769.7761511192, 44829.77585112078, 44883.77558112213, 8919.108089191077, 8983.730488085368, 9031.458112513237, 9036.051214622468, 9055.818883622323, 8887.688930887389, 8896.466212027266, 8927.0, 8993.505357205384, 9036.819263614756, 8979.865302020475, 9003.819923601557, 9062.139096785828, 9078.774365460644, 9083.591238394256, 8974.28205743539, 8982.146696063863, 9022.278217742565, 9057.728268151966, 9066.77333066672, 8912.777180570472, 8983.775405614846, 9030.142136497023, 9032.50321232332, 9066.501342426163, 42292.57707422917, 42349.153016939796, 42434.151316973795, 42540.57459425397, 42557.0, 3667.963320366789, 3674.412094064937, 3707.295613833363, 3877.515310586177, 3890.280298144852, 31571.21071973196, 32345.35309293801, 32348.191295217573, 32415.83792081048, 32428.837855810805, 4430.889227769299, 4497.280435130396, 4571.474280457756, 4588.082383523309, 4685.273782563708, 322706.0, 327062.0, 327678.0, 327927.0, 327951.3602431996, 33671.831640841636, 34453.310933781184, 34632.13419664478, 35665.0, 58009.709951450815, 36094.458583121275, 36121.638783612354, 36213.27573448569, 36241.63758362435, 36263.27473450569, 15421.84578154204, 15658.217089145497, 15714.764278535831, 15740.527784166494, 15750.976186547838, 12974.0, 13176.868231317756, 13189.274589897648, 13330.0, 13414.932925335506, 8241.011078670597, 8305.086440491541, 8359.247667709935, 8419.621117049748, 8447.66209351619, 3246.4481038223557, 3254.9837250813594, 3273.672632736755, 3285.2772390074147, 3325.418051840918, 998.8301988661945, 1013.4729940430934, 1019.3578045831078, 1043.6921108273077, 1118.0049755717419, 31068.271647503996, 32116.35767284641, 32340.83829580837, 32467.18832029171, 32621.18447038843, 1081.507913899174, 1110.306058713304, 1133.9149563782748, 1157.7684463107412, 1195.3425615911215, 16484.752728709078, 16895.746563801553, 17157.0, 17371.478855634352, 17431.73852392215, 539102.0, 540397.0, 542321.0, 546117.0, 555537.0, 57677.134842977386, 57797.0, 57878.0, 57887.42112578904, 58063.709681452165, 1276.5978716704208, 1329.7473480038761, 1352.7294541091821, 1354.6681063139595, 1355.1868878672717, 30916.381672366875, 31783.205419864687, 31853.36293274168, 32035.0, 32580.51129233016, 51040.74479627578, 51370.22944655908, 51676.0, 51679.74160129175, 51687.74156129346, 456583.0, 468869.0, 470135.0, 470554.0, 472521.0, 27885.721142789123, 27971.86014069998, 28342.43315133727, 28374.716252837206, 28443.146705598865, 43090.56909430991, 44063.77968110139, 47561.04877902492, 48564.75717621389, 48623.5137648619, 39738.801305993285, 40822.0, 41267.38098928458, 41555.168896622505, 41764.582354177284, 36070.8196459016, 36091.458628120075, 36265.27469450649, 36268.637313626525, 36842.63157368392, 40234.1953160941, 40587.797061014506, 40883.38674919938, 40948.59051409567, 41103.7944810286, 34682.0, 37128.25743485061, 37474.250514989006, 37615.6238437623, 37720.62279377171, 28283.303001819957, 28853.85573072121, 28879.711202888542, 28905.0, 28906.855465722536], "value": 18823.452282296224, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.28772490205364, 395.7032225830627, 397.3304981106833, 401.5703197578591, 412.3587820938441, 18002.369917052907, 19314.903425482888, 19589.804101958976, 19597.314094006713, 19610.607787844234, 18298.908505457486, 19069.90465047676, 19118.04409779509, 19230.711539326887, 19638.509037274038, 5504.889902201953, 5532.640378375393, 5727.742251598688, 5730.341010783751, 5766.250387449647, 5635.943640563603, 5648.435156484339, 5658.896515179542, 5666.121751128581, 5671.8014869479575, 5441.809536666217, 5607.327120745516, 5636.126400407943, 5641.68970706611, 5644.096944488882, 5618.522425593809, 5634.690092044936, 5654.660720356771, 5654.717264136777, 5668.121441176624, 4915.803367865316, 5061.620378471629, 5088.592912566985, 5097.158968770148, 5100.336956195708, 22395.21616743406, 22494.10023599054, 23102.19142330027, 23213.76786232133, 23396.64905026426, 2497.4016629357225, 2538.1750930947514, 2542.186500319898, 2871.454423659498, 3126.718595326409, 14132.22272774997, 14629.487967921179, 14759.18824464654, 15217.467388641455, 15356.308966096552, 1912.4453908366556, 1963.224526312113, 1994.3618042226494, 2045.3557129504159, 2067.503799088208, 52289.0, 67161.66419167921, 68886.31113688849, 72837.0, 74614.0, 10227.488625568692, 10594.629187978539, 10686.465676716132, 10738.194635402377, 10987.175961802897, 14751.63120921964, 14952.327145278488, 15010.924945375204, 15031.173285469404, 15079.472218472301, 7982.361411087099, 8044.0, 8074.677012919535, 8126.512409255463, 8135.1051384347675, 8046.517208967481, 8051.2351326623875, 8174.427790054639, 8177.795555111051, 8258.215469530385, 6653.900191497131, 6679.76620818269, 6733.283012831696, 6827.0, 6835.58986460814, 1935.816097470738, 1946.6301402733436, 1980.9702854457194, 1981.0787983587702, 2015.2644284835928, 436.29320500788924, 1007.8689770329956, 1023.559869256227, 1063.5107850388908, 1065.4619417194422, 11464.94267528657, 12128.757424851454, 12220.877791221974, 12316.322602256783, 12373.814392784116, 456.1606643775469, 460.43826531631356, 480.57949294367427, 490.7448126974025, 493.45226798253907, 5414.3232095988005, 6530.085787989685, 6670.366315200048, 6682.565633233921, 6731.798046058626, 471158.0, 472338.0, 473105.0, 479269.0, 482549.0, 73752.63123684455, 92209.0, 92653.0, 93100.53449732708, 95380.04619953712, 454.7521600727611, 462.58829641618985, 463.8956234847132, 464.0648495772636, 472.84396149270657, 10467.528961196613, 10787.298825576312, 11007.119430445706, 11264.324140551593, 11424.828627570427, 37612.81193594124, 40091.0, 41929.580704192565, 43152.56847431611, 43239.56760432355, 45349.773251133534, 45581.0, 58816.0, 58954.70522647359, 59652.0, 8112.675492980215, 10613.779415367331, 12629.684257893627, 12901.935490322488, 13219.206847589176, 14014.789778153132, 14230.501932432315, 14414.783778243125, 14630.487932922297, 14632.0, 12408.317542534885, 12423.503059877503, 12450.875491245333, 12557.623271301876, 12759.61721148367, 12195.817062743889, 12546.0, 12674.049446291749, 12764.106512544033, 12844.678883027998, 12386.38976932993, 12655.87344126547, 12757.107002509736, 12981.675458113623, 13028.804567931678, 12867.806982895452, 12883.935580322039, 12967.481300747864, 13009.674758131123, 13103.672408189872, 12125.636230913087, 12283.324417157142, 12327.630171094881, 12331.50673973031, 12429.627111186679], "value": 8827.141612208488, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1444.4366696988177, 1484.9331780069895, 1569.945051923183, 1671.9498415047553, 1714.1686282153162, 7581.43139264556, 8345.2072053155, 8403.201695838901, 8915.286777057836, 8940.418872773273, 8490.95754521228, 8520.659173633063, 8570.057293697704, 8587.48475091495, 8589.95705021474, 2255.379770563092, 2274.749777524471, 2288.553732022256, 2291.713535808024, 2296.1045192374986, 2253.549290141978, 2258.4918393361527, 2344.6131388320905, 2345.1323010486144, 2345.495718420539, 2298.4598619324447, 2315.606346921019, 2325.6278995360744, 2361.3034154924253, 2370.146747171017, 2223.5330580578097, 2227.3652009177385, 2235.1394713035515, 2265.2411442166895, 2273.761255068227, 2275.7382900966436, 2304.51605162916, 2305.7463678995296, 2314.6065168921323, 2316.8262380321544, 8959.462432254086, 8979.19187273142, 9020.0, 9025.142611451902, 9093.727188184364, 5165.22521621756, 5233.528982391603, 5257.947420525784, 5275.446078161776, 5279.049771041211, 3333.3833240850277, 3386.8137252451106, 3584.4085725855202, 3588.372034893883, 3593.82030898454, 1083.0793825248477, 1088.3306766338724, 1096.3641088168922, 1103.7461383881753, 1107.6123356825128, 12450.190737602117, 12456.439460224221, 12566.937165314206, 12701.110922235355, 12706.872931270662, 4576.222042252825, 4654.16225079489, 4692.389989301437, 4728.95271047292, 4729.597984171315, 10395.532201050972, 10410.843837342445, 10411.583536658449, 10425.791484170426, 10479.790404191874, 5378.542823860016, 5393.568514518829, 5396.109641909041, 5398.865028374244, 5416.485433883775, 4224.577542245812, 4798.880027999328, 4805.0, 4958.380202474691, 4981.601471882241, 4017.598240175959, 4027.7583344999393, 4045.0696339842, 4161.895952601149, 4167.374893765959, 1241.788895887683, 1277.1315505456193, 1284.8650891656428, 1285.7299967007034, 1291.4124073546702, 911.1617312072909, 920.8848893888264, 950.064186776025, 954.8138113067885, 962.6582563189967, 5684.033714268584, 5695.316562012585, 5814.883702325929, 5906.173135760997, 5936.940630593639, 434.9956500434955, 438.11938004610323, 440.27354864473875, 443.4146926057573, 450.8129126412568, 3825.84696612138, 3827.1771569112775, 3846.9615303846604, 3877.96122038776, 3891.922161556753, 10833.079188269085, 11149.498272577754, 11169.94415027936, 11248.606298779667, 11281.774364512663, 11004.614838480775, 11334.319940803412, 11376.431178441046, 11395.715107122389, 11408.600698975495, 8218.794530136794, 8248.257656810916, 8382.371322150862, 8401.03388110375, 8408.831823363498, 5622.5783066271015, 5673.290838645169, 5737.713114344349, 5837.153612726046, 5943.108533719977, 10154.74613134648, 10253.84619230727, 10373.844392333971, 10453.26827122094, 10509.264351495627, 10035.899641003496, 10232.48837558134, 10660.573577057141, 10660.733481663021, 10685.94657026741, 7052.400545953651, 7590.506617069873, 7673.232676732282, 7699.923000769921, 7984.84030319402, 8717.476951382938, 8721.65113395457, 8734.82530349402, 8774.824503510023, 8792.47245165292, 7694.384449243935, 7798.181190974866, 7964.283214510722, 8047.436679432383, 8057.194280571896, 7696.153423123564, 7799.142094369501, 7826.2173782621285, 8010.559419231999, 8065.758027259191, 7023.22744498115, 7053.153621565445, 7109.182444019004, 7145.82135446618, 7157.892631610634, 4996.450390457119, 5124.436312005601, 5127.256547800623, 5170.819021334235, 5200.063988482109, 4920.040592084652, 4923.507649235048, 4965.503449655005, 5001.224810154432, 5013.598912086952], "value": 4550.635307976275, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.6863348452454, 334.800793527851, 336.07411581094084, 339.38909962068277, 341.4417427506028, 5582.804601838937, 5609.0, 5610.719464026793, 5645.15322701595, 5659.801906933259, 5611.607187496877, 5617.4382561743805, 5642.153676948449, 5646.124850648146, 5659.547236221103, 4171.645410140134, 4249.681273904454, 4374.147041326943, 4389.385486031958, 4437.156940181355, 4383.736975781463, 4391.319345501436, 4401.845935392262, 4417.094495628388, 4428.579284967939, 4359.3896854440245, 4407.250767369539, 4411.955880441203, 4415.763586195854, 4442.51175856087, 4338.284183109783, 4359.280718681413, 4369.934450983238, 4381.78091095444, 4384.232759267132, 3804.714646401531, 3832.616738326173, 3833.7891415972113, 3865.5747867734526, 3875.476810630557, 5424.528301886796, 5457.154141108134, 5519.558435325164, 5546.944530554683, 5551.250581171571, 4853.757312134415, 4986.950130498685, 4990.975045124787, 5002.124628190052, 5035.169197082477, 5833.941660583382, 5864.824055278348, 5892.0, 5928.64428134309, 5946.583739138262, 4244.342126970325, 4245.8513952011845, 4261.296886013835, 4263.701540892139, 4273.337632666941, 5893.675847828367, 6079.240094988127, 6095.817125486198, 6112.63324200545, 6117.204763380732, 4340.240457919851, 4352.891177720519, 4360.9127817444105, 4362.411074504965, 4366.628836548865, 4386.846460373871, 4390.582894625006, 4416.271315232951, 4425.0, 4440.955590444119, 4895.7062576245535, 4930.137225985438, 4951.72765497901, 4953.157963146274, 4958.504149585013, 5802.709864506758, 5845.473907348274, 5921.407859214044, 5923.940760592339, 5975.19334889793, 1506.7091763256929, 1512.691521833606, 1552.7670849372685, 1554.2772610736063, 1560.968780624404, 973.3235401396104, 973.9805203896024, 983.6508039645822, 1028.876534815812, 1040.8022475729588, 5655.632383895034, 5667.858303542362, 5672.00739870521, 5678.025382232454, 5684.175794509855, 5980.940190598125, 6061.424164704346, 6105.908411373833, 6111.54163437744, 6127.540434467343, 5489.0, 5702.173184888168, 5807.622504537191, 5812.738426770806, 5820.3888591698105, 3272.1001724525945, 3283.1627934876933, 3288.704016638514, 3299.6040475143136, 3321.5515905352468, 6133.478654314434, 6310.5267104967315, 6383.872322553523, 6408.61548307103, 6432.774852880127, 6294.874102518015, 6306.747730090745, 6313.968430157912, 6321.1150438938585, 6334.619922804646, 6112.786052488231, 6226.941419958618, 6374.298827129012, 6384.904226436607, 6389.424951754364, 6106.877862442638, 6146.0, 6153.569250152446, 6194.845128871814, 6205.5106774372925, 6106.2902387331615, 6138.662373569497, 6140.754369825336, 6173.6913154343, 6213.782517611862, 5986.0, 6258.687065646791, 6311.337309582428, 6320.241571011508, 6338.366163383625, 4289.678274129516, 4317.222899878052, 4353.912921741484, 4359.694821362475, 4373.2128216921255, 5790.420957904176, 6179.536534760001, 6197.318294987457, 6198.597091189239, 6211.844703882439, 5943.692387674705, 6008.8798224036145, 6024.608400453956, 6057.969710151421, 6062.818115456544, 5878.470937615635, 5905.232319798399, 5943.732532036155, 5970.253718285215, 6052.546059045501, 5626.381098079126, 5825.242718446575, 5888.175655408332, 5899.203607513103, 5914.970425147847, 6031.939680603138, 6050.818475445743, 6078.939210607838, 6122.612181249227, 6142.6314421134875, 5639.407862174577, 5841.9707901461925, 5843.795467158629, 5871.324797648325, 5920.348761636131], "value": 4528.273333749111, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.2899173306027, 735.0407717928108, 785.5208322923016, 806.0926759309629, 845.6532821543168, 15319.770203446944, 16318.91840540797, 16380.180990950435, 16434.7534786978, 16446.342146314135, 14823.407063717439, 15028.323725432354, 15038.548843534683, 15094.698106037873, 15127.168005759679, 661.6856992928357, 781.4646966827713, 800.5396896784343, 800.9907516529186, 801.6472751989136, 790.119017295714, 793.0245797668871, 796.8924195233657, 797.4139007829269, 799.0810567846964, 843.3590471241839, 844.3962566764762, 845.1337379186352, 845.3701992015957, 845.530730444603, 836.6946064686376, 836.8493671139223, 838.7316058861167, 839.236294971579, 840.0465471689615, 615.9753609855601, 616.7163104971719, 619.5198720991223, 620.0884699491739, 620.4044117647064, 14618.415263389452, 14624.780628290584, 14722.852771472255, 14724.263786810616, 14745.70508589833, 14862.851371486364, 14978.775318370233, 15060.246987650684, 15104.697906041927, 15245.23773811305, 12310.692232694255, 12347.62957111288, 12500.437480313316, 12536.934360579362, 12588.4335204916, 3800.239952009609, 3861.5366156061455, 3971.3844354124867, 3989.122393073519, 4104.486939132608, 72131.0, 72310.63844680742, 72668.0, 72849.27150728478, 73056.63471682607, 10991.670249892515, 11630.127740419333, 11740.530378784924, 11922.582709605122, 12050.39748012596, 19405.2237910482, 19919.402417927486, 20186.293479728138, 21180.258690945742, 21339.67990480113, 8257.0, 8670.479771213748, 8699.695510657224, 8822.823543529094, 9173.44959302444, 4862.82980095702, 4874.902501949941, 4875.585575226075, 4891.364122664031, 4984.37695288089, 3532.152283452004, 3623.1847834237087, 3666.8816011116332, 3696.963030369716, 3699.130704284491, 688.6453476459627, 689.7034275261685, 698.6087790837147, 699.7655785311875, 700.5901547594714, 658.1082633032269, 688.9655517224119, 691.339770519153, 728.1044315491974, 746.9253074692488, 9196.080391960884, 9341.486218257925, 9737.415755054719, 10111.544980475895, 10200.948995255125, 627.8147946355836, 656.3108735827362, 725.8693435181718, 735.2316828913798, 761.7676608634309, 4797.496262892416, 4982.60139188864, 4987.12725273083, 5006.249062640561, 5081.898362032813, 106475.0, 110319.44840275908, 111773.44113279544, 113931.43034284776, 114076.0, 62609.0, 102392.0, 103131.48434257781, 104109.0, 104862.0, 88869.55565222133, 89911.55044224738, 90562.0, 92263.53868230616, 92367.53816230876, 9582.760430989281, 9596.704444900128, 9604.423734575948, 9628.0, 9630.422174669542, 52870.0, 52905.0, 53901.0, 54080.0, 56082.71958640181, 73684.63157684177, 78677.60661196658, 80187.59906200432, 80995.0, 81887.0, 11948.223365481215, 11982.58060967862, 12181.939090304491, 12195.817062743889, 12407.627771166879, 12786.488540458278, 12900.225986440844, 13264.53574124901, 13413.329333533089, 13590.796138058135, 11931.224470409396, 12068.275903445821, 12167.81748273759, 12232.938835305766, 12458.626241212778, 11680.415979200836, 11884.168108232341, 12021.639350819489, 12189.0, 12632.873671263169, 11303.886961130283, 11708.414579271173, 12124.393780311126, 12247.0, 12471.189372690746, 10437.634682786065, 10645.254832161674, 10709.410982396043, 10874.347539147677, 11018.0, 9670.0, 10295.17638588896, 10431.217658675478, 10579.682609521727, 10605.787884242427], "value": 7492.683734028722, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 105.0, 109.0, 110.0, 110.0, 112.0, 111.0, 112.0, 111.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 157.0, 189.0, 130.0, 154.0, 158.0, 133.0, 189.0, 127.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 163.0, 166.0, 174.0, 163.0, 162.0, 162.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 162.0, 75.0, 75.0, 77.0, 75.0, 155.0, 76.0], "value": 92.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 159.0, 85.0, 87.0, 85.0, 149.0, 85.0, 85.0, 139.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 120.0, 117.0, 119.0, 117.0, 119.0, 117.0, 122.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 148.0, 147.0, 149.0, 147.0, 147.0, 146.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 97.0, 94.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 57.0, 59.0, 57.0, 58.0, 57.0, 62.0, 58.0, 56.0, 57.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 60.0, 60.0, 62.0, 66.0, 61.0, 62.0, 60.0, 67.0, 61.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 79.0, 79.0, 79.0, 81.0, 80.0, 81.0, 81.0, 135.0, 80.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 126.0, 128.0, 121.0, 127.0, 122.0, 123.0, 124.0, 127.0, 123.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 161.0, 161.0, 166.0, 162.0, 162.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 67.0, 63.0, 62.0, 62.0, 61.0, 63.0, 63.0, 64.0], "value": 63.0, "unit": "score"}]}]} 04:26:56 INFO - Return code: 0 04:26:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:26:56 ERROR - # TBPL SUCCESS # 04:26:56 INFO - Running post-action listener: _resource_record_post_action 04:26:56 INFO - ##### 04:26:56 INFO - ##### Finished run-tests step (success) 04:26:56 INFO - ##### 04:26:56 INFO - Running post-run listener: _resource_record_post_run 04:26:56 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 552321024; Read time: 44; Write time: 468780 04:26:56 INFO - TinderboxPrint: CPU usage
13.4% 04:26:56 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 44 04:26:56 INFO - TinderboxPrint: I/O write bytes / time
552,321,024 / 468,780 04:26:56 INFO - TinderboxPrint: CPU idle
8,222.7 (86.6%) 04:26:56 INFO - TinderboxPrint: CPU user
1,221.3 (12.9%) 04:26:56 INFO - TinderboxPrint: Swap in / out
0 / 0 04:26:56 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256266240; Read time: 0; Write time: 219912 04:26:56 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 295264256; Read time: 44; Write time: 248376 04:26:57 INFO - Running post-run listener: _upload_blobber_files 04:26:57 INFO - Blob upload gear active. 04:26:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:26:57 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:26:57 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:26:57 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:26:57 INFO - (blobuploader) - INFO - Open directory for files ... 04:26:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:26:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:26:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:58 INFO - (blobuploader) - INFO - Done attempting. 04:26:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:26:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:27:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:02 INFO - (blobuploader) - INFO - Done attempting. 04:27:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:27:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:27:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:27:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:27:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:27:03 INFO - (blobuploader) - INFO - Done attempting. 04:27:03 INFO - (blobuploader) - INFO - Iteration through files over. 04:27:03 INFO - Return code: 0 04:27:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:27:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:27:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/431e61b39f516df4e9c3692a05333f7b2fa2c4ed20cb63e5306681df1d04fe9b42ec01f4cf28b3428853f59e5dd7a6517299cf885fce1ffc9e144d11a23d92f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b44beb08190675599bf06b6715d1e5c22f48dfe8ed97642ee538a24a8981df5c1b31bc8fd68dc3bfa9678a66bce1cc902a92fb875bef68a4628fe7bb8919b31f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/49c1d284af3a67d0d5375c316427740e7c256c90c75bafa73680c950309b92b0bd24837e0acca2ecf03add167c0121d3df1e8eca532730372d967e5298332b44"} 04:27:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:27:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:27:03 INFO - Contents: 04:27:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/431e61b39f516df4e9c3692a05333f7b2fa2c4ed20cb63e5306681df1d04fe9b42ec01f4cf28b3428853f59e5dd7a6517299cf885fce1ffc9e144d11a23d92f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b44beb08190675599bf06b6715d1e5c22f48dfe8ed97642ee538a24a8981df5c1b31bc8fd68dc3bfa9678a66bce1cc902a92fb875bef68a4628fe7bb8919b31f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/49c1d284af3a67d0d5375c316427740e7c256c90c75bafa73680c950309b92b0bd24837e0acca2ecf03add167c0121d3df1e8eca532730372d967e5298332b44"} 04:27:03 INFO - Running post-run listener: copy_logs_to_upload_dir 04:27:03 INFO - Copying logs to upload dir... 04:27:03 INFO - mkdir: /builds/slave/test/build/upload/logs 04:27:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.430138 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-27 04:27:03.160511) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 04:27:03.164349) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/431e61b39f516df4e9c3692a05333f7b2fa2c4ed20cb63e5306681df1d04fe9b42ec01f4cf28b3428853f59e5dd7a6517299cf885fce1ffc9e144d11a23d92f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b44beb08190675599bf06b6715d1e5c22f48dfe8ed97642ee538a24a8981df5c1b31bc8fd68dc3bfa9678a66bce1cc902a92fb875bef68a4628fe7bb8919b31f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/49c1d284af3a67d0d5375c316427740e7c256c90c75bafa73680c950309b92b0bd24837e0acca2ecf03add167c0121d3df1e8eca532730372d967e5298332b44"} build_url:https://queue.taskcluster.net/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/LKG7miW3SLOZvT_XM9byKQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/431e61b39f516df4e9c3692a05333f7b2fa2c4ed20cb63e5306681df1d04fe9b42ec01f4cf28b3428853f59e5dd7a6517299cf885fce1ffc9e144d11a23d92f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b44beb08190675599bf06b6715d1e5c22f48dfe8ed97642ee538a24a8981df5c1b31bc8fd68dc3bfa9678a66bce1cc902a92fb875bef68a4628fe7bb8919b31f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/49c1d284af3a67d0d5375c316427740e7c256c90c75bafa73680c950309b92b0bd24837e0acca2ecf03add167c0121d3df1e8eca532730372d967e5298332b44"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 04:27:03.197080) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 04:27:03.197482) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1467025584.827459-495802433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 04:27:03.279819) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 04:27:03.280186) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 04:27:03.280556) ========= ========= Total master_lag: 0.18 =========