builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1466906979.42 results: success (0) buildid: 20160625163004 builduid: d5312fe2465c48f8962718a30bb66710 revision: 6a0632dcd94b8a5efbd80e59e2fb12188becc440 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-25 19:09:39.416685) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-25 19:09:39.417182) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-25 19:09:39.417461) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-25 19:09:39.457677) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 19:09:39.457948) ========= 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=af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-25 19:09:40-- 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% 38.8M=0s 2016-06-25 19:09:40 (38.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095212 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 19:09:39.567070) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 19:09:39.567465) ========= 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=af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020143 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 19:09:39.619127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 19:09:39.619444) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6a0632dcd94b8a5efbd80e59e2fb12188becc440 --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 6a0632dcd94b8a5efbd80e59e2fb12188becc440 --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=af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-25 19:09:40,319 truncating revision to first 12 chars 2016-06-25 19:09:40,319 Setting DEBUG logging. 2016-06-25 19:09:40,319 attempt 1/10 2016-06-25 19:09:40,319 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/6a0632dcd94b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-25 19:09:40,640 unpacking tar archive at: mozilla-inbound-6a0632dcd94b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.664124 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 19:09:40.305597) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-25 19:09:40.305877) ========= script_repo_revision: 6a0632dcd94b8a5efbd80e59e2fb12188becc440 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-25 19:09:40.306262) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-25 19:09:40.306539) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-25 19:09:40.317644) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-06-25 19:09:40.317935) ========= /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=af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:09:41 INFO - MultiFileLogger online at 20160625 19:09:41 in /builds/slave/test 19:09:41 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 19:09:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:09:41 INFO - {'append_to_log': False, 19:09:41 INFO - 'base_work_dir': '/builds/slave/test', 19:09:41 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:09:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:09:41 INFO - 'branch': 'Mozilla-Inbound', 19:09:41 INFO - 'buildbot_json_path': 'buildprops.json', 19:09:41 INFO - 'config_files': ('talos/linux_config.py',), 19:09:41 INFO - 'default_actions': ('clobber', 19:09:41 INFO - 'read-buildbot-config', 19:09:41 INFO - 'download-and-extract', 19:09:41 INFO - 'populate-webroot', 19:09:41 INFO - 'create-virtualenv', 19:09:41 INFO - 'install', 19:09:41 INFO - 'run-tests'), 19:09:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:09:41 INFO - 'download_minidump_stackwalk': True, 19:09:41 INFO - 'download_symbols': 'ondemand', 19:09:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:09:41 INFO - 'tooltool.py': '/tools/tooltool.py', 19:09:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:09:41 INFO - '/tools/misc-python/virtualenv.py')}, 19:09:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:09:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:09:41 INFO - 'installer_path': 'installer.exe', 19:09:41 INFO - 'log_level': 'info', 19:09:41 INFO - 'log_name': 'talos', 19:09:41 INFO - 'log_to_console': True, 19:09:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:09:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:09:41 INFO - 'opt_config_files': (), 19:09:41 INFO - 'pip_index': False, 19:09:41 INFO - 'sps_profile': False, 19:09:41 INFO - 'sps_profile_interval': 0, 19:09:41 INFO - 'suite': 'dromaeojs-e10s', 19:09:41 INFO - 'system_bits': '32', 19:09:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:09:41 INFO - 'title': 'talos-linux64-ix-020', 19:09:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:09:41 INFO - 'use_talos_json': True, 19:09:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:09:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:09:41 INFO - 'work_dir': 'build'} 19:09:41 INFO - ##### 19:09:41 INFO - ##### Running clobber step. 19:09:41 INFO - ##### 19:09:41 INFO - Running pre-action listener: _resource_record_pre_action 19:09:41 INFO - Running main action method: clobber 19:09:41 INFO - rmtree: /builds/slave/test/build 19:09:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:09:41 INFO - Running post-action listener: _resource_record_post_action 19:09:41 INFO - ##### 19:09:41 INFO - ##### Finished clobber step (success) 19:09:41 INFO - ##### 19:09:41 INFO - ##### 19:09:41 INFO - ##### Running read-buildbot-config step. 19:09:41 INFO - ##### 19:09:41 INFO - Running pre-action listener: _resource_record_pre_action 19:09:41 INFO - Running main action method: read_buildbot_config 19:09:41 INFO - Using buildbot properties: 19:09:41 INFO - { 19:09:41 INFO - "project": "", 19:09:41 INFO - "product": "firefox", 19:09:41 INFO - "script_repo_revision": "production", 19:09:41 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 19:09:41 INFO - "repository": "", 19:09:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 19:09:41 INFO - "buildid": "20160625163004", 19:09:41 INFO - "pgo_build": "True", 19:09:41 INFO - "basedir": "/builds/slave/test", 19:09:41 INFO - "buildnumber": 1220, 19:09:41 INFO - "slavename": "talos-linux64-ix-020", 19:09:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:09:41 INFO - "platform": "ubuntu64_hw", 19:09:41 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:09:41 INFO - "branch": "mozilla-inbound", 19:09:41 INFO - "repo_path": "integration/mozilla-inbound", 19:09:41 INFO - "revision": "6a0632dcd94b8a5efbd80e59e2fb12188becc440", 19:09:41 INFO - "stage_platform": "linux64-pgo", 19:09:41 INFO - "builduid": "d5312fe2465c48f8962718a30bb66710", 19:09:41 INFO - "slavebuilddir": "test" 19:09:41 INFO - } 19:09:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:09:41 INFO - Running post-action listener: _resource_record_post_action 19:09:41 INFO - ##### 19:09:41 INFO - ##### Finished read-buildbot-config step (success) 19:09:41 INFO - ##### 19:09:41 INFO - ##### 19:09:41 INFO - ##### Running download-and-extract step. 19:09:41 INFO - ##### 19:09:41 INFO - Running pre-action listener: _resource_record_pre_action 19:09:41 INFO - Running main action method: download_and_extract 19:09:41 INFO - mkdir: /builds/slave/test/build/tests 19:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:41 INFO - https://queue.taskcluster.net/v1/task/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:09:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:09:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:09:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dBNNPExzRlWOd5bvn5ODIQ/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 19:09:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dBNNPExzRlWOd5bvn5ODIQ/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 19:09:52 INFO - Downloaded 1361 bytes. 19:09:52 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:09:52 INFO - Using the following test package requirements: 19:09:52 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:09:52 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:09:52 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:09:52 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:52 INFO - u'jsshell-linux-x86_64.zip'], 19:09:52 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:09:52 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:09:52 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:09:52 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:09:52 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:09:52 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:09:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:09:52 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:09:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:09:52 INFO - https://queue.taskcluster.net/v1/task/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:09:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:09:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:09:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dBNNPExzRlWOd5bvn5ODIQ/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 19:09:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dBNNPExzRlWOd5bvn5ODIQ/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 19:10:02 INFO - Downloaded 24279480 bytes. 19:10:02 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'] 19:10:02 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 19:10:03 INFO - Return code: 0 19:10:03 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 19:10:03 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')]} 19:10:03 INFO - https://queue.taskcluster.net/v1/task/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:10:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:10:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:10:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dBNNPExzRlWOd5bvn5ODIQ/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 19:10:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dBNNPExzRlWOd5bvn5ODIQ/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 19:10:06 INFO - Downloaded 24279480 bytes. 19:10:06 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'] 19:10:06 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 19:10:09 INFO - Return code: 0 19:10:09 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')]} 19:10:09 INFO - https://queue.taskcluster.net/v1/task/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:10:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:10:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:10:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dBNNPExzRlWOd5bvn5ODIQ/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 19:10:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dBNNPExzRlWOd5bvn5ODIQ/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 19:10:09 INFO - Downloaded 14405240 bytes. 19:10:09 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'] 19:10:09 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 19:10:10 INFO - Return code: 0 19:10:10 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')]} 19:10:10 INFO - https://queue.taskcluster.net/v1/task/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:10:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:10:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:10:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dBNNPExzRlWOd5bvn5ODIQ/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 19:10:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dBNNPExzRlWOd5bvn5ODIQ/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 19:10:14 INFO - Downloaded 60159928 bytes. 19:10:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:10:14 INFO - mkdir: /builds/slave/test/properties 19:10:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:10:14 INFO - Writing to file /builds/slave/test/properties/build_url 19:10:14 INFO - Contents: 19:10:14 INFO - build_url:https://queue.taskcluster.net/v1/task/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:10:14 INFO - Running post-action listener: _resource_record_post_action 19:10:14 INFO - Running post-action listener: set_extra_try_arguments 19:10:14 INFO - ##### 19:10:14 INFO - ##### Finished download-and-extract step (success) 19:10:14 INFO - ##### 19:10:14 INFO - ##### 19:10:14 INFO - ##### Running populate-webroot step. 19:10:14 INFO - ##### 19:10:14 INFO - Running pre-action listener: _resource_record_pre_action 19:10:14 INFO - Running main action method: populate_webroot 19:10:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:10:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:10:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:10:14 INFO - '--tppagecycles', 19:10:14 INFO - '7'], 19:10:14 INFO - 'tests': ['tsvgm']}}, 19:10:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:10:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:10:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:10:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:10:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:10:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:10:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:14 INFO - 'talos_options': ['--disable-e10s'], 19:10:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:10:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:10:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:14 INFO - 'talos_options': ['--disable-e10s'], 19:10:14 INFO - 'tests': ['damp', 'tps']}, 19:10:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:14 INFO - 'tests': ['damp', 'tps']}, 19:10:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:10:14 INFO - 'tests': ['dromaeo_dom']}, 19:10:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:10:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:10:14 INFO - 'tests': ['basic_compositor_video']}, 19:10:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:10:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:10:14 INFO - 'tests': ['a11yr', 19:10:14 INFO - 'ts_paint', 19:10:14 INFO - 'tpaint', 19:10:14 INFO - 'sessionrestore', 19:10:14 INFO - 'sessionrestore_no_auto_restore', 19:10:14 INFO - 'tabpaint']}, 19:10:14 INFO - 'other-e10s': {'tests': ['a11yr', 19:10:14 INFO - 'ts_paint', 19:10:14 INFO - 'tpaint', 19:10:14 INFO - 'sessionrestore', 19:10:14 INFO - 'sessionrestore_no_auto_restore', 19:10:14 INFO - 'tabpaint']}, 19:10:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:10:14 INFO - 'ts_paint', 19:10:14 INFO - 'tpaint', 19:10:14 INFO - 'sessionrestore', 19:10:14 INFO - 'sessionrestore_no_auto_restore', 19:10:14 INFO - 'tabpaint']}, 19:10:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:10:14 INFO - 'ts_paint', 19:10:14 INFO - 'tpaint', 19:10:14 INFO - 'sessionrestore', 19:10:14 INFO - 'sessionrestore_no_auto_restore', 19:10:14 INFO - 'tabpaint']}, 19:10:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:10:14 INFO - 'tests': ['a11yr', 19:10:14 INFO - 'ts_paint', 19:10:14 INFO - 'tpaint', 19:10:14 INFO - 'sessionrestore', 19:10:14 INFO - 'sessionrestore_no_auto_restore', 19:10:14 INFO - 'tabpaint']}, 19:10:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:10:14 INFO - 'tests': ['a11yr', 19:10:14 INFO - 'ts_paint', 19:10:14 INFO - 'tpaint', 19:10:14 INFO - 'sessionrestore', 19:10:14 INFO - 'sessionrestore_no_auto_restore', 19:10:14 INFO - 'tabpaint']}, 19:10:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:10:14 INFO - 'tests': ['tsvgx', 19:10:14 INFO - 'tsvgr_opacity', 19:10:14 INFO - 'tart', 19:10:14 INFO - 'tscrollx', 19:10:14 INFO - 'cart']}, 19:10:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:10:14 INFO - 'tsvgr_opacity', 19:10:14 INFO - 'tart', 19:10:14 INFO - 'tscrollx', 19:10:14 INFO - 'cart']}, 19:10:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:14 INFO - 'talos_options': ['--disable-e10s'], 19:10:14 INFO - 'tests': ['tp5o']}, 19:10:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:14 INFO - 'tests': ['tp5o']}, 19:10:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:14 INFO - 'talos_options': ['--disable-e10s', 19:10:14 INFO - '--xperf_path', 19:10:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:10:14 INFO - 'tests': ['tp5n']}, 19:10:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:10:14 INFO - 'talos_options': ['--xperf_path', 19:10:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:10:14 INFO - 'tests': ['tp5n']}}, 19:10:14 INFO - 'talos.zip': {'path': '', 19:10:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:10:14 INFO - Running post-action listener: _resource_record_post_action 19:10:14 INFO - ##### 19:10:14 INFO - ##### Finished populate-webroot step (success) 19:10:14 INFO - ##### 19:10:14 INFO - ##### 19:10:14 INFO - ##### Running create-virtualenv step. 19:10:14 INFO - ##### 19:10:14 INFO - Running pre-action listener: _resource_record_pre_action 19:10:14 INFO - Running main action method: create_virtualenv 19:10:14 INFO - Creating virtualenv /builds/slave/test/build/venv 19:10:14 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 19:10:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:10:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:10:14 INFO - Using real prefix '/usr' 19:10:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:10:15 INFO - Installing distribute.............................................................................................................................................................................................done. 19:10:17 INFO - Installing pip.................done. 19:10:17 INFO - Return code: 0 19:10:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:10:17 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')]} 19:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:17 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')]} 19:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:17 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 0x7fad1cc59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1133a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116b980>, '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 0x11b4a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b4f10>, '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': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', '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 19:10:17 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 19:10:17 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 19:10:17 INFO - Using env: {'DISPLAY': ':0', 19:10:17 INFO - 'HOME': '/home/cltbld', 19:10:17 INFO - 'LANG': 'en_US.UTF-8', 19:10:17 INFO - 'LANGUAGE': 'en_US:en', 19:10:17 INFO - 'LOGNAME': 'cltbld', 19:10:17 INFO - 'MAIL': '/var/mail/cltbld', 19:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:17 INFO - 'MOZ_NO_REMOTE': '1', 19:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:17 INFO - 'NO_EM_RESTART': '1', 19:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:17 INFO - 'PWD': '/builds/slave/test', 19:10:17 INFO - 'SHELL': '/bin/bash', 19:10:17 INFO - 'SHLVL': '1', 19:10:17 INFO - 'TERM': 'linux', 19:10:17 INFO - 'TMOUT': '86400', 19:10:17 INFO - 'USER': 'cltbld', 19:10:17 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', 19:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:17 INFO - '_': '/tools/buildbot/bin/python'} 19:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:17 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 19:10:17 INFO - Cleaning up... 19:10:17 INFO - Return code: 0 19:10:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:10:17 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')]} 19:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:17 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')]} 19:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:17 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 0x7fad1cc59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1133a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116b980>, '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 0x11b4a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b4f10>, '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': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', '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 19:10:17 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 19:10:17 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 19:10:17 INFO - Using env: {'DISPLAY': ':0', 19:10:17 INFO - 'HOME': '/home/cltbld', 19:10:17 INFO - 'LANG': 'en_US.UTF-8', 19:10:17 INFO - 'LANGUAGE': 'en_US:en', 19:10:17 INFO - 'LOGNAME': 'cltbld', 19:10:17 INFO - 'MAIL': '/var/mail/cltbld', 19:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:17 INFO - 'MOZ_NO_REMOTE': '1', 19:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:17 INFO - 'NO_EM_RESTART': '1', 19:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:17 INFO - 'PWD': '/builds/slave/test', 19:10:17 INFO - 'SHELL': '/bin/bash', 19:10:17 INFO - 'SHLVL': '1', 19:10:17 INFO - 'TERM': 'linux', 19:10:17 INFO - 'TMOUT': '86400', 19:10:17 INFO - 'USER': 'cltbld', 19:10:17 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', 19:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:17 INFO - '_': '/tools/buildbot/bin/python'} 19:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:17 INFO - Downloading/unpacking psutil>=3.1.1 19:10:17 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 19:10:17 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 19:10:17 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 19:10:17 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 19:10:17 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 19:10:17 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 19:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:10:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:10:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:10:19 INFO - Installing collected packages: psutil 19:10:19 INFO - Running setup.py install for psutil 19:10:19 INFO - building 'psutil._psutil_linux' extension 19:10:19 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 19:10:19 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 19:10:19 INFO - building 'psutil._psutil_posix' extension 19:10:19 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 19:10:20 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 19:10:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:10:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:10:20 INFO - Successfully installed psutil 19:10:20 INFO - Cleaning up... 19:10:20 INFO - Return code: 0 19:10:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:20 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 0x7fad1cc59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1133a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116b980>, '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 0x11b4a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b4f10>, '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': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', '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 19:10:20 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 19:10:20 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 19:10:20 INFO - Using env: {'DISPLAY': ':0', 19:10:20 INFO - 'HOME': '/home/cltbld', 19:10:20 INFO - 'LANG': 'en_US.UTF-8', 19:10:20 INFO - 'LANGUAGE': 'en_US:en', 19:10:20 INFO - 'LOGNAME': 'cltbld', 19:10:20 INFO - 'MAIL': '/var/mail/cltbld', 19:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:20 INFO - 'MOZ_NO_REMOTE': '1', 19:10:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:20 INFO - 'NO_EM_RESTART': '1', 19:10:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:20 INFO - 'PWD': '/builds/slave/test', 19:10:20 INFO - 'SHELL': '/bin/bash', 19:10:20 INFO - 'SHLVL': '1', 19:10:20 INFO - 'TERM': 'linux', 19:10:20 INFO - 'TMOUT': '86400', 19:10:20 INFO - 'USER': 'cltbld', 19:10:20 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', 19:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:20 INFO - '_': '/tools/buildbot/bin/python'} 19:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:10:20 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 19:10:20 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 19:10:20 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 19:10:20 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 19:10:20 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 19:10:20 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 19:10:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:10:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:10:22 INFO - Installing collected packages: mozsystemmonitor 19:10:22 INFO - Running setup.py install for mozsystemmonitor 19:10:22 INFO - Successfully installed mozsystemmonitor 19:10:22 INFO - Cleaning up... 19:10:22 INFO - Return code: 0 19:10:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:10: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')]} 19:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10: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')]} 19:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:22 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 0x7fad1cc59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1133a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116b980>, '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 0x11b4a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b4f10>, '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': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', '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 19:10:22 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 19:10:22 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 19:10:22 INFO - Using env: {'DISPLAY': ':0', 19:10:22 INFO - 'HOME': '/home/cltbld', 19:10:22 INFO - 'LANG': 'en_US.UTF-8', 19:10:22 INFO - 'LANGUAGE': 'en_US:en', 19:10:22 INFO - 'LOGNAME': 'cltbld', 19:10:22 INFO - 'MAIL': '/var/mail/cltbld', 19:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:22 INFO - 'MOZ_NO_REMOTE': '1', 19:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:22 INFO - 'NO_EM_RESTART': '1', 19:10:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:22 INFO - 'PWD': '/builds/slave/test', 19:10:22 INFO - 'SHELL': '/bin/bash', 19:10:22 INFO - 'SHLVL': '1', 19:10:22 INFO - 'TERM': 'linux', 19:10:22 INFO - 'TMOUT': '86400', 19:10:22 INFO - 'USER': 'cltbld', 19:10:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', 19:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:22 INFO - '_': '/tools/buildbot/bin/python'} 19:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:22 INFO - Downloading/unpacking jsonschema==2.5.1 19:10:22 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 19:10:22 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 19:10:22 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 19:10:22 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 19:10:22 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 19:10:22 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 19:10:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:10:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:10:24 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 19:10:24 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 19:10:24 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 19:10:24 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 19:10:24 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 19:10:24 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 19:10:24 INFO - Downloading functools32-3.2.3-2.tar.gz 19:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:10:24 INFO - warning: no files found matching '*.txt' 19:10:24 INFO - no previously-included directories found matching 'build' 19:10:24 INFO - no previously-included directories found matching 'dist' 19:10:24 INFO - no previously-included directories found matching '.git*' 19:10:24 INFO - Installing collected packages: jsonschema, functools32 19:10:25 INFO - Running setup.py install for functools32 19:10:25 INFO - warning: no files found matching '*.txt' 19:10:25 INFO - no previously-included directories found matching 'build' 19:10:25 INFO - no previously-included directories found matching 'dist' 19:10:25 INFO - no previously-included directories found matching '.git*' 19:10:25 INFO - Successfully installed jsonschema functools32 19:10:25 INFO - Cleaning up... 19:10:25 INFO - Return code: 0 19:10:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:25 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 0x7fad1cc59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1133a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116b980>, '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 0x11b4a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b4f10>, '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': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', '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 19:10:25 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 19:10:25 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 19:10:25 INFO - Using env: {'DISPLAY': ':0', 19:10:25 INFO - 'HOME': '/home/cltbld', 19:10:25 INFO - 'LANG': 'en_US.UTF-8', 19:10:25 INFO - 'LANGUAGE': 'en_US:en', 19:10:25 INFO - 'LOGNAME': 'cltbld', 19:10:25 INFO - 'MAIL': '/var/mail/cltbld', 19:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:25 INFO - 'MOZ_NO_REMOTE': '1', 19:10:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:25 INFO - 'NO_EM_RESTART': '1', 19:10:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:25 INFO - 'PWD': '/builds/slave/test', 19:10:25 INFO - 'SHELL': '/bin/bash', 19:10:25 INFO - 'SHLVL': '1', 19:10:25 INFO - 'TERM': 'linux', 19:10:25 INFO - 'TMOUT': '86400', 19:10:25 INFO - 'USER': 'cltbld', 19:10:25 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', 19:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:25 INFO - '_': '/tools/buildbot/bin/python'} 19:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:25 INFO - Downloading/unpacking blobuploader==1.2.4 19:10:25 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 19:10:25 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 19:10:25 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 19:10:25 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 19:10:25 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 19:10:25 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 19:10:27 INFO - Downloading blobuploader-1.2.4.tar.gz 19:10:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:10:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:10:27 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 19:10:27 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 19:10:27 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 19:10:27 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 19:10:27 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 19:10:27 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 19:10:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:10:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:10:27 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 19:10:27 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 19:10:27 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 19:10:27 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 19:10:27 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 19:10:27 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 19:10:27 INFO - Downloading docopt-0.6.1.tar.gz 19:10:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:10:28 INFO - Installing collected packages: blobuploader, requests, docopt 19:10:28 INFO - Running setup.py install for blobuploader 19:10:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:10:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:10:28 INFO - Running setup.py install for requests 19:10:28 INFO - Running setup.py install for docopt 19:10:28 INFO - Successfully installed blobuploader requests docopt 19:10:28 INFO - Cleaning up... 19:10:28 INFO - Return code: 0 19:10:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10: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')]} 19:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10: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')]} 19:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:28 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 0x7fad1cc59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1133a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116b980>, '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 0x11b4a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b4f10>, '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': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', '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 19:10:28 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 19:10:28 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 19:10:28 INFO - Using env: {'DISPLAY': ':0', 19:10:28 INFO - 'HOME': '/home/cltbld', 19:10:28 INFO - 'LANG': 'en_US.UTF-8', 19:10:28 INFO - 'LANGUAGE': 'en_US:en', 19:10:28 INFO - 'LOGNAME': 'cltbld', 19:10:28 INFO - 'MAIL': '/var/mail/cltbld', 19:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:28 INFO - 'MOZ_NO_REMOTE': '1', 19:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:28 INFO - 'NO_EM_RESTART': '1', 19:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:28 INFO - 'PWD': '/builds/slave/test', 19:10:28 INFO - 'SHELL': '/bin/bash', 19:10:28 INFO - 'SHLVL': '1', 19:10:28 INFO - 'TERM': 'linux', 19:10:28 INFO - 'TMOUT': '86400', 19:10:28 INFO - 'USER': 'cltbld', 19:10:28 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', 19:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:28 INFO - '_': '/tools/buildbot/bin/python'} 19:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:10:28 INFO - Running setup.py (path:/tmp/pip-Yyfxog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:10:28 INFO - Running setup.py (path:/tmp/pip-776tBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:10:29 INFO - Running setup.py (path:/tmp/pip-cTUaO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:10:29 INFO - Running setup.py (path:/tmp/pip-1j5W7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:10:29 INFO - Running setup.py (path:/tmp/pip-OnkqJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:10:29 INFO - Running setup.py (path:/tmp/pip-kgbESh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:10:29 INFO - Running setup.py (path:/tmp/pip-xvNSpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:10:29 INFO - Running setup.py (path:/tmp/pip-kGt9WA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:10:29 INFO - Running setup.py (path:/tmp/pip-0DYQGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:10:29 INFO - Running setup.py (path:/tmp/pip-neUV4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:10:29 INFO - Running setup.py (path:/tmp/pip-WrnCMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:10:29 INFO - Running setup.py (path:/tmp/pip-7LxuVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:10:29 INFO - Running setup.py (path:/tmp/pip-mi35CT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:10:29 INFO - Running setup.py (path:/tmp/pip-aHKdP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:29 INFO - Running setup.py (path:/tmp/pip-R39L4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:10:29 INFO - Running setup.py (path:/tmp/pip-3U5EQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:10:30 INFO - Running setup.py (path:/tmp/pip-I_Iwxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:10:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:10:30 INFO - Running setup.py install for manifestparser 19:10:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:10:30 INFO - Running setup.py install for mozcrash 19:10:30 INFO - Running setup.py install for mozdebug 19:10:30 INFO - Running setup.py install for mozdevice 19:10:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:10:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:10:30 INFO - Running setup.py install for mozfile 19:10:30 INFO - Running setup.py install for mozhttpd 19:10:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:10:30 INFO - Running setup.py install for mozinfo 19:10:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:10:30 INFO - Running setup.py install for mozInstall 19:10:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:10:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:10:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:10:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:10:30 INFO - Running setup.py install for mozleak 19:10:31 INFO - Running setup.py install for mozlog 19:10:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:10:31 INFO - Running setup.py install for moznetwork 19:10:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:10:31 INFO - Running setup.py install for mozprocess 19:10:31 INFO - Running setup.py install for mozprofile 19:10:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:10:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:10:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:10:31 INFO - Running setup.py install for mozrunner 19:10:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:10:31 INFO - Running setup.py install for mozscreenshot 19:10:31 INFO - Running setup.py install for moztest 19:10:31 INFO - Running setup.py install for mozversion 19:10:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:10:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:10:31 INFO - Cleaning up... 19:10:31 INFO - Return code: 0 19:10:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10: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')]} 19:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10: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')]} 19:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:31 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 0x7fad1cc59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1133a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116b980>, '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 0x11b4a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b4f10>, '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': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', '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 19:10:31 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 19:10:31 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 19:10:31 INFO - Using env: {'DISPLAY': ':0', 19:10:31 INFO - 'HOME': '/home/cltbld', 19:10:31 INFO - 'LANG': 'en_US.UTF-8', 19:10:31 INFO - 'LANGUAGE': 'en_US:en', 19:10:31 INFO - 'LOGNAME': 'cltbld', 19:10:31 INFO - 'MAIL': '/var/mail/cltbld', 19:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:31 INFO - 'MOZ_NO_REMOTE': '1', 19:10:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:31 INFO - 'NO_EM_RESTART': '1', 19:10:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:31 INFO - 'PWD': '/builds/slave/test', 19:10:31 INFO - 'SHELL': '/bin/bash', 19:10:31 INFO - 'SHLVL': '1', 19:10:31 INFO - 'TERM': 'linux', 19:10:31 INFO - 'TMOUT': '86400', 19:10:31 INFO - 'USER': 'cltbld', 19:10:31 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', 19:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:31 INFO - '_': '/tools/buildbot/bin/python'} 19:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:10:32 INFO - Running setup.py (path:/tmp/pip-hd52RL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:10:32 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)) 19:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:10:32 INFO - Running setup.py (path:/tmp/pip-iDi6A8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:10:32 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)) 19:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:10:32 INFO - Running setup.py (path:/tmp/pip-g2OagL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:10:32 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)) 19:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:10:32 INFO - Running setup.py (path:/tmp/pip-cRovxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:10:32 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)) 19:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:10:32 INFO - Running setup.py (path:/tmp/pip-ULj8Eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:10:32 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)) 19:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:10:32 INFO - Running setup.py (path:/tmp/pip-jq6AIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:10:32 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)) 19:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:10:32 INFO - Running setup.py (path:/tmp/pip-WW_u0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:10:32 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)) 19:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:10:32 INFO - Running setup.py (path:/tmp/pip-XGD0hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:10:32 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)) 19:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:10:32 INFO - Running setup.py (path:/tmp/pip-AIp1pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:10:32 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)) 19:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:10:32 INFO - Running setup.py (path:/tmp/pip-lYfZh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:10:32 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)) 19:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:10:32 INFO - Running setup.py (path:/tmp/pip-7J6WaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:10:32 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)) 19:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:10:32 INFO - Running setup.py (path:/tmp/pip-x7VSj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:10:32 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)) 19:10:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:10:32 INFO - Running setup.py (path:/tmp/pip-uxaYmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:10:33 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)) 19:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:10:33 INFO - Running setup.py (path:/tmp/pip-xuZ_wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:10:33 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)) 19:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:33 INFO - Running setup.py (path:/tmp/pip-2AS7Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:10:33 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)) 19:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:10:33 INFO - Running setup.py (path:/tmp/pip-1z2IgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:10:33 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)) 19:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:10:33 INFO - Running setup.py (path:/tmp/pip-RmF18j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:10:33 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)) 19:10:33 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)) 19:10:33 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)) 19:10:33 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)) 19:10:33 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)) 19:10:33 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)) 19:10:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:10:33 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 19:10:33 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 19:10:33 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 19:10:33 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 19:10:33 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 19:10:33 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 19:10:35 INFO - Downloading blessings-1.6.tar.gz 19:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:10:35 INFO - Installing collected packages: blessings 19:10:35 INFO - Running setup.py install for blessings 19:10:35 INFO - Successfully installed blessings 19:10:35 INFO - Cleaning up... 19:10:35 INFO - Return code: 0 19:10:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:10:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:10:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:10:35 INFO - Reading from file tmpfile_stdout 19:10:35 INFO - Current package versions: 19:10:35 INFO - argparse == 1.2.1 19:10:35 INFO - blessings == 1.6 19:10:35 INFO - blobuploader == 1.2.4 19:10:35 INFO - docopt == 0.6.1 19:10:35 INFO - functools32 == 3.2.3-2 19:10:35 INFO - jsonschema == 2.5.1 19:10:35 INFO - manifestparser == 1.1 19:10:35 INFO - mozInstall == 1.12 19:10:35 INFO - mozcrash == 0.17 19:10:35 INFO - mozdebug == 0.1 19:10:35 INFO - mozdevice == 0.48 19:10:35 INFO - mozfile == 1.2 19:10:35 INFO - mozhttpd == 0.7 19:10:35 INFO - mozinfo == 0.9 19:10:35 INFO - mozleak == 0.1 19:10:35 INFO - mozlog == 3.2 19:10:35 INFO - moznetwork == 0.27 19:10:35 INFO - mozprocess == 0.22 19:10:35 INFO - mozprofile == 0.28 19:10:35 INFO - mozrunner == 6.11 19:10:35 INFO - mozscreenshot == 0.1 19:10:35 INFO - mozsystemmonitor == 0.3 19:10:35 INFO - moztest == 0.7 19:10:35 INFO - mozversion == 1.4 19:10:35 INFO - psutil == 3.1.1 19:10:35 INFO - requests == 1.2.3 19:10:35 INFO - wsgiref == 0.1.2 19:10:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:10: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')]} 19:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10: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')]} 19:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:35 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 0x7fad1cc59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1133a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116b980>, '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 0x11b4a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b4f10>, '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': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', '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 19:10:35 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 19:10:35 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 19:10:35 INFO - Using env: {'DISPLAY': ':0', 19:10:35 INFO - 'HOME': '/home/cltbld', 19:10:35 INFO - 'LANG': 'en_US.UTF-8', 19:10:35 INFO - 'LANGUAGE': 'en_US:en', 19:10:35 INFO - 'LOGNAME': 'cltbld', 19:10:35 INFO - 'MAIL': '/var/mail/cltbld', 19:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:35 INFO - 'MOZ_NO_REMOTE': '1', 19:10:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:35 INFO - 'NO_EM_RESTART': '1', 19:10:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:35 INFO - 'PWD': '/builds/slave/test', 19:10:35 INFO - 'SHELL': '/bin/bash', 19:10:35 INFO - 'SHLVL': '1', 19:10:35 INFO - 'TERM': 'linux', 19:10:35 INFO - 'TMOUT': '86400', 19:10:35 INFO - 'USER': 'cltbld', 19:10:35 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', 19:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:35 INFO - '_': '/tools/buildbot/bin/python'} 19:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:35 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)) 19:10:35 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)) 19:10:35 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)) 19:10:35 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)) 19:10:35 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)) 19:10:35 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)) 19:10:35 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)) 19:10:35 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)) 19:10:35 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)) 19:10:35 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)) 19:10:35 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)) 19:10:35 INFO - Cleaning up... 19:10:35 INFO - Return code: 0 19:10:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:10: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')]} 19:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10: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')]} 19:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:35 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 0x7fad1cc59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1133a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116b980>, '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 0x11b4a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b4f10>, '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': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', '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 19:10:35 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 19:10:35 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 19:10:35 INFO - Using env: {'DISPLAY': ':0', 19:10:35 INFO - 'HOME': '/home/cltbld', 19:10:35 INFO - 'LANG': 'en_US.UTF-8', 19:10:35 INFO - 'LANGUAGE': 'en_US:en', 19:10:35 INFO - 'LOGNAME': 'cltbld', 19:10:35 INFO - 'MAIL': '/var/mail/cltbld', 19:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:35 INFO - 'MOZ_NO_REMOTE': '1', 19:10:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:35 INFO - 'NO_EM_RESTART': '1', 19:10:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:35 INFO - 'PWD': '/builds/slave/test', 19:10:35 INFO - 'SHELL': '/bin/bash', 19:10:35 INFO - 'SHLVL': '1', 19:10:35 INFO - 'TERM': 'linux', 19:10:35 INFO - 'TMOUT': '86400', 19:10:35 INFO - 'USER': 'cltbld', 19:10:35 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', 19:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:35 INFO - '_': '/tools/buildbot/bin/python'} 19:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:10:36 INFO - Cleaning up... 19:10:36 INFO - Return code: 0 19:10:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:10:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad1cc59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1133a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x116b980>, '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 0x11b4a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b4f10>, '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': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', '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 19:10:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:10:36 INFO - Using env: {'DISPLAY': ':0', 19:10:36 INFO - 'HOME': '/home/cltbld', 19:10:36 INFO - 'LANG': 'en_US.UTF-8', 19:10:36 INFO - 'LANGUAGE': 'en_US:en', 19:10:36 INFO - 'LOGNAME': 'cltbld', 19:10:36 INFO - 'MAIL': '/var/mail/cltbld', 19:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:36 INFO - 'MOZ_NO_REMOTE': '1', 19:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:36 INFO - 'NO_EM_RESTART': '1', 19:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:36 INFO - 'PWD': '/builds/slave/test', 19:10:36 INFO - 'SHELL': '/bin/bash', 19:10:36 INFO - 'SHLVL': '1', 19:10:36 INFO - 'TERM': 'linux', 19:10:36 INFO - 'TMOUT': '86400', 19:10:36 INFO - 'USER': 'cltbld', 19:10:36 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', 19:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:36 INFO - '_': '/tools/buildbot/bin/python'} 19:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:10:36 INFO - Downloading/unpacking flake8 19:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:10:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:10:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:10:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:10:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:10:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:10:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:10:38 INFO - no previously-included directories found matching 'docs/_build' 19:10:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:10:39 INFO - Running setup.py install for pep8 19:10:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:10:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:10:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:10:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:10:39 INFO - no previously-included directories found matching 'docs/_build' 19:10:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:10:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:10:39 INFO - Cleaning up... 19:10:39 INFO - Return code: 0 19:10:39 INFO - Running post-action listener: _resource_record_post_action 19:10:39 INFO - Running post-action listener: _start_resource_monitoring 19:10:39 INFO - Starting resource monitoring. 19:10:39 INFO - ##### 19:10:39 INFO - ##### Finished create-virtualenv step (success) 19:10:39 INFO - ##### 19:10:39 INFO - ##### 19:10:39 INFO - ##### Running install step. 19:10:39 INFO - ##### 19:10:39 INFO - Running pre-action listener: _resource_record_pre_action 19:10:39 INFO - Running main action method: install 19:10:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:10:39 INFO - Reading from file tmpfile_stdout 19:10:39 INFO - Detecting whether we're running mozinstall >=1.0... 19:10:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:10:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:10:39 INFO - Reading from file tmpfile_stdout 19:10:39 INFO - Output received: 19:10:39 INFO - Usage: mozinstall [options] installer 19:10:39 INFO - Options: 19:10:39 INFO - -h, --help show this help message and exit 19:10:39 INFO - -d DEST, --destination=DEST 19:10:39 INFO - Directory to install application into. [default: 19:10:39 INFO - "/builds/slave/test"] 19:10:39 INFO - --app=APP Application being installed. [default: firefox] 19:10:39 INFO - mkdir: /builds/slave/test/build/application 19:10:39 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'] 19:10:39 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 19:10:56 INFO - Reading from file tmpfile_stdout 19:10:56 INFO - Output received: 19:10:56 INFO - /builds/slave/test/build/application/firefox/firefox 19:10:56 INFO - Running post-action listener: _resource_record_post_action 19:10:56 INFO - ##### 19:10:56 INFO - ##### Finished install step (success) 19:10:56 INFO - ##### 19:10:56 INFO - ##### 19:10:56 INFO - ##### Running run-tests step. 19:10:56 INFO - ##### 19:10:56 INFO - Running pre-action listener: _resource_record_pre_action 19:10:56 INFO - Running main action method: run_tests 19:10:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:10:56 INFO - Python 2.7.3 19:10:56 INFO - Return code: 0 19:10:56 INFO - grabbing minidump binary from tooltool 19:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:10:56 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 0x116b980>, '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 0x11b4a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11b4f10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:10:56 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 19:10:56 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 19:10:56 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 19:10:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:10:56 INFO - Return code: 0 19:10:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:10:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:10:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:10:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:10:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:10:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:10:57 INFO - Return code: 0 19:10:57 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/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 19:10:57 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/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 19:10:57 INFO - Using env: {'DISPLAY': ':0', 19:10:57 INFO - 'HOME': '/home/cltbld', 19:10:57 INFO - 'LANG': 'en_US.UTF-8', 19:10:57 INFO - 'LANGUAGE': 'en_US:en', 19:10:57 INFO - 'LOGNAME': 'cltbld', 19:10:57 INFO - 'MAIL': '/var/mail/cltbld', 19:10:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:10:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:10:57 INFO - 'MOZ_NO_REMOTE': '1', 19:10:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:10:57 INFO - 'NO_EM_RESTART': '1', 19:10:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:10:57 INFO - 'PWD': '/builds/slave/test', 19:10:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:10:57 INFO - 'SHELL': '/bin/bash', 19:10:57 INFO - 'SHLVL': '1', 19:10:57 INFO - 'TERM': 'linux', 19:10:57 INFO - 'TMOUT': '86400', 19:10:57 INFO - 'USER': 'cltbld', 19:10:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442', 19:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:10:57 INFO - '_': '/tools/buildbot/bin/python'} 19:10:57 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/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 19:10:57 INFO - mozversion application_buildid: 20160625163004 19:10:57 INFO - mozversion application_changeset: 6a0632dcd94b8a5efbd80e59e2fb12188becc440 19:10:57 INFO - mozversion application_display_name: Nightly 19:10:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:10:57 INFO - mozversion application_name: Firefox 19:10:57 INFO - mozversion application_remotingname: firefox 19:10:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:10:57 INFO - mozversion application_vendor: Mozilla 19:10:57 INFO - mozversion application_version: 50.0a1 19:10:57 INFO - mozversion platform_buildid: 20160625163004 19:10:57 INFO - mozversion platform_changeset: 6a0632dcd94b8a5efbd80e59e2fb12188becc440 19:10:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:10:57 INFO - mozversion platform_version: 50.0a1 19:10:57 INFO - using testdate: 1466907057 19:10:57 INFO - actual date: 1466907057 19:10:57 INFO - starting webserver on 'localhost:44265' 19:10:57 INFO - SUITE-START | Running 2 tests 19:10:57 INFO - TEST-START | dromaeo_css 19:10:57 INFO - operating with platform_type : linux_ 19:10:57 INFO - Initialising browser for dromaeo_css test... 19:10:57 INFO - TEST-INFO | started process 19491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvRg2OK/profile http://localhost:44265/getInfo.html) 19:11:03 INFO - PROCESS | 19491 | __metrics Screen width/height:1600/1200 19:11:03 INFO - PROCESS | 19491 | colorDepth:24 19:11:03 INFO - PROCESS | 19491 | Browser inner width/height: 1024/697 19:11:03 INFO - PROCESS | 19491 | __metrics 19:11:03 ERROR - PROCESS | 19491 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 19:11:05 INFO - TEST-INFO | 19491: exit 0 19:11:05 INFO - Browser initialized. 19:11:05 INFO - Running cycle 1/1 for dromaeo_css test... 19:11:05 INFO - TEST-INFO | started process 19616 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvRg2OK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:11:17 INFO - PROCESS | 19616 | RSS: Main: 185016320 19:11:17 INFO - PROCESS | 19616 | 19:12:06 INFO - PROCESS | 19616 | 1466907126731 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] 19:14:14 INFO - PROCESS | 19616 | Cycle 1(1): loaded http://localhost:44265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44265/tests/dromaeo/cssquery-ext.html) 19:14:15 INFO - PROCESS | 19616 | RSS: Main: 188997632 19:14:15 INFO - PROCESS | 19616 | 19:17:18 INFO - PROCESS | 19616 | Cycle 1(1): loaded http://localhost:44265/tests/dromaeo/cssquery-ext.html (next: http://localhost:44265/tests/dromaeo/cssquery-jquery.html) 19:17:18 INFO - PROCESS | 19616 | RSS: Main: 187867136 19:17:18 INFO - PROCESS | 19616 | 19:20:20 INFO - PROCESS | 19616 | Cycle 1(1): loaded http://localhost:44265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44265/tests/dromaeo/cssquery-mootools.html) 19:20:21 INFO - PROCESS | 19616 | RSS: Main: 189558784 19:20:21 INFO - PROCESS | 19616 | 19:23:22 INFO - PROCESS | 19616 | Cycle 1(1): loaded http://localhost:44265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44265/tests/dromaeo/cssquery-prototype.html) 19:23:23 INFO - PROCESS | 19616 | RSS: Main: 186720256 19:23:23 INFO - PROCESS | 19616 | 19:26:25 INFO - PROCESS | 19616 | Cycle 1(1): loaded http://localhost:44265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44265/tests/dromaeo/cssquery-yui.html) 19:26:26 INFO - PROCESS | 19616 | RSS: Main: 189034496 19:26:26 INFO - PROCESS | 19616 | 19:29:28 INFO - PROCESS | 19616 | Cycle 1(1): loaded http://localhost:44265/tests/dromaeo/cssquery-yui.html (next: http://localhost:44265/tests/dromaeo/cssquery-dojo.html) 19:29:29 INFO - PROCESS | 19616 | RSS: Main: 190124032 19:29:29 INFO - PROCESS | 19616 | 19:29:29 INFO - PROCESS | 19616 | __start_tp_report 19:29:29 INFO - PROCESS | 19616 | _x_x_mozilla_page_load 19:29:29 INFO - PROCESS | 19616 | _x_x_mozilla_page_load_details 19:29:29 INFO - PROCESS | 19616 | |i|pagename|runs| 19:29:29 INFO - PROCESS | 19616 | |0;dojo.html;3119.56326114344;3167.4140284047467;3192.7445804335657;3198.1524895902576;3208.197950512373;5502.119660854264;5526.640768350059;5593.105103183491;5617.354004289497;5642.746076426561;5432.75552600133;5493.340799104113;5533.778648854041;5551.583631227654;5553.611247212697;4962.131626965275;5003.924941125886;5092.388913330406;5161.870953226162;5199.6360254782185;789.2894776862323;4921.064997650453;4953.777080031389;5044.924326135111;5154.664946778466;4945.332380128672;4986.800527978913;5001.824936127255;5007.399112106534;5035.84892453227;5040.067587496325;5045.495450454925;5055.393352797688;5060.342155519759;5096.61775366849;4891.902161956741;4912.606991440676;4978.7510624469;5021.322121513585;5042.369703787027;5562;5594.720263986825;5610.887782244373;5641.8589535261535;5649.124385720179;6035.758569657209;6047.274327080734;6059.151718759377;6063.211782468251;6063.666498342589;5771.682557459338;5948.37542058082;6001.279846418458;6006.8498287542725;6041.335453100155;5646.096624540095;5650.152477128422;5654.802081927113;5654.943450565524;5665.206871038058;6162.137300777895;6178.382161783876;6179.227596550431;6181.35095814933;6184.165137706352;5683;5723.427657234243;5749.13762935563;5757.337906140764;5793.04414771558;5826.796062137805;5856.297244330623;5862.970685146547;5868.23712917318;5873.618214816023;5768.2501274834;5793.710314484343;5835.008048631743;5845.240118784531;5860.413958604191;5828.300603927556;5927.022041363213;5941;5969.074793407029;5974.193483879708;4501.639868810487;4506.324051392317;4507.661925355612;4552.2488789350045;4557.635389168859;3996.9200615987515;4005.7997100144876;4051.331530297468;4078.5921407858978;4102.856400026045;5560.888782224333;5576.219329293902;5602.635828671123;5748.45389687979;5783.537317014713;5967.701614919237;5968.641881487038;5983.341832398432;5983.581149319506;5995.640261584319;5497.780088796483;5635.408282130399;5660.745266463019;5674.2623458950075;5689.743961521742;5106.361704786902;5141.331626888481;5142.434332223453;5143.048536020773;5189.143791274398;6211.223597050369;6228.22147231596;6235.750569977241;6237.189165408558;6239.96880015597;5834.94165058344;5907.911381329198;5978.043513037893;6034.39656034393;6036;6182.938170618237;6213;6220.129181914626;6233;6243.063540468966;5847;5876.94123058781;5886.146508756292;5910.970445147918;5952.464278214981;5815.360310365941;5954.851128721816;5998;6003;6017.699115044318;5823.679697616672;5883.882322353615;5889.263842019747;5895.14520394549;5895.263092113486;5870.295564532284;5888.705564721832;5889.411058894077;5900.557458190567;5907;5632.633878797865;5681.318241810844;5704.714764261853;5727.36998930109;5811.157382179645;5885.970570147122;5920.171176035445;5922.585419020799;5924.911126333022;5934.080217566284;5573;5724.313082429969;5734.455226753452;5745.971270143623;5775.797847075332 19:29:29 INFO - PROCESS | 19616 | |1;ext.html;547.7124509632442;598.9670568118753;613.2640831002798;628.1927722876102;630.1650313334833;33691.49462758061;36876;43976.120477590426;45057;45333.54666453334;47680.523194768044;47951.52048479514;48037;48113.278300825514;48285;8884.822303553941;9022.819543609125;9042.954785226098;9046.638134474646;9048.819023619524;8855;8960.059193784657;8985.640574377017;9000.144986226298;9030.68392606259;8980.685676001342;9007.729768106967;9050.1854833065;9065.592048357807;9085.046070162636;8988.77528061797;9004.324675649319;9030.819383612357;9034.232090272302;9040.095990400972;8883.555822208864;8957.686480973134;8984.10158984103;8992.730218093468;8996.910030899739;45082.098358032985;45433;45450.54549454496;45474;45530;3408.744344174172;3453.17123890267;3493;3601.9279614407565;3962.722609417342;31243.84378078118;31737;32107;34249.657503424896;34279.657203427894;4275.46556680415;4434.357018232338;4454.732716037016;4564;4601.401817763669;353538.99999999744;354175;356475;357529;359692;63451.36548634455;63503.68248158822;63847.6807615959;63854.36145638484;63955.36044639587;36314.63685363165;36723.816380917924;36942;38752.418713719315;39167.804160979584;16999.98000119997;17299.394521191698;17301.134943252786;17323.56691082733;17362.39231626887;11260.718482038015;11323.660290191307;11352.262102963447;11353.716157096138;11370.374629395297;20463.07916143777;20503.17987280492;20554.486137846674;20578.176872925214;20628.896855515628;7197.424206063502;7322.743703970335;7489.951406803052;7499.737509187153;7501.849963000709;922.8569571716395;1030.2273295028729;1056.6882769582992;1155.7457359380924;1166.125405945541;33508.32983340368;34311;34520;34944.30111397809;35103.4734478983;1158.652404278713;1170.6136974798296;1185.3776767197292;1197.275648232824;1219.1587804414926;17622.647547048986;17698.203580838894;17813.46559603214;18005.36981205678;18008.36970706019;557304;562447;563298;568228;568383;63623;64069.679651602375;64143;64165.67917160384;64218.35781642217;1310;1338.8728070833256;1361.047266913145;1371.2321100184129;1374.6838227207597;31888;32952;33580.328393432486;33634.831825840716;34180.31639367149;54426.727866362;55017;55072;55115.44884551103;55155.44844551664;464646;465365;465731;466036;467116;28783.136505904855;29799.10602681923;29804.55293170561;29904.85047574748;29985.250368740955;49479.50520494749;51597.48402516077;51970.740146299024;52336;53402.73298633482;43325;43477.34783978306;43687.04044802124;44740.55259447364;45259;42578.7226383209;43284.35073473964;43495.78252108719;43783.781081095665;44140.77929610331;43309.78345108254;44874.551254487036;44891;45688.31467527923;45798;41961.58038419577;46800.297995530775;47126.76436617795;47751.28373074476;47876.52123478721;34663.826680866434;35750.821245894644;36105.0973725659;36233.81883090568;36251 19:29:29 INFO - PROCESS | 19616 | |2;jquery.html;372.121792569536;391.4402404561477;394.2214127098979;394.9269385163743;407.9510458744949;17695.380661676845;18123.4562963111;20561;20624.896875515602;20654.896725516388;11996.40017999101;12126.090543209273;12164.882696485865;12282.63152105436;12302.876971230307;5128.5640720538795;5267.631265811395;5309.814156504523;5312.3093997780425;5313.149896016638;3775.8678446254385;5548.278723765925;5835.474807267345;5843.883122337551;5928.762849486037;5849.385814489481;5865.090910908816;5867.794627188049;5874.88250234995;5919.526437884959;5659.26429564154;5812.82561523155;5912.260967379078;5964.194833697438;5990.9400905990815;5374.274472946141;5493.395726470125;5528.806491772809;5543.417941116206;5646.2942132233475;12338.383080845922;12395.132340736061;15781.68436631261;23249;23523;2337.6960995070704;2404.314770290459;2457.3610861176044;2492.9252122436355;2898.130560831742;6030.758769649209;6079.209702738615;9921.10710036093;10308.845367319496;10388.84416733742;1911.9044047797554;1921.3947606504046;1960.362882063335;1969.8916559589218;1975.5456245063572;62811.68594157;83100.16899830985;83806;84588.57705711432;85368.57315713381;9732.318737688294;9884.55519501624;9920.503974801231;10070.69787906364;10255.156028510339;13058.477660893457;13125.212487250796;13129;13149.802752958713;13232.13991090576;7718.729844455529;7732.884006739903;7794.064712234568;7794.220577942274;7879.842403151905;7703.807404814813;7730.304272615379;7757.069151701832;7873.960630196812;7929.960350198212;4068.5931406859077;4085.571015043437;4088.7751173685137;4094.1811637672586;4203.6637069034405;1529.946451874179;1663.6506333670065;1744.7382892566216;1756.1833747307564;1766.0904634113442;1000.2448151645461;1009.5658866687395;1029.8764148302253;1073.8013467508536;1077.7874890747908;18437.5390615233;19451.22195112208;19571.706424403645;20733.58532829335;20856.687149692767;984.9753756156153;994.7811481474064;998.825205589019;1001.5943542865151;1029.7940411917646;10612.151027917902;10973.693269408299;10990.890091098987;11071.05895998833;11155.665330040112;476929;477016;479425;484898;488003;100778.496107519;101233;101782;101819;102891.48554257181;1009.5608410341379;1015.28422462164;1031.3708637730979;1035.13566172247;1050.669039252633;17530.47408577745;17632.206550704992;17735.645287094445;17764.644707106043;18005.369812056517;38952.6104738949;41928;43369.3494597575;43692;45346.54653453423;62765.68617156885;62828.51699110076;65138.348616515126;65230.67384663236;65389.67305163444;6902.206246281742;7525.58609276495;7801.687932482864;7996.24035716606;8554.828903422022;8101.432899697201;11585.478653460783;13263.734725305632;13399.464021439424;13554.118982266122;11404.258723182966;11404.315741055563;11554.884451155382;11606.825897611712;11617.825732613848;11763.588274410355;11770.470328835394;11868.465919033491;11912.821307680566;12019.218750781522;11668.591599293984;11850.525978960744;12018.399080045789;12655.11414200997;12699.428525716181;7476.962615186889;7671.580757559869;7741.496802707806;7907.406944479302;7976.282134607914;9992.750181245527;11356.26184298018;11512.769744604893;11766.705832354259;11779.05767538612 19:29:29 INFO - PROCESS | 19616 | |3;mootools.html;1494.5292232946622;1510.3882927414395;1608.4772448954093;1709.5469700529354;1764.4089230107913;8116;8561.357898157648;8677.69628063017;9467.715968520939;9479.47862867542;8804.603792829323;8998.460092394462;9150.267978561717;9162.90837091629;9172.128647778467;2268.432891777056;2273.920412785553;2287.7597852225526;2288.519410923708;2293.2546922250253;2244.068711484732;2255.255765597357;2278.7835155660187;2308.722953245613;2311.884405779704;2270.3302525754943;2270.3529494094187;2280.1221529711097;2303.6890019847274;2342.1919437794018;2194.6707993800896;2212.2920665387082;2223.2218723446663;2239.798418142375;2240.1487434774763;2255.639097744353;2280.7947284744455;2281.6121259385777;2299.7815207555254;2300.2524179641514;8985.820283594292;9055.818883622356;9057.049009854003;9057.68298109563;9063.637454501812;4944.208926571731;5079.085764562377;5082.364704411949;5086.008228395464;5100.311457953166;3090.629124505051;3185.442547554169;3346.4478361070396;3354.9832250838836;3355.9161020974425;1054.2830875004993;1085.5494969587612;1087.3584585094832;1094.8303013032992;1100.4662738571785;12187.756244875052;12232.449539770643;12253.326067066308;12271.447784849703;12307.138500304982;4490.461144662661;4503.301988191835;4589.2657174851865;4589.609883159902;4607.502561667471;10225.795484090277;10261.692149235534;10312.381257124596;10325.586976520855;10380.896191038144;5212.609054320941;5240.371155461293;5249.238860365225;5258.684478931276;5261.842144735664;4189.4344263524645;4622.4684161321875;4696.929546056812;4710.6702530823195;4914.852554423373;3924.941125883114;3957.7427467215116;3973.5827738087664;3978.6817054635558;4110.486189226347;1213.4721396192508;1214.1500949335325;1220.8412906322121;1228.3612521488776;1235.5922545559943;883.3816328570026;923.8568021956607;941.4022095969109;946.6071580294239;956.7655924298452;5921.703914804242;5981.880362392728;6047.879042419127;6111.633302001894;6379.585326953733;406.4634682219501;413.5347733799476;426.0775421213101;430.30076126294773;433.9978300108479;4100.200460910094;4109.321961876257;4130.91738165235;4139.503259608866;4158.480189976253;10986.395748233925;11211.831822522669;11328;11386.373749443694;11392.943035284936;11132.833007504894;11213.71965700864;11227.607033753942;11233.213675042833;11256;7874.842503150019;8214.99999999988;8235.29999950011;8453.66185352579;8553.871691924625;5947.167396564398;6047.758089676539;6059.424354686298;6084.026555751058;6151.446369826737;10176;10188.337758046;10250.692479225636;10260.281780275607;10391.324563903323;10145.54345054489;10267.281290309607;10278.588856445958;10551.103156231806;10554.102901253173;7104.822379440556;7663.923360766321;7838.490498117604;7923.920760792318;7977.282044616012;8856.291496680378;8887.244584210415;8988.10118988096;9037.457752534869;9050.728478145666;7540.17058123617;7733.7679869604;7778.766637000899;7804.609769511615;7825.413094018085;7627.54234745917;7633.69465221385;7674.309312161932;7742.070951485858;7758.4181186410115;7247.383972362408;7258.383037441666;7263;7276.818079548054;7342.412606991535;4832;4976.0794253063295;5034.69098034521;5090.745462726923;5094.6688465249645;5203.349581302337;5289.7355132242465;5300.5759539236;5313.760880760452;5397.433269506802 19:29:29 INFO - PROCESS | 19616 | |4;prototype.html;315.2701496036675;327.3698131097637;328.5236407209547;329.4070672788979;330.10706040161364;5531.419200983889;5587.664740115591;5601.859953501159;5628.465295796897;5736.7952729926665;5589.664620122796;5630.465105814951;5667.149927510865;5680.233168522248;5718.428157184279;4386.53051227839;4386.934195987063;4403.0973650401675;4420.1159768046355;4432.645388368923;4217.936730949038;4291.249031419489;4318.956810431887;4397.362382454542;4406.911861762763;4232.6613870890405;4234.047339348637;4236.533981262059;4259.850905218318;4279.40088387626;4265.360195970598;4311.611954924057;4312.654987600984;4315.3095504719095;4331.8700438986725;3693.4275187346007;3761.8119094045187;3771.3400154973046;3771.8868433947027;3772.5661548921953;5410.267814753524;5468.152436372368;5470.261514695505;5485.780568777244;5505.3393592768725;4905.117078925792;4939.58013568847;4971.850844474671;4975.477574854624;4984.725840078794;5657.405972372882;5834.299884013945;5869.530437564985;5884.558658100659;5944.851378715523;4150.460440142792;4157.97921010396;4158.708890377675;4166.291730405838;4172;5769.1346298055205;5910.615809972381;6119.204503414572;6147.200863887666;6162.198914141133;4133.2146892091005;4155.2728272552185;4155.958440415618;4158.480189976253;4162.646175075092;4132.380142978517;4133.483314585676;4205.453291072141;4212.599803018708;4222.4299719538085;4635.351050852883;4892.559669629751;4901.901961960741;4903.607711383081;4920.6555541111775;5858.50202732764;5859.853503662357;5881.176635271066;5908.965930962065;5918.763249470059;1453.5754960139122;1453.9273036348352;1464.1215270837413;1465.2453986196904;1469.3314541883417;894.5571941888807;922.9847168115019;932.9224745419052;933.8972713001565;944.8299306124964;5044.445111037783;5085.262636917701;5104.2088476286235;5107.61692873036;5125.538701516882;5416.51251387377;5429.497973806872;5433.212184233264;5433.641589602599;5481.561475081984;4888.291197776302;4968.931749266832;5111.923321150186;5152.407473140562;5218;2841.261272069277;2933.2813460701836;2940.7206315400003;2942.3526824098662;2957.7190166934106;5496.862578435571;5516.393196748354;5539.639923404966;5543.196236545759;5648.548116150698;5544;5723.742431590588;6253.499720022387;6254.249490061222;6290.622562646256;6315.368463153648;6371.553991220663;6392.680365981682;6394.26465956421;6403.263624683221;6044.214252147192;6104.7485265521345;6141.232345956755;6151.92403798101;6171;6015.819525414245;6063.272407311151;6094;6117.632942023492;6122.5918038852205;6160.784372546939;6213.875722485615;6273;6299.842503937438;6305.274893387319;4265.786710664516;4272.209641216385;4307.590778876001;4313.97843010783;4326.697131200785;6067.787627433018;6104.847378815388;6140.293866205444;6150.969245153746;6166.128758280908;5910.438508341701;5932.317783454958;5940.198073260054;5950.196723442453;5971.91042134377;5842.503387211965;5894.498967587803;5897.970510147422;5912.822615321547;5948.791792287249;5503.449655034465;5742.989953516236;5761.135829625589;5798.217240672455;5817.661937754425;5931.881362372815;5934.732937017931;5934.97032514852;5947.988841896801;5948.970255148696;5606.467385598362;5759.337676167127;5772.9711351442975;5802.738876750641;5823.912641310469 19:29:29 INFO - PROCESS | 19616 | |5;yui.html;760.8059944714097;797.7185250184472;801.603206412825;806.3065763443437;843.6203708331251;14970.5508834735;15962.361505539764;15967.840321596796;15975.360985560592;15976.680466390666;13835;14110;14192.36134373953;14205.218712970809;14251.287435628203;798.3294033012254;806.8426656801926;809.8866158737782;811.9878201826948;813.0649752784286;790.4901338636575;803.6664784114614;820.5117954816874;826.1573195340749;826.9669213231464;850.5619605902934;856.327782690588;858.5792961448908;860.290260535058;864.4985908173276;850.022474154727;852.4927668037508;853.4324674091753;855.1234984141242;855.1277696749343;623.563505546115;624.3007831229007;624.307019208678;624.3631495874183;624.388099662329;14440.49458268966;14466.421343146261;14467.92766036163;14478.927605361905;14543.27283635814;14375.209363485004;14510.637234069127;14551.854481455155;14561.854381456156;14665.26673666323;11558.364289964049;11824.822627660593;11875.821862672066;11930.582429614922;12275.877241227563;3855.6915446764474;3903.82600887914;3912.0219945013746;3916.1776027034357;4047.332190188615;74940.25059749387;79020.60489697514;80510.59744701297;80530.59734701348;80784.19215807825;10646.30046802958;10720.517576709066;10808.675739727822;10828.623354836152;10985.395803230898;21151.78848211529;21152;21233.575328493345;21239.256626018014;21289;8204.302634276153;8310.168983101641;8370.581470926429;8380.832383352299;8687.131286871389;4751.429828420542;4924.187509060965;4926.310316555685;4978.47725988766;5082.618803589746;3546.4503002034726;3675.46705727668;3682.6869716074434;3697.6487233712755;3705.7035437164964;623.0094150301043;624.6907780648608;631.7062565906875;634.2452481546944;638.9073584330339;613.362103412455;670.8825955457874;689.6173172788627;733.2008111158756;758.309937956457;9405.341626086245;9937.304388692866;10250.179985601284;10309.948450257702;10340.534675939602;701.421327404893;702.3222590200481;708.4190963410057;719.9064121664151;743.4461326311932;4888.7311197884455;4937.160682683881;5029.371328583927;5034.395872495251;5122.436531981479;97947;114665;115215.42392287985;121653.39173304253;123311;99611.50194249128;100852;101473;102647;104044;27469.038583649875;56506;56706;89897;90323.54838225766;10006.749831254278;10024.348417352849;10053.9477689776;10201.54093065799;10234.232432567438;42970.78514607407;51825.22262165995;52706.47293527169;53123.73438132785;53342.73328633332;54904.72547637236;55796.163057553356;65794;72863.63568182125;79140.60429697814;14066.718665626426;14360.497382591559;14361.64095897611;14376.424943002581;14548.345324460637;14858;15380.615484612974;15458.072515649097;15641.608959776097;16298.42955496552;13548.525801596898;13765.587032389045;13942.302884855919;14028.719425611227;14408.207548584509;13392.866071339162;13639.863601363859;13678;13934.303284835514;14125.223112728487;12860.549880754128;14101.224432656303;14110;14391.424343026161;14529.636759081108;11569.710757231136;11740.882591173979;11815.291082535075;11914.40427978615;12328.568500102454;11228.606998755004;11234.141172042879;11265.319939068668;11595.710107247387;11658 19:29:29 INFO - PROCESS | 19616 | __end_tp_report 19:29:29 INFO - PROCESS | 19616 | __start_cc_report 19:29:29 INFO - PROCESS | 19616 | _x_x_mozilla_cycle_collect,346 19:29:29 INFO - PROCESS | 19616 | __end_cc_report 19:29:29 INFO - PROCESS | 19616 | __startTimestamp1466908169134__endTimestamp 19:29:29 INFO - PROCESS | 19616 | 19:29:29 INFO - PROCESS | 19616 | ------- Summary: start ------- 19:29:29 INFO - PROCESS | 19616 | Number of tests: 6 19:29:29 INFO - PROCESS | 19616 | 19:29:29 INFO - PROCESS | 19616 | [#0] dojo.html Cycles:165 Average:5505.94 Median:5748.45 stddev:743.47 (12.9%) stddev-sans-first:721.80 19:29:29 INFO - PROCESS | 19616 | Values: 3119.6 3167.4 3192.7 3198.2 3208.2 5502.1 5526.6 5593.1 5617.4 5642.7 5432.8 5493.3 5533.8 5551.6 5553.6 4962.1 5003.9 5092.4 5161.9 5199.6 789.3 4921.1 4953.8 5044.9 5154.7 4945.3 4986.8 5001.8 5007.4 5035.8 5040.1 5045.5 5055.4 5060.3 5096.6 4891.9 4912.6 4978.8 5021.3 5042.4 5562.0 5594.7 5610.9 5641.9 5649.1 6035.8 6047.3 6059.2 6063.2 6063.7 5771.7 5948.4 6001.3 6006.8 6041.3 5646.1 5650.2 5654.8 5654.9 5665.2 6162.1 6178.4 6179.2 6181.4 6184.2 5683.0 5723.4 5749.1 5757.3 5793.0 5826.8 5856.3 5863.0 5868.2 5873.6 5768.3 5793.7 5835.0 5845.2 5860.4 5828.3 5927.0 5941.0 5969.1 5974.2 4501.6 4506.3 4507.7 4552.2 4557.6 3996.9 4005.8 4051.3 4078.6 4102.9 5560.9 5576.2 5602.6 5748.5 5783.5 5967.7 5968.6 5983.3 5983.6 5995.6 5497.8 5635.4 5660.7 5674.3 5689.7 5106.4 5141.3 5142.4 5143.0 5189.1 6211.2 6228.2 6235.8 6237.2 6240.0 5834.9 5907.9 5978.0 6034.4 6036.0 6182.9 6213.0 6220.1 6233.0 6243.1 5847.0 5876.9 5886.1 5911.0 5952.5 5815.4 5954.9 5998.0 6003.0 6017.7 5823.7 5883.9 5889.3 5895.1 5895.3 5870.3 5888.7 5889.4 5900.6 5907.0 5632.6 5681.3 5704.7 5727.4 5811.2 5886.0 5920.2 5922.6 5924.9 5934.1 5573.0 5724.3 5734.5 5746.0 5775.8 19:29:29 INFO - PROCESS | 19616 | 19:29:29 INFO - PROCESS | 19616 | [#1] ext.html Cycles:180 Average:63020.63 Median:44807.55 stddev:124565.18 (278.0%) stddev-sans-first:124826.31 19:29:29 INFO - PROCESS | 19616 | Values: 547.7 599.0 613.3 628.2 630.2 33691.5 36876.0 43976.1 45057.0 45333.5 47680.5 47951.5 48037.0 48113.3 48285.0 8884.8 9022.8 9043.0 9046.6 9048.8 8855.0 8960.1 8985.6 9000.1 9030.7 8980.7 9007.7 9050.2 9065.6 9085.0 8988.8 9004.3 9030.8 9034.2 9040.1 8883.6 8957.7 8984.1 8992.7 8996.9 45082.1 45433.0 45450.5 45474.0 45530.0 3408.7 3453.2 3493.0 3601.9 3962.7 31243.8 31737.0 32107.0 34249.7 34279.7 4275.5 4434.4 4454.7 4564.0 4601.4 353539.0 354175.0 356475.0 357529.0 359692.0 63451.4 63503.7 63847.7 63854.4 63955.4 36314.6 36723.8 36942.0 38752.4 39167.8 17000.0 17299.4 17301.1 17323.6 17362.4 11260.7 11323.7 11352.3 11353.7 11370.4 20463.1 20503.2 20554.5 20578.2 20628.9 7197.4 7322.7 7490.0 7499.7 7501.8 922.9 1030.2 1056.7 1155.7 1166.1 33508.3 34311.0 34520.0 34944.3 35103.5 1158.7 1170.6 1185.4 1197.3 1219.2 17622.6 17698.2 17813.5 18005.4 18008.4 557304.0 562447.0 563298.0 568228.0 568383.0 63623.0 64069.7 64143.0 64165.7 64218.4 1310.0 1338.9 1361.0 1371.2 1374.7 31888.0 32952.0 33580.3 33634.8 34180.3 54426.7 55017.0 55072.0 55115.4 55155.4 464646.0 465365.0 465731.0 466036.0 467116.0 28783.1 29799.1 29804.6 29904.9 29985.3 49479.5 51597.5 51970.7 52336.0 53402.7 43325.0 43477.3 43687.0 44740.6 45259.0 42578.7 43284.4 43495.8 43783.8 44140.8 43309.8 44874.6 44891.0 45688.3 45798.0 41961.6 46800.3 47126.8 47751.3 47876.5 34663.8 35750.8 36105.1 36233.8 36251.0 19:29:29 INFO - PROCESS | 19616 | 19:29:29 INFO - PROCESS | 19616 | [#2] jquery.html Cycles:180 Average:28630.65 Median:2430.84 stddev:79812.50 (3283.3%) stddev-sans-first:80008.19 19:29:29 INFO - PROCESS | 19616 | Values: 372.1 391.4 394.2 394.9 408.0 17695.4 18123.5 20561.0 20624.9 20654.9 11996.4 12126.1 12164.9 12282.6 12302.9 5128.6 5267.6 5309.8 5312.3 5313.1 3775.9 5548.3 5835.5 5843.9 5928.8 5849.4 5865.1 5867.8 5874.9 5919.5 5659.3 5812.8 5912.3 5964.2 5990.9 5374.3 5493.4 5528.8 5543.4 5646.3 12338.4 12395.1 15781.7 23249.0 23523.0 2337.7 2404.3 2457.4 2492.9 2898.1 6030.8 6079.2 9921.1 10308.8 10388.8 1911.9 1921.4 1960.4 1969.9 1975.5 62811.7 83100.2 83806.0 84588.6 85368.6 9732.3 9884.6 9920.5 10070.7 10255.2 13058.5 13125.2 13129.0 13149.8 13232.1 7718.7 7732.9 7794.1 7794.2 7879.8 7703.8 7730.3 7757.1 7874.0 7930.0 4068.6 4085.6 4088.8 4094.2 4203.7 1529.9 1663.7 1744.7 1756.2 1766.1 1000.2 1009.6 1029.9 1073.8 1077.8 18437.5 19451.2 19571.7 20733.6 20856.7 985.0 994.8 998.8 1001.6 1029.8 10612.2 10973.7 10990.9 11071.1 11155.7 476929.0 477016.0 479425.0 484898.0 488003.0 100778.5 101233.0 101782.0 101819.0 102891.5 1009.6 1015.3 1031.4 1035.1 1050.7 17530.5 17632.2 17735.6 17764.6 18005.4 38952.6 41928.0 43369.3 43692.0 45346.5 62765.7 62828.5 65138.3 65230.7 65389.7 6902.2 7525.6 7801.7 7996.2 8554.8 8101.4 11585.5 13263.7 13399.5 13554.1 11404.3 11404.3 11554.9 11606.8 11617.8 11763.6 11770.5 11868.5 11912.8 12019.2 11668.6 11850.5 12018.4 12655.1 12699.4 7477.0 7671.6 7741.5 7907.4 7976.3 9992.8 11356.3 11512.8 11766.7 11779.1 19:29:29 INFO - PROCESS | 19616 | 19:29:29 INFO - PROCESS | 19616 | [#3] mootools.html Cycles:180 Average:5838.73 Median:2462.23 stddev:3403.91 (138.2%) stddev-sans-first:3397.80 19:29:29 INFO - PROCESS | 19616 | Values: 1494.5 1510.4 1608.5 1709.5 1764.4 8116.0 8561.4 8677.7 9467.7 9479.5 8804.6 8998.5 9150.3 9162.9 9172.1 2268.4 2273.9 2287.8 2288.5 2293.3 2244.1 2255.3 2278.8 2308.7 2311.9 2270.3 2270.4 2280.1 2303.7 2342.2 2194.7 2212.3 2223.2 2239.8 2240.1 2255.6 2280.8 2281.6 2299.8 2300.3 8985.8 9055.8 9057.0 9057.7 9063.6 4944.2 5079.1 5082.4 5086.0 5100.3 3090.6 3185.4 3346.4 3355.0 3355.9 1054.3 1085.5 1087.4 1094.8 1100.5 12187.8 12232.4 12253.3 12271.4 12307.1 4490.5 4503.3 4589.3 4589.6 4607.5 10225.8 10261.7 10312.4 10325.6 10380.9 5212.6 5240.4 5249.2 5258.7 5261.8 4189.4 4622.5 4696.9 4710.7 4914.9 3924.9 3957.7 3973.6 3978.7 4110.5 1213.5 1214.2 1220.8 1228.4 1235.6 883.4 923.9 941.4 946.6 956.8 5921.7 5981.9 6047.9 6111.6 6379.6 406.5 413.5 426.1 430.3 434.0 4100.2 4109.3 4130.9 4139.5 4158.5 10986.4 11211.8 11328.0 11386.4 11392.9 11132.8 11213.7 11227.6 11233.2 11256.0 7874.8 8215.0 8235.3 8453.7 8553.9 5947.2 6047.8 6059.4 6084.0 6151.4 10176.0 10188.3 10250.7 10260.3 10391.3 10145.5 10267.3 10278.6 10551.1 10554.1 7104.8 7663.9 7838.5 7923.9 7977.3 8856.3 8887.2 8988.1 9037.5 9050.7 7540.2 7733.8 7778.8 7804.6 7825.4 7627.5 7633.7 7674.3 7742.1 7758.4 7247.4 7258.4 7263.0 7276.8 7342.4 4832.0 4976.1 5034.7 5090.7 5094.7 5203.3 5289.7 5300.6 5313.8 5397.4 19:29:29 INFO - PROCESS | 19616 | 19:29:29 INFO - PROCESS | 19616 | [#4] prototype.html Cycles:180 Average:4865.07 Median:5504.39 stddev:1464.40 (26.6%) stddev-sans-first:1428.14 19:29:29 INFO - PROCESS | 19616 | Values: 315.3 327.4 328.5 329.4 330.1 5531.4 5587.7 5601.9 5628.5 5736.8 5589.7 5630.5 5667.1 5680.2 5718.4 4386.5 4386.9 4403.1 4420.1 4432.6 4217.9 4291.2 4319.0 4397.4 4406.9 4232.7 4234.0 4236.5 4259.9 4279.4 4265.4 4311.6 4312.7 4315.3 4331.9 3693.4 3761.8 3771.3 3771.9 3772.6 5410.3 5468.2 5470.3 5485.8 5505.3 4905.1 4939.6 4971.9 4975.5 4984.7 5657.4 5834.3 5869.5 5884.6 5944.9 4150.5 4158.0 4158.7 4166.3 4172.0 5769.1 5910.6 6119.2 6147.2 6162.2 4133.2 4155.3 4156.0 4158.5 4162.6 4132.4 4133.5 4205.5 4212.6 4222.4 4635.4 4892.6 4901.9 4903.6 4920.7 5858.5 5859.9 5881.2 5909.0 5918.8 1453.6 1453.9 1464.1 1465.2 1469.3 894.6 923.0 932.9 933.9 944.8 5044.4 5085.3 5104.2 5107.6 5125.5 5416.5 5429.5 5433.2 5433.6 5481.6 4888.3 4968.9 5111.9 5152.4 5218.0 2841.3 2933.3 2940.7 2942.4 2957.7 5496.9 5516.4 5539.6 5543.2 5648.5 5544.0 5723.7 6253.5 6254.2 6290.6 6315.4 6371.6 6392.7 6394.3 6403.3 6044.2 6104.7 6141.2 6151.9 6171.0 6015.8 6063.3 6094.0 6117.6 6122.6 6160.8 6213.9 6273.0 6299.8 6305.3 4265.8 4272.2 4307.6 4314.0 4326.7 6067.8 6104.8 6140.3 6151.0 6166.1 5910.4 5932.3 5940.2 5950.2 5971.9 5842.5 5894.5 5898.0 5912.8 5948.8 5503.4 5743.0 5761.1 5798.2 5817.7 5931.9 5934.7 5935.0 5948.0 5949.0 5606.5 5759.3 5773.0 5802.7 5823.9 19:29:29 INFO - PROCESS | 19616 | 19:29:29 INFO - PROCESS | 19616 | [#5] yui.html Cycles:180 Average:20183.81 Median:3701.68 stddev:28983.52 (783.0%) stddev-sans-first:29028.13 19:29:29 INFO - PROCESS | 19616 | Values: 760.8 797.7 801.6 806.3 843.6 14970.6 15962.4 15967.8 15975.4 15976.7 13835.0 14110.0 14192.4 14205.2 14251.3 798.3 806.8 809.9 812.0 813.1 790.5 803.7 820.5 826.2 827.0 850.6 856.3 858.6 860.3 864.5 850.0 852.5 853.4 855.1 855.1 623.6 624.3 624.3 624.4 624.4 14440.5 14466.4 14467.9 14478.9 14543.3 14375.2 14510.6 14551.9 14561.9 14665.3 11558.4 11824.8 11875.8 11930.6 12275.9 3855.7 3903.8 3912.0 3916.2 4047.3 74940.3 79020.6 80510.6 80530.6 80784.2 10646.3 10720.5 10808.7 10828.6 10985.4 21151.8 21152.0 21233.6 21239.3 21289.0 8204.3 8310.2 8370.6 8380.8 8687.1 4751.4 4924.2 4926.3 4978.5 5082.6 3546.5 3675.5 3682.7 3697.6 3705.7 623.0 624.7 631.7 634.2 638.9 613.4 670.9 689.6 733.2 758.3 9405.3 9937.3 10250.2 10309.9 10340.5 701.4 702.3 708.4 719.9 743.4 4888.7 4937.2 5029.4 5034.4 5122.4 97947.0 114665.0 115215.4 121653.4 123311.0 99611.5 100852.0 101473.0 102647.0 104044.0 27469.0 56506.0 56706.0 89897.0 90323.5 10006.7 10024.3 10053.9 10201.5 10234.2 42970.8 51825.2 52706.5 53123.7 53342.7 54904.7 55796.2 65794.0 72863.6 79140.6 14066.7 14360.5 14361.6 14376.4 14548.3 14858.0 15380.6 15458.1 15641.6 16298.4 13548.5 13765.6 13942.3 14028.7 14408.2 13392.9 13639.9 13678.0 13934.3 14125.2 12860.5 14101.2 14110.0 14391.4 14529.6 11569.7 11740.9 11815.3 11914.4 12328.6 11228.6 11234.1 11265.3 11595.7 11658.0 19:29:29 INFO - PROCESS | 19616 | -------- Summary: end -------- 19:29:29 INFO - PROCESS | 19616 | 19:29:29 INFO - TEST-INFO | 19616: exit 0 19:29:29 INFO - TEST-OK | dromaeo_css | took 1112114ms 19:29:29 INFO - TEST-START | kraken 19:29:29 INFO - operating with platform_type : linux_ 19:29:29 INFO - Initialising browser for kraken test... 19:29:29 INFO - TEST-INFO | started process 19857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAJ5UNt/profile http://localhost:44265/getInfo.html) 19:29:35 INFO - PROCESS | 19857 | __metrics Screen width/height:1600/1200 19:29:35 INFO - PROCESS | 19857 | colorDepth:24 19:29:35 INFO - PROCESS | 19857 | Browser inner width/height: 1024/697 19:29:35 INFO - PROCESS | 19857 | __metrics 19:29:36 ERROR - PROCESS | 19857 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 19:29:37 INFO - TEST-INFO | 19857: exit 0 19:29:37 INFO - Browser initialized. 19:29:37 INFO - Running cycle 1/1 for kraken test... 19:29:37 INFO - TEST-INFO | started process 19975 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAJ5UNt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:29:49 INFO - PROCESS | 19975 | RSS: Main: 185090048 19:29:49 INFO - PROCESS | 19975 | 19:29:51 INFO - PROCESS | 19975 | Cycle 1(1): loaded http://localhost:44265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44265/tests/kraken/driver.html?testName=audio-beat-detection) 19:29:52 INFO - PROCESS | 19975 | RSS: Main: 190296064 19:29:52 INFO - PROCESS | 19975 | 19:29:55 INFO - PROCESS | 19975 | Cycle 1(1): loaded http://localhost:44265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44265/tests/kraken/driver.html?testName=audio-dft) 19:29:55 INFO - PROCESS | 19975 | RSS: Main: 189378560 19:29:55 INFO - PROCESS | 19975 | 19:29:58 INFO - PROCESS | 19975 | Cycle 1(1): loaded http://localhost:44265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44265/tests/kraken/driver.html?testName=audio-fft) 19:29:59 INFO - PROCESS | 19975 | RSS: Main: 183996416 19:29:59 INFO - PROCESS | 19975 | 19:30:01 INFO - PROCESS | 19975 | Cycle 1(1): loaded http://localhost:44265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44265/tests/kraken/driver.html?testName=audio-oscillator) 19:30:01 INFO - PROCESS | 19975 | RSS: Main: 184627200 19:30:01 INFO - PROCESS | 19975 | 19:30:04 INFO - PROCESS | 19975 | Cycle 1(1): loaded http://localhost:44265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:30:04 INFO - PROCESS | 19975 | RSS: Main: 185204736 19:30:04 INFO - PROCESS | 19975 | 19:30:07 INFO - PROCESS | 19975 | Cycle 1(1): loaded http://localhost:44265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44265/tests/kraken/driver.html?testName=imaging-darkroom) 19:30:08 INFO - PROCESS | 19975 | RSS: Main: 185380864 19:30:08 INFO - PROCESS | 19975 | 19:30:12 INFO - PROCESS | 19975 | Cycle 1(1): loaded http://localhost:44265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44265/tests/kraken/driver.html?testName=imaging-desaturate) 19:30:12 INFO - PROCESS | 19975 | RSS: Main: 183160832 19:30:12 INFO - PROCESS | 19975 | 19:30:15 INFO - PROCESS | 19975 | Cycle 1(1): loaded http://localhost:44265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44265/tests/kraken/driver.html?testName=json-parse-financial) 19:30:16 INFO - PROCESS | 19975 | RSS: Main: 184221696 19:30:16 INFO - PROCESS | 19975 | 19:30:17 INFO - PROCESS | 19975 | Cycle 1(1): loaded http://localhost:44265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:30:18 INFO - PROCESS | 19975 | RSS: Main: 184487936 19:30:18 INFO - PROCESS | 19975 | 19:30:20 INFO - PROCESS | 19975 | Cycle 1(1): loaded http://localhost:44265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44265/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:30:20 INFO - PROCESS | 19975 | RSS: Main: 184737792 19:30:20 INFO - PROCESS | 19975 | 19:30:22 INFO - PROCESS | 19975 | Cycle 1(1): loaded http://localhost:44265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:30:23 INFO - PROCESS | 19975 | RSS: Main: 185413632 19:30:23 INFO - PROCESS | 19975 | 19:30:25 INFO - PROCESS | 19975 | Cycle 1(1): loaded http://localhost:44265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:30:26 INFO - PROCESS | 19975 | RSS: Main: 185720832 19:30:26 INFO - PROCESS | 19975 | 19:30:29 INFO - PROCESS | 19975 | Cycle 1(1): loaded http://localhost:44265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:30:30 INFO - PROCESS | 19975 | RSS: Main: 185561088 19:30:30 INFO - PROCESS | 19975 | 19:30:31 INFO - PROCESS | 19975 | Cycle 1(1): loaded http://localhost:44265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44265/tests/kraken/driver.html?testName=ai-astar) 19:30:31 INFO - PROCESS | 19975 | RSS: Main: 185995264 19:30:31 INFO - PROCESS | 19975 | 19:30:31 INFO - PROCESS | 19975 | __start_tp_report 19:30:31 INFO - PROCESS | 19975 | _x_x_mozilla_page_load 19:30:31 INFO - PROCESS | 19975 | _x_x_mozilla_page_load_details 19:30:31 INFO - PROCESS | 19975 | |i|pagename|runs| 19:30:31 INFO - PROCESS | 19975 | |0;ai-astar;102;110;105;110;110;111;111;110;109;111 19:30:31 INFO - PROCESS | 19975 | |1;audio-beat-detection;156;127;154;194;128;165;153;127;192;130 19:30:31 INFO - PROCESS | 19975 | |2;audio-dft;162;164;161;162;162;176;161;162;164;164 19:30:31 INFO - PROCESS | 19975 | |3;audio-fft;75;75;74;167;77;76;73;75;167;79 19:30:31 INFO - PROCESS | 19975 | |4;audio-oscillator;86;86;162;86;85;84;143;85;85;140 19:30:31 INFO - PROCESS | 19975 | |5;imaging-gaussian-blur;118;118;117;118;119;116;118;117;118;118 19:30:31 INFO - PROCESS | 19975 | |6;imaging-darkroom;147;148;147;154;147;147;148;149;148;147 19:30:31 INFO - PROCESS | 19975 | |7;imaging-desaturate;95;102;96;96;96;96;96;96;96;95 19:30:31 INFO - PROCESS | 19975 | |8;json-parse-financial;54;53;61;54;56;54;53;56;55;55 19:30:31 INFO - PROCESS | 19975 | |9;json-stringify-tinderbox;62;61;61;61;62;61;61;62;61;61 19:30:31 INFO - PROCESS | 19975 | |10;stanford-crypto-aes;79;80;84;84;82;78;84;79;128;79 19:30:31 INFO - PROCESS | 19975 | |11;stanford-crypto-ccm;125;122;127;118;121;122;121;124;128;124 19:30:31 INFO - PROCESS | 19975 | |12;stanford-crypto-pbkdf2;168;160;164;162;164;163;159;161;162;159 19:30:31 INFO - PROCESS | 19975 | |13;stanford-crypto-sha256-iterative;64;62;64;64;64;62;62;64;66;63 19:30:31 INFO - PROCESS | 19975 | __end_tp_report 19:30:31 INFO - PROCESS | 19975 | __start_cc_report 19:30:31 INFO - PROCESS | 19975 | _x_x_mozilla_cycle_collect,873 19:30:31 INFO - PROCESS | 19975 | __end_cc_report 19:30:31 INFO - PROCESS | 19975 | __startTimestamp1466908231930__endTimestamp 19:30:31 INFO - PROCESS | 19975 | 19:30:31 INFO - PROCESS | 19975 | ------- Summary: start ------- 19:30:31 INFO - PROCESS | 19975 | Number of tests: 14 19:30:31 INFO - PROCESS | 19975 | 19:30:31 INFO - PROCESS | 19975 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:3.00 (2.7%) stddev-sans-first:1.87 19:30:31 INFO - PROCESS | 19975 | Values: 102.0 110.0 105.0 110.0 110.0 111.0 111.0 110.0 109.0 111.0 19:30:31 INFO - PROCESS | 19975 | 19:30:31 INFO - PROCESS | 19975 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:155.00 stddev:25.52 (16.5%) stddev-sans-first:27.04 19:30:31 INFO - PROCESS | 19975 | Values: 156.0 127.0 154.0 194.0 128.0 165.0 153.0 127.0 192.0 130.0 19:30:31 INFO - PROCESS | 19975 | 19:30:31 INFO - PROCESS | 19975 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:4.44 (2.7%) stddev-sans-first:4.66 19:30:31 INFO - PROCESS | 19975 | Values: 162.0 164.0 161.0 162.0 162.0 176.0 161.0 162.0 164.0 164.0 19:30:31 INFO - PROCESS | 19975 | 19:30:31 INFO - PROCESS | 19975 | [#3] audio-fft Cycles:10 Average:93.80 Median:75.00 stddev:38.61 (51.5%) stddev-sans-first:40.35 19:30:31 INFO - PROCESS | 19975 | Values: 75.0 75.0 74.0 167.0 77.0 76.0 73.0 75.0 167.0 79.0 19:30:31 INFO - PROCESS | 19975 | 19:30:31 INFO - PROCESS | 19975 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:85.00 stddev:30.98 (36.4%) stddev-sans-first:32.15 19:30:31 INFO - PROCESS | 19975 | Values: 86.0 86.0 162.0 86.0 85.0 84.0 143.0 85.0 85.0 140.0 19:30:31 INFO - PROCESS | 19975 | 19:30:31 INFO - PROCESS | 19975 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 19:30:31 INFO - PROCESS | 19975 | Values: 118.0 118.0 117.0 118.0 119.0 116.0 118.0 117.0 118.0 118.0 19:30:31 INFO - PROCESS | 19975 | 19:30:31 INFO - PROCESS | 19975 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:2.15 (1.5%) stddev-sans-first:2.24 19:30:31 INFO - PROCESS | 19975 | Values: 147.0 148.0 147.0 154.0 147.0 147.0 148.0 149.0 148.0 147.0 19:30:31 INFO - PROCESS | 19975 | 19:30:31 INFO - PROCESS | 19975 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:2.01 (2.1%) stddev-sans-first:2.07 19:30:31 INFO - PROCESS | 19975 | Values: 95.0 102.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 19:30:31 INFO - PROCESS | 19975 | 19:30:31 INFO - PROCESS | 19975 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:2.33 (4.2%) stddev-sans-first:2.44 19:30:31 INFO - PROCESS | 19975 | Values: 54.0 53.0 61.0 54.0 56.0 54.0 53.0 56.0 55.0 55.0 19:30:31 INFO - PROCESS | 19975 | 19:30:31 INFO - PROCESS | 19975 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 19:30:31 INFO - PROCESS | 19975 | Values: 62.0 61.0 61.0 61.0 62.0 61.0 61.0 62.0 61.0 61.0 19:30:31 INFO - PROCESS | 19975 | 19:30:31 INFO - PROCESS | 19975 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:81.00 stddev:15.05 (18.6%) stddev-sans-first:15.76 19:30:31 INFO - PROCESS | 19975 | Values: 79.0 80.0 84.0 84.0 82.0 78.0 84.0 79.0 128.0 79.0 19:30:31 INFO - PROCESS | 19975 | 19:30:31 INFO - PROCESS | 19975 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:124.00 stddev:3.01 (2.4%) stddev-sans-first:3.12 19:30:31 INFO - PROCESS | 19975 | Values: 125.0 122.0 127.0 118.0 121.0 122.0 121.0 124.0 128.0 124.0 19:30:31 INFO - PROCESS | 19975 | 19:30:31 INFO - PROCESS | 19975 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:162.50 stddev:2.74 (1.7%) stddev-sans-first:1.94 19:30:31 INFO - PROCESS | 19975 | Values: 168.0 160.0 164.0 162.0 164.0 163.0 159.0 161.0 162.0 159.0 19:30:31 INFO - PROCESS | 19975 | 19:30:31 INFO - PROCESS | 19975 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.27 (2.0%) stddev-sans-first:1.33 19:30:31 INFO - PROCESS | 19975 | Values: 64.0 62.0 64.0 64.0 64.0 62.0 62.0 64.0 66.0 63.0 19:30:31 INFO - PROCESS | 19975 | -------- Summary: end -------- 19:30:31 INFO - PROCESS | 19975 | 19:30:32 INFO - TEST-INFO | 19975: exit 0 19:30:32 INFO - TEST-OK | kraken | took 63033ms 19:30:32 INFO - SUITE-END | took 1175s 19:30:33 INFO - Completed test suite (00:19:35) 19:30:33 INFO - javascript benchmark 19:30:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7305.529072409895, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3119.56326114344, 3167.4140284047467, 3192.7445804335657, 3198.1524895902576, 3208.197950512373, 5502.119660854264, 5526.640768350059, 5593.105103183491, 5617.354004289497, 5642.746076426561, 5432.75552600133, 5493.340799104113, 5533.778648854041, 5551.583631227654, 5553.611247212697, 4962.131626965275, 5003.924941125886, 5092.388913330406, 5161.870953226162, 5199.6360254782185, 789.2894776862323, 4921.064997650453, 4953.777080031389, 5044.924326135111, 5154.664946778466, 4945.332380128672, 4986.800527978913, 5001.824936127255, 5007.399112106534, 5035.84892453227, 5040.067587496325, 5045.495450454925, 5055.393352797688, 5060.342155519759, 5096.61775366849, 4891.902161956741, 4912.606991440676, 4978.7510624469, 5021.322121513585, 5042.369703787027, 5562.0, 5594.720263986825, 5610.887782244373, 5641.8589535261535, 5649.124385720179, 6035.758569657209, 6047.274327080734, 6059.151718759377, 6063.211782468251, 6063.666498342589, 5771.682557459338, 5948.37542058082, 6001.279846418458, 6006.8498287542725, 6041.335453100155, 5646.096624540095, 5650.152477128422, 5654.802081927113, 5654.943450565524, 5665.206871038058, 6162.137300777895, 6178.382161783876, 6179.227596550431, 6181.35095814933, 6184.165137706352, 5683.0, 5723.427657234243, 5749.13762935563, 5757.337906140764, 5793.04414771558, 5826.796062137805, 5856.297244330623, 5862.970685146547, 5868.23712917318, 5873.618214816023, 5768.2501274834, 5793.710314484343, 5835.008048631743, 5845.240118784531, 5860.413958604191, 5828.300603927556, 5927.022041363213, 5941.0, 5969.074793407029, 5974.193483879708, 4501.639868810487, 4506.324051392317, 4507.661925355612, 4552.2488789350045, 4557.635389168859, 3996.9200615987515, 4005.7997100144876, 4051.331530297468, 4078.5921407858978, 4102.856400026045, 5560.888782224333, 5576.219329293902, 5602.635828671123, 5748.45389687979, 5783.537317014713, 5967.701614919237, 5968.641881487038, 5983.341832398432, 5983.581149319506, 5995.640261584319, 5497.780088796483, 5635.408282130399, 5660.745266463019, 5674.2623458950075, 5689.743961521742, 5106.361704786902, 5141.331626888481, 5142.434332223453, 5143.048536020773, 5189.143791274398, 6211.223597050369, 6228.22147231596, 6235.750569977241, 6237.189165408558, 6239.96880015597, 5834.94165058344, 5907.911381329198, 5978.043513037893, 6034.39656034393, 6036.0, 6182.938170618237, 6213.0, 6220.129181914626, 6233.0, 6243.063540468966, 5847.0, 5876.94123058781, 5886.146508756292, 5910.970445147918, 5952.464278214981, 5815.360310365941, 5954.851128721816, 5998.0, 6003.0, 6017.699115044318, 5823.679697616672, 5883.882322353615, 5889.263842019747, 5895.14520394549, 5895.263092113486, 5870.295564532284, 5888.705564721832, 5889.411058894077, 5900.557458190567, 5907.0, 5632.633878797865, 5681.318241810844, 5704.714764261853, 5727.36998930109, 5811.157382179645, 5885.970570147122, 5920.171176035445, 5922.585419020799, 5924.911126333022, 5934.080217566284, 5573.0, 5724.313082429969, 5734.455226753452, 5745.971270143623, 5775.797847075332], "value": 5455.96080600737, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.7124509632442, 598.9670568118753, 613.2640831002798, 628.1927722876102, 630.1650313334833, 33691.49462758061, 36876.0, 43976.120477590426, 45057.0, 45333.54666453334, 47680.523194768044, 47951.52048479514, 48037.0, 48113.278300825514, 48285.0, 8884.822303553941, 9022.819543609125, 9042.954785226098, 9046.638134474646, 9048.819023619524, 8855.0, 8960.059193784657, 8985.640574377017, 9000.144986226298, 9030.68392606259, 8980.685676001342, 9007.729768106967, 9050.1854833065, 9065.592048357807, 9085.046070162636, 8988.77528061797, 9004.324675649319, 9030.819383612357, 9034.232090272302, 9040.095990400972, 8883.555822208864, 8957.686480973134, 8984.10158984103, 8992.730218093468, 8996.910030899739, 45082.098358032985, 45433.0, 45450.54549454496, 45474.0, 45530.0, 3408.744344174172, 3453.17123890267, 3493.0, 3601.9279614407565, 3962.722609417342, 31243.84378078118, 31737.0, 32107.0, 34249.657503424896, 34279.657203427894, 4275.46556680415, 4434.357018232338, 4454.732716037016, 4564.0, 4601.401817763669, 353538.99999999744, 354175.0, 356475.0, 357529.0, 359692.0, 63451.36548634455, 63503.68248158822, 63847.6807615959, 63854.36145638484, 63955.36044639587, 36314.63685363165, 36723.816380917924, 36942.0, 38752.418713719315, 39167.804160979584, 16999.98000119997, 17299.394521191698, 17301.134943252786, 17323.56691082733, 17362.39231626887, 11260.718482038015, 11323.660290191307, 11352.262102963447, 11353.716157096138, 11370.374629395297, 20463.07916143777, 20503.17987280492, 20554.486137846674, 20578.176872925214, 20628.896855515628, 7197.424206063502, 7322.743703970335, 7489.951406803052, 7499.737509187153, 7501.849963000709, 922.8569571716395, 1030.2273295028729, 1056.6882769582992, 1155.7457359380924, 1166.125405945541, 33508.32983340368, 34311.0, 34520.0, 34944.30111397809, 35103.4734478983, 1158.652404278713, 1170.6136974798296, 1185.3776767197292, 1197.275648232824, 1219.1587804414926, 17622.647547048986, 17698.203580838894, 17813.46559603214, 18005.36981205678, 18008.36970706019, 557304.0, 562447.0, 563298.0, 568228.0, 568383.0, 63623.0, 64069.679651602375, 64143.0, 64165.67917160384, 64218.35781642217, 1310.0, 1338.8728070833256, 1361.047266913145, 1371.2321100184129, 1374.6838227207597, 31888.0, 32952.0, 33580.328393432486, 33634.831825840716, 34180.31639367149, 54426.727866362, 55017.0, 55072.0, 55115.44884551103, 55155.44844551664, 464646.0, 465365.0, 465731.0, 466036.0, 467116.0, 28783.136505904855, 29799.10602681923, 29804.55293170561, 29904.85047574748, 29985.250368740955, 49479.50520494749, 51597.48402516077, 51970.740146299024, 52336.0, 53402.73298633482, 43325.0, 43477.34783978306, 43687.04044802124, 44740.55259447364, 45259.0, 42578.7226383209, 43284.35073473964, 43495.78252108719, 43783.781081095665, 44140.77929610331, 43309.78345108254, 44874.551254487036, 44891.0, 45688.31467527923, 45798.0, 41961.58038419577, 46800.297995530775, 47126.76436617795, 47751.28373074476, 47876.52123478721, 34663.826680866434, 35750.821245894644, 36105.0973725659, 36233.81883090568, 36251.0], "value": 20836.577427661512, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.121792569536, 391.4402404561477, 394.2214127098979, 394.9269385163743, 407.9510458744949, 17695.380661676845, 18123.4562963111, 20561.0, 20624.896875515602, 20654.896725516388, 11996.40017999101, 12126.090543209273, 12164.882696485865, 12282.63152105436, 12302.876971230307, 5128.5640720538795, 5267.631265811395, 5309.814156504523, 5312.3093997780425, 5313.149896016638, 3775.8678446254385, 5548.278723765925, 5835.474807267345, 5843.883122337551, 5928.762849486037, 5849.385814489481, 5865.090910908816, 5867.794627188049, 5874.88250234995, 5919.526437884959, 5659.26429564154, 5812.82561523155, 5912.260967379078, 5964.194833697438, 5990.9400905990815, 5374.274472946141, 5493.395726470125, 5528.806491772809, 5543.417941116206, 5646.2942132233475, 12338.383080845922, 12395.132340736061, 15781.68436631261, 23249.0, 23523.0, 2337.6960995070704, 2404.314770290459, 2457.3610861176044, 2492.9252122436355, 2898.130560831742, 6030.758769649209, 6079.209702738615, 9921.10710036093, 10308.845367319496, 10388.84416733742, 1911.9044047797554, 1921.3947606504046, 1960.362882063335, 1969.8916559589218, 1975.5456245063572, 62811.68594157, 83100.16899830985, 83806.0, 84588.57705711432, 85368.57315713381, 9732.318737688294, 9884.55519501624, 9920.503974801231, 10070.69787906364, 10255.156028510339, 13058.477660893457, 13125.212487250796, 13129.0, 13149.802752958713, 13232.13991090576, 7718.729844455529, 7732.884006739903, 7794.064712234568, 7794.220577942274, 7879.842403151905, 7703.807404814813, 7730.304272615379, 7757.069151701832, 7873.960630196812, 7929.960350198212, 4068.5931406859077, 4085.571015043437, 4088.7751173685137, 4094.1811637672586, 4203.6637069034405, 1529.946451874179, 1663.6506333670065, 1744.7382892566216, 1756.1833747307564, 1766.0904634113442, 1000.2448151645461, 1009.5658866687395, 1029.8764148302253, 1073.8013467508536, 1077.7874890747908, 18437.5390615233, 19451.22195112208, 19571.706424403645, 20733.58532829335, 20856.687149692767, 984.9753756156153, 994.7811481474064, 998.825205589019, 1001.5943542865151, 1029.7940411917646, 10612.151027917902, 10973.693269408299, 10990.890091098987, 11071.05895998833, 11155.665330040112, 476929.0, 477016.0, 479425.0, 484898.0, 488003.0, 100778.496107519, 101233.0, 101782.0, 101819.0, 102891.48554257181, 1009.5608410341379, 1015.28422462164, 1031.3708637730979, 1035.13566172247, 1050.669039252633, 17530.47408577745, 17632.206550704992, 17735.645287094445, 17764.644707106043, 18005.369812056517, 38952.6104738949, 41928.0, 43369.3494597575, 43692.0, 45346.54653453423, 62765.68617156885, 62828.51699110076, 65138.348616515126, 65230.67384663236, 65389.67305163444, 6902.206246281742, 7525.58609276495, 7801.687932482864, 7996.24035716606, 8554.828903422022, 8101.432899697201, 11585.478653460783, 13263.734725305632, 13399.464021439424, 13554.118982266122, 11404.258723182966, 11404.315741055563, 11554.884451155382, 11606.825897611712, 11617.825732613848, 11763.588274410355, 11770.470328835394, 11868.465919033491, 11912.821307680566, 12019.218750781522, 11668.591599293984, 11850.525978960744, 12018.399080045789, 12655.11414200997, 12699.428525716181, 7476.962615186889, 7671.580757559869, 7741.496802707806, 7907.406944479302, 7976.282134607914, 9992.750181245527, 11356.26184298018, 11512.769744604893, 11766.705832354259, 11779.05767538612], "value": 8848.817093299302, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1494.5292232946622, 1510.3882927414395, 1608.4772448954093, 1709.5469700529354, 1764.4089230107913, 8116.0, 8561.357898157648, 8677.69628063017, 9467.715968520939, 9479.47862867542, 8804.603792829323, 8998.460092394462, 9150.267978561717, 9162.90837091629, 9172.128647778467, 2268.432891777056, 2273.920412785553, 2287.7597852225526, 2288.519410923708, 2293.2546922250253, 2244.068711484732, 2255.255765597357, 2278.7835155660187, 2308.722953245613, 2311.884405779704, 2270.3302525754943, 2270.3529494094187, 2280.1221529711097, 2303.6890019847274, 2342.1919437794018, 2194.6707993800896, 2212.2920665387082, 2223.2218723446663, 2239.798418142375, 2240.1487434774763, 2255.639097744353, 2280.7947284744455, 2281.6121259385777, 2299.7815207555254, 2300.2524179641514, 8985.820283594292, 9055.818883622356, 9057.049009854003, 9057.68298109563, 9063.637454501812, 4944.208926571731, 5079.085764562377, 5082.364704411949, 5086.008228395464, 5100.311457953166, 3090.629124505051, 3185.442547554169, 3346.4478361070396, 3354.9832250838836, 3355.9161020974425, 1054.2830875004993, 1085.5494969587612, 1087.3584585094832, 1094.8303013032992, 1100.4662738571785, 12187.756244875052, 12232.449539770643, 12253.326067066308, 12271.447784849703, 12307.138500304982, 4490.461144662661, 4503.301988191835, 4589.2657174851865, 4589.609883159902, 4607.502561667471, 10225.795484090277, 10261.692149235534, 10312.381257124596, 10325.586976520855, 10380.896191038144, 5212.609054320941, 5240.371155461293, 5249.238860365225, 5258.684478931276, 5261.842144735664, 4189.4344263524645, 4622.4684161321875, 4696.929546056812, 4710.6702530823195, 4914.852554423373, 3924.941125883114, 3957.7427467215116, 3973.5827738087664, 3978.6817054635558, 4110.486189226347, 1213.4721396192508, 1214.1500949335325, 1220.8412906322121, 1228.3612521488776, 1235.5922545559943, 883.3816328570026, 923.8568021956607, 941.4022095969109, 946.6071580294239, 956.7655924298452, 5921.703914804242, 5981.880362392728, 6047.879042419127, 6111.633302001894, 6379.585326953733, 406.4634682219501, 413.5347733799476, 426.0775421213101, 430.30076126294773, 433.9978300108479, 4100.200460910094, 4109.321961876257, 4130.91738165235, 4139.503259608866, 4158.480189976253, 10986.395748233925, 11211.831822522669, 11328.0, 11386.373749443694, 11392.943035284936, 11132.833007504894, 11213.71965700864, 11227.607033753942, 11233.213675042833, 11256.0, 7874.842503150019, 8214.99999999988, 8235.29999950011, 8453.66185352579, 8553.871691924625, 5947.167396564398, 6047.758089676539, 6059.424354686298, 6084.026555751058, 6151.446369826737, 10176.0, 10188.337758046, 10250.692479225636, 10260.281780275607, 10391.324563903323, 10145.54345054489, 10267.281290309607, 10278.588856445958, 10551.103156231806, 10554.102901253173, 7104.822379440556, 7663.923360766321, 7838.490498117604, 7923.920760792318, 7977.282044616012, 8856.291496680378, 8887.244584210415, 8988.10118988096, 9037.457752534869, 9050.728478145666, 7540.17058123617, 7733.7679869604, 7778.766637000899, 7804.609769511615, 7825.413094018085, 7627.54234745917, 7633.69465221385, 7674.309312161932, 7742.070951485858, 7758.4181186410115, 7247.383972362408, 7258.383037441666, 7263.0, 7276.818079548054, 7342.412606991535, 4832.0, 4976.0794253063295, 5034.69098034521, 5090.745462726923, 5094.6688465249645, 5203.349581302337, 5289.7355132242465, 5300.5759539236, 5313.760880760452, 5397.433269506802], "value": 4541.813605810417, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.2701496036675, 327.3698131097637, 328.5236407209547, 329.4070672788979, 330.10706040161364, 5531.419200983889, 5587.664740115591, 5601.859953501159, 5628.465295796897, 5736.7952729926665, 5589.664620122796, 5630.465105814951, 5667.149927510865, 5680.233168522248, 5718.428157184279, 4386.53051227839, 4386.934195987063, 4403.0973650401675, 4420.1159768046355, 4432.645388368923, 4217.936730949038, 4291.249031419489, 4318.956810431887, 4397.362382454542, 4406.911861762763, 4232.6613870890405, 4234.047339348637, 4236.533981262059, 4259.850905218318, 4279.40088387626, 4265.360195970598, 4311.611954924057, 4312.654987600984, 4315.3095504719095, 4331.8700438986725, 3693.4275187346007, 3761.8119094045187, 3771.3400154973046, 3771.8868433947027, 3772.5661548921953, 5410.267814753524, 5468.152436372368, 5470.261514695505, 5485.780568777244, 5505.3393592768725, 4905.117078925792, 4939.58013568847, 4971.850844474671, 4975.477574854624, 4984.725840078794, 5657.405972372882, 5834.299884013945, 5869.530437564985, 5884.558658100659, 5944.851378715523, 4150.460440142792, 4157.97921010396, 4158.708890377675, 4166.291730405838, 4172.0, 5769.1346298055205, 5910.615809972381, 6119.204503414572, 6147.200863887666, 6162.198914141133, 4133.2146892091005, 4155.2728272552185, 4155.958440415618, 4158.480189976253, 4162.646175075092, 4132.380142978517, 4133.483314585676, 4205.453291072141, 4212.599803018708, 4222.4299719538085, 4635.351050852883, 4892.559669629751, 4901.901961960741, 4903.607711383081, 4920.6555541111775, 5858.50202732764, 5859.853503662357, 5881.176635271066, 5908.965930962065, 5918.763249470059, 1453.5754960139122, 1453.9273036348352, 1464.1215270837413, 1465.2453986196904, 1469.3314541883417, 894.5571941888807, 922.9847168115019, 932.9224745419052, 933.8972713001565, 944.8299306124964, 5044.445111037783, 5085.262636917701, 5104.2088476286235, 5107.61692873036, 5125.538701516882, 5416.51251387377, 5429.497973806872, 5433.212184233264, 5433.641589602599, 5481.561475081984, 4888.291197776302, 4968.931749266832, 5111.923321150186, 5152.407473140562, 5218.0, 2841.261272069277, 2933.2813460701836, 2940.7206315400003, 2942.3526824098662, 2957.7190166934106, 5496.862578435571, 5516.393196748354, 5539.639923404966, 5543.196236545759, 5648.548116150698, 5544.0, 5723.742431590588, 6253.499720022387, 6254.249490061222, 6290.622562646256, 6315.368463153648, 6371.553991220663, 6392.680365981682, 6394.26465956421, 6403.263624683221, 6044.214252147192, 6104.7485265521345, 6141.232345956755, 6151.92403798101, 6171.0, 6015.819525414245, 6063.272407311151, 6094.0, 6117.632942023492, 6122.5918038852205, 6160.784372546939, 6213.875722485615, 6273.0, 6299.842503937438, 6305.274893387319, 4265.786710664516, 4272.209641216385, 4307.590778876001, 4313.97843010783, 4326.697131200785, 6067.787627433018, 6104.847378815388, 6140.293866205444, 6150.969245153746, 6166.128758280908, 5910.438508341701, 5932.317783454958, 5940.198073260054, 5950.196723442453, 5971.91042134377, 5842.503387211965, 5894.498967587803, 5897.970510147422, 5912.822615321547, 5948.791792287249, 5503.449655034465, 5742.989953516236, 5761.135829625589, 5798.217240672455, 5817.661937754425, 5931.881362372815, 5934.732937017931, 5934.97032514852, 5947.988841896801, 5948.970255148696, 5606.467385598362, 5759.337676167127, 5772.9711351442975, 5802.738876750641, 5823.912641310469], "value": 4388.410769402983, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.8059944714097, 797.7185250184472, 801.603206412825, 806.3065763443437, 843.6203708331251, 14970.5508834735, 15962.361505539764, 15967.840321596796, 15975.360985560592, 15976.680466390666, 13835.0, 14110.0, 14192.36134373953, 14205.218712970809, 14251.287435628203, 798.3294033012254, 806.8426656801926, 809.8866158737782, 811.9878201826948, 813.0649752784286, 790.4901338636575, 803.6664784114614, 820.5117954816874, 826.1573195340749, 826.9669213231464, 850.5619605902934, 856.327782690588, 858.5792961448908, 860.290260535058, 864.4985908173276, 850.022474154727, 852.4927668037508, 853.4324674091753, 855.1234984141242, 855.1277696749343, 623.563505546115, 624.3007831229007, 624.307019208678, 624.3631495874183, 624.388099662329, 14440.49458268966, 14466.421343146261, 14467.92766036163, 14478.927605361905, 14543.27283635814, 14375.209363485004, 14510.637234069127, 14551.854481455155, 14561.854381456156, 14665.26673666323, 11558.364289964049, 11824.822627660593, 11875.821862672066, 11930.582429614922, 12275.877241227563, 3855.6915446764474, 3903.82600887914, 3912.0219945013746, 3916.1776027034357, 4047.332190188615, 74940.25059749387, 79020.60489697514, 80510.59744701297, 80530.59734701348, 80784.19215807825, 10646.30046802958, 10720.517576709066, 10808.675739727822, 10828.623354836152, 10985.395803230898, 21151.78848211529, 21152.0, 21233.575328493345, 21239.256626018014, 21289.0, 8204.302634276153, 8310.168983101641, 8370.581470926429, 8380.832383352299, 8687.131286871389, 4751.429828420542, 4924.187509060965, 4926.310316555685, 4978.47725988766, 5082.618803589746, 3546.4503002034726, 3675.46705727668, 3682.6869716074434, 3697.6487233712755, 3705.7035437164964, 623.0094150301043, 624.6907780648608, 631.7062565906875, 634.2452481546944, 638.9073584330339, 613.362103412455, 670.8825955457874, 689.6173172788627, 733.2008111158756, 758.309937956457, 9405.341626086245, 9937.304388692866, 10250.179985601284, 10309.948450257702, 10340.534675939602, 701.421327404893, 702.3222590200481, 708.4190963410057, 719.9064121664151, 743.4461326311932, 4888.7311197884455, 4937.160682683881, 5029.371328583927, 5034.395872495251, 5122.436531981479, 97947.0, 114665.0, 115215.42392287985, 121653.39173304253, 123311.0, 99611.50194249128, 100852.0, 101473.0, 102647.0, 104044.0, 27469.038583649875, 56506.0, 56706.0, 89897.0, 90323.54838225766, 10006.749831254278, 10024.348417352849, 10053.9477689776, 10201.54093065799, 10234.232432567438, 42970.78514607407, 51825.22262165995, 52706.47293527169, 53123.73438132785, 53342.73328633332, 54904.72547637236, 55796.163057553356, 65794.0, 72863.63568182125, 79140.60429697814, 14066.718665626426, 14360.497382591559, 14361.64095897611, 14376.424943002581, 14548.345324460637, 14858.0, 15380.615484612974, 15458.072515649097, 15641.608959776097, 16298.42955496552, 13548.525801596898, 13765.587032389045, 13942.302884855919, 14028.719425611227, 14408.207548584509, 13392.866071339162, 13639.863601363859, 13678.0, 13934.303284835514, 14125.223112728487, 12860.549880754128, 14101.224432656303, 14110.0, 14391.424343026161, 14529.636759081108, 11569.710757231136, 11740.882591173979, 11815.291082535075, 11914.40427978615, 12328.568500102454, 11228.606998755004, 11234.141172042879, 11265.319939068668, 11595.710107247387, 11658.0], "value": 7581.339068566227, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 105.0, 110.0, 110.0, 111.0, 111.0, 110.0, 109.0, 111.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 154.0, 194.0, 128.0, 165.0, 153.0, 127.0, 192.0, 130.0], "value": 152.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 161.0, 162.0, 162.0, 176.0, 161.0, 162.0, 164.0, 164.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 167.0, 77.0, 76.0, 73.0, 75.0, 167.0, 79.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 162.0, 86.0, 85.0, 84.0, 143.0, 85.0, 85.0, 140.0], "value": 104.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 119.0, 116.0, 118.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 154.0, 147.0, 147.0, 148.0, 149.0, 148.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 102.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 61.0, 54.0, 56.0, 54.0, 53.0, 56.0, 55.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 84.0, 84.0, 82.0, 78.0, 84.0, 79.0, 128.0, 79.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 122.0, 127.0, 118.0, 121.0, 122.0, 121.0, 124.0, 128.0, 124.0], "value": 123.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 160.0, 164.0, 162.0, 164.0, 163.0, 159.0, 161.0, 162.0, 159.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 64.0, 64.0, 64.0, 62.0, 62.0, 64.0, 66.0, 63.0], "value": 63.5, "unit": "score"}]}]} 19:30:33 INFO - Return code: 0 19:30:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:30:33 ERROR - # TBPL SUCCESS # 19:30:33 INFO - Running post-action listener: _resource_record_post_action 19:30:33 INFO - ##### 19:30:33 INFO - ##### Finished run-tests step (success) 19:30:33 INFO - ##### 19:30:33 INFO - Running post-run listener: _resource_record_post_run 19:30:33 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552308736; Read time: 8; Write time: 1054476 19:30:33 INFO - TinderboxPrint: CPU usage
13.5% 19:30:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:30:33 INFO - TinderboxPrint: I/O write bytes / time
552,308,736 / 1,054,476 19:30:33 INFO - TinderboxPrint: CPU idle
8,231.0 (86.5%) 19:30:33 INFO - TinderboxPrint: CPU user
1,218.5 (12.8%) 19:30:33 INFO - TinderboxPrint: Swap in / out
0 / 0 19:30:33 INFO - install - Wall time: 17s; CPU: 18.0%; Read bytes: 0; Write bytes: 229875712; Read time: 0; Write time: 683936 19:30:33 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289730560; Read time: 8; Write time: 364708 19:30:33 INFO - Running post-run listener: _upload_blobber_files 19:30:33 INFO - Blob upload gear active. 19:30:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:30:33 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 19:30:33 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'] 19:30:33 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 19:30:34 INFO - (blobuploader) - INFO - Open directory for files ... 19:30:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:30:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:30:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:37 INFO - (blobuploader) - INFO - Done attempting. 19:30:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:30:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:30:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:38 INFO - (blobuploader) - INFO - Done attempting. 19:30:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:30:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:30:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:30:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:30:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:30:39 INFO - (blobuploader) - INFO - Done attempting. 19:30:39 INFO - (blobuploader) - INFO - Iteration through files over. 19:30:39 INFO - Return code: 0 19:30:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:30:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:30:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/18195beff25a6ecc6a75e84e5162f3500c74a24f464c75926ba3087e6d1f7d9c13238ede2be231daba8bdd6f9eff232ccb7d69bc66cc97221b127c91485c3d09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4e700c7dc8eec6ff42ee2f3b411606b80b92e5c7be60ee4d16dd62c1816ed986fc30cd958c6b98a7cad1a165ca3164ff1aebac572577839da5043d220a6c5fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa81b6647d136b4f2c87c71176c6e1e509984be2780845d406270fc4dd2366666ba5a66cbfc2fa00f2d263e8b695d513392116703971d12bc554ac06bb716026"} 19:30:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:30:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:30:39 INFO - Contents: 19:30:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/18195beff25a6ecc6a75e84e5162f3500c74a24f464c75926ba3087e6d1f7d9c13238ede2be231daba8bdd6f9eff232ccb7d69bc66cc97221b127c91485c3d09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4e700c7dc8eec6ff42ee2f3b411606b80b92e5c7be60ee4d16dd62c1816ed986fc30cd958c6b98a7cad1a165ca3164ff1aebac572577839da5043d220a6c5fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa81b6647d136b4f2c87c71176c6e1e509984be2780845d406270fc4dd2366666ba5a66cbfc2fa00f2d263e8b695d513392116703971d12bc554ac06bb716026"} 19:30:39 INFO - Running post-run listener: copy_logs_to_upload_dir 19:30:39 INFO - Copying logs to upload dir... 19:30:39 INFO - mkdir: /builds/slave/test/build/upload/logs 19:30:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.584272 ========= master_lag: 40.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 38 secs) (at 2016-06-25 19:31:18.922274) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-25 19:31:18.925489) ========= 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=af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442 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/18195beff25a6ecc6a75e84e5162f3500c74a24f464c75926ba3087e6d1f7d9c13238ede2be231daba8bdd6f9eff232ccb7d69bc66cc97221b127c91485c3d09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4e700c7dc8eec6ff42ee2f3b411606b80b92e5c7be60ee4d16dd62c1816ed986fc30cd958c6b98a7cad1a165ca3164ff1aebac572577839da5043d220a6c5fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa81b6647d136b4f2c87c71176c6e1e509984be2780845d406270fc4dd2366666ba5a66cbfc2fa00f2d263e8b695d513392116703971d12bc554ac06bb716026"} build_url:https://queue.taskcluster.net/v1/task/dBNNPExzRlWOd5bvn5ODIQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011316 build_url: 'https://queue.taskcluster.net/v1/task/dBNNPExzRlWOd5bvn5ODIQ/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/18195beff25a6ecc6a75e84e5162f3500c74a24f464c75926ba3087e6d1f7d9c13238ede2be231daba8bdd6f9eff232ccb7d69bc66cc97221b127c91485c3d09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a4e700c7dc8eec6ff42ee2f3b411606b80b92e5c7be60ee4d16dd62c1816ed986fc30cd958c6b98a7cad1a165ca3164ff1aebac572577839da5043d220a6c5fc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aa81b6647d136b4f2c87c71176c6e1e509984be2780845d406270fc4dd2366666ba5a66cbfc2fa00f2d263e8b695d513392116703971d12bc554ac06bb716026"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-25 19:31:18.953300) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 19:31:18.953644) ========= 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=af724c981e2a0f424dbabf99000001e7-1466903349.8411-1344487442 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-25 19:31:19.037092) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-25 19:31:19.037418) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-25 19:31:19.037743) ========= ========= Total master_lag: 40.18 =========