builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-015 starttime: 1466648552.81 results: success (0) buildid: 20160622163003 builduid: 6907781e6871434c91d1b3144a705520 revision: d2a087cdfb007a8a1aa919fcea061af9970fed72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:32.808456) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:32.808995) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:32.809423) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:32.853241) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:32.853537) ========= 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=20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 19:22:33-- 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% 221M=0s 2016-06-22 19:22:33 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097999 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:32.967487) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:32.967801) ========= 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=20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016599 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:33.020222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 19:22:33.020569) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d2a087cdfb007a8a1aa919fcea061af9970fed72 --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 d2a087cdfb007a8a1aa919fcea061af9970fed72 --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=20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 19:22:33,545 truncating revision to first 12 chars 2016-06-22 19:22:33,545 Setting DEBUG logging. 2016-06-22 19:22:33,545 attempt 1/10 2016-06-22 19:22:33,545 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d2a087cdfb00?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 19:22:34,141 unpacking tar archive at: mozilla-inbound-d2a087cdfb00/testing/mozharness/ program finished with exit code 0 elapsedTime=0.988303 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-22 19:22:34.025642) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:34.026059) ========= script_repo_revision: d2a087cdfb007a8a1aa919fcea061af9970fed72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:34.026549) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:34.026851) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 19:22:34.040868) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-22 19:22:34.041233) ========= /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=20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:22:34 INFO - MultiFileLogger online at 20160622 19:22:34 in /builds/slave/test 19:22:34 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:22:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:22:34 INFO - {'append_to_log': False, 19:22:34 INFO - 'base_work_dir': '/builds/slave/test', 19:22:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 19:22:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:22:34 INFO - 'branch': 'Mozilla-Inbound', 19:22:34 INFO - 'buildbot_json_path': 'buildprops.json', 19:22:34 INFO - 'config_files': ('talos/linux_config.py',), 19:22:34 INFO - 'default_actions': ('clobber', 19:22:34 INFO - 'read-buildbot-config', 19:22:34 INFO - 'download-and-extract', 19:22:34 INFO - 'populate-webroot', 19:22:34 INFO - 'create-virtualenv', 19:22:34 INFO - 'install', 19:22:34 INFO - 'run-tests'), 19:22:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:22:34 INFO - 'download_minidump_stackwalk': True, 19:22:34 INFO - 'download_symbols': 'ondemand', 19:22:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:22:34 INFO - 'tooltool.py': '/tools/tooltool.py', 19:22:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:22:34 INFO - '/tools/misc-python/virtualenv.py')}, 19:22:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:22:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:22:34 INFO - 'installer_path': 'installer.exe', 19:22:34 INFO - 'log_level': 'info', 19:22:34 INFO - 'log_name': 'talos', 19:22:34 INFO - 'log_to_console': True, 19:22:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:22:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:22:34 INFO - 'opt_config_files': (), 19:22:34 INFO - 'pip_index': False, 19:22:34 INFO - 'sps_profile': False, 19:22:34 INFO - 'sps_profile_interval': 0, 19:22:34 INFO - 'suite': 'dromaeojs-e10s', 19:22:34 INFO - 'system_bits': '32', 19:22:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:22:34 INFO - 'title': 'talos-linux64-ix-015', 19:22:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:22:34 INFO - 'use_talos_json': True, 19:22:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:22:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:22:34 INFO - 'work_dir': 'build'} 19:22:34 INFO - ##### 19:22:34 INFO - ##### Running clobber step. 19:22:34 INFO - ##### 19:22:34 INFO - Running pre-action listener: _resource_record_pre_action 19:22:34 INFO - Running main action method: clobber 19:22:34 INFO - rmtree: /builds/slave/test/build 19:22:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:22:35 INFO - Running post-action listener: _resource_record_post_action 19:22:35 INFO - ##### 19:22:35 INFO - ##### Finished clobber step (success) 19:22:35 INFO - ##### 19:22:35 INFO - ##### 19:22:35 INFO - ##### Running read-buildbot-config step. 19:22:35 INFO - ##### 19:22:35 INFO - Running pre-action listener: _resource_record_pre_action 19:22:35 INFO - Running main action method: read_buildbot_config 19:22:35 INFO - Using buildbot properties: 19:22:35 INFO - { 19:22:35 INFO - "project": "", 19:22:35 INFO - "product": "firefox", 19:22:35 INFO - "script_repo_revision": "production", 19:22:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 19:22:35 INFO - "repository": "", 19:22:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 19:22:35 INFO - "buildid": "20160622163003", 19:22:35 INFO - "pgo_build": "True", 19:22:35 INFO - "basedir": "/builds/slave/test", 19:22:35 INFO - "buildnumber": 1194, 19:22:35 INFO - "slavename": "talos-linux64-ix-015", 19:22:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:22:35 INFO - "platform": "ubuntu64_hw", 19:22:35 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 19:22:35 INFO - "branch": "mozilla-inbound", 19:22:35 INFO - "repo_path": "integration/mozilla-inbound", 19:22:35 INFO - "revision": "d2a087cdfb007a8a1aa919fcea061af9970fed72", 19:22:35 INFO - "stage_platform": "linux64-pgo", 19:22:35 INFO - "builduid": "6907781e6871434c91d1b3144a705520", 19:22:35 INFO - "slavebuilddir": "test" 19:22:35 INFO - } 19:22:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 19:22:35 INFO - Running post-action listener: _resource_record_post_action 19:22:35 INFO - ##### 19:22:35 INFO - ##### Finished read-buildbot-config step (success) 19:22:35 INFO - ##### 19:22:35 INFO - ##### 19:22:35 INFO - ##### Running download-and-extract step. 19:22:35 INFO - ##### 19:22:35 INFO - Running pre-action listener: _resource_record_pre_action 19:22:35 INFO - Running main action method: download_and_extract 19:22:35 INFO - mkdir: /builds/slave/test/build/tests 19:22: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:22:35 INFO - https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 19:22:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:22:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:22:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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:22:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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:22:42 INFO - Downloaded 1361 bytes. 19:22:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 19:22:42 INFO - Using the following test package requirements: 19:22:42 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:22:42 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:22:42 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:22:42 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:42 INFO - u'jsshell-linux-x86_64.zip'], 19:22:42 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:22:42 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 19:22:42 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:22:42 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:22:42 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:22:42 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 19:22:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:22:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:42 INFO - https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:22:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:22:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:22:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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:22:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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:22:53 INFO - Downloaded 24269771 bytes. 19:22:53 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:22:53 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:22:54 INFO - Return code: 0 19:22:54 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:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:22:54 INFO - https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:22:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:22:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 19:22:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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:22:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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:22:59 INFO - Downloaded 24269771 bytes. 19:22:59 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:22:59 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:23:00 INFO - Return code: 0 19:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:00 INFO - https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:23:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:23:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 19:23:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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:23:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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:23:07 INFO - Downloaded 14405384 bytes. 19:23:07 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:23:07 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:23:07 INFO - Return code: 0 19:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:07 INFO - https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:23:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:23:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:23:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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:23:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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:23:10 INFO - Downloaded 60125999 bytes. 19:23:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:23:10 INFO - mkdir: /builds/slave/test/properties 19:23:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:23:10 INFO - Writing to file /builds/slave/test/properties/build_url 19:23:10 INFO - Contents: 19:23:10 INFO - build_url:https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 19:23:11 INFO - Running post-action listener: _resource_record_post_action 19:23:11 INFO - Running post-action listener: set_extra_try_arguments 19:23:11 INFO - ##### 19:23:11 INFO - ##### Finished download-and-extract step (success) 19:23:11 INFO - ##### 19:23:11 INFO - ##### 19:23:11 INFO - ##### Running populate-webroot step. 19:23:11 INFO - ##### 19:23:11 INFO - Running pre-action listener: _resource_record_pre_action 19:23:11 INFO - Running main action method: populate_webroot 19:23:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:23:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:23:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:23:11 INFO - '--tppagecycles', 19:23:11 INFO - '7'], 19:23:11 INFO - 'tests': ['tsvgm']}}, 19:23:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:23:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:23:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:23:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:23:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:23:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:23:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:11 INFO - 'talos_options': ['--disable-e10s'], 19:23:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:23:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:23:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:11 INFO - 'talos_options': ['--disable-e10s'], 19:23:11 INFO - 'tests': ['damp', 'tps']}, 19:23:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:11 INFO - 'tests': ['damp', 'tps']}, 19:23:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:23:11 INFO - 'tests': ['dromaeo_dom']}, 19:23:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:23:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:23:11 INFO - 'tests': ['basic_compositor_video']}, 19:23:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:23:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:23:11 INFO - 'tests': ['a11yr', 19:23:11 INFO - 'ts_paint', 19:23:11 INFO - 'tpaint', 19:23:11 INFO - 'sessionrestore', 19:23:11 INFO - 'sessionrestore_no_auto_restore', 19:23:11 INFO - 'tabpaint']}, 19:23:11 INFO - 'other-e10s': {'tests': ['a11yr', 19:23:11 INFO - 'ts_paint', 19:23:11 INFO - 'tpaint', 19:23:11 INFO - 'sessionrestore', 19:23:11 INFO - 'sessionrestore_no_auto_restore', 19:23:11 INFO - 'tabpaint']}, 19:23:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:23:11 INFO - 'ts_paint', 19:23:11 INFO - 'tpaint', 19:23:11 INFO - 'sessionrestore', 19:23:11 INFO - 'sessionrestore_no_auto_restore', 19:23:11 INFO - 'tabpaint']}, 19:23:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:23:11 INFO - 'ts_paint', 19:23:11 INFO - 'tpaint', 19:23:11 INFO - 'sessionrestore', 19:23:11 INFO - 'sessionrestore_no_auto_restore', 19:23:11 INFO - 'tabpaint']}, 19:23:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:23:11 INFO - 'tests': ['a11yr', 19:23:11 INFO - 'ts_paint', 19:23:11 INFO - 'tpaint', 19:23:11 INFO - 'sessionrestore', 19:23:11 INFO - 'sessionrestore_no_auto_restore', 19:23:11 INFO - 'tabpaint']}, 19:23:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:23:11 INFO - 'tests': ['a11yr', 19:23:11 INFO - 'ts_paint', 19:23:11 INFO - 'tpaint', 19:23:11 INFO - 'sessionrestore', 19:23:11 INFO - 'sessionrestore_no_auto_restore', 19:23:11 INFO - 'tabpaint']}, 19:23:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:23:11 INFO - 'tests': ['tsvgx', 19:23:11 INFO - 'tsvgr_opacity', 19:23:11 INFO - 'tart', 19:23:11 INFO - 'tscrollx', 19:23:11 INFO - 'cart']}, 19:23:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:23:11 INFO - 'tsvgr_opacity', 19:23:11 INFO - 'tart', 19:23:11 INFO - 'tscrollx', 19:23:11 INFO - 'cart']}, 19:23:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:11 INFO - 'talos_options': ['--disable-e10s'], 19:23:11 INFO - 'tests': ['tp5o']}, 19:23:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:11 INFO - 'tests': ['tp5o']}, 19:23:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:11 INFO - 'talos_options': ['--disable-e10s', 19:23:11 INFO - '--xperf_path', 19:23:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:23:11 INFO - 'tests': ['tp5n']}, 19:23:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:23:11 INFO - 'talos_options': ['--xperf_path', 19:23:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:23:11 INFO - 'tests': ['tp5n']}}, 19:23:11 INFO - 'talos.zip': {'path': '', 19:23:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:23:11 INFO - Running post-action listener: _resource_record_post_action 19:23:11 INFO - ##### 19:23:11 INFO - ##### Finished populate-webroot step (success) 19:23:11 INFO - ##### 19:23:11 INFO - ##### 19:23:11 INFO - ##### Running create-virtualenv step. 19:23:11 INFO - ##### 19:23:11 INFO - Running pre-action listener: _resource_record_pre_action 19:23:11 INFO - Running main action method: create_virtualenv 19:23:11 INFO - Creating virtualenv /builds/slave/test/build/venv 19:23:11 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:23:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:23:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:23:11 INFO - Using real prefix '/usr' 19:23:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:23:11 INFO - Installing distribute.............................................................................................................................................................................................done. 19:23:13 INFO - Installing pip.................done. 19:23:13 INFO - Return code: 0 19:23:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:23:13 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:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:13 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:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:13 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 0x7fadfefebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ab350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1c0>, '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 0x1a3b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3b550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', '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:23:13 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:23:13 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:23:13 INFO - Using env: {'DISPLAY': ':0', 19:23:13 INFO - 'HOME': '/home/cltbld', 19:23:13 INFO - 'LANG': 'en_US.UTF-8', 19:23:13 INFO - 'LANGUAGE': 'en_US:en', 19:23:13 INFO - 'LOGNAME': 'cltbld', 19:23:13 INFO - 'MAIL': '/var/mail/cltbld', 19:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:13 INFO - 'MOZ_NO_REMOTE': '1', 19:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:13 INFO - 'NO_EM_RESTART': '1', 19:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:13 INFO - 'PWD': '/builds/slave/test', 19:23:13 INFO - 'SHELL': '/bin/bash', 19:23:13 INFO - 'SHLVL': '1', 19:23:13 INFO - 'TERM': 'linux', 19:23:13 INFO - 'TMOUT': '86400', 19:23:13 INFO - 'USER': 'cltbld', 19:23:13 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', 19:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:13 INFO - '_': '/tools/buildbot/bin/python'} 19:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:14 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:23:14 INFO - Cleaning up... 19:23:14 INFO - Return code: 0 19:23:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:14 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 0x7fadfefebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ab350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1c0>, '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 0x1a3b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3b550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', '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:23:14 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:23:14 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:23:14 INFO - Using env: {'DISPLAY': ':0', 19:23:14 INFO - 'HOME': '/home/cltbld', 19:23:14 INFO - 'LANG': 'en_US.UTF-8', 19:23:14 INFO - 'LANGUAGE': 'en_US:en', 19:23:14 INFO - 'LOGNAME': 'cltbld', 19:23:14 INFO - 'MAIL': '/var/mail/cltbld', 19:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:14 INFO - 'MOZ_NO_REMOTE': '1', 19:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:14 INFO - 'NO_EM_RESTART': '1', 19:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:14 INFO - 'PWD': '/builds/slave/test', 19:23:14 INFO - 'SHELL': '/bin/bash', 19:23:14 INFO - 'SHLVL': '1', 19:23:14 INFO - 'TERM': 'linux', 19:23:14 INFO - 'TMOUT': '86400', 19:23:14 INFO - 'USER': 'cltbld', 19:23:14 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', 19:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:14 INFO - '_': '/tools/buildbot/bin/python'} 19:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:14 INFO - Downloading/unpacking psutil>=3.1.1 19:23:14 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:23:14 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:23:14 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:23:14 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:23:14 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:23:14 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:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:23:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:23:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:23:16 INFO - Installing collected packages: psutil 19:23:16 INFO - Running setup.py install for psutil 19:23:16 INFO - building 'psutil._psutil_linux' extension 19:23:16 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:23:16 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:23:16 INFO - building 'psutil._psutil_posix' extension 19:23:16 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:23:16 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:23:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:23:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:23:16 INFO - Successfully installed psutil 19:23:16 INFO - Cleaning up... 19:23:16 INFO - Return code: 0 19:23:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:23:16 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:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:16 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:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:16 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 0x7fadfefebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ab350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1c0>, '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 0x1a3b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3b550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', '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:23:16 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:23:16 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:23:16 INFO - Using env: {'DISPLAY': ':0', 19:23:16 INFO - 'HOME': '/home/cltbld', 19:23:16 INFO - 'LANG': 'en_US.UTF-8', 19:23:16 INFO - 'LANGUAGE': 'en_US:en', 19:23:16 INFO - 'LOGNAME': 'cltbld', 19:23:16 INFO - 'MAIL': '/var/mail/cltbld', 19:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:16 INFO - 'MOZ_NO_REMOTE': '1', 19:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:16 INFO - 'NO_EM_RESTART': '1', 19:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:16 INFO - 'PWD': '/builds/slave/test', 19:23:16 INFO - 'SHELL': '/bin/bash', 19:23:16 INFO - 'SHLVL': '1', 19:23:16 INFO - 'TERM': 'linux', 19:23:16 INFO - 'TMOUT': '86400', 19:23:16 INFO - 'USER': 'cltbld', 19:23:16 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', 19:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:16 INFO - '_': '/tools/buildbot/bin/python'} 19:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:23:16 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:23:16 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:23:16 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:23: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:23: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:23: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:23:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:23:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:23:18 INFO - Installing collected packages: mozsystemmonitor 19:23:18 INFO - Running setup.py install for mozsystemmonitor 19:23:19 INFO - Successfully installed mozsystemmonitor 19:23:19 INFO - Cleaning up... 19:23:19 INFO - Return code: 0 19:23:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:23:19 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:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:19 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:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:19 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 0x7fadfefebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ab350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1c0>, '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 0x1a3b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3b550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', '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:23:19 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:23:19 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:23:19 INFO - Using env: {'DISPLAY': ':0', 19:23:19 INFO - 'HOME': '/home/cltbld', 19:23:19 INFO - 'LANG': 'en_US.UTF-8', 19:23:19 INFO - 'LANGUAGE': 'en_US:en', 19:23:19 INFO - 'LOGNAME': 'cltbld', 19:23:19 INFO - 'MAIL': '/var/mail/cltbld', 19:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:19 INFO - 'MOZ_NO_REMOTE': '1', 19:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:19 INFO - 'NO_EM_RESTART': '1', 19:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:19 INFO - 'PWD': '/builds/slave/test', 19:23:19 INFO - 'SHELL': '/bin/bash', 19:23:19 INFO - 'SHLVL': '1', 19:23:19 INFO - 'TERM': 'linux', 19:23:19 INFO - 'TMOUT': '86400', 19:23:19 INFO - 'USER': 'cltbld', 19:23:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', 19:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:19 INFO - '_': '/tools/buildbot/bin/python'} 19:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:19 INFO - Downloading/unpacking jsonschema==2.5.1 19:23:19 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:23:19 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:23:19 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:23:19 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:23:19 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:23:19 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:23:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:23:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:23:21 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:23:21 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:23:21 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:23:21 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:23:21 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:23:21 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:23:21 INFO - Downloading functools32-3.2.3-2.tar.gz 19:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:23:21 INFO - warning: no files found matching '*.txt' 19:23:21 INFO - no previously-included directories found matching 'build' 19:23:21 INFO - no previously-included directories found matching 'dist' 19:23:21 INFO - no previously-included directories found matching '.git*' 19:23:21 INFO - Installing collected packages: jsonschema, functools32 19:23:21 INFO - Running setup.py install for functools32 19:23:21 INFO - warning: no files found matching '*.txt' 19:23:21 INFO - no previously-included directories found matching 'build' 19:23:21 INFO - no previously-included directories found matching 'dist' 19:23:21 INFO - no previously-included directories found matching '.git*' 19:23:21 INFO - Successfully installed jsonschema functools32 19:23:21 INFO - Cleaning up... 19:23:21 INFO - Return code: 0 19:23:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:23:21 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:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:21 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:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:21 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 0x7fadfefebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ab350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1c0>, '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 0x1a3b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3b550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', '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:23:21 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:23:21 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:23:21 INFO - Using env: {'DISPLAY': ':0', 19:23:21 INFO - 'HOME': '/home/cltbld', 19:23:21 INFO - 'LANG': 'en_US.UTF-8', 19:23:21 INFO - 'LANGUAGE': 'en_US:en', 19:23:21 INFO - 'LOGNAME': 'cltbld', 19:23:21 INFO - 'MAIL': '/var/mail/cltbld', 19:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:21 INFO - 'MOZ_NO_REMOTE': '1', 19:23:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:21 INFO - 'NO_EM_RESTART': '1', 19:23:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:21 INFO - 'PWD': '/builds/slave/test', 19:23:21 INFO - 'SHELL': '/bin/bash', 19:23:21 INFO - 'SHLVL': '1', 19:23:21 INFO - 'TERM': 'linux', 19:23:21 INFO - 'TMOUT': '86400', 19:23:21 INFO - 'USER': 'cltbld', 19:23:21 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', 19:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:21 INFO - '_': '/tools/buildbot/bin/python'} 19:23:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:21 INFO - Downloading/unpacking blobuploader==1.2.4 19:23:21 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:23:21 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:23:21 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:23:21 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:23:21 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:23:21 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:23:23 INFO - Downloading blobuploader-1.2.4.tar.gz 19:23:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:23:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:23:23 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:23:23 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:23:23 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:23:23 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:23:23 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:23:23 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:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:23:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:23: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:23: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:23: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:23: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:23: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:23: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:23:24 INFO - Downloading docopt-0.6.1.tar.gz 19:23:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:23:24 INFO - Installing collected packages: blobuploader, requests, docopt 19:23:24 INFO - Running setup.py install for blobuploader 19:23:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:23:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:23:24 INFO - Running setup.py install for requests 19:23:24 INFO - Running setup.py install for docopt 19:23:25 INFO - Successfully installed blobuploader requests docopt 19:23:25 INFO - Cleaning up... 19:23:25 INFO - Return code: 0 19:23:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:23: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:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23: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:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:25 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 0x7fadfefebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ab350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1c0>, '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 0x1a3b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3b550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', '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:23:25 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:23:25 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:23:25 INFO - Using env: {'DISPLAY': ':0', 19:23:25 INFO - 'HOME': '/home/cltbld', 19:23:25 INFO - 'LANG': 'en_US.UTF-8', 19:23:25 INFO - 'LANGUAGE': 'en_US:en', 19:23:25 INFO - 'LOGNAME': 'cltbld', 19:23:25 INFO - 'MAIL': '/var/mail/cltbld', 19:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:25 INFO - 'MOZ_NO_REMOTE': '1', 19:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:25 INFO - 'NO_EM_RESTART': '1', 19:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:25 INFO - 'PWD': '/builds/slave/test', 19:23:25 INFO - 'SHELL': '/bin/bash', 19:23:25 INFO - 'SHLVL': '1', 19:23:25 INFO - 'TERM': 'linux', 19:23:25 INFO - 'TMOUT': '86400', 19:23:25 INFO - 'USER': 'cltbld', 19:23:25 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', 19:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:25 INFO - '_': '/tools/buildbot/bin/python'} 19:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:23:25 INFO - Running setup.py (path:/tmp/pip-XHQaQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:23:25 INFO - Running setup.py (path:/tmp/pip-Xc5QwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:23:25 INFO - Running setup.py (path:/tmp/pip-lUIcEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:23:25 INFO - Running setup.py (path:/tmp/pip-Jb_rG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:23:25 INFO - Running setup.py (path:/tmp/pip-b94d3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:23:25 INFO - Running setup.py (path:/tmp/pip-LWxYWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:23:25 INFO - Running setup.py (path:/tmp/pip-Pro3KZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:23:25 INFO - Running setup.py (path:/tmp/pip-bYXvJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:23:25 INFO - Running setup.py (path:/tmp/pip-vgKjON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:23:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:23:25 INFO - Running setup.py (path:/tmp/pip-iIsgme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:23:26 INFO - Running setup.py (path:/tmp/pip-UTt23C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:23:26 INFO - Running setup.py (path:/tmp/pip-I8Oz2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:23:26 INFO - Running setup.py (path:/tmp/pip-AJQBow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:23:26 INFO - Running setup.py (path:/tmp/pip-WirFvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:26 INFO - Running setup.py (path:/tmp/pip-pFgPjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:23:26 INFO - Running setup.py (path:/tmp/pip-C1YNrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:23:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:23:26 INFO - Running setup.py (path:/tmp/pip-Gu8cFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:23:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:23:26 INFO - Running setup.py install for manifestparser 19:23:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:23:26 INFO - Running setup.py install for mozcrash 19:23:26 INFO - Running setup.py install for mozdebug 19:23:26 INFO - Running setup.py install for mozdevice 19:23:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:23:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:23:26 INFO - Running setup.py install for mozfile 19:23:27 INFO - Running setup.py install for mozhttpd 19:23:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:23:27 INFO - Running setup.py install for mozinfo 19:23:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:23:27 INFO - Running setup.py install for mozInstall 19:23:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:23:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:23:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:23:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:23:27 INFO - Running setup.py install for mozleak 19:23:27 INFO - Running setup.py install for mozlog 19:23:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:23:27 INFO - Running setup.py install for moznetwork 19:23:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:23:27 INFO - Running setup.py install for mozprocess 19:23:27 INFO - Running setup.py install for mozprofile 19:23:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:23:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:23:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:23:27 INFO - Running setup.py install for mozrunner 19:23:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:23:28 INFO - Running setup.py install for mozscreenshot 19:23:28 INFO - Running setup.py install for moztest 19:23:28 INFO - Running setup.py install for mozversion 19:23:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:23:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:23:28 INFO - Cleaning up... 19:23:28 INFO - Return code: 0 19:23:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:23: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:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23: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:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:28 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 0x7fadfefebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ab350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1c0>, '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 0x1a3b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3b550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', '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:23:28 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:23:28 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:23:28 INFO - Using env: {'DISPLAY': ':0', 19:23:28 INFO - 'HOME': '/home/cltbld', 19:23:28 INFO - 'LANG': 'en_US.UTF-8', 19:23:28 INFO - 'LANGUAGE': 'en_US:en', 19:23:28 INFO - 'LOGNAME': 'cltbld', 19:23:28 INFO - 'MAIL': '/var/mail/cltbld', 19:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:28 INFO - 'MOZ_NO_REMOTE': '1', 19:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:28 INFO - 'NO_EM_RESTART': '1', 19:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:28 INFO - 'PWD': '/builds/slave/test', 19:23:28 INFO - 'SHELL': '/bin/bash', 19:23:28 INFO - 'SHLVL': '1', 19:23:28 INFO - 'TERM': 'linux', 19:23:28 INFO - 'TMOUT': '86400', 19:23:28 INFO - 'USER': 'cltbld', 19:23:28 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', 19:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:28 INFO - '_': '/tools/buildbot/bin/python'} 19:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:23:28 INFO - Running setup.py (path:/tmp/pip-VmiuXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:23:28 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:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:23:28 INFO - Running setup.py (path:/tmp/pip-cJtA_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:23:28 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:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:23:28 INFO - Running setup.py (path:/tmp/pip-oz5vxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:23:28 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:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:23:28 INFO - Running setup.py (path:/tmp/pip-xwvD3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:23:28 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:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:23:28 INFO - Running setup.py (path:/tmp/pip-w0kUyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:23:28 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:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:23:28 INFO - Running setup.py (path:/tmp/pip-pG6nIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:23:29 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:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:23:29 INFO - Running setup.py (path:/tmp/pip-phwpWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:23:29 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:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:23:29 INFO - Running setup.py (path:/tmp/pip-T26pUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:23:29 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:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:23:29 INFO - Running setup.py (path:/tmp/pip-GONT09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:23:29 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:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:23:29 INFO - Running setup.py (path:/tmp/pip-BJt87Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:23:29 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:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:23:29 INFO - Running setup.py (path:/tmp/pip-jeicLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:23:29 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:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:23:29 INFO - Running setup.py (path:/tmp/pip-ZS0jK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:23:29 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:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:23:29 INFO - Running setup.py (path:/tmp/pip-00Wm6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:23:29 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:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:23:29 INFO - Running setup.py (path:/tmp/pip-XYfHJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:23:29 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:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:29 INFO - Running setup.py (path:/tmp/pip-r2gJWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:23:29 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:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:23:29 INFO - Running setup.py (path:/tmp/pip-25_zHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:23:29 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:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:23:29 INFO - Running setup.py (path:/tmp/pip-O21JqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:23:29 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:23:29 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:23:29 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:23:29 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:23:29 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:23:29 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:23:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:23:29 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:23:29 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:23:29 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:23:29 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:23:29 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:23:29 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:23:31 INFO - Downloading blessings-1.6.tar.gz 19:23:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:23:31 INFO - Installing collected packages: blessings 19:23:31 INFO - Running setup.py install for blessings 19:23:31 INFO - Successfully installed blessings 19:23:31 INFO - Cleaning up... 19:23:31 INFO - Return code: 0 19:23:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:23:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:23:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:23:32 INFO - Reading from file tmpfile_stdout 19:23:32 INFO - Current package versions: 19:23:32 INFO - argparse == 1.2.1 19:23:32 INFO - blessings == 1.6 19:23:32 INFO - blobuploader == 1.2.4 19:23:32 INFO - docopt == 0.6.1 19:23:32 INFO - functools32 == 3.2.3-2 19:23:32 INFO - jsonschema == 2.5.1 19:23:32 INFO - manifestparser == 1.1 19:23:32 INFO - mozInstall == 1.12 19:23:32 INFO - mozcrash == 0.17 19:23:32 INFO - mozdebug == 0.1 19:23:32 INFO - mozdevice == 0.48 19:23:32 INFO - mozfile == 1.2 19:23:32 INFO - mozhttpd == 0.7 19:23:32 INFO - mozinfo == 0.9 19:23:32 INFO - mozleak == 0.1 19:23:32 INFO - mozlog == 3.2 19:23:32 INFO - moznetwork == 0.27 19:23:32 INFO - mozprocess == 0.22 19:23:32 INFO - mozprofile == 0.28 19:23:32 INFO - mozrunner == 6.11 19:23:32 INFO - mozscreenshot == 0.1 19:23:32 INFO - mozsystemmonitor == 0.3 19:23:32 INFO - moztest == 0.7 19:23:32 INFO - mozversion == 1.4 19:23:32 INFO - psutil == 3.1.1 19:23:32 INFO - requests == 1.2.3 19:23:32 INFO - wsgiref == 0.1.2 19:23:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:32 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 0x7fadfefebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ab350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1c0>, '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 0x1a3b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3b550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', '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:23:32 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:23:32 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:23:32 INFO - Using env: {'DISPLAY': ':0', 19:23:32 INFO - 'HOME': '/home/cltbld', 19:23:32 INFO - 'LANG': 'en_US.UTF-8', 19:23:32 INFO - 'LANGUAGE': 'en_US:en', 19:23:32 INFO - 'LOGNAME': 'cltbld', 19:23:32 INFO - 'MAIL': '/var/mail/cltbld', 19:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:32 INFO - 'MOZ_NO_REMOTE': '1', 19:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:32 INFO - 'NO_EM_RESTART': '1', 19:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:32 INFO - 'PWD': '/builds/slave/test', 19:23:32 INFO - 'SHELL': '/bin/bash', 19:23:32 INFO - 'SHLVL': '1', 19:23:32 INFO - 'TERM': 'linux', 19:23:32 INFO - 'TMOUT': '86400', 19:23:32 INFO - 'USER': 'cltbld', 19:23:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', 19:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:32 INFO - '_': '/tools/buildbot/bin/python'} 19:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:32 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:23:32 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:23:32 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:23:32 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:23:32 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:23:32 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:23:32 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:23:32 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:23:32 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:23:32 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:23:32 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:23:32 INFO - Cleaning up... 19:23:32 INFO - Return code: 0 19:23:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:32 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 0x7fadfefebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ab350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1c0>, '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 0x1a3b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3b550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', '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:23:32 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:23:32 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:23:32 INFO - Using env: {'DISPLAY': ':0', 19:23:32 INFO - 'HOME': '/home/cltbld', 19:23:32 INFO - 'LANG': 'en_US.UTF-8', 19:23:32 INFO - 'LANGUAGE': 'en_US:en', 19:23:32 INFO - 'LOGNAME': 'cltbld', 19:23:32 INFO - 'MAIL': '/var/mail/cltbld', 19:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:32 INFO - 'MOZ_NO_REMOTE': '1', 19:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:32 INFO - 'NO_EM_RESTART': '1', 19:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:32 INFO - 'PWD': '/builds/slave/test', 19:23:32 INFO - 'SHELL': '/bin/bash', 19:23:32 INFO - 'SHLVL': '1', 19:23:32 INFO - 'TERM': 'linux', 19:23:32 INFO - 'TMOUT': '86400', 19:23:32 INFO - 'USER': 'cltbld', 19:23:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', 19:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:32 INFO - '_': '/tools/buildbot/bin/python'} 19:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:23:32 INFO - Cleaning up... 19:23:32 INFO - Return code: 0 19:23:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:23:32 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 0x7fadfefebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ab350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a3a1c0>, '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 0x1a3b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3b550>, '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': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', '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:23:32 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:23:32 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:23:32 INFO - Using env: {'DISPLAY': ':0', 19:23:32 INFO - 'HOME': '/home/cltbld', 19:23:32 INFO - 'LANG': 'en_US.UTF-8', 19:23:32 INFO - 'LANGUAGE': 'en_US:en', 19:23:32 INFO - 'LOGNAME': 'cltbld', 19:23:32 INFO - 'MAIL': '/var/mail/cltbld', 19:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:32 INFO - 'MOZ_NO_REMOTE': '1', 19:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:32 INFO - 'NO_EM_RESTART': '1', 19:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:32 INFO - 'PWD': '/builds/slave/test', 19:23:32 INFO - 'SHELL': '/bin/bash', 19:23:32 INFO - 'SHLVL': '1', 19:23:32 INFO - 'TERM': 'linux', 19:23:32 INFO - 'TMOUT': '86400', 19:23:32 INFO - 'USER': 'cltbld', 19:23:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', 19:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:32 INFO - '_': '/tools/buildbot/bin/python'} 19:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:23:32 INFO - Downloading/unpacking flake8 19:23:32 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:23:32 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:23:32 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:23:32 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:23:32 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:23:32 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:23:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:23:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:23:34 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:23:34 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:23:34 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:23:34 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:23:34 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:23:34 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:23:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:23:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:23:34 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:23:34 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:23:34 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:23:34 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:23:34 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:23:34 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:23:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:23:35 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:23:35 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:23:35 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:23:35 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:23:35 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:23:35 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:23:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:23:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:23:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:23:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:23:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:23:35 INFO - no previously-included directories found matching 'docs/_build' 19:23:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:23:35 INFO - Running setup.py install for pep8 19:23:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:23:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:23:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:23:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:23:35 INFO - no previously-included directories found matching 'docs/_build' 19:23:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:23:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:23:35 INFO - Cleaning up... 19:23:35 INFO - Return code: 0 19:23:35 INFO - Running post-action listener: _resource_record_post_action 19:23:35 INFO - Running post-action listener: _start_resource_monitoring 19:23:35 INFO - Starting resource monitoring. 19:23:35 INFO - ##### 19:23:35 INFO - ##### Finished create-virtualenv step (success) 19:23:35 INFO - ##### 19:23:35 INFO - ##### 19:23:35 INFO - ##### Running install step. 19:23:35 INFO - ##### 19:23:35 INFO - Running pre-action listener: _resource_record_pre_action 19:23:35 INFO - Running main action method: install 19:23:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:23:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:23:35 INFO - Reading from file tmpfile_stdout 19:23:35 INFO - Detecting whether we're running mozinstall >=1.0... 19:23:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:23:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:23:35 INFO - Reading from file tmpfile_stdout 19:23:35 INFO - Output received: 19:23:35 INFO - Usage: mozinstall [options] installer 19:23:35 INFO - Options: 19:23:35 INFO - -h, --help show this help message and exit 19:23:35 INFO - -d DEST, --destination=DEST 19:23:35 INFO - Directory to install application into. [default: 19:23:35 INFO - "/builds/slave/test"] 19:23:35 INFO - --app=APP Application being installed. [default: firefox] 19:23:35 INFO - mkdir: /builds/slave/test/build/application 19:23:35 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:23:35 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:23:53 INFO - Reading from file tmpfile_stdout 19:23:53 INFO - Output received: 19:23:53 INFO - /builds/slave/test/build/application/firefox/firefox 19:23:53 INFO - Running post-action listener: _resource_record_post_action 19:23:53 INFO - ##### 19:23:53 INFO - ##### Finished install step (success) 19:23:53 INFO - ##### 19:23:53 INFO - ##### 19:23:53 INFO - ##### Running run-tests step. 19:23:53 INFO - ##### 19:23:53 INFO - Running pre-action listener: _resource_record_pre_action 19:23:53 INFO - Running main action method: run_tests 19:23:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:23:53 INFO - Python 2.7.3 19:23:53 INFO - Return code: 0 19:23:53 INFO - grabbing minidump binary from tooltool 19:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:23:53 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 0x1a3a1c0>, '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 0x1a3b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a3b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:23:53 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:23:53 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:23:53 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:23:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:23:53 INFO - Return code: 0 19:23:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:23:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:23:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:23:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:23:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:23:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:23:54 INFO - Return code: 0 19:23:54 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/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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:23:54 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/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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:23:54 INFO - Using env: {'DISPLAY': ':0', 19:23:54 INFO - 'HOME': '/home/cltbld', 19:23:54 INFO - 'LANG': 'en_US.UTF-8', 19:23:54 INFO - 'LANGUAGE': 'en_US:en', 19:23:54 INFO - 'LOGNAME': 'cltbld', 19:23:54 INFO - 'MAIL': '/var/mail/cltbld', 19:23:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:23:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:23:54 INFO - 'MOZ_NO_REMOTE': '1', 19:23:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:23:54 INFO - 'NO_EM_RESTART': '1', 19:23:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:23:54 INFO - 'PWD': '/builds/slave/test', 19:23:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:23:54 INFO - 'SHELL': '/bin/bash', 19:23:54 INFO - 'SHLVL': '1', 19:23:54 INFO - 'TERM': 'linux', 19:23:54 INFO - 'TMOUT': '86400', 19:23:54 INFO - 'USER': 'cltbld', 19:23:54 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774', 19:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:23:54 INFO - '_': '/tools/buildbot/bin/python'} 19:23:54 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/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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:23:54 INFO - mozversion application_buildid: 20160622163003 19:23:54 INFO - mozversion application_changeset: d2a087cdfb007a8a1aa919fcea061af9970fed72 19:23:54 INFO - mozversion application_display_name: Nightly 19:23:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:23:54 INFO - mozversion application_name: Firefox 19:23:54 INFO - mozversion application_remotingname: firefox 19:23:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:23:54 INFO - mozversion application_vendor: Mozilla 19:23:54 INFO - mozversion application_version: 50.0a1 19:23:54 INFO - mozversion platform_buildid: 20160622163003 19:23:54 INFO - mozversion platform_changeset: d2a087cdfb007a8a1aa919fcea061af9970fed72 19:23:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 19:23:54 INFO - mozversion platform_version: 50.0a1 19:23:54 INFO - using testdate: 1466648634 19:23:54 INFO - actual date: 1466648634 19:23:54 INFO - starting webserver on 'localhost:40512' 19:23:54 INFO - SUITE-START | Running 2 tests 19:23:54 INFO - TEST-START | dromaeo_css 19:23:54 INFO - operating with platform_type : linux_ 19:23:54 INFO - Initialising browser for dromaeo_css test... 19:23:54 INFO - TEST-INFO | started process 4031 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAvQB3S/profile http://localhost:40512/getInfo.html) 19:23:58 INFO - PROCESS | 4031 | __metrics Screen width/height:1600/1200 19:23:58 INFO - PROCESS | 4031 | colorDepth:24 19:23:58 INFO - PROCESS | 4031 | Browser inner width/height: 1024/697 19:23:58 INFO - PROCESS | 4031 | __metrics 19:23:59 ERROR - PROCESS | 4031 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 19:24:00 INFO - TEST-INFO | 4031: exit 0 19:24:00 INFO - Browser initialized. 19:24:00 INFO - Running cycle 1/1 for dromaeo_css test... 19:24:00 INFO - TEST-INFO | started process 4150 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAvQB3S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:24:12 INFO - PROCESS | 4150 | RSS: Main: 185028608 19:24:12 INFO - PROCESS | 4150 | 19:25:01 INFO - PROCESS | 4150 | 1466648701905 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:27:10 INFO - PROCESS | 4150 | Cycle 1(1): loaded http://localhost:40512/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40512/tests/dromaeo/cssquery-ext.html) 19:27:11 INFO - PROCESS | 4150 | RSS: Main: 189333504 19:27:11 INFO - PROCESS | 4150 | 19:30:13 INFO - PROCESS | 4150 | Cycle 1(1): loaded http://localhost:40512/tests/dromaeo/cssquery-ext.html (next: http://localhost:40512/tests/dromaeo/cssquery-jquery.html) 19:30:14 INFO - PROCESS | 4150 | RSS: Main: 187932672 19:30:14 INFO - PROCESS | 4150 | 19:33:16 INFO - PROCESS | 4150 | Cycle 1(1): loaded http://localhost:40512/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40512/tests/dromaeo/cssquery-mootools.html) 19:33:17 INFO - PROCESS | 4150 | RSS: Main: 189599744 19:33:17 INFO - PROCESS | 4150 | 19:36:18 INFO - PROCESS | 4150 | Cycle 1(1): loaded http://localhost:40512/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40512/tests/dromaeo/cssquery-prototype.html) 19:36:19 INFO - PROCESS | 4150 | RSS: Main: 187019264 19:36:19 INFO - PROCESS | 4150 | 19:39:21 INFO - PROCESS | 4150 | Cycle 1(1): loaded http://localhost:40512/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40512/tests/dromaeo/cssquery-yui.html) 19:39:22 INFO - PROCESS | 4150 | RSS: Main: 188936192 19:39:22 INFO - PROCESS | 4150 | 19:42:25 INFO - PROCESS | 4150 | Cycle 1(1): loaded http://localhost:40512/tests/dromaeo/cssquery-yui.html (next: http://localhost:40512/tests/dromaeo/cssquery-dojo.html) 19:42:25 INFO - PROCESS | 4150 | RSS: Main: 190242816 19:42:25 INFO - PROCESS | 4150 | 19:42:25 INFO - PROCESS | 4150 | __start_tp_report 19:42:25 INFO - PROCESS | 4150 | _x_x_mozilla_page_load 19:42:25 INFO - PROCESS | 4150 | _x_x_mozilla_page_load_details 19:42:25 INFO - PROCESS | 4150 | |i|pagename|runs| 19:42:25 INFO - PROCESS | 4150 | |0;dojo.html;3070.710301673297;3122.422351864905;3139.0582825152455;3147.7796554241186;3158.6683398243185;5430.864228394292;5451.809186678467;5454.372747134081;5592.6085174037835;5597.552195824334;5388.78444862206;5446.319210098738;5561.972190139044;5570.916436253459;5666.263385759856;4971.055499455101;4986.700797952134;5021.949780502185;5103.106956282654;5147.794088236466;5023.0707319145895;5173.482651734834;5196.610254230948;5197.558207552343;5219.791208351661;5030.924536131961;5041.19340905457;5080.77136528857;5089.033083714083;5099.566536844372;5050.4697006814495;5054.545090941796;5055.241713742931;5067.113255180328;5094.261332106824;4997.950020499785;5030.949690503085;5035.093683137034;5043.218301163325;5085.593152547787;5406.621536492447;5419.430959749209;5498.752556134944;5516.972415137939;5551.195076713854;5949.077892926603;5953.196318496991;5965.821025369246;5968.552358573081;5972.074328479092;6005.219321488223;6009.549283803733;6019.578629495937;6021.066734656135;6022.156898034279;5397.136458166714;5529.585281103893;5611.9438805612235;5615.747291371898;5633.492985631313;6157.96921015401;6166.352532983972;6167.167432396659;6173;6175.104609831639;5697.572682048863;5928.644281343047;5934;5937.198478205387;5949.9107513387335;5882.147088672119;5912.615679980788;5943.167956486095;5994.280686317583;6026.186464827279;5769.134629805562;5856.882862342814;5931.6441013539325;5959.821205363846;5963.224780778471;5787.710614469344;5913.970430147821;5979.760809567569;5986.880262394728;5987.072003839412;4513.413256276663;4572.291294849304;4578.725276483355;4591.9081618367445;4594.609458196024;4046.109855831712;4057.8173982170283;4072.1041370898356;4084.571120032413;4086.8773936781945;5474.7810087596845;5530.834074977757;5617;5629.577781666391;5652.378238393773;5922.851928701817;5930.1994230779155;5971.581989260797;6011.218541589653;6014.428629280212;5662.433756624305;5670.5463562914865;5677.1768093627015;5677.744501497443;5696.772129114872;4989.351384320088;5124.564412024945;5132.589392848563;5191.195364718475;5220.7128607926925;6199.225096862892;6221.06683997404;6227.346128656516;6255.96872015637;6256.405641464054;6005.219321488178;6028.668423236589;6031.7587296507645;6047.746415034187;6107.053406721965;5923.111533270044;6113.908291375722;6120.663363515049;6138.9095594588325;6177.343742190901;5827.24245848037;5871.706414679335;5906.143609176731;5909.793157239648;5976.551758618208;5966.463018328372;5989.700514974146;5995.61028533144;6020.187274717857;6037.335893051673;5644.6330988485615;5721.084626459747;5833.708314584169;5855.3559108497175;5913.142594323885;5639.097744360883;5732.656040637575;5742.971285143548;5761.769529218785;5762.538996880324;5658.5473162147755;5661.518770904519;5664.688442135557;5669.064604340238;5673.801416950387;5820.883582328245;5826.155207494805;5838.854028649318;5841.415858414124;5957.046872500379;5760.279965004374;5796.304443466811;5796.681182534832;5796.739146738322;5799.884002320015 19:42:25 INFO - PROCESS | 4150 | |1;ext.html;574.6293640601812;621.5431657731566;623.8689875126223;637.5059329020011;655.8852200864848;38446.615533844655;42938.355924661075;42950.78524607376;43062;43153.13693726124;43274.350884736756;43866.56133438665;44095;44123.558764412424;44156;8659.87010194846;8821.558922053904;8830;8846.955765221164;8852.336074794384;8900.955495222515;8901.109889011112;8966.910330896706;8980.730578082635;8986.550672466383;8987.101289870994;8990.775230619254;9020.45877247364;9026.323025773061;9054.32092593055;8957.865632015524;8986.146316099992;9020.323475739313;9024.63901443948;9025.277977761796;8712.21590056898;8796.07641197678;8805.515696636683;8852.247558957497;8903.866442003375;40870.38694419586;40984.38523422151;41015.794921025205;41354.58645413537;41428.37857432141;3352.329534093167;3438.5186073949667;3500.929981400383;3502.282032183422;3597.442396428558;29574.852125739235;29890;31140;34511.309773804634;34548;4337.110892267077;4367.235733746614;4411.830551478813;4565.018521017964;4590.747508887043;344574;345184;345490;345917;347046;60683.39316606866;60899.391006090256;60943.69528152331;61314.38685613176;61391.6930415354;33949.32101357959;35220.119497012776;35364.823175883954;58144.418555814744;58285.708571456875;15399.92300038515;15451.768223476656;15596.610084747972;15598.766018509732;15659.2953317101;11529.48117334722;11765.235259708263;11815.11386646005;11818.290902545874;11820.113491488173;19823.405297841087;19847.801521984886;19880.801191988183;19897.104630291673;20077.096530656156;7101.928980710127;7260.6732697028765;7419.480636355512;7470.439717021245;7490.250974902466;951.8619800128943;1005.7787286796893;1026.8921763214905;1085.495244711213;1102.1127991966384;31947.680523194937;32250.516242256384;32683.346333073205;32824.50763238553;33124.503132453036;1128.8814674459227;1184.7867383870814;1190.220405634311;1205.1443475132578;1211.309553554483;16722;17022.659546808994;17104.74342884858;17139.314427422763;17174.570635733955;561744;564088;566942;567831;568531;58932;59790.40209597848;60415.39584604186;60655.69672151611;60945.39054609486;1293.6765808547864;1339.799030145486;1360.4830164537414;1362.3120324236197;1367.8402889325491;30404.5439318406;31886.36227275488;31912.723491060096;32557.348853022333;32658.51012234866;51634;51891.740541297055;52095.73952130215;52232.73883630557;52314.738426307624;447742;449116;451373;451900;453611;27548.724512754616;27763.583546247228;28782.712172878004;29002.419951600426;30627.387452250383;46787.76606117084;46994.29508557443;47317.290240647104;48257.276140858616;48322;39074.2185156301;39377.60622393739;39772.801135995294;40236;40614.18771624492;41251.793741031106;41902.37146442867;42134.78932605317;42873.35689964715;43079.569204307554;41582.79208603938;42000.4754546524;43214.35178472388;43250;43452.34821477617;35737.821310893276;38196.61803381931;38696.613033869304;38750.224995500495;39082.6091739079;28410.57384139281;28818.423631527672;29006.27484312909;29024.41951161007;29125.563116552847 19:42:25 INFO - PROCESS | 4150 | |2;jquery.html;393.18806664238355;395.19577659463;400.49937578027465;400.7935913004801;408.2406723494302;13299.933500332509;17926.82073179268;18679.97260150691;19570;19602.509937251576;18011.729824052618;18660.440186794385;18897.244110235573;19072.71390929137;19147.234110635593;5582.441755824405;5638;5790.160426738121;5818.534517238632;5866.325372582143;5766.567507436938;5787.913181302284;5832.562557808182;5838.416158384149;5863.941360586404;5270.7628156733035;5572.693501857396;5593;5767.625104368202;5800.9129863052085;5611.382747897728;5641.210230567724;5654.038813401711;5672.461116193976;5684.062129748628;5470.781168753285;5475.0966090595;5484.177373393983;5503;5529.723513824292;13744.175349479063;13799.103058301178;13821.723565528633;13878.444862205499;15050.021748586416;2295.540891821626;2366.408397900525;2562.8718564071723;2772.459370422768;3000.1899487138567;10083.546240419126;10349.275550711453;10405.11556517697;10522.78954420915;14032.737053665118;1842.7235914612916;1895.781985071707;1916;1969.2319995201883;1995.122146255643;78592.60703696503;82908.58545707293;83408;84742;85073;10578.576856925636;10730.946345268223;10826.242163048511;11043.558257669763;11075.889241107647;15315.081095134328;15478.380864765508;15482.148481833607;15483.148426836633;15539.766903496457;7673.654685539164;7822.882656760153;7825.060992680915;7890.210978902064;8010;7369.8894516582295;7374.778756637309;7539.660715267826;7596.658150383246;7627.5042122261875;4609.423822022247;4623.098495793288;4623.537646235417;4682.41469816273;4767.141914455431;1901.9334323298617;1964.0965156028387;1964.116147733497;2004.4287378097172;2010.9195632174842;879.4942907828024;1032.8812186598636;1041.8749750030045;1042.7601651620018;1046.5918291866178;17736.822631773775;18534.629307414045;18743.34398296053;19221.423357299303;19884.304049358205;990.821652102614;993.9850902236327;1029.7683021320292;1059.6344261229863;1068.120108608854;10326.225533084898;10749.83875241872;10775;10777.137828973664;10812;439399;449073;454051;456565;459330;69336;82257.58871205605;82567.587162065;94142.5292873545;94187;1021.274894824668;1043.6555936540924;1048.5229220704562;1073.2809017957986;1078.1536493852288;15078.698426031637;16406.425775097814;16844.831551684325;17009.234584443482;17225.827741722424;30554.70839686988;39124.6087539121;39843;40007.799961001176;44465;58756.41243587509;59866.70066649813;59968.40031599628;60233.39766602453;61712.38287617066;8647.87028194565;8655.221030107321;8674.132586741276;8734.56327183651;8859.468431894107;9958.800823983334;13806.033577649468;13863.861361386256;13886.166829990232;14050.78923816164;11790.882091178979;12052;12064.698382540506;12282.324472154118;12344.074194435274;11806.586769463027;12019.519219231483;12262.938685306517;12282.201656892274;12565.748685026065;12125.75748485043;12158.331291779037;12192.08559358034;12303.138780285293;12378.876211238132;8500.914990850013;8597.785055373666;8697.95651021741;8744.868826967473;8811.515366654896;11183.608573699881;12008.519659213534;12065.215760975509;12112;12179.330136842558 19:42:25 INFO - PROCESS | 4150 | |3;mootools.html;1463.8755705765006;1468.7943687883694;1592.7292360298748;1689.543823167744;1731.3334366268991;8036.799080023003;8455.661773529058;8712.651493940251;8968.73093807186;9022.954885225572;8804.955975220115;9072.546372681372;9076;9141.177294043535;9170.862437063433;2332.7783860533223;2368.822338324624;2370.596998510249;2370.845895016827;2370.928872133839;2290.7709229077127;2310.4223944013997;2320.269115228706;2321.9419514512188;2326.081197926818;2240.0815665577115;2279.555486680098;2280.920167794119;2295.1622657729977;2324.9651255231183;2254.639257718757;2259.7175353080866;2263.173941511353;2263.5246598214394;2267.9319620411416;2231.732192136954;2234.128689810975;2236.6421372580307;2240.8207343412487;2247.179779380531;8967.730968070968;9008.279337652972;9042.547872606343;9044.683436079771;9104.681336153202;5288.862894477667;5358.571314294886;5383.4616538346245;5440.91838622417;5444.101723215665;3078.6459557150993;3196.5844440222622;3299.1752061984503;3312.271300313927;3319.452290372086;1047.1518070363031;1049.2130901823632;1061.310148403544;1073.6617965340893;1075.5160177919968;12752.872471275261;12796.2962037087;12796.48814047437;12799.168054076456;12828.871711282954;4733.219018861918;4743.786529606176;4838.516148385203;4855.077535268288;4860.441049279378;10704.571817127384;10710.303830251009;10712.089472394779;10719.410432426135;10753.51609177589;5441.564674826004;5458;5467;5485.6434331768305;5511.5039646432015;4306.267934451151;4821.63837712173;4875.24433712775;4979.203327467588;4981.402231732215;3975.284448799186;4004.959950400517;4033.233685599727;4142.337226043818;4148.875533733993;1198.17924721566;1204.151073493185;1229.9016078713682;1231.4335405713293;1270.555305643036;904.9457032578066;926.4765407544716;930.3627015494408;931.8089791592707;933.118203297877;5614.326280846324;5683.886322273532;5707.971460142673;5715.485606295453;5837.09525023622;961.3847137831793;1001.5693251901606;1006.2453160129902;1012.6405126180247;1032.9225308101923;3929.1945151243926;3964.0882597002274;3975.2447035063246;3985.163115745726;4053.5541090480024;11120.666380008613;11359.886401135884;11510.021648159833;11518.712032199262;11528.942355288338;11185.32888026721;11242.156838237164;11284.266522676;11306.886931130748;11465.885341146482;8231.835363292701;8625.69810056645;8644.913550864536;8652.264557512555;8663.176998185163;5664.320281566238;5813.128030795415;5841.561882858718;5904.763809447574;5966.642001479925;10365.429901355497;10480.161587072864;10487;10548.472576371305;10599.205059620714;10536.789264214825;10636.361818290927;10801.459927003776;10861.837072444077;10956.671299861016;6884.277150899084;7158.856822863618;7242.927570724225;7308.926910731037;7562.848743025219;8900.821983560163;8934.151255630704;8958.596863141043;9008.549572521479;9021.548922553977;7877.960610196912;7972;8010.639521221442;8180.222878826502;8208;7821.882671759814;7838.3337416320255;7913.485623434458;8073.35413166957;8158.796030099057;7173.748918787817;7198.49610527279;7224.060872086595;7328.157261914735;7337.59643219628;4726.385569875894;4772.618190544678;4920.926186107283;4922.581580565692;4926.778294976663;5255.3168088148295;5260.342457192851;5321.201819727072;5329.813456529003;5388.784448622011 19:42:25 INFO - PROCESS | 4150 | |4;prototype.html;324.61370968547425;326.8757872008637;328.54332477855775;330.6164848775421;331.9867205311786;5546.4730850569185;5606.467385598372;5623.184638227454;5655.095184770437;5713.771629064669;5532.419095994923;5571.582131340156;5601.915971260424;5606.299212598426;5617.915731264035;4141.337386018237;4159.70882038256;4322.654187664979;4348.195583816988;4351.456067991501;4313.633341166004;4315.4389929309145;4317.913641727164;4320.719153255044;4322.783860806962;4272.145570885819;4296.871093867173;4298.699091063627;4316.503602085753;4345.652347812167;4016.8995775105564;4256.701381254119;4256.872293831159;4262.829486820523;4310.762908040057;3710.517632707758;3727.2295659561764;3761.605031471711;3769.378052621314;3775.093977445421;5521.475459831309;5522.0336441123045;5540.279763630742;5568.638038527523;5581.246531718247;4776.379070720819;4839.516048395168;4844.934114494806;4851.587615052725;4910.281401509443;5790.623609465413;5819.883602327972;5825.359210486843;5828.300603927513;5835.912461313042;4098.6516146127615;4112.876613701564;4122;4124.298869192245;4142.212979533909;5774.307083150007;6037.154798328237;6045.969770151121;6086.360932102154;6106.877862442726;4167.395727619478;4193.496780386373;4210.115875666144;4215.683823713233;4231.61915427613;4232.978835105805;4233.364995250737;4243.0269924485265;4250.598411897268;4250.766207858597;4567.58891699742;4816.446108697544;4852.568492294781;4900.117978763857;4917.827876024322;5813.273340832396;5815.621984570989;5826.533877289891;5839.357670656224;5857.88284234313;1445.1401416157369;1461.3350925329162;1463.3122432456728;1470.2722152534564;1481.5925620454461;893.6738090596886;933.4119504712123;936.8220038192721;976.829054915387;982.8230918434607;5564.360098588714;5574;5582.441755824385;5585.218069470277;5593.664380137205;5905.557083218776;5912.290525137011;5934.347221805598;5959.731812068468;5981.940180598225;5235.842924712265;5551.806361632269;5568.415316391802;5592.5805564582815;5622.718864056781;3165.398574270881;3186.1715953852167;3188.8998295587985;3197.280611862359;3214.1803840020643;5906.350301466835;6157.89157951573;6162.414570615784;6163.84590385235;6178.474829639441;5995.5803093783015;5999.910001349983;6013.9699301503215;6116.174316467309;6135.233095863017;5991.490723288569;6019.247594050744;6055.485283750842;6074.605150665193;6100.572959892854;5656.236408084856;5921.667624784389;5923.229980102559;5932.199153114274;5941.821745347646;5743.224664670216;5789.8709751598035;5864.794732184353;5874.739519566681;5905.645661260338;5871.530277577698;5995.820125396245;6030.3668114847305;6041.18444010053;6068.21113255274;4113.745307681066;4114.670826333946;4123.938140927949;4131.566185550474;4132.421460995403;5873.882522349443;5898.587098903035;5914.792982245601;5924.119701595462;5950.583459157991;5539.279893613804;5768.884622307614;5769.8557536061935;5780.797672081457;5782.971085144547;5595.63628364155;5677.687727175045;5689.6586204827845;5746.482816546531;5757.856053598526;5475.72621368922;5567.498925096761;5633.4084921082695;5656.208130861765;5720.827230417671;5845.883082338244;5845.883082338244;5853.9121913172185;5880.117982302689;5890.4993075589055;5438.972805135949;5691.4877661010705;5700.458456446631;5741.25363702716;5747.224124743107 19:42:25 INFO - PROCESS | 4150 | |5;yui.html;717.3328804212088;732.1068296678051;799.1848314718986;815.1563132158213;864.5331520978672;14374.13755174689;15591.220438978062;15655.686886262281;15746.133962632051;15859;15001.249937503137;15032.849671503282;15108.773368399483;15144.848551514482;15265.08409495431;813.5037627047496;822.576373167819;825.2737590920012;827.3133299361516;828.1097819843662;680.2313385873955;801.5551368990238;830.8213734047179;833.62903507939;834.70785225171;852.433131967241;852.6163226548047;853.1937319233327;857.7555396711938;861.7285555050139;848.325581162977;849.6813694864426;854.0690647194557;855.897292324925;856.9057403685621;615.4676205082616;618.3383779356091;619.0961196652892;621.4438077920281;621.7295476467751;14706.411743530245;14715.926420367936;14719.337629806685;14719.484818031318;14759.409623615042;15260.236988150547;15272.923635381752;15434;15716.449924252596;15753.527394178078;11947.761044779056;12029.759404811943;12052.161020533009;12359.62921112368;12474.126811123226;3600.1719604491113;3601.6398360164035;3659.396199627058;3661;3753.39945608704;73172;73428;73608.63195684041;74656;77383;11687.415629218505;11731.945992815557;11794.29234245948;11863.88136118645;11936.820947685792;19161.808381916282;19949.900250498944;22554.661680074812;22692.546149076927;22890.084396623948;8853.114688531095;8926.464412135292;8987.595558199897;9120.771980700403;9167.541622918961;4728.125296820031;4848.5636292733825;4851.611871050308;4861.659683822169;4987.251912213124;3654.1230104775195;3787.62123787619;3788.507494025759;3812.7902965336616;3840.5583357914197;662.3939095727355;665.2682049745338;666.8299583606247;682.6552590941642;684.8253695307765;603.9969800150972;643.5045015338256;646.4989633034436;680.9216940051957;713.4587411065096;9823.901760982442;10175.694729158136;10217.18262538995;10405;10417.427041512638;628.2649300318546;730.7259777583406;733.7211859493358;761.2121454294778;766.2375935943771;4284.4430224070675;4746.928796068062;4781.641376896747;4847.304928258916;4867;107133.46433267783;110355.44822275998;111664;113014.43492782484;114163;96304;96902.51548742212;97872.51063744635;97922;99377;86684.56657716798;86936.56531717427;87466;87928.56035719908;88217.99999999872;8999.415038022507;9038.864417033617;9055.637774488947;9080.364374493722;9182.444621004197;47015.76492117518;48404.75797620989;49334;49695.25457118074;50642.240366393795;66670;73676.26323736909;75232.49535009378;75468;76288.61855690686;11445.25605835618;11477.139214559109;11508;11646.126540509325;11743.76512469763;13656.549966144916;13838.723225535634;13920.95592830562;14034.649133771738;14361.64095897611;12649;12794.552190673281;13032.869671303544;13089.934550327187;13596.456141754219;12682.87317126817;12953.611391658265;13175;13186.340682966005;13380.93309533485;12930.288834114213;13231.27228002469;13285;13309.86690133125;13842.792358114837;10321;10599.682009539727;10783.245172837826;10790.35257884498;10886.727831803952;10877.184211184034;10986.176036797113;11113.388763618079;11200.271982321123;11285.43572821372 19:42:25 INFO - PROCESS | 4150 | __end_tp_report 19:42:25 INFO - PROCESS | 4150 | __start_cc_report 19:42:25 INFO - PROCESS | 4150 | _x_x_mozilla_cycle_collect,365 19:42:25 INFO - PROCESS | 4150 | __end_cc_report 19:42:25 INFO - PROCESS | 4150 | __startTimestamp1466649745457__endTimestamp 19:42:25 INFO - PROCESS | 4150 | 19:42:25 INFO - PROCESS | 4150 | ------- Summary: start ------- 19:42:25 INFO - PROCESS | 4150 | Number of tests: 6 19:42:25 INFO - PROCESS | 4150 | 19:42:25 INFO - PROCESS | 4150 | [#0] dojo.html Cycles:165 Average:5530.10 Median:5697.57 stddev:641.93 (11.3%) stddev-sans-first:614.22 19:42:25 INFO - PROCESS | 4150 | Values: 3070.7 3122.4 3139.1 3147.8 3158.7 5430.9 5451.8 5454.4 5592.6 5597.6 5388.8 5446.3 5562.0 5570.9 5666.3 4971.1 4986.7 5021.9 5103.1 5147.8 5023.1 5173.5 5196.6 5197.6 5219.8 5030.9 5041.2 5080.8 5089.0 5099.6 5050.5 5054.5 5055.2 5067.1 5094.3 4998.0 5030.9 5035.1 5043.2 5085.6 5406.6 5419.4 5498.8 5517.0 5551.2 5949.1 5953.2 5965.8 5968.6 5972.1 6005.2 6009.5 6019.6 6021.1 6022.2 5397.1 5529.6 5611.9 5615.7 5633.5 6158.0 6166.4 6167.2 6173.0 6175.1 5697.6 5928.6 5934.0 5937.2 5949.9 5882.1 5912.6 5943.2 5994.3 6026.2 5769.1 5856.9 5931.6 5959.8 5963.2 5787.7 5914.0 5979.8 5986.9 5987.1 4513.4 4572.3 4578.7 4591.9 4594.6 4046.1 4057.8 4072.1 4084.6 4086.9 5474.8 5530.8 5617.0 5629.6 5652.4 5922.9 5930.2 5971.6 6011.2 6014.4 5662.4 5670.5 5677.2 5677.7 5696.8 4989.4 5124.6 5132.6 5191.2 5220.7 6199.2 6221.1 6227.3 6256.0 6256.4 6005.2 6028.7 6031.8 6047.7 6107.1 5923.1 6113.9 6120.7 6138.9 6177.3 5827.2 5871.7 5906.1 5909.8 5976.6 5966.5 5989.7 5995.6 6020.2 6037.3 5644.6 5721.1 5833.7 5855.4 5913.1 5639.1 5732.7 5743.0 5761.8 5762.5 5658.5 5661.5 5664.7 5669.1 5673.8 5820.9 5826.2 5838.9 5841.4 5957.0 5760.3 5796.3 5796.7 5796.7 5799.9 19:42:25 INFO - PROCESS | 4150 | 19:42:25 INFO - PROCESS | 4150 | [#1] ext.html Cycles:180 Average:61096.04 Median:41951.42 stddev:122951.90 (293.1%) stddev-sans-first:123212.85 19:42:25 INFO - PROCESS | 4150 | Values: 574.6 621.5 623.9 637.5 655.9 38446.6 42938.4 42950.8 43062.0 43153.1 43274.4 43866.6 44095.0 44123.6 44156.0 8659.9 8821.6 8830.0 8847.0 8852.3 8901.0 8901.1 8966.9 8980.7 8986.6 8987.1 8990.8 9020.5 9026.3 9054.3 8957.9 8986.1 9020.3 9024.6 9025.3 8712.2 8796.1 8805.5 8852.2 8903.9 40870.4 40984.4 41015.8 41354.6 41428.4 3352.3 3438.5 3500.9 3502.3 3597.4 29574.9 29890.0 31140.0 34511.3 34548.0 4337.1 4367.2 4411.8 4565.0 4590.7 344574.0 345184.0 345490.0 345917.0 347046.0 60683.4 60899.4 60943.7 61314.4 61391.7 33949.3 35220.1 35364.8 58144.4 58285.7 15399.9 15451.8 15596.6 15598.8 15659.3 11529.5 11765.2 11815.1 11818.3 11820.1 19823.4 19847.8 19880.8 19897.1 20077.1 7101.9 7260.7 7419.5 7470.4 7490.3 951.9 1005.8 1026.9 1085.5 1102.1 31947.7 32250.5 32683.3 32824.5 33124.5 1128.9 1184.8 1190.2 1205.1 1211.3 16722.0 17022.7 17104.7 17139.3 17174.6 561744.0 564088.0 566942.0 567831.0 568531.0 58932.0 59790.4 60415.4 60655.7 60945.4 1293.7 1339.8 1360.5 1362.3 1367.8 30404.5 31886.4 31912.7 32557.3 32658.5 51634.0 51891.7 52095.7 52232.7 52314.7 447742.0 449116.0 451373.0 451900.0 453611.0 27548.7 27763.6 28782.7 29002.4 30627.4 46787.8 46994.3 47317.3 48257.3 48322.0 39074.2 39377.6 39772.8 40236.0 40614.2 41251.8 41902.4 42134.8 42873.4 43079.6 41582.8 42000.5 43214.4 43250.0 43452.3 35737.8 38196.6 38696.6 38750.2 39082.6 28410.6 28818.4 29006.3 29024.4 29125.6 19:42:25 INFO - PROCESS | 4150 | 19:42:25 INFO - PROCESS | 4150 | [#2] jquery.html Cycles:180 Average:27480.72 Median:2153.23 stddev:74642.03 (3466.5%) stddev-sans-first:74823.71 19:42:25 INFO - PROCESS | 4150 | Values: 393.2 395.2 400.5 400.8 408.2 13299.9 17926.8 18680.0 19570.0 19602.5 18011.7 18660.4 18897.2 19072.7 19147.2 5582.4 5638.0 5790.2 5818.5 5866.3 5766.6 5787.9 5832.6 5838.4 5863.9 5270.8 5572.7 5593.0 5767.6 5800.9 5611.4 5641.2 5654.0 5672.5 5684.1 5470.8 5475.1 5484.2 5503.0 5529.7 13744.2 13799.1 13821.7 13878.4 15050.0 2295.5 2366.4 2562.9 2772.5 3000.2 10083.5 10349.3 10405.1 10522.8 14032.7 1842.7 1895.8 1916.0 1969.2 1995.1 78592.6 82908.6 83408.0 84742.0 85073.0 10578.6 10730.9 10826.2 11043.6 11075.9 15315.1 15478.4 15482.1 15483.1 15539.8 7673.7 7822.9 7825.1 7890.2 8010.0 7369.9 7374.8 7539.7 7596.7 7627.5 4609.4 4623.1 4623.5 4682.4 4767.1 1901.9 1964.1 1964.1 2004.4 2010.9 879.5 1032.9 1041.9 1042.8 1046.6 17736.8 18534.6 18743.3 19221.4 19884.3 990.8 994.0 1029.8 1059.6 1068.1 10326.2 10749.8 10775.0 10777.1 10812.0 439399.0 449073.0 454051.0 456565.0 459330.0 69336.0 82257.6 82567.6 94142.5 94187.0 1021.3 1043.7 1048.5 1073.3 1078.2 15078.7 16406.4 16844.8 17009.2 17225.8 30554.7 39124.6 39843.0 40007.8 44465.0 58756.4 59866.7 59968.4 60233.4 61712.4 8647.9 8655.2 8674.1 8734.6 8859.5 9958.8 13806.0 13863.9 13886.2 14050.8 11790.9 12052.0 12064.7 12282.3 12344.1 11806.6 12019.5 12262.9 12282.2 12565.7 12125.8 12158.3 12192.1 12303.1 12378.9 8500.9 8597.8 8698.0 8744.9 8811.5 11183.6 12008.5 12065.2 12112.0 12179.3 19:42:25 INFO - PROCESS | 4150 | 19:42:25 INFO - PROCESS | 4150 | [#3] mootools.html Cycles:180 Average:5915.08 Median:4729.80 stddev:3456.72 (73.1%) stddev-sans-first:3450.23 19:42:25 INFO - PROCESS | 4150 | Values: 1463.9 1468.8 1592.7 1689.5 1731.3 8036.8 8455.7 8712.7 8968.7 9023.0 8805.0 9072.5 9076.0 9141.2 9170.9 2332.8 2368.8 2370.6 2370.8 2370.9 2290.8 2310.4 2320.3 2321.9 2326.1 2240.1 2279.6 2280.9 2295.2 2325.0 2254.6 2259.7 2263.2 2263.5 2267.9 2231.7 2234.1 2236.6 2240.8 2247.2 8967.7 9008.3 9042.5 9044.7 9104.7 5288.9 5358.6 5383.5 5440.9 5444.1 3078.6 3196.6 3299.2 3312.3 3319.5 1047.2 1049.2 1061.3 1073.7 1075.5 12752.9 12796.3 12796.5 12799.2 12828.9 4733.2 4743.8 4838.5 4855.1 4860.4 10704.6 10710.3 10712.1 10719.4 10753.5 5441.6 5458.0 5467.0 5485.6 5511.5 4306.3 4821.6 4875.2 4979.2 4981.4 3975.3 4005.0 4033.2 4142.3 4148.9 1198.2 1204.2 1229.9 1231.4 1270.6 904.9 926.5 930.4 931.8 933.1 5614.3 5683.9 5708.0 5715.5 5837.1 961.4 1001.6 1006.2 1012.6 1032.9 3929.2 3964.1 3975.2 3985.2 4053.6 11120.7 11359.9 11510.0 11518.7 11528.9 11185.3 11242.2 11284.3 11306.9 11465.9 8231.8 8625.7 8644.9 8652.3 8663.2 5664.3 5813.1 5841.6 5904.8 5966.6 10365.4 10480.2 10487.0 10548.5 10599.2 10536.8 10636.4 10801.5 10861.8 10956.7 6884.3 7158.9 7242.9 7308.9 7562.8 8900.8 8934.2 8958.6 9008.5 9021.5 7878.0 7972.0 8010.6 8180.2 8208.0 7821.9 7838.3 7913.5 8073.4 8158.8 7173.7 7198.5 7224.1 7328.2 7337.6 4726.4 4772.6 4920.9 4922.6 4926.8 5255.3 5260.3 5321.2 5329.8 5388.8 19:42:25 INFO - PROCESS | 4150 | 19:42:25 INFO - PROCESS | 4150 | [#4] prototype.html Cycles:180 Average:4860.69 Median:5594.65 stddev:1439.53 (25.7%) stddev-sans-first:1402.73 19:42:25 INFO - PROCESS | 4150 | Values: 324.6 326.9 328.5 330.6 332.0 5546.5 5606.5 5623.2 5655.1 5713.8 5532.4 5571.6 5601.9 5606.3 5617.9 4141.3 4159.7 4322.7 4348.2 4351.5 4313.6 4315.4 4317.9 4320.7 4322.8 4272.1 4296.9 4298.7 4316.5 4345.7 4016.9 4256.7 4256.9 4262.8 4310.8 3710.5 3727.2 3761.6 3769.4 3775.1 5521.5 5522.0 5540.3 5568.6 5581.2 4776.4 4839.5 4844.9 4851.6 4910.3 5790.6 5819.9 5825.4 5828.3 5835.9 4098.7 4112.9 4122.0 4124.3 4142.2 5774.3 6037.2 6046.0 6086.4 6106.9 4167.4 4193.5 4210.1 4215.7 4231.6 4233.0 4233.4 4243.0 4250.6 4250.8 4567.6 4816.4 4852.6 4900.1 4917.8 5813.3 5815.6 5826.5 5839.4 5857.9 1445.1 1461.3 1463.3 1470.3 1481.6 893.7 933.4 936.8 976.8 982.8 5564.4 5574.0 5582.4 5585.2 5593.7 5905.6 5912.3 5934.3 5959.7 5981.9 5235.8 5551.8 5568.4 5592.6 5622.7 3165.4 3186.2 3188.9 3197.3 3214.2 5906.4 6157.9 6162.4 6163.8 6178.5 5995.6 5999.9 6014.0 6116.2 6135.2 5991.5 6019.2 6055.5 6074.6 6100.6 5656.2 5921.7 5923.2 5932.2 5941.8 5743.2 5789.9 5864.8 5874.7 5905.6 5871.5 5995.8 6030.4 6041.2 6068.2 4113.7 4114.7 4123.9 4131.6 4132.4 5873.9 5898.6 5914.8 5924.1 5950.6 5539.3 5768.9 5769.9 5780.8 5783.0 5595.6 5677.7 5689.7 5746.5 5757.9 5475.7 5567.5 5633.4 5656.2 5720.8 5845.9 5845.9 5853.9 5880.1 5890.5 5439.0 5691.5 5700.5 5741.3 5747.2 19:42:25 INFO - PROCESS | 4150 | 19:42:25 INFO - PROCESS | 4150 | [#5] yui.html Cycles:180 Average:20508.60 Median:25871.95 stddev:29377.63 (113.6%) stddev-sans-first:29422.46 19:42:25 INFO - PROCESS | 4150 | Values: 717.3 732.1 799.2 815.2 864.5 14374.1 15591.2 15655.7 15746.1 15859.0 15001.2 15032.8 15108.8 15144.8 15265.1 813.5 822.6 825.3 827.3 828.1 680.2 801.6 830.8 833.6 834.7 852.4 852.6 853.2 857.8 861.7 848.3 849.7 854.1 855.9 856.9 615.5 618.3 619.1 621.4 621.7 14706.4 14715.9 14719.3 14719.5 14759.4 15260.2 15272.9 15434.0 15716.4 15753.5 11947.8 12029.8 12052.2 12359.6 12474.1 3600.2 3601.6 3659.4 3661.0 3753.4 73172.0 73428.0 73608.6 74656.0 77383.0 11687.4 11731.9 11794.3 11863.9 11936.8 19161.8 19949.9 22554.7 22692.5 22890.1 8853.1 8926.5 8987.6 9120.8 9167.5 4728.1 4848.6 4851.6 4861.7 4987.3 3654.1 3787.6 3788.5 3812.8 3840.6 662.4 665.3 666.8 682.7 684.8 604.0 643.5 646.5 680.9 713.5 9823.9 10175.7 10217.2 10405.0 10417.4 628.3 730.7 733.7 761.2 766.2 4284.4 4746.9 4781.6 4847.3 4867.0 107133.5 110355.4 111664.0 113014.4 114163.0 96304.0 96902.5 97872.5 97922.0 99377.0 86684.6 86936.6 87466.0 87928.6 88218.0 8999.4 9038.9 9055.6 9080.4 9182.4 47015.8 48404.8 49334.0 49695.3 50642.2 66670.0 73676.3 75232.5 75468.0 76288.6 11445.3 11477.1 11508.0 11646.1 11743.8 13656.5 13838.7 13921.0 14034.6 14361.6 12649.0 12794.6 13032.9 13089.9 13596.5 12682.9 12953.6 13175.0 13186.3 13380.9 12930.3 13231.3 13285.0 13309.9 13842.8 10321.0 10599.7 10783.2 10790.4 10886.7 10877.2 10986.2 11113.4 11200.3 11285.4 19:42:25 INFO - PROCESS | 4150 | -------- Summary: end -------- 19:42:25 INFO - PROCESS | 4150 | 19:42:26 INFO - TEST-INFO | 4150: exit 0 19:42:26 INFO - TEST-OK | dromaeo_css | took 1111961ms 19:42:26 INFO - TEST-START | kraken 19:42:26 INFO - operating with platform_type : linux_ 19:42:26 INFO - Initialising browser for kraken test... 19:42:26 INFO - TEST-INFO | started process 4385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGD9vV1/profile http://localhost:40512/getInfo.html) 19:42:30 INFO - PROCESS | 4385 | __metrics Screen width/height:1600/1200 19:42:30 INFO - PROCESS | 4385 | colorDepth:24 19:42:30 INFO - PROCESS | 4385 | Browser inner width/height: 1024/697 19:42:30 INFO - PROCESS | 4385 | __metrics 19:42:31 ERROR - PROCESS | 4385 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 19:42:32 INFO - TEST-INFO | 4385: exit 0 19:42:32 INFO - Browser initialized. 19:42:32 INFO - Running cycle 1/1 for kraken test... 19:42:32 INFO - TEST-INFO | started process 4506 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGD9vV1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:42:44 INFO - PROCESS | 4506 | RSS: Main: 184971264 19:42:44 INFO - PROCESS | 4506 | 19:42:46 INFO - PROCESS | 4506 | Cycle 1(1): loaded http://localhost:40512/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40512/tests/kraken/driver.html?testName=audio-beat-detection) 19:42:47 INFO - PROCESS | 4506 | RSS: Main: 190857216 19:42:47 INFO - PROCESS | 4506 | 19:42:50 INFO - PROCESS | 4506 | Cycle 1(1): loaded http://localhost:40512/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40512/tests/kraken/driver.html?testName=audio-dft) 19:42:50 INFO - PROCESS | 4506 | RSS: Main: 189837312 19:42:50 INFO - PROCESS | 4506 | 19:42:53 INFO - PROCESS | 4506 | Cycle 1(1): loaded http://localhost:40512/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40512/tests/kraken/driver.html?testName=audio-fft) 19:42:54 INFO - PROCESS | 4506 | RSS: Main: 185106432 19:42:54 INFO - PROCESS | 4506 | 19:42:56 INFO - PROCESS | 4506 | Cycle 1(1): loaded http://localhost:40512/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40512/tests/kraken/driver.html?testName=audio-oscillator) 19:42:57 INFO - PROCESS | 4506 | RSS: Main: 185532416 19:42:57 INFO - PROCESS | 4506 | 19:42:59 INFO - PROCESS | 4506 | Cycle 1(1): loaded http://localhost:40512/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40512/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:42:59 INFO - PROCESS | 4506 | RSS: Main: 185843712 19:42:59 INFO - PROCESS | 4506 | 19:43:02 INFO - PROCESS | 4506 | Cycle 1(1): loaded http://localhost:40512/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40512/tests/kraken/driver.html?testName=imaging-darkroom) 19:43:03 INFO - PROCESS | 4506 | RSS: Main: 185982976 19:43:03 INFO - PROCESS | 4506 | 19:43:07 INFO - PROCESS | 4506 | Cycle 1(1): loaded http://localhost:40512/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40512/tests/kraken/driver.html?testName=imaging-desaturate) 19:43:07 INFO - PROCESS | 4506 | RSS: Main: 183238656 19:43:07 INFO - PROCESS | 4506 | 19:43:10 INFO - PROCESS | 4506 | Cycle 1(1): loaded http://localhost:40512/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40512/tests/kraken/driver.html?testName=json-parse-financial) 19:43:11 INFO - PROCESS | 4506 | RSS: Main: 185188352 19:43:11 INFO - PROCESS | 4506 | 19:43:12 INFO - PROCESS | 4506 | Cycle 1(1): loaded http://localhost:40512/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40512/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:43:13 INFO - PROCESS | 4506 | RSS: Main: 185720832 19:43:13 INFO - PROCESS | 4506 | 19:43:15 INFO - PROCESS | 4506 | Cycle 1(1): loaded http://localhost:40512/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40512/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:43:15 INFO - PROCESS | 4506 | RSS: Main: 186257408 19:43:15 INFO - PROCESS | 4506 | 19:43:18 INFO - PROCESS | 4506 | Cycle 1(1): loaded http://localhost:40512/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40512/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:43:18 INFO - PROCESS | 4506 | RSS: Main: 186372096 19:43:18 INFO - PROCESS | 4506 | 19:43:21 INFO - PROCESS | 4506 | Cycle 1(1): loaded http://localhost:40512/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:43:21 INFO - PROCESS | 4506 | RSS: Main: 186617856 19:43:21 INFO - PROCESS | 4506 | 19:43:24 INFO - PROCESS | 4506 | Cycle 1(1): loaded http://localhost:40512/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:43:25 INFO - PROCESS | 4506 | RSS: Main: 186269696 19:43:25 INFO - PROCESS | 4506 | 19:43:26 INFO - PROCESS | 4506 | Cycle 1(1): loaded http://localhost:40512/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40512/tests/kraken/driver.html?testName=ai-astar) 19:43:27 INFO - PROCESS | 4506 | RSS: Main: 187023360 19:43:27 INFO - PROCESS | 4506 | 19:43:27 INFO - PROCESS | 4506 | __start_tp_report 19:43:27 INFO - PROCESS | 4506 | _x_x_mozilla_page_load 19:43:27 INFO - PROCESS | 4506 | _x_x_mozilla_page_load_details 19:43:27 INFO - PROCESS | 4506 | |i|pagename|runs| 19:43:27 INFO - PROCESS | 4506 | |0;ai-astar;102;111;106;111;110;110;111;111;111;111 19:43:27 INFO - PROCESS | 4506 | |1;audio-beat-detection;154;127;156;190;128;154;148;131;193;136 19:43:27 INFO - PROCESS | 4506 | |2;audio-dft;163;163;161;163;166;174;164;163;162;162 19:43:27 INFO - PROCESS | 4506 | |3;audio-fft;76;78;77;164;77;76;75;76;183;75 19:43:27 INFO - PROCESS | 4506 | |4;audio-oscillator;87;85;144;85;85;86;141;85;84;146 19:43:27 INFO - PROCESS | 4506 | |5;imaging-gaussian-blur;118;117;118;119;118;117;119;119;119;118 19:43:27 INFO - PROCESS | 4506 | |6;imaging-darkroom;146;148;150;148;148;147;149;147;147;148 19:43:27 INFO - PROCESS | 4506 | |7;imaging-desaturate;100;96;96;96;95;96;95;97;96;96 19:43:27 INFO - PROCESS | 4506 | |8;json-parse-financial;56;54;56;54;55;61;57;55;61;55 19:43:27 INFO - PROCESS | 4506 | |9;json-stringify-tinderbox;63;63;64;63;62;62;67;63;63;63 19:43:27 INFO - PROCESS | 4506 | |10;stanford-crypto-aes;81;78;80;79;83;79;80;86;91;82 19:43:27 INFO - PROCESS | 4506 | |11;stanford-crypto-ccm;124;125;131;120;122;126;127;138;125;123 19:43:27 INFO - PROCESS | 4506 | |12;stanford-crypto-pbkdf2;166;162;158;163;165;162;161;162;159;156 19:43:27 INFO - PROCESS | 4506 | |13;stanford-crypto-sha256-iterative;64;63;64;63;68;64;64;63;62;62 19:43:27 INFO - PROCESS | 4506 | __end_tp_report 19:43:27 INFO - PROCESS | 4506 | __start_cc_report 19:43:27 INFO - PROCESS | 4506 | _x_x_mozilla_cycle_collect,875 19:43:27 INFO - PROCESS | 4506 | __end_cc_report 19:43:27 INFO - PROCESS | 4506 | __startTimestamp1466649807186__endTimestamp 19:43:27 INFO - PROCESS | 4506 | 19:43:27 INFO - PROCESS | 4506 | ------- Summary: start ------- 19:43:27 INFO - PROCESS | 4506 | Number of tests: 14 19:43:27 INFO - PROCESS | 4506 | 19:43:27 INFO - PROCESS | 4506 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.00 stddev:3.03 (2.7%) stddev-sans-first:1.64 19:43:27 INFO - PROCESS | 4506 | Values: 102.0 111.0 106.0 111.0 110.0 110.0 111.0 111.0 111.0 111.0 19:43:27 INFO - PROCESS | 4506 | 19:43:27 INFO - PROCESS | 4506 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:154.00 stddev:23.72 (15.4%) stddev-sans-first:25.14 19:43:27 INFO - PROCESS | 4506 | Values: 154.0 127.0 156.0 190.0 128.0 154.0 148.0 131.0 193.0 136.0 19:43:27 INFO - PROCESS | 4506 | 19:43:27 INFO - PROCESS | 4506 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.00 stddev:3.73 (2.3%) stddev-sans-first:3.93 19:43:27 INFO - PROCESS | 4506 | Values: 163.0 163.0 161.0 163.0 166.0 174.0 164.0 163.0 162.0 162.0 19:43:27 INFO - PROCESS | 4506 | 19:43:27 INFO - PROCESS | 4506 | [#3] audio-fft Cycles:10 Average:95.70 Median:76.00 stddev:41.26 (54.3%) stddev-sans-first:43.14 19:43:27 INFO - PROCESS | 4506 | Values: 76.0 78.0 77.0 164.0 77.0 76.0 75.0 76.0 183.0 75.0 19:43:27 INFO - PROCESS | 4506 | 19:43:27 INFO - PROCESS | 4506 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:85.00 stddev:28.24 (33.2%) stddev-sans-first:29.36 19:43:27 INFO - PROCESS | 4506 | Values: 87.0 85.0 144.0 85.0 85.0 86.0 141.0 85.0 84.0 146.0 19:43:27 INFO - PROCESS | 4506 | 19:43:27 INFO - PROCESS | 4506 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.50 stddev:0.79 (0.7%) stddev-sans-first:0.83 19:43:27 INFO - PROCESS | 4506 | Values: 118.0 117.0 118.0 119.0 118.0 117.0 119.0 119.0 119.0 118.0 19:43:27 INFO - PROCESS | 4506 | 19:43:27 INFO - PROCESS | 4506 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.14 (0.8%) stddev-sans-first:1.00 19:43:27 INFO - PROCESS | 4506 | Values: 146.0 148.0 150.0 148.0 148.0 147.0 149.0 147.0 147.0 148.0 19:43:27 INFO - PROCESS | 4506 | 19:43:27 INFO - PROCESS | 4506 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.42 (1.5%) stddev-sans-first:0.60 19:43:27 INFO - PROCESS | 4506 | Values: 100.0 96.0 96.0 96.0 95.0 96.0 95.0 97.0 96.0 96.0 19:43:27 INFO - PROCESS | 4506 | 19:43:27 INFO - PROCESS | 4506 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.00 stddev:2.59 (4.6%) stddev-sans-first:2.74 19:43:27 INFO - PROCESS | 4506 | Values: 56.0 54.0 56.0 54.0 55.0 61.0 57.0 55.0 61.0 55.0 19:43:27 INFO - PROCESS | 4506 | 19:43:27 INFO - PROCESS | 4506 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:1.42 (2.3%) stddev-sans-first:1.50 19:43:27 INFO - PROCESS | 4506 | Values: 63.0 63.0 64.0 63.0 62.0 62.0 67.0 63.0 63.0 63.0 19:43:27 INFO - PROCESS | 4506 | 19:43:27 INFO - PROCESS | 4506 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:81.50 stddev:3.96 (4.9%) stddev-sans-first:4.18 19:43:27 INFO - PROCESS | 4506 | Values: 81.0 78.0 80.0 79.0 83.0 79.0 80.0 86.0 91.0 82.0 19:43:27 INFO - PROCESS | 4506 | 19:43:27 INFO - PROCESS | 4506 | [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:125.50 stddev:5.13 (4.1%) stddev-sans-first:5.39 19:43:27 INFO - PROCESS | 4506 | Values: 124.0 125.0 131.0 120.0 122.0 126.0 127.0 138.0 125.0 123.0 19:43:27 INFO - PROCESS | 4506 | 19:43:27 INFO - PROCESS | 4506 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:162.00 stddev:3.06 (1.9%) stddev-sans-first:2.76 19:43:27 INFO - PROCESS | 4506 | Values: 166.0 162.0 158.0 163.0 165.0 162.0 161.0 162.0 159.0 156.0 19:43:27 INFO - PROCESS | 4506 | 19:43:27 INFO - PROCESS | 4506 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.70 (2.7%) stddev-sans-first:1.80 19:43:27 INFO - PROCESS | 4506 | Values: 64.0 63.0 64.0 63.0 68.0 64.0 64.0 63.0 62.0 62.0 19:43:27 INFO - PROCESS | 4506 | -------- Summary: end -------- 19:43:27 INFO - PROCESS | 4506 | 19:43:28 INFO - TEST-INFO | 4506: exit 0 19:43:28 INFO - TEST-OK | kraken | took 62036ms 19:43:28 INFO - SUITE-END | took 1173s 19:43:28 INFO - Completed test suite (00:19:34) 19:43:28 INFO - javascript benchmark 19:43:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7329.570306340676, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3070.710301673297, 3122.422351864905, 3139.0582825152455, 3147.7796554241186, 3158.6683398243185, 5430.864228394292, 5451.809186678467, 5454.372747134081, 5592.6085174037835, 5597.552195824334, 5388.78444862206, 5446.319210098738, 5561.972190139044, 5570.916436253459, 5666.263385759856, 4971.055499455101, 4986.700797952134, 5021.949780502185, 5103.106956282654, 5147.794088236466, 5023.0707319145895, 5173.482651734834, 5196.610254230948, 5197.558207552343, 5219.791208351661, 5030.924536131961, 5041.19340905457, 5080.77136528857, 5089.033083714083, 5099.566536844372, 5050.4697006814495, 5054.545090941796, 5055.241713742931, 5067.113255180328, 5094.261332106824, 4997.950020499785, 5030.949690503085, 5035.093683137034, 5043.218301163325, 5085.593152547787, 5406.621536492447, 5419.430959749209, 5498.752556134944, 5516.972415137939, 5551.195076713854, 5949.077892926603, 5953.196318496991, 5965.821025369246, 5968.552358573081, 5972.074328479092, 6005.219321488223, 6009.549283803733, 6019.578629495937, 6021.066734656135, 6022.156898034279, 5397.136458166714, 5529.585281103893, 5611.9438805612235, 5615.747291371898, 5633.492985631313, 6157.96921015401, 6166.352532983972, 6167.167432396659, 6173.0, 6175.104609831639, 5697.572682048863, 5928.644281343047, 5934.0, 5937.198478205387, 5949.9107513387335, 5882.147088672119, 5912.615679980788, 5943.167956486095, 5994.280686317583, 6026.186464827279, 5769.134629805562, 5856.882862342814, 5931.6441013539325, 5959.821205363846, 5963.224780778471, 5787.710614469344, 5913.970430147821, 5979.760809567569, 5986.880262394728, 5987.072003839412, 4513.413256276663, 4572.291294849304, 4578.725276483355, 4591.9081618367445, 4594.609458196024, 4046.109855831712, 4057.8173982170283, 4072.1041370898356, 4084.571120032413, 4086.8773936781945, 5474.7810087596845, 5530.834074977757, 5617.0, 5629.577781666391, 5652.378238393773, 5922.851928701817, 5930.1994230779155, 5971.581989260797, 6011.218541589653, 6014.428629280212, 5662.433756624305, 5670.5463562914865, 5677.1768093627015, 5677.744501497443, 5696.772129114872, 4989.351384320088, 5124.564412024945, 5132.589392848563, 5191.195364718475, 5220.7128607926925, 6199.225096862892, 6221.06683997404, 6227.346128656516, 6255.96872015637, 6256.405641464054, 6005.219321488178, 6028.668423236589, 6031.7587296507645, 6047.746415034187, 6107.053406721965, 5923.111533270044, 6113.908291375722, 6120.663363515049, 6138.9095594588325, 6177.343742190901, 5827.24245848037, 5871.706414679335, 5906.143609176731, 5909.793157239648, 5976.551758618208, 5966.463018328372, 5989.700514974146, 5995.61028533144, 6020.187274717857, 6037.335893051673, 5644.6330988485615, 5721.084626459747, 5833.708314584169, 5855.3559108497175, 5913.142594323885, 5639.097744360883, 5732.656040637575, 5742.971285143548, 5761.769529218785, 5762.538996880324, 5658.5473162147755, 5661.518770904519, 5664.688442135557, 5669.064604340238, 5673.801416950387, 5820.883582328245, 5826.155207494805, 5838.854028649318, 5841.415858414124, 5957.046872500379, 5760.279965004374, 5796.304443466811, 5796.681182534832, 5796.739146738322, 5799.884002320015], "value": 5485.347342101224, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.6293640601812, 621.5431657731566, 623.8689875126223, 637.5059329020011, 655.8852200864848, 38446.615533844655, 42938.355924661075, 42950.78524607376, 43062.0, 43153.13693726124, 43274.350884736756, 43866.56133438665, 44095.0, 44123.558764412424, 44156.0, 8659.87010194846, 8821.558922053904, 8830.0, 8846.955765221164, 8852.336074794384, 8900.955495222515, 8901.109889011112, 8966.910330896706, 8980.730578082635, 8986.550672466383, 8987.101289870994, 8990.775230619254, 9020.45877247364, 9026.323025773061, 9054.32092593055, 8957.865632015524, 8986.146316099992, 9020.323475739313, 9024.63901443948, 9025.277977761796, 8712.21590056898, 8796.07641197678, 8805.515696636683, 8852.247558957497, 8903.866442003375, 40870.38694419586, 40984.38523422151, 41015.794921025205, 41354.58645413537, 41428.37857432141, 3352.329534093167, 3438.5186073949667, 3500.929981400383, 3502.282032183422, 3597.442396428558, 29574.852125739235, 29890.0, 31140.0, 34511.309773804634, 34548.0, 4337.110892267077, 4367.235733746614, 4411.830551478813, 4565.018521017964, 4590.747508887043, 344574.0, 345184.0, 345490.0, 345917.0, 347046.0, 60683.39316606866, 60899.391006090256, 60943.69528152331, 61314.38685613176, 61391.6930415354, 33949.32101357959, 35220.119497012776, 35364.823175883954, 58144.418555814744, 58285.708571456875, 15399.92300038515, 15451.768223476656, 15596.610084747972, 15598.766018509732, 15659.2953317101, 11529.48117334722, 11765.235259708263, 11815.11386646005, 11818.290902545874, 11820.113491488173, 19823.405297841087, 19847.801521984886, 19880.801191988183, 19897.104630291673, 20077.096530656156, 7101.928980710127, 7260.6732697028765, 7419.480636355512, 7470.439717021245, 7490.250974902466, 951.8619800128943, 1005.7787286796893, 1026.8921763214905, 1085.495244711213, 1102.1127991966384, 31947.680523194937, 32250.516242256384, 32683.346333073205, 32824.50763238553, 33124.503132453036, 1128.8814674459227, 1184.7867383870814, 1190.220405634311, 1205.1443475132578, 1211.309553554483, 16722.0, 17022.659546808994, 17104.74342884858, 17139.314427422763, 17174.570635733955, 561744.0, 564088.0, 566942.0, 567831.0, 568531.0, 58932.0, 59790.40209597848, 60415.39584604186, 60655.69672151611, 60945.39054609486, 1293.6765808547864, 1339.799030145486, 1360.4830164537414, 1362.3120324236197, 1367.8402889325491, 30404.5439318406, 31886.36227275488, 31912.723491060096, 32557.348853022333, 32658.51012234866, 51634.0, 51891.740541297055, 52095.73952130215, 52232.73883630557, 52314.738426307624, 447742.0, 449116.0, 451373.0, 451900.0, 453611.0, 27548.724512754616, 27763.583546247228, 28782.712172878004, 29002.419951600426, 30627.387452250383, 46787.76606117084, 46994.29508557443, 47317.290240647104, 48257.276140858616, 48322.0, 39074.2185156301, 39377.60622393739, 39772.801135995294, 40236.0, 40614.18771624492, 41251.793741031106, 41902.37146442867, 42134.78932605317, 42873.35689964715, 43079.569204307554, 41582.79208603938, 42000.4754546524, 43214.35178472388, 43250.0, 43452.34821477617, 35737.821310893276, 38196.61803381931, 38696.613033869304, 38750.224995500495, 39082.6091739079, 28410.57384139281, 28818.423631527672, 29006.27484312909, 29024.41951161007, 29125.563116552847], "value": 20104.382305390885, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.18806664238355, 395.19577659463, 400.49937578027465, 400.7935913004801, 408.2406723494302, 13299.933500332509, 17926.82073179268, 18679.97260150691, 19570.0, 19602.509937251576, 18011.729824052618, 18660.440186794385, 18897.244110235573, 19072.71390929137, 19147.234110635593, 5582.441755824405, 5638.0, 5790.160426738121, 5818.534517238632, 5866.325372582143, 5766.567507436938, 5787.913181302284, 5832.562557808182, 5838.416158384149, 5863.941360586404, 5270.7628156733035, 5572.693501857396, 5593.0, 5767.625104368202, 5800.9129863052085, 5611.382747897728, 5641.210230567724, 5654.038813401711, 5672.461116193976, 5684.062129748628, 5470.781168753285, 5475.0966090595, 5484.177373393983, 5503.0, 5529.723513824292, 13744.175349479063, 13799.103058301178, 13821.723565528633, 13878.444862205499, 15050.021748586416, 2295.540891821626, 2366.408397900525, 2562.8718564071723, 2772.459370422768, 3000.1899487138567, 10083.546240419126, 10349.275550711453, 10405.11556517697, 10522.78954420915, 14032.737053665118, 1842.7235914612916, 1895.781985071707, 1916.0, 1969.2319995201883, 1995.122146255643, 78592.60703696503, 82908.58545707293, 83408.0, 84742.0, 85073.0, 10578.576856925636, 10730.946345268223, 10826.242163048511, 11043.558257669763, 11075.889241107647, 15315.081095134328, 15478.380864765508, 15482.148481833607, 15483.148426836633, 15539.766903496457, 7673.654685539164, 7822.882656760153, 7825.060992680915, 7890.210978902064, 8010.0, 7369.8894516582295, 7374.778756637309, 7539.660715267826, 7596.658150383246, 7627.5042122261875, 4609.423822022247, 4623.098495793288, 4623.537646235417, 4682.41469816273, 4767.141914455431, 1901.9334323298617, 1964.0965156028387, 1964.116147733497, 2004.4287378097172, 2010.9195632174842, 879.4942907828024, 1032.8812186598636, 1041.8749750030045, 1042.7601651620018, 1046.5918291866178, 17736.822631773775, 18534.629307414045, 18743.34398296053, 19221.423357299303, 19884.304049358205, 990.821652102614, 993.9850902236327, 1029.7683021320292, 1059.6344261229863, 1068.120108608854, 10326.225533084898, 10749.83875241872, 10775.0, 10777.137828973664, 10812.0, 439399.0, 449073.0, 454051.0, 456565.0, 459330.0, 69336.0, 82257.58871205605, 82567.587162065, 94142.5292873545, 94187.0, 1021.274894824668, 1043.6555936540924, 1048.5229220704562, 1073.2809017957986, 1078.1536493852288, 15078.698426031637, 16406.425775097814, 16844.831551684325, 17009.234584443482, 17225.827741722424, 30554.70839686988, 39124.6087539121, 39843.0, 40007.799961001176, 44465.0, 58756.41243587509, 59866.70066649813, 59968.40031599628, 60233.39766602453, 61712.38287617066, 8647.87028194565, 8655.221030107321, 8674.132586741276, 8734.56327183651, 8859.468431894107, 9958.800823983334, 13806.033577649468, 13863.861361386256, 13886.166829990232, 14050.78923816164, 11790.882091178979, 12052.0, 12064.698382540506, 12282.324472154118, 12344.074194435274, 11806.586769463027, 12019.519219231483, 12262.938685306517, 12282.201656892274, 12565.748685026065, 12125.75748485043, 12158.331291779037, 12192.08559358034, 12303.138780285293, 12378.876211238132, 8500.914990850013, 8597.785055373666, 8697.95651021741, 8744.868826967473, 8811.515366654896, 11183.608573699881, 12008.519659213534, 12065.215760975509, 12112.0, 12179.330136842558], "value": 9083.366305235892, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.8755705765006, 1468.7943687883694, 1592.7292360298748, 1689.543823167744, 1731.3334366268991, 8036.799080023003, 8455.661773529058, 8712.651493940251, 8968.73093807186, 9022.954885225572, 8804.955975220115, 9072.546372681372, 9076.0, 9141.177294043535, 9170.862437063433, 2332.7783860533223, 2368.822338324624, 2370.596998510249, 2370.845895016827, 2370.928872133839, 2290.7709229077127, 2310.4223944013997, 2320.269115228706, 2321.9419514512188, 2326.081197926818, 2240.0815665577115, 2279.555486680098, 2280.920167794119, 2295.1622657729977, 2324.9651255231183, 2254.639257718757, 2259.7175353080866, 2263.173941511353, 2263.5246598214394, 2267.9319620411416, 2231.732192136954, 2234.128689810975, 2236.6421372580307, 2240.8207343412487, 2247.179779380531, 8967.730968070968, 9008.279337652972, 9042.547872606343, 9044.683436079771, 9104.681336153202, 5288.862894477667, 5358.571314294886, 5383.4616538346245, 5440.91838622417, 5444.101723215665, 3078.6459557150993, 3196.5844440222622, 3299.1752061984503, 3312.271300313927, 3319.452290372086, 1047.1518070363031, 1049.2130901823632, 1061.310148403544, 1073.6617965340893, 1075.5160177919968, 12752.872471275261, 12796.2962037087, 12796.48814047437, 12799.168054076456, 12828.871711282954, 4733.219018861918, 4743.786529606176, 4838.516148385203, 4855.077535268288, 4860.441049279378, 10704.571817127384, 10710.303830251009, 10712.089472394779, 10719.410432426135, 10753.51609177589, 5441.564674826004, 5458.0, 5467.0, 5485.6434331768305, 5511.5039646432015, 4306.267934451151, 4821.63837712173, 4875.24433712775, 4979.203327467588, 4981.402231732215, 3975.284448799186, 4004.959950400517, 4033.233685599727, 4142.337226043818, 4148.875533733993, 1198.17924721566, 1204.151073493185, 1229.9016078713682, 1231.4335405713293, 1270.555305643036, 904.9457032578066, 926.4765407544716, 930.3627015494408, 931.8089791592707, 933.118203297877, 5614.326280846324, 5683.886322273532, 5707.971460142673, 5715.485606295453, 5837.09525023622, 961.3847137831793, 1001.5693251901606, 1006.2453160129902, 1012.6405126180247, 1032.9225308101923, 3929.1945151243926, 3964.0882597002274, 3975.2447035063246, 3985.163115745726, 4053.5541090480024, 11120.666380008613, 11359.886401135884, 11510.021648159833, 11518.712032199262, 11528.942355288338, 11185.32888026721, 11242.156838237164, 11284.266522676, 11306.886931130748, 11465.885341146482, 8231.835363292701, 8625.69810056645, 8644.913550864536, 8652.264557512555, 8663.176998185163, 5664.320281566238, 5813.128030795415, 5841.561882858718, 5904.763809447574, 5966.642001479925, 10365.429901355497, 10480.161587072864, 10487.0, 10548.472576371305, 10599.205059620714, 10536.789264214825, 10636.361818290927, 10801.459927003776, 10861.837072444077, 10956.671299861016, 6884.277150899084, 7158.856822863618, 7242.927570724225, 7308.926910731037, 7562.848743025219, 8900.821983560163, 8934.151255630704, 8958.596863141043, 9008.549572521479, 9021.548922553977, 7877.960610196912, 7972.0, 8010.639521221442, 8180.222878826502, 8208.0, 7821.882671759814, 7838.3337416320255, 7913.485623434458, 8073.35413166957, 8158.796030099057, 7173.748918787817, 7198.49610527279, 7224.060872086595, 7328.157261914735, 7337.59643219628, 4726.385569875894, 4772.618190544678, 4920.926186107283, 4922.581580565692, 4926.778294976663, 5255.3168088148295, 5260.342457192851, 5321.201819727072, 5329.813456529003, 5388.784448622011], "value": 4680.886772120101, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.61370968547425, 326.8757872008637, 328.54332477855775, 330.6164848775421, 331.9867205311786, 5546.4730850569185, 5606.467385598372, 5623.184638227454, 5655.095184770437, 5713.771629064669, 5532.419095994923, 5571.582131340156, 5601.915971260424, 5606.299212598426, 5617.915731264035, 4141.337386018237, 4159.70882038256, 4322.654187664979, 4348.195583816988, 4351.456067991501, 4313.633341166004, 4315.4389929309145, 4317.913641727164, 4320.719153255044, 4322.783860806962, 4272.145570885819, 4296.871093867173, 4298.699091063627, 4316.503602085753, 4345.652347812167, 4016.8995775105564, 4256.701381254119, 4256.872293831159, 4262.829486820523, 4310.762908040057, 3710.517632707758, 3727.2295659561764, 3761.605031471711, 3769.378052621314, 3775.093977445421, 5521.475459831309, 5522.0336441123045, 5540.279763630742, 5568.638038527523, 5581.246531718247, 4776.379070720819, 4839.516048395168, 4844.934114494806, 4851.587615052725, 4910.281401509443, 5790.623609465413, 5819.883602327972, 5825.359210486843, 5828.300603927513, 5835.912461313042, 4098.6516146127615, 4112.876613701564, 4122.0, 4124.298869192245, 4142.212979533909, 5774.307083150007, 6037.154798328237, 6045.969770151121, 6086.360932102154, 6106.877862442726, 4167.395727619478, 4193.496780386373, 4210.115875666144, 4215.683823713233, 4231.61915427613, 4232.978835105805, 4233.364995250737, 4243.0269924485265, 4250.598411897268, 4250.766207858597, 4567.58891699742, 4816.446108697544, 4852.568492294781, 4900.117978763857, 4917.827876024322, 5813.273340832396, 5815.621984570989, 5826.533877289891, 5839.357670656224, 5857.88284234313, 1445.1401416157369, 1461.3350925329162, 1463.3122432456728, 1470.2722152534564, 1481.5925620454461, 893.6738090596886, 933.4119504712123, 936.8220038192721, 976.829054915387, 982.8230918434607, 5564.360098588714, 5574.0, 5582.441755824385, 5585.218069470277, 5593.664380137205, 5905.557083218776, 5912.290525137011, 5934.347221805598, 5959.731812068468, 5981.940180598225, 5235.842924712265, 5551.806361632269, 5568.415316391802, 5592.5805564582815, 5622.718864056781, 3165.398574270881, 3186.1715953852167, 3188.8998295587985, 3197.280611862359, 3214.1803840020643, 5906.350301466835, 6157.89157951573, 6162.414570615784, 6163.84590385235, 6178.474829639441, 5995.5803093783015, 5999.910001349983, 6013.9699301503215, 6116.174316467309, 6135.233095863017, 5991.490723288569, 6019.247594050744, 6055.485283750842, 6074.605150665193, 6100.572959892854, 5656.236408084856, 5921.667624784389, 5923.229980102559, 5932.199153114274, 5941.821745347646, 5743.224664670216, 5789.8709751598035, 5864.794732184353, 5874.739519566681, 5905.645661260338, 5871.530277577698, 5995.820125396245, 6030.3668114847305, 6041.18444010053, 6068.21113255274, 4113.745307681066, 4114.670826333946, 4123.938140927949, 4131.566185550474, 4132.421460995403, 5873.882522349443, 5898.587098903035, 5914.792982245601, 5924.119701595462, 5950.583459157991, 5539.279893613804, 5768.884622307614, 5769.8557536061935, 5780.797672081457, 5782.971085144547, 5595.63628364155, 5677.687727175045, 5689.6586204827845, 5746.482816546531, 5757.856053598526, 5475.72621368922, 5567.498925096761, 5633.4084921082695, 5656.208130861765, 5720.827230417671, 5845.883082338244, 5845.883082338244, 5853.9121913172185, 5880.117982302689, 5890.4993075589055, 5438.972805135949, 5691.4877661010705, 5700.458456446631, 5741.25363702716, 5747.224124743107], "value": 4393.622458457729, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.3328804212088, 732.1068296678051, 799.1848314718986, 815.1563132158213, 864.5331520978672, 14374.13755174689, 15591.220438978062, 15655.686886262281, 15746.133962632051, 15859.0, 15001.249937503137, 15032.849671503282, 15108.773368399483, 15144.848551514482, 15265.08409495431, 813.5037627047496, 822.576373167819, 825.2737590920012, 827.3133299361516, 828.1097819843662, 680.2313385873955, 801.5551368990238, 830.8213734047179, 833.62903507939, 834.70785225171, 852.433131967241, 852.6163226548047, 853.1937319233327, 857.7555396711938, 861.7285555050139, 848.325581162977, 849.6813694864426, 854.0690647194557, 855.897292324925, 856.9057403685621, 615.4676205082616, 618.3383779356091, 619.0961196652892, 621.4438077920281, 621.7295476467751, 14706.411743530245, 14715.926420367936, 14719.337629806685, 14719.484818031318, 14759.409623615042, 15260.236988150547, 15272.923635381752, 15434.0, 15716.449924252596, 15753.527394178078, 11947.761044779056, 12029.759404811943, 12052.161020533009, 12359.62921112368, 12474.126811123226, 3600.1719604491113, 3601.6398360164035, 3659.396199627058, 3661.0, 3753.39945608704, 73172.0, 73428.0, 73608.63195684041, 74656.0, 77383.0, 11687.415629218505, 11731.945992815557, 11794.29234245948, 11863.88136118645, 11936.820947685792, 19161.808381916282, 19949.900250498944, 22554.661680074812, 22692.546149076927, 22890.084396623948, 8853.114688531095, 8926.464412135292, 8987.595558199897, 9120.771980700403, 9167.541622918961, 4728.125296820031, 4848.5636292733825, 4851.611871050308, 4861.659683822169, 4987.251912213124, 3654.1230104775195, 3787.62123787619, 3788.507494025759, 3812.7902965336616, 3840.5583357914197, 662.3939095727355, 665.2682049745338, 666.8299583606247, 682.6552590941642, 684.8253695307765, 603.9969800150972, 643.5045015338256, 646.4989633034436, 680.9216940051957, 713.4587411065096, 9823.901760982442, 10175.694729158136, 10217.18262538995, 10405.0, 10417.427041512638, 628.2649300318546, 730.7259777583406, 733.7211859493358, 761.2121454294778, 766.2375935943771, 4284.4430224070675, 4746.928796068062, 4781.641376896747, 4847.304928258916, 4867.0, 107133.46433267783, 110355.44822275998, 111664.0, 113014.43492782484, 114163.0, 96304.0, 96902.51548742212, 97872.51063744635, 97922.0, 99377.0, 86684.56657716798, 86936.56531717427, 87466.0, 87928.56035719908, 88217.99999999872, 8999.415038022507, 9038.864417033617, 9055.637774488947, 9080.364374493722, 9182.444621004197, 47015.76492117518, 48404.75797620989, 49334.0, 49695.25457118074, 50642.240366393795, 66670.0, 73676.26323736909, 75232.49535009378, 75468.0, 76288.61855690686, 11445.25605835618, 11477.139214559109, 11508.0, 11646.126540509325, 11743.76512469763, 13656.549966144916, 13838.723225535634, 13920.95592830562, 14034.649133771738, 14361.64095897611, 12649.0, 12794.552190673281, 13032.869671303544, 13089.934550327187, 13596.456141754219, 12682.87317126817, 12953.611391658265, 13175.0, 13186.340682966005, 13380.93309533485, 12930.288834114213, 13231.27228002469, 13285.0, 13309.86690133125, 13842.792358114837, 10321.0, 10599.682009539727, 10783.245172837826, 10790.35257884498, 10886.727831803952, 10877.184211184034, 10986.176036797113, 11113.388763618079, 11200.271982321123, 11285.43572821372], "value": 7525.51324128989, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 106.0, 111.0, 110.0, 110.0, 111.0, 111.0, 111.0, 111.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 156.0, 190.0, 128.0, 154.0, 148.0, 131.0, 193.0, 136.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 163.0, 166.0, 174.0, 164.0, 163.0, 162.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 164.0, 77.0, 76.0, 75.0, 76.0, 183.0, 75.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 144.0, 85.0, 85.0, 86.0, 141.0, 85.0, 84.0, 146.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 119.0, 118.0, 117.0, 119.0, 119.0, 119.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 150.0, 148.0, 148.0, 147.0, 149.0, 147.0, 147.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 97.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 56.0, 54.0, 55.0, 61.0, 57.0, 55.0, 61.0, 55.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 62.0, 62.0, 67.0, 63.0, 63.0, 63.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 80.0, 79.0, 83.0, 79.0, 80.0, 86.0, 91.0, 82.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 125.0, 131.0, 120.0, 122.0, 126.0, 127.0, 138.0, 125.0, 123.0], "value": 126.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 158.0, 163.0, 165.0, 162.0, 161.0, 162.0, 159.0, 156.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 68.0, 64.0, 64.0, 63.0, 62.0, 62.0], "value": 63.7, "unit": "score"}]}]} 19:43:28 INFO - Return code: 0 19:43:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:43:28 ERROR - # TBPL SUCCESS # 19:43:28 INFO - Running post-action listener: _resource_record_post_action 19:43:28 INFO - ##### 19:43:28 INFO - ##### Finished run-tests step (success) 19:43:28 INFO - ##### 19:43:28 INFO - Running post-run listener: _resource_record_post_run 19:43:28 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 415354880; Read time: 8; Write time: 304888 19:43:28 INFO - TinderboxPrint: CPU usage
13.4% 19:43:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:43:28 INFO - TinderboxPrint: I/O write bytes / time
415,354,880 / 304,888 19:43:28 INFO - TinderboxPrint: CPU idle
8,228.2 (86.5%) 19:43:28 INFO - TinderboxPrint: CPU user
1,224.4 (12.9%) 19:43:28 INFO - TinderboxPrint: Swap in / out
0 / 0 19:43:28 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 125251584; Read time: 0; Write time: 80160 19:43:28 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290103296; Read time: 8; Write time: 224728 19:43:29 INFO - Running post-run listener: _upload_blobber_files 19:43:29 INFO - Blob upload gear active. 19:43:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:43:29 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:43:29 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:43:29 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:43:29 INFO - (blobuploader) - INFO - Open directory for files ... 19:43:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:43:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:43:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:43:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:43:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:43:30 INFO - (blobuploader) - INFO - Done attempting. 19:43:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:43:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:43:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:43:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:43:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:43:33 INFO - (blobuploader) - INFO - Done attempting. 19:43:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:43:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:43:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:43:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:43:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:43:34 INFO - (blobuploader) - INFO - Done attempting. 19:43:34 INFO - (blobuploader) - INFO - Iteration through files over. 19:43:34 INFO - Return code: 0 19:43:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:43:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:43:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e6be21c08d79943cb582ddb2d6b1ef66bbef179cd962a7703a5e4ada5b195f5829d0288676070ce3e55ae1bf8b41e5fa695e475065c29399136d405d45050464", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/71e6f496755f09cdb6a67287d27ecf83c654dd089893a42c6e53910467ff3c2c3a898f3039b878bc59ceb61ce5b9479d09257cf43ecffdd59b8533446d162d08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/778a536efbca2a0890068d81f1a41e97d4afd9b7c57f930f20d8c0fbc56472ef5c901f9b7e2af631217ab6fcf3547f4aa64619073954ac122dc378bfbf525fef"} 19:43:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:43:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:43:34 INFO - Contents: 19:43:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e6be21c08d79943cb582ddb2d6b1ef66bbef179cd962a7703a5e4ada5b195f5829d0288676070ce3e55ae1bf8b41e5fa695e475065c29399136d405d45050464", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/71e6f496755f09cdb6a67287d27ecf83c654dd089893a42c6e53910467ff3c2c3a898f3039b878bc59ceb61ce5b9479d09257cf43ecffdd59b8533446d162d08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/778a536efbca2a0890068d81f1a41e97d4afd9b7c57f930f20d8c0fbc56472ef5c901f9b7e2af631217ab6fcf3547f4aa64619073954ac122dc378bfbf525fef"} 19:43:34 INFO - Running post-run listener: copy_logs_to_upload_dir 19:43:34 INFO - Copying logs to upload dir... 19:43:34 INFO - mkdir: /builds/slave/test/build/upload/logs 19:43:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.018960 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-06-22 19:43:34.079944) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 19:43:34.084967) ========= 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=20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774 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/e6be21c08d79943cb582ddb2d6b1ef66bbef179cd962a7703a5e4ada5b195f5829d0288676070ce3e55ae1bf8b41e5fa695e475065c29399136d405d45050464", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/71e6f496755f09cdb6a67287d27ecf83c654dd089893a42c6e53910467ff3c2c3a898f3039b878bc59ceb61ce5b9479d09257cf43ecffdd59b8533446d162d08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/778a536efbca2a0890068d81f1a41e97d4afd9b7c57f930f20d8c0fbc56472ef5c901f9b7e2af631217ab6fcf3547f4aa64619073954ac122dc378bfbf525fef"} build_url:https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011452 build_url: 'https://queue.taskcluster.net/v1/task/HC4bSvpOSYGCkSdFcWAF6g/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/e6be21c08d79943cb582ddb2d6b1ef66bbef179cd962a7703a5e4ada5b195f5829d0288676070ce3e55ae1bf8b41e5fa695e475065c29399136d405d45050464", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/71e6f496755f09cdb6a67287d27ecf83c654dd089893a42c6e53910467ff3c2c3a898f3039b878bc59ceb61ce5b9479d09257cf43ecffdd59b8533446d162d08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/778a536efbca2a0890068d81f1a41e97d4afd9b7c57f930f20d8c0fbc56472ef5c901f9b7e2af631217ab6fcf3547f4aa64619073954ac122dc378bfbf525fef"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 19:43:34.110492) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:43:34.110807) ========= 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=20e666a3d4cfbb71505a330e000001b4-1466646787.146092-2147055774 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 19:43:34.194130) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 19:43:34.194457) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 19:43:34.194782) ========= ========= Total master_lag: 0.18 =========