builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-060 starttime: 1466607385.7 results: success (0) buildid: 20160622063901 builduid: eaca88a07a6142ae95eef53a4d422973 revision: c9edfe35619f69f7785776ebd19a3140684024dc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:25.704029) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:25.704475) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:25.704789) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:25.740881) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:25.741147) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-22 07:56:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.5M=0s 2016-06-22 07:56:26 (50.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129058 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:25.884837) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:25.885174) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016461 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:25.935092) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:25.935422) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c9edfe35619f69f7785776ebd19a3140684024dc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c9edfe35619f69f7785776ebd19a3140684024dc --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=337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-22 07:56:26,120 truncating revision to first 12 chars 2016-06-22 07:56:26,120 Setting DEBUG logging. 2016-06-22 07:56:26,120 attempt 1/10 2016-06-22 07:56:26,120 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c9edfe35619f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-22 07:56:26,432 unpacking tar archive at: mozilla-central-c9edfe35619f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640710 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:26.589670) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:26.589973) ========= script_repo_revision: c9edfe35619f69f7785776ebd19a3140684024dc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:26.590373) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:26.590653) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-22 07:56:26.600730) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2016-06-22 07:56:26.601003) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:56:26 INFO - MultiFileLogger online at 20160622 07:56:26 in /builds/slave/test 07:56:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:56:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:56:26 INFO - {'append_to_log': False, 07:56:26 INFO - 'base_work_dir': '/builds/slave/test', 07:56:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:56:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:56:26 INFO - 'branch': 'Firefox-Non-PGO', 07:56:26 INFO - 'buildbot_json_path': 'buildprops.json', 07:56:26 INFO - 'config_files': ('talos/linux_config.py',), 07:56:26 INFO - 'default_actions': ('clobber', 07:56:26 INFO - 'read-buildbot-config', 07:56:26 INFO - 'download-and-extract', 07:56:26 INFO - 'populate-webroot', 07:56:26 INFO - 'create-virtualenv', 07:56:26 INFO - 'install', 07:56:26 INFO - 'run-tests'), 07:56:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:56:26 INFO - 'download_minidump_stackwalk': True, 07:56:26 INFO - 'download_symbols': 'ondemand', 07:56:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:56:26 INFO - 'tooltool.py': '/tools/tooltool.py', 07:56:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:56:26 INFO - '/tools/misc-python/virtualenv.py')}, 07:56:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:56:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:56:26 INFO - 'installer_path': 'installer.exe', 07:56:26 INFO - 'log_level': 'info', 07:56:26 INFO - 'log_name': 'talos', 07:56:26 INFO - 'log_to_console': True, 07:56:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:56:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:56:26 INFO - 'opt_config_files': (), 07:56:26 INFO - 'pip_index': False, 07:56:26 INFO - 'sps_profile': False, 07:56:26 INFO - 'sps_profile_interval': 0, 07:56:26 INFO - 'suite': 'dromaeojs-e10s', 07:56:26 INFO - 'system_bits': '32', 07:56:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:56:26 INFO - 'title': 'talos-linux64-ix-060', 07:56:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:56:26 INFO - 'use_talos_json': True, 07:56:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:56:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:56:26 INFO - 'work_dir': 'build'} 07:56:26 INFO - ##### 07:56:26 INFO - ##### Running clobber step. 07:56:26 INFO - ##### 07:56:26 INFO - Running pre-action listener: _resource_record_pre_action 07:56:26 INFO - Running main action method: clobber 07:56:26 INFO - rmtree: /builds/slave/test/build 07:56:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:56:27 INFO - Running post-action listener: _resource_record_post_action 07:56:27 INFO - ##### 07:56:27 INFO - ##### Finished clobber step (success) 07:56:27 INFO - ##### 07:56:27 INFO - ##### 07:56:27 INFO - ##### Running read-buildbot-config step. 07:56:27 INFO - ##### 07:56:27 INFO - Running pre-action listener: _resource_record_pre_action 07:56:27 INFO - Running main action method: read_buildbot_config 07:56:27 INFO - Using buildbot properties: 07:56:27 INFO - { 07:56:27 INFO - "project": "", 07:56:27 INFO - "product": "firefox", 07:56:27 INFO - "script_repo_revision": "production", 07:56:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:56:27 INFO - "repository": "", 07:56:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:56:27 INFO - "buildid": "20160622063901", 07:56:27 INFO - "pgo_build": "False", 07:56:27 INFO - "basedir": "/builds/slave/test", 07:56:27 INFO - "buildnumber": 357, 07:56:27 INFO - "slavename": "talos-linux64-ix-060", 07:56:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:56:27 INFO - "platform": "ubuntu64_hw", 07:56:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:56:27 INFO - "branch": "mozilla-central", 07:56:27 INFO - "repo_path": "mozilla-central", 07:56:27 INFO - "revision": "c9edfe35619f69f7785776ebd19a3140684024dc", 07:56:27 INFO - "stage_platform": "linux64", 07:56:27 INFO - "builduid": "eaca88a07a6142ae95eef53a4d422973", 07:56:27 INFO - "slavebuilddir": "test" 07:56:27 INFO - } 07:56:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:56:27 INFO - Running post-action listener: _resource_record_post_action 07:56:27 INFO - ##### 07:56:27 INFO - ##### Finished read-buildbot-config step (success) 07:56:27 INFO - ##### 07:56:27 INFO - ##### 07:56:27 INFO - ##### Running download-and-extract step. 07:56:27 INFO - ##### 07:56:27 INFO - Running pre-action listener: _resource_record_pre_action 07:56:27 INFO - Running main action method: download_and_extract 07:56:27 INFO - mkdir: /builds/slave/test/build/tests 07:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:27 INFO - https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:56:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:56:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:56:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:56:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:56:32 INFO - Downloaded 1361 bytes. 07:56:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:56:32 INFO - Using the following test package requirements: 07:56:32 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:56:32 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:56:32 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:56:32 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:32 INFO - u'jsshell-linux-x86_64.zip'], 07:56:32 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:56:32 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:56:32 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:56:32 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:56:32 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:56:32 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:56:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:56:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:32 INFO - https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:56:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:56:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:56:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:56:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:56:37 INFO - Downloaded 22703215 bytes. 07:56:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:56:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:56:38 INFO - Return code: 0 07:56:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:38 INFO - https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:56:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:56:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:56:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:56:41 INFO - Downloaded 22703215 bytes. 07:56:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:56:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:56:42 INFO - Return code: 0 07:56: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')]} 07:56:42 INFO - https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:56:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:56:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:56:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:56:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:56:43 INFO - Downloaded 14405384 bytes. 07:56:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:56:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:56:43 INFO - Return code: 0 07:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:56:43 INFO - https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:56:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:56:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:56:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:56:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:57:27 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2: The read operation timed out 07:57:27 INFO - retry: attempt #1 caught exception: The read operation timed out 07:57:27 INFO - retry: Failed, sleeping 30 seconds before retrying 07:57:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/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 #2 07:58:09 INFO - Downloaded 56261643 bytes. 07:58:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:58:09 INFO - mkdir: /builds/slave/test/properties 07:58:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:58:09 INFO - Writing to file /builds/slave/test/properties/build_url 07:58:09 INFO - Contents: 07:58:09 INFO - build_url:https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:58:10 INFO - Running post-action listener: _resource_record_post_action 07:58:10 INFO - Running post-action listener: set_extra_try_arguments 07:58:10 INFO - ##### 07:58:10 INFO - ##### Finished download-and-extract step (success) 07:58:10 INFO - ##### 07:58:10 INFO - ##### 07:58:10 INFO - ##### Running populate-webroot step. 07:58:10 INFO - ##### 07:58:10 INFO - Running pre-action listener: _resource_record_pre_action 07:58:10 INFO - Running main action method: populate_webroot 07:58:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:58:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:58:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:58:10 INFO - '--tppagecycles', 07:58:10 INFO - '7'], 07:58:10 INFO - 'tests': ['tsvgm']}}, 07:58:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:58:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:58:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:58:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:58:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:58:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:58:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:10 INFO - 'talos_options': ['--disable-e10s'], 07:58:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:58:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:58:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:10 INFO - 'talos_options': ['--disable-e10s'], 07:58:10 INFO - 'tests': ['damp', 'tps']}, 07:58:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:10 INFO - 'tests': ['damp', 'tps']}, 07:58:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:58:10 INFO - 'tests': ['dromaeo_dom']}, 07:58:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:58:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:58:10 INFO - 'tests': ['basic_compositor_video']}, 07:58:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:58:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:58:10 INFO - 'tests': ['a11yr', 07:58:10 INFO - 'ts_paint', 07:58:10 INFO - 'tpaint', 07:58:10 INFO - 'sessionrestore', 07:58:10 INFO - 'sessionrestore_no_auto_restore', 07:58:10 INFO - 'tabpaint']}, 07:58:10 INFO - 'other-e10s': {'tests': ['a11yr', 07:58:10 INFO - 'ts_paint', 07:58:10 INFO - 'tpaint', 07:58:10 INFO - 'sessionrestore', 07:58:10 INFO - 'sessionrestore_no_auto_restore', 07:58:10 INFO - 'tabpaint']}, 07:58:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:58:10 INFO - 'ts_paint', 07:58:10 INFO - 'tpaint', 07:58:10 INFO - 'sessionrestore', 07:58:10 INFO - 'sessionrestore_no_auto_restore', 07:58:10 INFO - 'tabpaint']}, 07:58:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:58:10 INFO - 'ts_paint', 07:58:10 INFO - 'tpaint', 07:58:10 INFO - 'sessionrestore', 07:58:10 INFO - 'sessionrestore_no_auto_restore', 07:58:10 INFO - 'tabpaint']}, 07:58:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:58:10 INFO - 'tests': ['a11yr', 07:58:10 INFO - 'ts_paint', 07:58:10 INFO - 'tpaint', 07:58:10 INFO - 'sessionrestore', 07:58:10 INFO - 'sessionrestore_no_auto_restore', 07:58:10 INFO - 'tabpaint']}, 07:58:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:58:10 INFO - 'tests': ['a11yr', 07:58:10 INFO - 'ts_paint', 07:58:10 INFO - 'tpaint', 07:58:10 INFO - 'sessionrestore', 07:58:10 INFO - 'sessionrestore_no_auto_restore', 07:58:10 INFO - 'tabpaint']}, 07:58:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:58:10 INFO - 'tests': ['tsvgx', 07:58:10 INFO - 'tsvgr_opacity', 07:58:10 INFO - 'tart', 07:58:10 INFO - 'tscrollx', 07:58:10 INFO - 'cart']}, 07:58:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:58:10 INFO - 'tsvgr_opacity', 07:58:10 INFO - 'tart', 07:58:10 INFO - 'tscrollx', 07:58:10 INFO - 'cart']}, 07:58:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:10 INFO - 'talos_options': ['--disable-e10s'], 07:58:10 INFO - 'tests': ['tp5o']}, 07:58:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:10 INFO - 'tests': ['tp5o']}, 07:58:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:10 INFO - 'talos_options': ['--disable-e10s', 07:58:10 INFO - '--xperf_path', 07:58:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:58:10 INFO - 'tests': ['tp5n']}, 07:58:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:10 INFO - 'talos_options': ['--xperf_path', 07:58:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:58:10 INFO - 'tests': ['tp5n']}}, 07:58:10 INFO - 'talos.zip': {'path': '', 07:58:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:58:10 INFO - Running post-action listener: _resource_record_post_action 07:58:10 INFO - ##### 07:58:10 INFO - ##### Finished populate-webroot step (success) 07:58:10 INFO - ##### 07:58:10 INFO - ##### 07:58:10 INFO - ##### Running create-virtualenv step. 07:58:10 INFO - ##### 07:58:10 INFO - Running pre-action listener: _resource_record_pre_action 07:58:10 INFO - Running main action method: create_virtualenv 07:58:10 INFO - Creating virtualenv /builds/slave/test/build/venv 07:58:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:58:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:58:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:58:10 INFO - Using real prefix '/usr' 07:58:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:58:10 INFO - Installing distribute.............................................................................................................................................................................................done. 07:58:12 INFO - Installing pip.................done. 07:58:12 INFO - Return code: 0 07:58:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:12 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 0x7f2650a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbc3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4e990>, '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 0xdba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdba900>, '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': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:58:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:58:12 INFO - Using env: {'DISPLAY': ':0', 07:58:12 INFO - 'HOME': '/home/cltbld', 07:58:12 INFO - 'LANG': 'en_US.UTF-8', 07:58:12 INFO - 'LANGUAGE': 'en_US:en', 07:58:12 INFO - 'LOGNAME': 'cltbld', 07:58:12 INFO - 'MAIL': '/var/mail/cltbld', 07:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:12 INFO - 'MOZ_NO_REMOTE': '1', 07:58:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:12 INFO - 'NO_EM_RESTART': '1', 07:58:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:12 INFO - 'PWD': '/builds/slave/test', 07:58:12 INFO - 'SHELL': '/bin/bash', 07:58:12 INFO - 'SHLVL': '1', 07:58:12 INFO - 'TERM': 'linux', 07:58:12 INFO - 'TMOUT': '86400', 07:58:12 INFO - 'USER': 'cltbld', 07:58:12 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 07:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:12 INFO - '_': '/tools/buildbot/bin/python'} 07:58:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:58:13 INFO - Cleaning up... 07:58:13 INFO - Return code: 0 07:58:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:58: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')]} 07:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58: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')]} 07:58:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58: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', '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 0x7f2650a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbc3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4e990>, '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 0xdba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdba900>, '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': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:58: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:58: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 psutil>=3.1.1 07:58:13 INFO - Using env: {'DISPLAY': ':0', 07:58:13 INFO - 'HOME': '/home/cltbld', 07:58:13 INFO - 'LANG': 'en_US.UTF-8', 07:58:13 INFO - 'LANGUAGE': 'en_US:en', 07:58:13 INFO - 'LOGNAME': 'cltbld', 07:58:13 INFO - 'MAIL': '/var/mail/cltbld', 07:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:13 INFO - 'MOZ_NO_REMOTE': '1', 07:58:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:13 INFO - 'NO_EM_RESTART': '1', 07:58:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:13 INFO - 'PWD': '/builds/slave/test', 07:58:13 INFO - 'SHELL': '/bin/bash', 07:58:13 INFO - 'SHLVL': '1', 07:58:13 INFO - 'TERM': 'linux', 07:58:13 INFO - 'TMOUT': '86400', 07:58:13 INFO - 'USER': 'cltbld', 07:58:13 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 07:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:13 INFO - '_': '/tools/buildbot/bin/python'} 07:58:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:13 INFO - Downloading/unpacking psutil>=3.1.1 07:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:58:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:58:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:58:15 INFO - Installing collected packages: psutil 07:58:15 INFO - Running setup.py install for psutil 07:58:15 INFO - building 'psutil._psutil_linux' extension 07:58:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:58:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:58:15 INFO - building 'psutil._psutil_posix' extension 07:58:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:58:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:58:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:58:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:58:15 INFO - Successfully installed psutil 07:58:15 INFO - Cleaning up... 07:58:15 INFO - Return code: 0 07:58:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:15 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 0x7f2650a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbc3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4e990>, '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 0xdba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdba900>, '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': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:58:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:58:15 INFO - Using env: {'DISPLAY': ':0', 07:58:15 INFO - 'HOME': '/home/cltbld', 07:58:15 INFO - 'LANG': 'en_US.UTF-8', 07:58:15 INFO - 'LANGUAGE': 'en_US:en', 07:58:15 INFO - 'LOGNAME': 'cltbld', 07:58:15 INFO - 'MAIL': '/var/mail/cltbld', 07:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:15 INFO - 'MOZ_NO_REMOTE': '1', 07:58:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:15 INFO - 'NO_EM_RESTART': '1', 07:58:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:15 INFO - 'PWD': '/builds/slave/test', 07:58:15 INFO - 'SHELL': '/bin/bash', 07:58:15 INFO - 'SHLVL': '1', 07:58:15 INFO - 'TERM': 'linux', 07:58:15 INFO - 'TMOUT': '86400', 07:58:15 INFO - 'USER': 'cltbld', 07:58:15 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 07:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:15 INFO - '_': '/tools/buildbot/bin/python'} 07:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:58: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 07:58: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 07:58: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 07:58:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58: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 07:58: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 07:58:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:58:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:58:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:58:18 INFO - Installing collected packages: mozsystemmonitor 07:58:18 INFO - Running setup.py install for mozsystemmonitor 07:58:18 INFO - Successfully installed mozsystemmonitor 07:58:18 INFO - Cleaning up... 07:58:18 INFO - Return code: 0 07:58:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:18 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 0x7f2650a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbc3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4e990>, '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 0xdba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdba900>, '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': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:58:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:58:18 INFO - Using env: {'DISPLAY': ':0', 07:58:18 INFO - 'HOME': '/home/cltbld', 07:58:18 INFO - 'LANG': 'en_US.UTF-8', 07:58:18 INFO - 'LANGUAGE': 'en_US:en', 07:58:18 INFO - 'LOGNAME': 'cltbld', 07:58:18 INFO - 'MAIL': '/var/mail/cltbld', 07:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:18 INFO - 'MOZ_NO_REMOTE': '1', 07:58:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:18 INFO - 'NO_EM_RESTART': '1', 07:58:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:18 INFO - 'PWD': '/builds/slave/test', 07:58:18 INFO - 'SHELL': '/bin/bash', 07:58:18 INFO - 'SHLVL': '1', 07:58:18 INFO - 'TERM': 'linux', 07:58:18 INFO - 'TMOUT': '86400', 07:58:18 INFO - 'USER': 'cltbld', 07:58:18 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 07:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:18 INFO - '_': '/tools/buildbot/bin/python'} 07:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:18 INFO - Downloading/unpacking jsonschema==2.5.1 07:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:58:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:20 INFO - Downloading functools32-3.2.3-2.tar.gz 07:58:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:58:20 INFO - warning: no files found matching '*.txt' 07:58:20 INFO - no previously-included directories found matching 'build' 07:58:20 INFO - no previously-included directories found matching 'dist' 07:58:20 INFO - no previously-included directories found matching '.git*' 07:58:20 INFO - Installing collected packages: jsonschema, functools32 07:58:20 INFO - Running setup.py install for functools32 07:58:20 INFO - warning: no files found matching '*.txt' 07:58:20 INFO - no previously-included directories found matching 'build' 07:58:20 INFO - no previously-included directories found matching 'dist' 07:58:20 INFO - no previously-included directories found matching '.git*' 07:58:20 INFO - Successfully installed jsonschema functools32 07:58:20 INFO - Cleaning up... 07:58:20 INFO - Return code: 0 07:58:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2650a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbc3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4e990>, '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 0xdba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdba900>, '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': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:58:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:58:20 INFO - Using env: {'DISPLAY': ':0', 07:58:20 INFO - 'HOME': '/home/cltbld', 07:58:20 INFO - 'LANG': 'en_US.UTF-8', 07:58:20 INFO - 'LANGUAGE': 'en_US:en', 07:58:20 INFO - 'LOGNAME': 'cltbld', 07:58:20 INFO - 'MAIL': '/var/mail/cltbld', 07:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:20 INFO - 'MOZ_NO_REMOTE': '1', 07:58:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:20 INFO - 'NO_EM_RESTART': '1', 07:58:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:20 INFO - 'PWD': '/builds/slave/test', 07:58:20 INFO - 'SHELL': '/bin/bash', 07:58:20 INFO - 'SHLVL': '1', 07:58:20 INFO - 'TERM': 'linux', 07:58:20 INFO - 'TMOUT': '86400', 07:58:20 INFO - 'USER': 'cltbld', 07:58:20 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 07:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:20 INFO - '_': '/tools/buildbot/bin/python'} 07:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:20 INFO - Downloading/unpacking blobuploader==1.2.4 07:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:22 INFO - Downloading blobuploader-1.2.4.tar.gz 07:58:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:58:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:58:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:58: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 07:58: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 07:58: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 07:58: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 07:58: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 07:58: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 07:58:23 INFO - Downloading docopt-0.6.1.tar.gz 07:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:58:23 INFO - Installing collected packages: blobuploader, requests, docopt 07:58:23 INFO - Running setup.py install for blobuploader 07:58:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:58:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:58:23 INFO - Running setup.py install for requests 07:58:24 INFO - Running setup.py install for docopt 07:58:24 INFO - Successfully installed blobuploader requests docopt 07:58:24 INFO - Cleaning up... 07:58:24 INFO - Return code: 0 07:58:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:24 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 0x7f2650a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbc3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4e990>, '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 0xdba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdba900>, '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': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:58:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:58:24 INFO - Using env: {'DISPLAY': ':0', 07:58:24 INFO - 'HOME': '/home/cltbld', 07:58:24 INFO - 'LANG': 'en_US.UTF-8', 07:58:24 INFO - 'LANGUAGE': 'en_US:en', 07:58:24 INFO - 'LOGNAME': 'cltbld', 07:58:24 INFO - 'MAIL': '/var/mail/cltbld', 07:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:24 INFO - 'MOZ_NO_REMOTE': '1', 07:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:24 INFO - 'NO_EM_RESTART': '1', 07:58:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:24 INFO - 'PWD': '/builds/slave/test', 07:58:24 INFO - 'SHELL': '/bin/bash', 07:58:24 INFO - 'SHLVL': '1', 07:58:24 INFO - 'TERM': 'linux', 07:58:24 INFO - 'TMOUT': '86400', 07:58:24 INFO - 'USER': 'cltbld', 07:58:24 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 07:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:24 INFO - '_': '/tools/buildbot/bin/python'} 07:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:58:24 INFO - Running setup.py (path:/tmp/pip-GWWGN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:58:24 INFO - Running setup.py (path:/tmp/pip-2hB6Ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:58:24 INFO - Running setup.py (path:/tmp/pip-BG1l8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:58:24 INFO - Running setup.py (path:/tmp/pip-1v9RXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:58:24 INFO - Running setup.py (path:/tmp/pip-a6Q_kP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:58:24 INFO - Running setup.py (path:/tmp/pip-VV5fS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:58:24 INFO - Running setup.py (path:/tmp/pip-7QPY82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:58:24 INFO - Running setup.py (path:/tmp/pip-08kNfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:58:24 INFO - Running setup.py (path:/tmp/pip-HsvoJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:58:25 INFO - Running setup.py (path:/tmp/pip-Qh72cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:58:25 INFO - Running setup.py (path:/tmp/pip-mfr26G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:58:25 INFO - Running setup.py (path:/tmp/pip-tle0zS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:58:25 INFO - Running setup.py (path:/tmp/pip-A80OCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:58:25 INFO - Running setup.py (path:/tmp/pip-9rSbfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:25 INFO - Running setup.py (path:/tmp/pip-mudlyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:58:25 INFO - Running setup.py (path:/tmp/pip-hC0UK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:58:25 INFO - Running setup.py (path:/tmp/pip-QZSce3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:58:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:58:25 INFO - Running setup.py install for manifestparser 07:58:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:58:25 INFO - Running setup.py install for mozcrash 07:58:25 INFO - Running setup.py install for mozdebug 07:58:25 INFO - Running setup.py install for mozdevice 07:58:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:58:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:58:26 INFO - Running setup.py install for mozfile 07:58:26 INFO - Running setup.py install for mozhttpd 07:58:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:58:26 INFO - Running setup.py install for mozinfo 07:58:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:58:26 INFO - Running setup.py install for mozInstall 07:58:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:58:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:58:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:58:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:58:26 INFO - Running setup.py install for mozleak 07:58:26 INFO - Running setup.py install for mozlog 07:58:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:58:26 INFO - Running setup.py install for moznetwork 07:58:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:58:26 INFO - Running setup.py install for mozprocess 07:58:26 INFO - Running setup.py install for mozprofile 07:58:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:58:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:58:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:58:26 INFO - Running setup.py install for mozrunner 07:58:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:58:27 INFO - Running setup.py install for mozscreenshot 07:58:27 INFO - Running setup.py install for moztest 07:58:27 INFO - Running setup.py install for mozversion 07:58:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:58:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:58:27 INFO - Cleaning up... 07:58:27 INFO - Return code: 0 07:58:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:27 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 0x7f2650a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbc3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4e990>, '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 0xdba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdba900>, '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': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:58:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:58:27 INFO - Using env: {'DISPLAY': ':0', 07:58:27 INFO - 'HOME': '/home/cltbld', 07:58:27 INFO - 'LANG': 'en_US.UTF-8', 07:58:27 INFO - 'LANGUAGE': 'en_US:en', 07:58:27 INFO - 'LOGNAME': 'cltbld', 07:58:27 INFO - 'MAIL': '/var/mail/cltbld', 07:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:27 INFO - 'MOZ_NO_REMOTE': '1', 07:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:27 INFO - 'NO_EM_RESTART': '1', 07:58:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:27 INFO - 'PWD': '/builds/slave/test', 07:58:27 INFO - 'SHELL': '/bin/bash', 07:58:27 INFO - 'SHLVL': '1', 07:58:27 INFO - 'TERM': 'linux', 07:58:27 INFO - 'TMOUT': '86400', 07:58:27 INFO - 'USER': 'cltbld', 07:58:27 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 07:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:27 INFO - '_': '/tools/buildbot/bin/python'} 07:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:58:27 INFO - Running setup.py (path:/tmp/pip-JFFaeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:58:27 INFO - Running setup.py (path:/tmp/pip-_ObXGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:58:27 INFO - Running setup.py (path:/tmp/pip-H5GzxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:58:27 INFO - Running setup.py (path:/tmp/pip-Sz8pyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:58:27 INFO - Running setup.py (path:/tmp/pip-38hZ6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:58: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)) 07:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:58:28 INFO - Running setup.py (path:/tmp/pip-MGJEas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:58:28 INFO - Running setup.py (path:/tmp/pip-V0CTrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:58:28 INFO - Running setup.py (path:/tmp/pip-kX56__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:58:28 INFO - Running setup.py (path:/tmp/pip-FysBC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:58:28 INFO - Running setup.py (path:/tmp/pip-sOZuOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:58:28 INFO - Running setup.py (path:/tmp/pip-3BFelE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:58:28 INFO - Running setup.py (path:/tmp/pip-2lift9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:58:28 INFO - Running setup.py (path:/tmp/pip-DzTbWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:58:28 INFO - Running setup.py (path:/tmp/pip-WYcsu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:28 INFO - Running setup.py (path:/tmp/pip-y4c3Qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:58:28 INFO - Running setup.py (path:/tmp/pip-yUwJcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:58:28 INFO - Running setup.py (path:/tmp/pip-BEH3y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:58:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:30 INFO - Downloading blessings-1.6.tar.gz 07:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:58:30 INFO - Installing collected packages: blessings 07:58:30 INFO - Running setup.py install for blessings 07:58:30 INFO - Successfully installed blessings 07:58:30 INFO - Cleaning up... 07:58:31 INFO - Return code: 0 07:58:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:58:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:58:31 INFO - Reading from file tmpfile_stdout 07:58:31 INFO - Current package versions: 07:58:31 INFO - argparse == 1.2.1 07:58:31 INFO - blessings == 1.6 07:58:31 INFO - blobuploader == 1.2.4 07:58:31 INFO - docopt == 0.6.1 07:58:31 INFO - functools32 == 3.2.3-2 07:58:31 INFO - jsonschema == 2.5.1 07:58:31 INFO - manifestparser == 1.1 07:58:31 INFO - mozInstall == 1.12 07:58:31 INFO - mozcrash == 0.17 07:58:31 INFO - mozdebug == 0.1 07:58:31 INFO - mozdevice == 0.48 07:58:31 INFO - mozfile == 1.2 07:58:31 INFO - mozhttpd == 0.7 07:58:31 INFO - mozinfo == 0.9 07:58:31 INFO - mozleak == 0.1 07:58:31 INFO - mozlog == 3.2 07:58:31 INFO - moznetwork == 0.27 07:58:31 INFO - mozprocess == 0.22 07:58:31 INFO - mozprofile == 0.28 07:58:31 INFO - mozrunner == 6.11 07:58:31 INFO - mozscreenshot == 0.1 07:58:31 INFO - mozsystemmonitor == 0.3 07:58:31 INFO - moztest == 0.7 07:58:31 INFO - mozversion == 1.4 07:58:31 INFO - psutil == 3.1.1 07:58:31 INFO - requests == 1.2.3 07:58:31 INFO - wsgiref == 0.1.2 07:58:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:31 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 0x7f2650a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbc3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4e990>, '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 0xdba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdba900>, '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': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:58:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:58:31 INFO - Using env: {'DISPLAY': ':0', 07:58:31 INFO - 'HOME': '/home/cltbld', 07:58:31 INFO - 'LANG': 'en_US.UTF-8', 07:58:31 INFO - 'LANGUAGE': 'en_US:en', 07:58:31 INFO - 'LOGNAME': 'cltbld', 07:58:31 INFO - 'MAIL': '/var/mail/cltbld', 07:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:31 INFO - 'MOZ_NO_REMOTE': '1', 07:58:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:31 INFO - 'NO_EM_RESTART': '1', 07:58:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:31 INFO - 'PWD': '/builds/slave/test', 07:58:31 INFO - 'SHELL': '/bin/bash', 07:58:31 INFO - 'SHLVL': '1', 07:58:31 INFO - 'TERM': 'linux', 07:58:31 INFO - 'TMOUT': '86400', 07:58:31 INFO - 'USER': 'cltbld', 07:58:31 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 07:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:31 INFO - '_': '/tools/buildbot/bin/python'} 07:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:58:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:58:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:58:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:58:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:58:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:58:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:58:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:58:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:58:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:58:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:58:31 INFO - Cleaning up... 07:58:31 INFO - Return code: 0 07:58:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:31 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 0x7f2650a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbc3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4e990>, '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 0xdba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdba900>, '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': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:58:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:58:31 INFO - Using env: {'DISPLAY': ':0', 07:58:31 INFO - 'HOME': '/home/cltbld', 07:58:31 INFO - 'LANG': 'en_US.UTF-8', 07:58:31 INFO - 'LANGUAGE': 'en_US:en', 07:58:31 INFO - 'LOGNAME': 'cltbld', 07:58:31 INFO - 'MAIL': '/var/mail/cltbld', 07:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:31 INFO - 'MOZ_NO_REMOTE': '1', 07:58:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:31 INFO - 'NO_EM_RESTART': '1', 07:58:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:31 INFO - 'PWD': '/builds/slave/test', 07:58:31 INFO - 'SHELL': '/bin/bash', 07:58:31 INFO - 'SHLVL': '1', 07:58:31 INFO - 'TERM': 'linux', 07:58:31 INFO - 'TMOUT': '86400', 07:58:31 INFO - 'USER': 'cltbld', 07:58:31 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 07:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:31 INFO - '_': '/tools/buildbot/bin/python'} 07:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:58:31 INFO - Cleaning up... 07:58:31 INFO - Return code: 0 07:58:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:31 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 0x7f2650a62f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcee8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbc3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4e990>, '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 0xdba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdba900>, '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': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:58:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:58:31 INFO - Using env: {'DISPLAY': ':0', 07:58:31 INFO - 'HOME': '/home/cltbld', 07:58:31 INFO - 'LANG': 'en_US.UTF-8', 07:58:31 INFO - 'LANGUAGE': 'en_US:en', 07:58:31 INFO - 'LOGNAME': 'cltbld', 07:58:31 INFO - 'MAIL': '/var/mail/cltbld', 07:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:31 INFO - 'MOZ_NO_REMOTE': '1', 07:58:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:31 INFO - 'NO_EM_RESTART': '1', 07:58:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:31 INFO - 'PWD': '/builds/slave/test', 07:58:31 INFO - 'SHELL': '/bin/bash', 07:58:31 INFO - 'SHLVL': '1', 07:58:31 INFO - 'TERM': 'linux', 07:58:31 INFO - 'TMOUT': '86400', 07:58:31 INFO - 'USER': 'cltbld', 07:58:31 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 07:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:31 INFO - '_': '/tools/buildbot/bin/python'} 07:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:31 INFO - Downloading/unpacking flake8 07:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:58:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:58:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:58: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 07:58: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 07:58: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 07:58: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 07:58: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 07:58: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 07:58:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:58: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 07:58: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 07:58: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 07:58: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 07:58: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 07:58: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 07:58:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:58:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:58:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:58:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:58:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:58:34 INFO - no previously-included directories found matching 'docs/_build' 07:58:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:58:34 INFO - Running setup.py install for pep8 07:58:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:58:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:58:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:58:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:58:34 INFO - no previously-included directories found matching 'docs/_build' 07:58:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:58:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:58:34 INFO - Cleaning up... 07:58:34 INFO - Return code: 0 07:58:34 INFO - Running post-action listener: _resource_record_post_action 07:58:34 INFO - Running post-action listener: _start_resource_monitoring 07:58:34 INFO - Starting resource monitoring. 07:58:34 INFO - ##### 07:58:34 INFO - ##### Finished create-virtualenv step (success) 07:58:34 INFO - ##### 07:58:34 INFO - ##### 07:58:34 INFO - ##### Running install step. 07:58:34 INFO - ##### 07:58:34 INFO - Running pre-action listener: _resource_record_pre_action 07:58:34 INFO - Running main action method: install 07:58:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:58:35 INFO - Reading from file tmpfile_stdout 07:58:35 INFO - Detecting whether we're running mozinstall >=1.0... 07:58:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:58:35 INFO - Reading from file tmpfile_stdout 07:58:35 INFO - Output received: 07:58:35 INFO - Usage: mozinstall [options] installer 07:58:35 INFO - Options: 07:58:35 INFO - -h, --help show this help message and exit 07:58:35 INFO - -d DEST, --destination=DEST 07:58:35 INFO - Directory to install application into. [default: 07:58:35 INFO - "/builds/slave/test"] 07:58:35 INFO - --app=APP Application being installed. [default: firefox] 07:58:35 INFO - mkdir: /builds/slave/test/build/application 07:58: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'] 07:58: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 07:58:51 INFO - Reading from file tmpfile_stdout 07:58:51 INFO - Output received: 07:58:51 INFO - /builds/slave/test/build/application/firefox/firefox 07:58:51 INFO - Running post-action listener: _resource_record_post_action 07:58:51 INFO - ##### 07:58:51 INFO - ##### Finished install step (success) 07:58:51 INFO - ##### 07:58:51 INFO - ##### 07:58:51 INFO - ##### Running run-tests step. 07:58:51 INFO - ##### 07:58:51 INFO - Running pre-action listener: _resource_record_pre_action 07:58:51 INFO - Running main action method: run_tests 07:58:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:58:51 INFO - Python 2.7.3 07:58:51 INFO - Return code: 0 07:58:51 INFO - grabbing minidump binary from tooltool 07:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:51 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 0xe4e990>, '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 0xdba470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdba900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:58:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:58:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:58:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:58:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:58:51 INFO - Return code: 0 07:58:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:58:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:58:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:58:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:58:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:58:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:58:52 INFO - Return code: 0 07:58:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 07:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 07:58:52 INFO - Using env: {'DISPLAY': ':0', 07:58:52 INFO - 'HOME': '/home/cltbld', 07:58:52 INFO - 'LANG': 'en_US.UTF-8', 07:58:52 INFO - 'LANGUAGE': 'en_US:en', 07:58:52 INFO - 'LOGNAME': 'cltbld', 07:58:52 INFO - 'MAIL': '/var/mail/cltbld', 07:58:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:58:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:52 INFO - 'MOZ_NO_REMOTE': '1', 07:58:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:52 INFO - 'NO_EM_RESTART': '1', 07:58:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:52 INFO - 'PWD': '/builds/slave/test', 07:58:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:58:52 INFO - 'SHELL': '/bin/bash', 07:58:52 INFO - 'SHLVL': '1', 07:58:52 INFO - 'TERM': 'linux', 07:58:52 INFO - 'TMOUT': '86400', 07:58:52 INFO - 'USER': 'cltbld', 07:58:52 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354', 07:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:52 INFO - '_': '/tools/buildbot/bin/python'} 07:58:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 07:58:52 INFO - mozversion application_buildid: 20160622063901 07:58:52 INFO - mozversion application_changeset: c9edfe35619f69f7785776ebd19a3140684024dc 07:58:52 INFO - mozversion application_display_name: Nightly 07:58:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:58:52 INFO - mozversion application_name: Firefox 07:58:52 INFO - mozversion application_remotingname: firefox 07:58:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:58:52 INFO - mozversion application_vendor: Mozilla 07:58:52 INFO - mozversion application_version: 50.0a1 07:58:52 INFO - mozversion platform_buildid: 20160622063901 07:58:52 INFO - mozversion platform_changeset: c9edfe35619f69f7785776ebd19a3140684024dc 07:58:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:58:52 INFO - mozversion platform_version: 50.0a1 07:58:52 INFO - using testdate: 1466607532 07:58:52 INFO - actual date: 1466607532 07:58:52 INFO - starting webserver on 'localhost:53137' 07:58:52 INFO - SUITE-START | Running 2 tests 07:58:52 INFO - TEST-START | dromaeo_css 07:58:52 INFO - operating with platform_type : linux_ 07:58:52 INFO - Initialising browser for dromaeo_css test... 07:58:52 INFO - TEST-INFO | started process 24858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8cFi2n/profile http://localhost:53137/getInfo.html) 07:58:57 INFO - PROCESS | 24858 | __metrics Screen width/height:1600/1200 07:58:57 INFO - PROCESS | 24858 | colorDepth:24 07:58:57 INFO - PROCESS | 24858 | Browser inner width/height: 1024/697 07:58:57 INFO - PROCESS | 24858 | __metrics 07:58:58 ERROR - PROCESS | 24858 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 07:58:58 INFO - TEST-INFO | 24858: exit 0 07:58:58 INFO - Browser initialized. 07:58:58 INFO - Running cycle 1/1 for dromaeo_css test... 07:58:58 INFO - TEST-INFO | started process 24979 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8cFi2n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:59:11 INFO - PROCESS | 24979 | RSS: Main: 186212352 07:59:11 INFO - PROCESS | 24979 | 08:00:00 INFO - PROCESS | 24979 | 1466607600770 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] 08:02:13 INFO - PROCESS | 24979 | Cycle 1(1): loaded http://localhost:53137/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53137/tests/dromaeo/cssquery-ext.html) 08:02:14 INFO - PROCESS | 24979 | RSS: Main: 189194240 08:02:14 INFO - PROCESS | 24979 | 08:05:16 INFO - PROCESS | 24979 | Cycle 1(1): loaded http://localhost:53137/tests/dromaeo/cssquery-ext.html (next: http://localhost:53137/tests/dromaeo/cssquery-jquery.html) 08:05:17 INFO - PROCESS | 24979 | RSS: Main: 188030976 08:05:17 INFO - PROCESS | 24979 | 08:08:19 INFO - PROCESS | 24979 | Cycle 1(1): loaded http://localhost:53137/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53137/tests/dromaeo/cssquery-mootools.html) 08:08:19 INFO - PROCESS | 24979 | RSS: Main: 189116416 08:08:19 INFO - PROCESS | 24979 | 08:11:21 INFO - PROCESS | 24979 | Cycle 1(1): loaded http://localhost:53137/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53137/tests/dromaeo/cssquery-prototype.html) 08:11:22 INFO - PROCESS | 24979 | RSS: Main: 186916864 08:11:22 INFO - PROCESS | 24979 | 08:14:24 INFO - PROCESS | 24979 | Cycle 1(1): loaded http://localhost:53137/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53137/tests/dromaeo/cssquery-yui.html) 08:14:25 INFO - PROCESS | 24979 | RSS: Main: 189018112 08:14:25 INFO - PROCESS | 24979 | 08:17:28 INFO - PROCESS | 24979 | Cycle 1(1): loaded http://localhost:53137/tests/dromaeo/cssquery-yui.html (next: http://localhost:53137/tests/dromaeo/cssquery-dojo.html) 08:17:28 INFO - PROCESS | 24979 | RSS: Main: 189947904 08:17:28 INFO - PROCESS | 24979 | 08:17:28 INFO - PROCESS | 24979 | __start_tp_report 08:17:28 INFO - PROCESS | 24979 | _x_x_mozilla_page_load 08:17:28 INFO - PROCESS | 24979 | _x_x_mozilla_page_load_details 08:17:28 INFO - PROCESS | 24979 | |i|pagename|runs| 08:17:28 INFO - PROCESS | 24979 | |0;dojo.html;2674.438367942732;2732.863356832158;2745.986270068651;2753.7108603596635;2758.048473276719;4874.293227482013;4917.877053073675;4932.408111026677;5015.673981191229;5064.13909635362;4828.855134345967;4899.510048995098;4911.287863259825;4966.776495057722;4983.302337672729;4450.888727781807;4495.190865644183;4614.653900957424;4618.722876627413;4627.606653434462;524.9595598013523;4457.33140028995;4512.59386655201;4523.683342166049;4588.059447813191;4536.591706746409;4560.543945605446;4578.084383123389;4587.174308624446;4601.44782626087;4557.658175636808;4582.289745089516;4589.793459294307;4595.8391456299205;4623.052274283764;4399.6040356368085;4472.44094488189;4475.530069342704;4525.434320709911;4526.932096018562;4807.567318941312;4863.19757240055;4896.583790377822;4925.876853078702;5000.649954503187;5210;5283.709395983219;5284.709340986245;5335.893282134374;5365.06111430502;5270.710110943896;5284.339457567804;5286.735663216824;5316.867078323035;5353.277307563468;4903.975480122613;4922.926156107661;4924.655274130848;4925.876853078702;4937.481564435754;5341.7062061586985;5405.378381486179;5409.945900541023;5435.592330575223;5488.780448782084;5249.186376111708;5250.317458730341;5264.131418316011;5264.289320941701;5323.787048518094;5347.973260133752;5356.009138309425;5358.062339090721;5367.1680889462195;5409.107497262986;5073.340465739504;5181.715005674724;5226.947730522646;5244.606654500928;5296.682199068068;5212.921806172911;5228.764705588182;5252.606054545848;5256.9737151314;5261.210818377198;4309.181255561433;4312.849050283225;4329;4354.912901741947;4386.670999675037;3714.238581090924;3717.2565486902727;3717.5353080864893;3720.497732806091;3763.1532905096683;4535.297028960516;4560.087982403533;4563.06457176278;4578.5650363215445;4609.815607375667;5384.192371144281;5407.891842163213;5409.918851217235;5412.052890744104;5416.83749487516;4464.084862603158;4477.888052798706;4503.842365517191;4521.367008618796;4530.524294948983;4694.929576056294;4729.0541891621815;4732.716037037789;4747.335373047776;4784.569388755029;4851.151048566416;4918.508149185053;4921.237208232729;4923.08922849274;4980.302757613937;5311.628186027096;5341.599380046589;5345.9465405345445;5348.5186333230195;5367.194920761917;4974.726390048582;4990.72551009698;4994.700317980933;5005.074061298671;5059.848204553869;5109.105906466428;5243;5280.6303558750515;5288.074586947192;5291.76187071575;5307.57539396855;5356.5714742821265;5378.784848606168;5380;5433.049216387196;5210.817621383233;5229.346331708536;5229.790808367775;5237.2929654497675;5284.762185701576;5059;5091.338126043591;5102.030614183293;5200.635955483232;5202.73986300691;5059.87350316245;5073.949260507347;5082.872928176826;5087.084324821568;5139.820106296262;5217.2434996925995;5221.895562088813;5226.372835259793;5229.738513074407;5249.763760630704;4988.80044798204;5094.108531006985;5099.184130539096;5128.743562821918;5159.793608255778 08:17:28 INFO - PROCESS | 24979 | |1;ext.html;539.5572984337718;577.0421100972385;588.4174667079592;597.7519329478265;618.7308520793453;36665;37427.81286093569;39865.20269594614;40084.398734019014;40192.39711404331;40525.59474405255;40860.18279634405;41099.178016439655;41215.58784412155;41284.38073428901;7866.331361834236;7987.121416644164;8015;8038.598070096501;8054.718084867001;7798.688052477894;7889.8027549311155;7890.526568405885;7895.328897043758;7924.762257132295;7915.683372665087;7931.920680793176;7937.960310198441;7940.563269020202;7978.36173106153;7922.920770792276;7985.04179498461;7992.840143197103;8017.358611311081;8022.598870056532;7923.683052677886;7936.127026027132;7974.122846486882;7997.120316765209;8002.19978002201;37982.81008594939;38682.61317386818;38836;38909.22181556381;38932.416013759816;2728.249731323882;3076.1694342527617;3113.2839446927333;3142.4814905540557;3176.2059485128716;28080.157595272176;28167;28227.57658635122;28331.57502637462;28812.567811482844;3392.4741665041956;3400.268942177444;3426.0749597608506;3428.879989200391;3472.2187507810795;224260;228639;229602;230754;232068.83965580232;31947.361052778815;32493.350132997206;32729.67270327314;32828.507572386436;32985.67014329826;33320.83339583335;33579.328413432086;33732.156696082304;33775.66224337725;33814.49278260828;13539.864601354057;13626.93186534061;13627;13629.522966696119;13632.727345453035;11114.610988615359;11119.777604447865;11141.777164456666;11173.329600224013;11611;7786.338161256356;7851.450398472166;7866.921330786733;7926.405519586054;7947.642356093989;3161.0832858470785;3163.8711481516843;3177.0468859342104;3198.4722520784276;3230.2085988932863;881.1672969044191;898.034612791252;901.3600343755876;927.675313640234;1032.4321623107412;28224.15327540136;30468.390632187675;32144.35711285761;32461.513077303858;32702;948.9952550237205;975.317277905469;1006.3810756384917;1032.0041160280216;1044.8537204791335;14382.424703011762;15032.774508382383;15144.772828407582;15232.162231077396;15308.617284567752;422904;423013;425103;426440;427405;49638.25542616864;50029;50240.24639630409;50307.24539131916;50320.24519632208;1190.4166958190597;1220.9084318676134;1230.3417671545858;1235.086036333125;1312.4094157628915;26680.733192668602;28215;28233.15300540987;28694.282642934093;28980.565291520223;44149.77925110354;44416.11167776691;44558.3316250263;44786.3282050763;45271.773641131585;360026;360528;360976;361654;361690;25141.497170056864;25162.496750065264;25306.240812775646;26154;26428.207153785417;42708.145837083706;42961.14077718365;43093.784531077144;43193;43895;36677.63322366742;36713.81643091767;37085.814570926974;37231;37630.811845940596;35756.66474207174;36368.45447318239;36825.447618286285;36838.63161368352;37071.8146409277;31948.20129496781;36457.270854583294;36830.44754328633;36998.63001369952;37144;32046.35907281888;33282.66717332796;33767.662323376455;34061.14847128842;34116.829415852764;25573.23280301594;26118.216453506426;26161.215163545123;26186.73813261843;26601 08:17:28 INFO - PROCESS | 24979 | |2;jquery.html;374.1301474072781;375.7520036775727;379.76644363716315;384.55199692358406;392.3408673428639;15804.288807003684;16246.512604621865;17055.658886822257;17070.23183956722;17083.487495375157;15111.697766044672;15869.206539673;15872.920635396837;16044.679106417894;16208.594785130348;4651.325557794118;4790.137775200463;4813.061453016663;4813.49458306878;4814.711117332954;3315.6187038490643;5183.974080129613;5512.090505066659;5532.723363831812;5605.747741351649;5525.254090697765;5553.416891226424;5557.777688892439;5576.079946808792;5597.356304025028;5912.881742365172;6092.11664308675;6092.695365231765;6124.0813877918445;6135.938640613604;4529.116822219668;4891.6820406673805;5422.322209723785;5423.755930983115;5440.564754819605;12052.156349055569;12245.816312755316;12565.748685026248;12569.497220111185;12613.684657883627;1696.180873211714;1863.6924907390264;2002.4693456233963;2173.206779525462;2181.5636872625537;9228;9445.386049906803;9541.809163816753;9671.613135474572;9916;1648.9917550412292;1656.097426902341;1665.883388162829;1668.9499315020448;1709.6324290277526;67896.6605166976;69416.3058369415;71544;71790;72350;10156.593736250466;10177.796444071077;10333.121684656888;10754.731131721614;11104.222704410613;13927.23400212998;14042;14115.576532704035;14166.433342666178;14233.43066277358;7245;7410;7423.294786995227;7492.475526713078;7525.661345239478;7011.754588589375;7038.612876291853;7166.534175278694;7231.132264128233;7249.456290778213;4296.4414626098405;4337.696361254745;4359.498657654347;4435.6673249505775;4590.862274131781;1720.8451239388264;1744.8973986346423;1861.5811442425618;1863.1988245054756;1876.9249230030646;800.9078955920144;833.358314098141;853.4836423963537;860.2902605350611;888.4092078767676;16479.17604119813;16688.6662266754;16856.57858553546;17222.655546888993;17521.474355769347;834.845553572591;854.43607219235;863.3697400897255;896.4979611417497;953.7806304549854;9157;9504.524773761284;9670.129688328085;9685.031496850259;9766.36518626287;356276;359296;379533;387591;394517;69303.30696692968;75267.24732752712;75658;76833.0114240364;80064.19935800567;869.7058982140064;880.933929955256;895.4940458640978;896.2202883491404;906.3655441191192;15046.172460514339;15289.6177595561;15578;15629.14039727826;15680.451184208498;35616.28767424689;35869.64130358663;36689.44965825461;36729;37692.05769855776;50979.74510127425;51376.229356558935;51586.74206628943;51792.74103629609;51836;7838.529688218725;7848.254415830487;7901.604919754104;7934.841303174019;7965;11472.426378680866;11710;11764.000059994996;11894.107941904218;12019.879801201876;10048.748781280527;10071.949640251752;10118.443485608363;10342.948285258526;10577.9471102644;10378.377297362182;10434.843477347998;10528.315659482108;10631.94684026575;10715.946420267848;10265.897341026493;10291.794164116825;10475.895241047492;10480.213983951387;10536.104431123134;6409.583377080475;6717.9328206719265;7731.110922244014;7868;7998.720044798404;9475;10437.373757574569;10566;10680.786384272427;10710.946445268035 08:17:28 INFO - PROCESS | 24979 | |3;mootools.html;1388.9583312500622;1407.2769191614227;1494.760838265877;1666.566692659908;1694.949151525454;6902.344277293661;7613.276738709814;8019.959900200498;8401.957990210049;8408.915910840897;7756.96121519393;7988.121306656263;8018.398620103487;8032.678692852279;8068.233517815798;2238.697775800262;2260.446190683285;2277.2598905355744;2277.7152855893014;2280.2817112609473;2235.1506427557506;2247.5954328220914;2270.330252575486;2271.522980174157;2276.829237807163;2222.2666520048347;2224.4550085229143;2229.7435794883554;2232.944176395595;2237.7538470768204;2194.3416974907545;2201.416624594484;2202.702635144251;2211.1155537784853;2212.889355532217;2186.7813218678166;2206.5145667953025;2208.624533829237;2214.878181700022;2221.944451388712;7905.169957154473;8041.6381262843315;8052.838943221162;8081.151479094669;8108.310793582553;4773.904521909577;4922.852314430573;4930.605551555867;4938;4941.50584941503;2966.7478264347556;3097.6127984002;3138.074268090919;3143.779935404523;3163.3040731039137;957.8850537935423;978.33473238198;990.8612794208816;993.6323560282742;994.2791476179784;11052.281601695944;11150.944245278803;11262.943685281603;11266.774664506664;11280.097592192606;4373;4494.235979883428;4531.77341132942;4590.563896429834;4608.470025947059;9451;9523.523823808782;9523.666671666459;9532.571034303335;9589.328746987783;4946.480619534897;4981;4998.2002879539095;5014.774335154927;5024.296598476216;3736.439534069857;4239.745615263094;4367.956320436819;4398.472183337956;4404.185225733249;3736.906577335534;3777.506845481969;3867.690584753213;3887.9611203888167;3997.1605962747567;1233.2785320587557;1244.4213440750095;1259.2444533279959;1259.924404535731;1264.9241045537112;803.7950322667682;825.6573521988428;830.0409041766085;830.3274347778319;833.7998880268692;5037.244413338029;5067.5185857343495;5076.340075790124;5112.795488180505;5144;426.10305307328247;430.1246962431437;432.42487491636047;435.8561674647359;441.6819889679426;3393.389189945784;3403.8127902965575;3423.7089847362754;3464.2378676691087;3497.1082373994977;9745.951270243604;10034.046765557261;10038.347507411994;10144.036316549917;10144.188464922789;9770;9994.400335979864;10007.199424046059;10016.54925528353;10033.097021267975;7492.138404083491;7514.173440921603;7566.848663026819;7633.770986870402;7659.617019149132;5110.3356563646485;5247.65916668331;5256.553192978487;5388.54197393226;5405.324334458192;9089.681861134828;9111.544422778701;9121.726348209564;9170.220531254918;9315.767105822408;9188.95405522968;9312.44125352481;9334.346595738505;9346.299027573095;9380.733600963782;6097.603655762361;6759.357861003196;6972.616506092214;7003.719851206099;7087.539309944837;7767.3786097113225;7778.6888524460655;7782;7805.102413222325;7877.212278772077;6931.7227310907;7189.5686258824635;7211.134663840373;7233.674484648309;7347.19180890091;6960.47796415281;6998.370146686822;6999.6850141742725;7106.543158652567;7171.4621403395995;5944.5838791284195;6081.027035674271;6100.633961962297;6120.08198770188;6145.938540614537;4370.431843860278;4402.229609818205;4443.377927090274;4557.339185818104;4576.725396476222;4554.2485489895125;4588.013577080944;4605.539446055368;4659.790309436015;4669.7898594564 08:17:28 INFO - PROCESS | 24979 | |4;prototype.html;294.92331993681637;302.4631279478925;309.7599360495616;312.03736472980853;320.42003972809204;5009.223570346602;5069.619778516612;5108.69347839129;5236.2407450919645;5277.920831187531;5136.229565565167;5144.17693169093;5173.560247378978;5185.144451165553;5226.973865130679;3983.382575700771;3997.180577981514;3997.800109994503;4016.3975403689533;4027.2750904837117;3896.47397601323;3963;3988.6410223079915;4018.3168861293652;4034.253663072326;3927;3929.489166408363;3930.1353702185475;3930.6219737059096;3955.5846636103083;3931.331673615478;3944.9211015779524;3947.3881548359764;3966.8809935701975;3984.9639093835813;3426.6059403168706;3435.9828200859088;3447.5862896452336;3464.064702530303;3487.232808782064;4890.657653964224;5060.228919878014;5065.341505604285;5073.1122053640465;5078.390593128811;4514.864554063383;4553;4565.288016993627;4567.246404343279;4578.9542104579195;5395.730213489349;5420.430854760233;5430.15832545956;5438.374586922476;5451.700156491392;3727.422249551324;3755.286495565834;3776.4320262221677;3790.2040571480024;3843.1160833008566;5630.8029218977135;5658.43415658435;5681.630694004876;5685.744141513642;5743.138529220567;3869.187470631199;3871.554771201348;3895.337792575269;3899.454076429302;3951.8419263229725;3872.6514613684903;3946.546147193052;3985.4818873546255;3990.7030215180184;4009.51885773709;4533.7279763213655;4542.364069030338;4545.181867263925;4546.136234115574;4571.222892108283;5411.891762164734;5417.702026388586;5436.70098144598;5449.918251226235;5504.137848318932;1315.5066849931275;1348.8786009259213;1375.848656647768;1377.1805775563523;1378.8690074442911;898.4770813471104;904.2043002158059;909.704346087511;932.9626814927327;933.4492649336923;4186.6859985501205;4221.176870510282;4223.606209950709;4233.661307095425;4234.449521562239;4842.322074909515;4875.317455556225;4886.3403440535785;4924.089043526959;4941.604671626261;4163.3130533462245;4197;4216.177845320133;4222.59885310895;4224.704270701021;2480.822428439705;2639.2214296782495;2659.880305386262;2667.7594918363056;2689.354554906808;4592.977035114803;4653.488116307203;4684.446976397871;4709.858704238878;4718.9292160617615;4970.229614409773;5013.222950442687;5016.369679854062;5026.84919452417;5033.47148549397;4834.444038935497;5192.701824543864;5199.584033277329;5218.3737951444555;5225.059489291964;5523.861903452445;5632.915506267327;5692.914606280826;5698.489900176373;5717.22817419643;5304.602154838325;5518.392976772471;5529.612927095226;5557.833265002057;5576.442355764391;5164.8565845175335;5216.895662086813;5233.142234506695;5248.868778280574;5278.445763194963;3785.2051069275763;3813.790241536631;3832.1760821423527;3852.2680690668685;3857.40210267409;5396.946030539644;5628.521575666115;5655.519280861173;5664.527222921987;5668;5398.165962869525;5404.486573775485;5405.405405405324;5425.104857698436;5466.316710411199;5433.592480563894;5466;5473.768402109494;5478.506934375925;5500.972495137658;5094.7707353169935;5316.122839731555;5325.680459172462;5340.359156901197;5374.623776335619;5465.426130256425;5470.398256191896;5518.91721624184;5520.503154716095;5531.28966806254;5208.244804503402;5399.514043735925;5416.674999500043;5419.620626556103;5441.204402547229 08:17:28 INFO - PROCESS | 24979 | |5;yui.html;685.8182581615876;710.2435905760365;711.9964400178;721.6355740351122;779.7154038775847;12148.939255303721;12958.611241662742;13038.348082595856;13054.2820144892;13073.954083673307;13063.216207027584;13292.667683307922;13327.866721332784;13329.533466328681;13347.132436391628;626.6960524145786;759.3090287838069;772.2624893226969;781.4295564238109;789.4000559574736;772.2779201446638;775.7362496751103;777.0791611939869;782.886481460188;784.9803754906116;823.3577809308749;823.390690888744;825.0800357601291;825.7027470110755;827.5365795154732;815.6248125862052;820.1347578304886;823.4194892600702;823.7734622978669;826.243986752121;593.0955293177896;595.074658905402;598.3597550620838;602.9457348838625;603.4478452216217;11372.545098196062;11383.601573944872;11407.144464165138;11414.086873050135;11422.543098276059;13323;13467;13606.523771667944;13823.377947992263;13850.376733047036;10749.247552671317;10921.890781092166;10927.235093543455;11053.668389948314;11086.334819910831;3309.5697559317136;3365.074604483762;3377.5440315557576;3455.740819438527;3460.9480857787153;59490.702546487424;59532.10701839432;62301.68849155725;62337;63314.683426582575;9907.851382229272;10158;10282.07461328469;10490.842637360445;10493.790124197625;18194.090295485174;18485.353012644493;18680.159392827354;18693.345732899284;18735.812641873406;6941.895871561931;6952.895706564405;6963.860722785617;7096.148462184571;7242.130944286614;3928.0965377962657;3952.7825969571372;3983.1237127831832;4014.3175660137263;4069.674426045909;2984.0749367696085;3052.252198211452;3056.862441190152;3071.0326247232497;3080.122165182912;494.44622023334097;514.5754752329343;541.5207541325955;551.3824516541499;551.4210079416597;488.32610996824155;597.2892258212713;641.9614823110628;644.5359341274275;652.8302641313293;8075.7482590198615;8146.144654811278;8190.631421586043;8237.232289950614;8360.163983601591;469.34291991211893;601.3373023589778;611.7797592866565;632.4529282170889;650.4731167754135;3930.9606903931167;3933.862314819025;3949.624785645359;3960.881173564798;4027.7583344999393;57140.428595714344;97000.51499742597;98276;99075.50462247642;100556;84934.5753271242;87837.12162878417;88082.55958720166;88319;88612;76897.231027689;78415;79442.60278698686;79924.20075799283;81305;7661.15727270011;7673.501222420525;7682.347000504796;7730.381569474316;7780.572068536285;46205.306920395546;46214;46302;46943.29585056158;47998.520014799404;39350.80324598473;53845.461545384045;58976.41023589709;65418;65840.6707966457;11625.12811539121;11644.53421863116;11869.881301187223;11983.580574679845;12082.758344832879;13548.79676804829;13695.109817861807;13768.24274664863;14315.212663303619;14716.337764800395;12061.638150855488;12246.816297755719;12304.630861074182;12694.619161425171;12740.426680799572;12273.202241854251;12444.128910976146;12968.092233543939;13132.671683207614;13315.667108321983;11213.159013074215;11318.886811131782;11469.139814513777;11980.400979951142;13141.934290328487;9774.75563110928;9830.606775728891;10066.295359324777;10099.343542669703;10210.540525676213;9245.399049061789;9457.148856602938;9735.123838854537;9760.46317452547;9894.554745036347 08:17:28 INFO - PROCESS | 24979 | __end_tp_report 08:17:28 INFO - PROCESS | 24979 | __start_cc_report 08:17:28 INFO - PROCESS | 24979 | _x_x_mozilla_cycle_collect,398 08:17:28 INFO - PROCESS | 24979 | __end_cc_report 08:17:28 INFO - PROCESS | 24979 | __startTimestamp1466608648650__endTimestamp 08:17:28 INFO - PROCESS | 24979 | 08:17:28 INFO - PROCESS | 24979 | ------- Summary: start ------- 08:17:28 INFO - PROCESS | 24979 | Number of tests: 6 08:17:28 INFO - PROCESS | 24979 | 08:17:28 INFO - PROCESS | 24979 | [#0] dojo.html Cycles:165 Average:4860.56 Median:5015.67 stddev:640.04 (12.8%) stddev-sans-first:618.60 08:17:28 INFO - PROCESS | 24979 | Values: 2674.4 2732.9 2746.0 2753.7 2758.0 4874.3 4917.9 4932.4 5015.7 5064.1 4828.9 4899.5 4911.3 4966.8 4983.3 4450.9 4495.2 4614.7 4618.7 4627.6 525.0 4457.3 4512.6 4523.7 4588.1 4536.6 4560.5 4578.1 4587.2 4601.4 4557.7 4582.3 4589.8 4595.8 4623.1 4399.6 4472.4 4475.5 4525.4 4526.9 4807.6 4863.2 4896.6 4925.9 5000.6 5210.0 5283.7 5284.7 5335.9 5365.1 5270.7 5284.3 5286.7 5316.9 5353.3 4904.0 4922.9 4924.7 4925.9 4937.5 5341.7 5405.4 5409.9 5435.6 5488.8 5249.2 5250.3 5264.1 5264.3 5323.8 5348.0 5356.0 5358.1 5367.2 5409.1 5073.3 5181.7 5226.9 5244.6 5296.7 5212.9 5228.8 5252.6 5257.0 5261.2 4309.2 4312.8 4329.0 4354.9 4386.7 3714.2 3717.3 3717.5 3720.5 3763.2 4535.3 4560.1 4563.1 4578.6 4609.8 5384.2 5407.9 5409.9 5412.1 5416.8 4464.1 4477.9 4503.8 4521.4 4530.5 4694.9 4729.1 4732.7 4747.3 4784.6 4851.2 4918.5 4921.2 4923.1 4980.3 5311.6 5341.6 5345.9 5348.5 5367.2 4974.7 4990.7 4994.7 5005.1 5059.8 5109.1 5243.0 5280.6 5288.1 5291.8 5307.6 5356.6 5378.8 5380.0 5433.0 5210.8 5229.3 5229.8 5237.3 5284.8 5059.0 5091.3 5102.0 5200.6 5202.7 5059.9 5073.9 5082.9 5087.1 5139.8 5217.2 5221.9 5226.4 5229.7 5249.8 4988.8 5094.1 5099.2 5128.7 5159.8 08:17:28 INFO - PROCESS | 24979 | 08:17:28 INFO - PROCESS | 24979 | [#1] ext.html Cycles:180 Average:47806.06 Median:199029.23 stddev:92202.46 (46.3%) stddev-sans-first:92392.81 08:17:28 INFO - PROCESS | 24979 | Values: 539.6 577.0 588.4 597.8 618.7 36665.0 37427.8 39865.2 40084.4 40192.4 40525.6 40860.2 41099.2 41215.6 41284.4 7866.3 7987.1 8015.0 8038.6 8054.7 7798.7 7889.8 7890.5 7895.3 7924.8 7915.7 7931.9 7938.0 7940.6 7978.4 7922.9 7985.0 7992.8 8017.4 8022.6 7923.7 7936.1 7974.1 7997.1 8002.2 37982.8 38682.6 38836.0 38909.2 38932.4 2728.2 3076.2 3113.3 3142.5 3176.2 28080.2 28167.0 28227.6 28331.6 28812.6 3392.5 3400.3 3426.1 3428.9 3472.2 224260.0 228639.0 229602.0 230754.0 232068.8 31947.4 32493.4 32729.7 32828.5 32985.7 33320.8 33579.3 33732.2 33775.7 33814.5 13539.9 13626.9 13627.0 13629.5 13632.7 11114.6 11119.8 11141.8 11173.3 11611.0 7786.3 7851.5 7866.9 7926.4 7947.6 3161.1 3163.9 3177.0 3198.5 3230.2 881.2 898.0 901.4 927.7 1032.4 28224.2 30468.4 32144.4 32461.5 32702.0 949.0 975.3 1006.4 1032.0 1044.9 14382.4 15032.8 15144.8 15232.2 15308.6 422904.0 423013.0 425103.0 426440.0 427405.0 49638.3 50029.0 50240.2 50307.2 50320.2 1190.4 1220.9 1230.3 1235.1 1312.4 26680.7 28215.0 28233.2 28694.3 28980.6 44149.8 44416.1 44558.3 44786.3 45271.8 360026.0 360528.0 360976.0 361654.0 361690.0 25141.5 25162.5 25306.2 26154.0 26428.2 42708.1 42961.1 43093.8 43193.0 43895.0 36677.6 36713.8 37085.8 37231.0 37630.8 35756.7 36368.5 36825.4 36838.6 37071.8 31948.2 36457.3 36830.4 36998.6 37144.0 32046.4 33282.7 33767.7 34061.1 34116.8 25573.2 26118.2 26161.2 26186.7 26601.0 08:17:28 INFO - PROCESS | 24979 | 08:17:28 INFO - PROCESS | 24979 | [#2] jquery.html Cycles:180 Average:23696.67 Median:4317.07 stddev:62158.20 (1439.8%) stddev-sans-first:62307.90 08:17:28 INFO - PROCESS | 24979 | Values: 374.1 375.8 379.8 384.6 392.3 15804.3 16246.5 17055.7 17070.2 17083.5 15111.7 15869.2 15872.9 16044.7 16208.6 4651.3 4790.1 4813.1 4813.5 4814.7 3315.6 5184.0 5512.1 5532.7 5605.7 5525.3 5553.4 5557.8 5576.1 5597.4 5912.9 6092.1 6092.7 6124.1 6135.9 4529.1 4891.7 5422.3 5423.8 5440.6 12052.2 12245.8 12565.7 12569.5 12613.7 1696.2 1863.7 2002.5 2173.2 2181.6 9228.0 9445.4 9541.8 9671.6 9916.0 1649.0 1656.1 1665.9 1668.9 1709.6 67896.7 69416.3 71544.0 71790.0 72350.0 10156.6 10177.8 10333.1 10754.7 11104.2 13927.2 14042.0 14115.6 14166.4 14233.4 7245.0 7410.0 7423.3 7492.5 7525.7 7011.8 7038.6 7166.5 7231.1 7249.5 4296.4 4337.7 4359.5 4435.7 4590.9 1720.8 1744.9 1861.6 1863.2 1876.9 800.9 833.4 853.5 860.3 888.4 16479.2 16688.7 16856.6 17222.7 17521.5 834.8 854.4 863.4 896.5 953.8 9157.0 9504.5 9670.1 9685.0 9766.4 356276.0 359296.0 379533.0 387591.0 394517.0 69303.3 75267.2 75658.0 76833.0 80064.2 869.7 880.9 895.5 896.2 906.4 15046.2 15289.6 15578.0 15629.1 15680.5 35616.3 35869.6 36689.4 36729.0 37692.1 50979.7 51376.2 51586.7 51792.7 51836.0 7838.5 7848.3 7901.6 7934.8 7965.0 11472.4 11710.0 11764.0 11894.1 12019.9 10048.7 10071.9 10118.4 10342.9 10577.9 10378.4 10434.8 10528.3 10631.9 10715.9 10265.9 10291.8 10475.9 10480.2 10536.1 6409.6 6717.9 7731.1 7868.0 7998.7 9475.0 10437.4 10566.0 10680.8 10710.9 08:17:28 INFO - PROCESS | 24979 | 08:17:28 INFO - PROCESS | 24979 | [#3] mootools.html Cycles:180 Average:5283.81 Median:4939.75 stddev:3008.63 (60.9%) stddev-sans-first:3002.83 08:17:28 INFO - PROCESS | 24979 | Values: 1389.0 1407.3 1494.8 1666.6 1694.9 6902.3 7613.3 8020.0 8402.0 8408.9 7757.0 7988.1 8018.4 8032.7 8068.2 2238.7 2260.4 2277.3 2277.7 2280.3 2235.2 2247.6 2270.3 2271.5 2276.8 2222.3 2224.5 2229.7 2232.9 2237.8 2194.3 2201.4 2202.7 2211.1 2212.9 2186.8 2206.5 2208.6 2214.9 2221.9 7905.2 8041.6 8052.8 8081.2 8108.3 4773.9 4922.9 4930.6 4938.0 4941.5 2966.7 3097.6 3138.1 3143.8 3163.3 957.9 978.3 990.9 993.6 994.3 11052.3 11150.9 11262.9 11266.8 11280.1 4373.0 4494.2 4531.8 4590.6 4608.5 9451.0 9523.5 9523.7 9532.6 9589.3 4946.5 4981.0 4998.2 5014.8 5024.3 3736.4 4239.7 4368.0 4398.5 4404.2 3736.9 3777.5 3867.7 3888.0 3997.2 1233.3 1244.4 1259.2 1259.9 1264.9 803.8 825.7 830.0 830.3 833.8 5037.2 5067.5 5076.3 5112.8 5144.0 426.1 430.1 432.4 435.9 441.7 3393.4 3403.8 3423.7 3464.2 3497.1 9746.0 10034.0 10038.3 10144.0 10144.2 9770.0 9994.4 10007.2 10016.5 10033.1 7492.1 7514.2 7566.8 7633.8 7659.6 5110.3 5247.7 5256.6 5388.5 5405.3 9089.7 9111.5 9121.7 9170.2 9315.8 9189.0 9312.4 9334.3 9346.3 9380.7 6097.6 6759.4 6972.6 7003.7 7087.5 7767.4 7778.7 7782.0 7805.1 7877.2 6931.7 7189.6 7211.1 7233.7 7347.2 6960.5 6998.4 6999.7 7106.5 7171.5 5944.6 6081.0 6100.6 6120.1 6145.9 4370.4 4402.2 4443.4 4557.3 4576.7 4554.2 4588.0 4605.5 4659.8 4669.8 08:17:28 INFO - PROCESS | 24979 | 08:17:28 INFO - PROCESS | 24979 | [#4] prototype.html Cycles:180 Average:4393.93 Median:4932.85 stddev:1304.45 (26.4%) stddev-sans-first:1271.31 08:17:28 INFO - PROCESS | 24979 | Values: 294.9 302.5 309.8 312.0 320.4 5009.2 5069.6 5108.7 5236.2 5277.9 5136.2 5144.2 5173.6 5185.1 5227.0 3983.4 3997.2 3997.8 4016.4 4027.3 3896.5 3963.0 3988.6 4018.3 4034.3 3927.0 3929.5 3930.1 3930.6 3955.6 3931.3 3944.9 3947.4 3966.9 3985.0 3426.6 3436.0 3447.6 3464.1 3487.2 4890.7 5060.2 5065.3 5073.1 5078.4 4514.9 4553.0 4565.3 4567.2 4579.0 5395.7 5420.4 5430.2 5438.4 5451.7 3727.4 3755.3 3776.4 3790.2 3843.1 5630.8 5658.4 5681.6 5685.7 5743.1 3869.2 3871.6 3895.3 3899.5 3951.8 3872.7 3946.5 3985.5 3990.7 4009.5 4533.7 4542.4 4545.2 4546.1 4571.2 5411.9 5417.7 5436.7 5449.9 5504.1 1315.5 1348.9 1375.8 1377.2 1378.9 898.5 904.2 909.7 933.0 933.4 4186.7 4221.2 4223.6 4233.7 4234.4 4842.3 4875.3 4886.3 4924.1 4941.6 4163.3 4197.0 4216.2 4222.6 4224.7 2480.8 2639.2 2659.9 2667.8 2689.4 4593.0 4653.5 4684.4 4709.9 4718.9 4970.2 5013.2 5016.4 5026.8 5033.5 4834.4 5192.7 5199.6 5218.4 5225.1 5523.9 5632.9 5692.9 5698.5 5717.2 5304.6 5518.4 5529.6 5557.8 5576.4 5164.9 5216.9 5233.1 5248.9 5278.4 3785.2 3813.8 3832.2 3852.3 3857.4 5396.9 5628.5 5655.5 5664.5 5668.0 5398.2 5404.5 5405.4 5425.1 5466.3 5433.6 5466.0 5473.8 5478.5 5501.0 5094.8 5316.1 5325.7 5340.4 5374.6 5465.4 5470.4 5518.9 5520.5 5531.3 5208.2 5399.5 5416.7 5419.6 5441.2 08:17:28 INFO - PROCESS | 24979 | 08:17:28 INFO - PROCESS | 24979 | [#5] yui.html Cycles:180 Average:17749.35 Median:491.39 stddev:25217.07 (5131.8%) stddev-sans-first:25255.26 08:17:28 INFO - PROCESS | 24979 | Values: 685.8 710.2 712.0 721.6 779.7 12148.9 12958.6 13038.3 13054.3 13074.0 13063.2 13292.7 13327.9 13329.5 13347.1 626.7 759.3 772.3 781.4 789.4 772.3 775.7 777.1 782.9 785.0 823.4 823.4 825.1 825.7 827.5 815.6 820.1 823.4 823.8 826.2 593.1 595.1 598.4 602.9 603.4 11372.5 11383.6 11407.1 11414.1 11422.5 13323.0 13467.0 13606.5 13823.4 13850.4 10749.2 10921.9 10927.2 11053.7 11086.3 3309.6 3365.1 3377.5 3455.7 3460.9 59490.7 59532.1 62301.7 62337.0 63314.7 9907.9 10158.0 10282.1 10490.8 10493.8 18194.1 18485.4 18680.2 18693.3 18735.8 6941.9 6952.9 6963.9 7096.1 7242.1 3928.1 3952.8 3983.1 4014.3 4069.7 2984.1 3052.3 3056.9 3071.0 3080.1 494.4 514.6 541.5 551.4 551.4 488.3 597.3 642.0 644.5 652.8 8075.7 8146.1 8190.6 8237.2 8360.2 469.3 601.3 611.8 632.5 650.5 3931.0 3933.9 3949.6 3960.9 4027.8 57140.4 97000.5 98276.0 99075.5 100556.0 84934.6 87837.1 88082.6 88319.0 88612.0 76897.2 78415.0 79442.6 79924.2 81305.0 7661.2 7673.5 7682.3 7730.4 7780.6 46205.3 46214.0 46302.0 46943.3 47998.5 39350.8 53845.5 58976.4 65418.0 65840.7 11625.1 11644.5 11869.9 11983.6 12082.8 13548.8 13695.1 13768.2 14315.2 14716.3 12061.6 12246.8 12304.6 12694.6 12740.4 12273.2 12444.1 12968.1 13132.7 13315.7 11213.2 11318.9 11469.1 11980.4 13141.9 9774.8 9830.6 10066.3 10099.3 10210.5 9245.4 9457.1 9735.1 9760.5 9894.6 08:17:28 INFO - PROCESS | 24979 | -------- Summary: end -------- 08:17:28 INFO - PROCESS | 24979 | 08:17:29 INFO - TEST-INFO | 24979: exit 0 08:17:29 INFO - TEST-OK | dromaeo_css | took 1117002ms 08:17:29 INFO - TEST-START | kraken 08:17:29 INFO - operating with platform_type : linux_ 08:17:29 INFO - Initialising browser for kraken test... 08:17:29 INFO - TEST-INFO | started process 25219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphVVrF3/profile http://localhost:53137/getInfo.html) 08:17:34 INFO - PROCESS | 25219 | __metrics Screen width/height:1600/1200 08:17:34 INFO - PROCESS | 25219 | colorDepth:24 08:17:34 INFO - PROCESS | 25219 | Browser inner width/height: 1024/697 08:17:34 INFO - PROCESS | 25219 | __metrics 08:17:35 ERROR - PROCESS | 25219 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 08:17:36 INFO - TEST-INFO | 25219: exit 0 08:17:36 INFO - Browser initialized. 08:17:36 INFO - Running cycle 1/1 for kraken test... 08:17:36 INFO - TEST-INFO | started process 25340 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphVVrF3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:17:48 INFO - PROCESS | 25340 | RSS: Main: 186322944 08:17:48 INFO - PROCESS | 25340 | 08:17:50 INFO - PROCESS | 25340 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53137/tests/kraken/driver.html?testName=audio-beat-detection) 08:17:51 INFO - PROCESS | 25340 | RSS: Main: 190816256 08:17:51 INFO - PROCESS | 25340 | 08:17:54 INFO - PROCESS | 25340 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53137/tests/kraken/driver.html?testName=audio-dft) 08:17:55 INFO - PROCESS | 25340 | RSS: Main: 190623744 08:17:55 INFO - PROCESS | 25340 | 08:17:58 INFO - PROCESS | 25340 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53137/tests/kraken/driver.html?testName=audio-fft) 08:17:58 INFO - PROCESS | 25340 | RSS: Main: 185982976 08:17:58 INFO - PROCESS | 25340 | 08:18:01 INFO - PROCESS | 25340 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53137/tests/kraken/driver.html?testName=audio-oscillator) 08:18:01 INFO - PROCESS | 25340 | RSS: Main: 186716160 08:18:01 INFO - PROCESS | 25340 | 08:18:03 INFO - PROCESS | 25340 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53137/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:18:04 INFO - PROCESS | 25340 | RSS: Main: 187277312 08:18:04 INFO - PROCESS | 25340 | 08:18:07 INFO - PROCESS | 25340 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53137/tests/kraken/driver.html?testName=imaging-darkroom) 08:18:08 INFO - PROCESS | 25340 | RSS: Main: 187662336 08:18:08 INFO - PROCESS | 25340 | 08:18:11 INFO - PROCESS | 25340 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53137/tests/kraken/driver.html?testName=imaging-desaturate) 08:18:12 INFO - PROCESS | 25340 | RSS: Main: 184627200 08:18:12 INFO - PROCESS | 25340 | 08:18:15 INFO - PROCESS | 25340 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53137/tests/kraken/driver.html?testName=json-parse-financial) 08:18:16 INFO - PROCESS | 25340 | RSS: Main: 186392576 08:18:16 INFO - PROCESS | 25340 | 08:18:17 INFO - PROCESS | 25340 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53137/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:18:18 INFO - PROCESS | 25340 | RSS: Main: 186605568 08:18:18 INFO - PROCESS | 25340 | 08:18:20 INFO - PROCESS | 25340 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53137/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:18:21 INFO - PROCESS | 25340 | RSS: Main: 186707968 08:18:21 INFO - PROCESS | 25340 | 08:18:23 INFO - PROCESS | 25340 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53137/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:18:24 INFO - PROCESS | 25340 | RSS: Main: 186802176 08:18:24 INFO - PROCESS | 25340 | 08:18:26 INFO - PROCESS | 25340 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53137/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:18:27 INFO - PROCESS | 25340 | RSS: Main: 187006976 08:18:27 INFO - PROCESS | 25340 | 08:18:30 INFO - PROCESS | 25340 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53137/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:18:31 INFO - PROCESS | 25340 | RSS: Main: 186978304 08:18:31 INFO - PROCESS | 25340 | 08:18:32 INFO - PROCESS | 25340 | Cycle 1(1): loaded http://localhost:53137/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53137/tests/kraken/driver.html?testName=ai-astar) 08:18:33 INFO - PROCESS | 25340 | RSS: Main: 187731968 08:18:33 INFO - PROCESS | 25340 | 08:18:33 INFO - PROCESS | 25340 | __start_tp_report 08:18:33 INFO - PROCESS | 25340 | _x_x_mozilla_page_load 08:18:33 INFO - PROCESS | 25340 | _x_x_mozilla_page_load_details 08:18:33 INFO - PROCESS | 25340 | |i|pagename|runs| 08:18:33 INFO - PROCESS | 25340 | |0;ai-astar;103;113;109;115;114;115;117;116;113;114 08:18:33 INFO - PROCESS | 25340 | |1;audio-beat-detection;155;135;156;186;132;166;158;133;193;137 08:18:33 INFO - PROCESS | 25340 | |2;audio-dft;164;166;164;172;163;164;166;165;165;166 08:18:33 INFO - PROCESS | 25340 | |3;audio-fft;76;76;77;155;78;76;77;76;177;78 08:18:33 INFO - PROCESS | 25340 | |4;audio-oscillator;87;87;141;86;86;87;135;87;86;142 08:18:33 INFO - PROCESS | 25340 | |5;imaging-gaussian-blur;119;118;119;119;118;118;118;118;119;121 08:18:33 INFO - PROCESS | 25340 | |6;imaging-darkroom;149;149;147;150;148;151;147;148;148;147 08:18:33 INFO - PROCESS | 25340 | |7;imaging-desaturate;95;96;96;97;95;95;96;95;96;96 08:18:33 INFO - PROCESS | 25340 | |8;json-parse-financial;64;63;62;63;63;63;63;63;67;63 08:18:33 INFO - PROCESS | 25340 | |9;json-stringify-tinderbox;65;65;64;66;66;64;66;65;65;66 08:18:33 INFO - PROCESS | 25340 | |10;stanford-crypto-aes;90;82;81;86;85;84;84;84;108;84 08:18:33 INFO - PROCESS | 25340 | |11;stanford-crypto-ccm;134;133;156;145;130;147;135;137;139;137 08:18:33 INFO - PROCESS | 25340 | |12;stanford-crypto-pbkdf2;171;171;171;172;179;170;172;169;171;174 08:18:33 INFO - PROCESS | 25340 | |13;stanford-crypto-sha256-iterative;72;70;69;68;73;67;67;67;68;66 08:18:33 INFO - PROCESS | 25340 | __end_tp_report 08:18:33 INFO - PROCESS | 25340 | __start_cc_report 08:18:33 INFO - PROCESS | 25340 | _x_x_mozilla_cycle_collect,1019 08:18:33 INFO - PROCESS | 25340 | __end_cc_report 08:18:33 INFO - PROCESS | 25340 | __startTimestamp1466608713019__endTimestamp 08:18:33 INFO - PROCESS | 25340 | 08:18:33 INFO - PROCESS | 25340 | ------- Summary: start ------- 08:18:33 INFO - PROCESS | 25340 | Number of tests: 14 08:18:33 INFO - PROCESS | 25340 | 08:18:33 INFO - PROCESS | 25340 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.50 stddev:4.09 (3.6%) stddev-sans-first:2.29 08:18:33 INFO - PROCESS | 25340 | Values: 103.0 113.0 109.0 115.0 114.0 115.0 117.0 116.0 113.0 114.0 08:18:33 INFO - PROCESS | 25340 | 08:18:33 INFO - PROCESS | 25340 | [#1] audio-beat-detection Cycles:10 Average:155.10 Median:157.00 stddev:21.79 (13.9%) stddev-sans-first:23.11 08:18:33 INFO - PROCESS | 25340 | Values: 155.0 135.0 156.0 186.0 132.0 166.0 158.0 133.0 193.0 137.0 08:18:33 INFO - PROCESS | 25340 | 08:18:33 INFO - PROCESS | 25340 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.50 stddev:2.51 (1.5%) stddev-sans-first:2.60 08:18:33 INFO - PROCESS | 25340 | Values: 164.0 166.0 164.0 172.0 163.0 164.0 166.0 165.0 165.0 166.0 08:18:33 INFO - PROCESS | 25340 | 08:18:33 INFO - PROCESS | 25340 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.50 stddev:37.99 (49.7%) stddev-sans-first:39.70 08:18:33 INFO - PROCESS | 25340 | Values: 76.0 76.0 77.0 155.0 78.0 76.0 77.0 76.0 177.0 78.0 08:18:33 INFO - PROCESS | 25340 | 08:18:33 INFO - PROCESS | 25340 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:86.50 stddev:25.55 (29.5%) stddev-sans-first:26.49 08:18:33 INFO - PROCESS | 25340 | Values: 87.0 87.0 141.0 86.0 86.0 87.0 135.0 87.0 86.0 142.0 08:18:33 INFO - PROCESS | 25340 | 08:18:33 INFO - PROCESS | 25340 | [#5] imaging-gaussian-blur Cycles:10 Average:118.70 Median:119.00 stddev:0.95 (0.8%) stddev-sans-first:1.00 08:18:33 INFO - PROCESS | 25340 | Values: 119.0 118.0 119.0 119.0 118.0 118.0 118.0 118.0 119.0 121.0 08:18:33 INFO - PROCESS | 25340 | 08:18:33 INFO - PROCESS | 25340 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:1.35 (0.9%) stddev-sans-first:1.41 08:18:33 INFO - PROCESS | 25340 | Values: 149.0 149.0 147.0 150.0 148.0 151.0 147.0 148.0 148.0 147.0 08:18:33 INFO - PROCESS | 25340 | 08:18:33 INFO - PROCESS | 25340 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 08:18:33 INFO - PROCESS | 25340 | Values: 95.0 96.0 96.0 97.0 95.0 95.0 96.0 95.0 96.0 96.0 08:18:33 INFO - PROCESS | 25340 | 08:18:33 INFO - PROCESS | 25340 | [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.00 stddev:1.35 (2.1%) stddev-sans-first:1.41 08:18:33 INFO - PROCESS | 25340 | Values: 64.0 63.0 62.0 63.0 63.0 63.0 63.0 63.0 67.0 63.0 08:18:33 INFO - PROCESS | 25340 | 08:18:33 INFO - PROCESS | 25340 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.50 stddev:0.79 (1.2%) stddev-sans-first:0.83 08:18:33 INFO - PROCESS | 25340 | Values: 65.0 65.0 64.0 66.0 66.0 64.0 66.0 65.0 65.0 66.0 08:18:33 INFO - PROCESS | 25340 | 08:18:33 INFO - PROCESS | 25340 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:84.00 stddev:7.83 (9.3%) stddev-sans-first:8.22 08:18:33 INFO - PROCESS | 25340 | Values: 90.0 82.0 81.0 86.0 85.0 84.0 84.0 84.0 108.0 84.0 08:18:33 INFO - PROCESS | 25340 | 08:18:33 INFO - PROCESS | 25340 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:138.00 stddev:7.85 (5.7%) stddev-sans-first:8.08 08:18:33 INFO - PROCESS | 25340 | Values: 134.0 133.0 156.0 145.0 130.0 147.0 135.0 137.0 139.0 137.0 08:18:33 INFO - PROCESS | 25340 | 08:18:33 INFO - PROCESS | 25340 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.00 Median:171.50 stddev:2.79 (1.6%) stddev-sans-first:2.93 08:18:33 INFO - PROCESS | 25340 | Values: 171.0 171.0 171.0 172.0 179.0 170.0 172.0 169.0 171.0 174.0 08:18:33 INFO - PROCESS | 25340 | 08:18:33 INFO - PROCESS | 25340 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.50 stddev:2.31 (3.4%) stddev-sans-first:2.12 08:18:33 INFO - PROCESS | 25340 | Values: 72.0 70.0 69.0 68.0 73.0 67.0 67.0 67.0 68.0 66.0 08:18:33 INFO - PROCESS | 25340 | -------- Summary: end -------- 08:18:33 INFO - PROCESS | 25340 | 08:18:34 INFO - TEST-INFO | 25340: exit 0 08:18:34 INFO - TEST-OK | kraken | took 64668ms 08:18:34 INFO - SUITE-END | took 1181s 08:18:34 INFO - Completed test suite (00:19:41) 08:18:34 INFO - javascript benchmark 08:18:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6443.147941260486, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2674.438367942732, 2732.863356832158, 2745.986270068651, 2753.7108603596635, 2758.048473276719, 4874.293227482013, 4917.877053073675, 4932.408111026677, 5015.673981191229, 5064.13909635362, 4828.855134345967, 4899.510048995098, 4911.287863259825, 4966.776495057722, 4983.302337672729, 4450.888727781807, 4495.190865644183, 4614.653900957424, 4618.722876627413, 4627.606653434462, 524.9595598013523, 4457.33140028995, 4512.59386655201, 4523.683342166049, 4588.059447813191, 4536.591706746409, 4560.543945605446, 4578.084383123389, 4587.174308624446, 4601.44782626087, 4557.658175636808, 4582.289745089516, 4589.793459294307, 4595.8391456299205, 4623.052274283764, 4399.6040356368085, 4472.44094488189, 4475.530069342704, 4525.434320709911, 4526.932096018562, 4807.567318941312, 4863.19757240055, 4896.583790377822, 4925.876853078702, 5000.649954503187, 5210.0, 5283.709395983219, 5284.709340986245, 5335.893282134374, 5365.06111430502, 5270.710110943896, 5284.339457567804, 5286.735663216824, 5316.867078323035, 5353.277307563468, 4903.975480122613, 4922.926156107661, 4924.655274130848, 4925.876853078702, 4937.481564435754, 5341.7062061586985, 5405.378381486179, 5409.945900541023, 5435.592330575223, 5488.780448782084, 5249.186376111708, 5250.317458730341, 5264.131418316011, 5264.289320941701, 5323.787048518094, 5347.973260133752, 5356.009138309425, 5358.062339090721, 5367.1680889462195, 5409.107497262986, 5073.340465739504, 5181.715005674724, 5226.947730522646, 5244.606654500928, 5296.682199068068, 5212.921806172911, 5228.764705588182, 5252.606054545848, 5256.9737151314, 5261.210818377198, 4309.181255561433, 4312.849050283225, 4329.0, 4354.912901741947, 4386.670999675037, 3714.238581090924, 3717.2565486902727, 3717.5353080864893, 3720.497732806091, 3763.1532905096683, 4535.297028960516, 4560.087982403533, 4563.06457176278, 4578.5650363215445, 4609.815607375667, 5384.192371144281, 5407.891842163213, 5409.918851217235, 5412.052890744104, 5416.83749487516, 4464.084862603158, 4477.888052798706, 4503.842365517191, 4521.367008618796, 4530.524294948983, 4694.929576056294, 4729.0541891621815, 4732.716037037789, 4747.335373047776, 4784.569388755029, 4851.151048566416, 4918.508149185053, 4921.237208232729, 4923.08922849274, 4980.302757613937, 5311.628186027096, 5341.599380046589, 5345.9465405345445, 5348.5186333230195, 5367.194920761917, 4974.726390048582, 4990.72551009698, 4994.700317980933, 5005.074061298671, 5059.848204553869, 5109.105906466428, 5243.0, 5280.6303558750515, 5288.074586947192, 5291.76187071575, 5307.57539396855, 5356.5714742821265, 5378.784848606168, 5380.0, 5433.049216387196, 5210.817621383233, 5229.346331708536, 5229.790808367775, 5237.2929654497675, 5284.762185701576, 5059.0, 5091.338126043591, 5102.030614183293, 5200.635955483232, 5202.73986300691, 5059.87350316245, 5073.949260507347, 5082.872928176826, 5087.084324821568, 5139.820106296262, 5217.2434996925995, 5221.895562088813, 5226.372835259793, 5229.738513074407, 5249.763760630704, 4988.80044798204, 5094.108531006985, 5099.184130539096, 5128.743562821918, 5159.793608255778], "value": 4819.592641666499, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.5572984337718, 577.0421100972385, 588.4174667079592, 597.7519329478265, 618.7308520793453, 36665.0, 37427.81286093569, 39865.20269594614, 40084.398734019014, 40192.39711404331, 40525.59474405255, 40860.18279634405, 41099.178016439655, 41215.58784412155, 41284.38073428901, 7866.331361834236, 7987.121416644164, 8015.0, 8038.598070096501, 8054.718084867001, 7798.688052477894, 7889.8027549311155, 7890.526568405885, 7895.328897043758, 7924.762257132295, 7915.683372665087, 7931.920680793176, 7937.960310198441, 7940.563269020202, 7978.36173106153, 7922.920770792276, 7985.04179498461, 7992.840143197103, 8017.358611311081, 8022.598870056532, 7923.683052677886, 7936.127026027132, 7974.122846486882, 7997.120316765209, 8002.19978002201, 37982.81008594939, 38682.61317386818, 38836.0, 38909.22181556381, 38932.416013759816, 2728.249731323882, 3076.1694342527617, 3113.2839446927333, 3142.4814905540557, 3176.2059485128716, 28080.157595272176, 28167.0, 28227.57658635122, 28331.57502637462, 28812.567811482844, 3392.4741665041956, 3400.268942177444, 3426.0749597608506, 3428.879989200391, 3472.2187507810795, 224260.0, 228639.0, 229602.0, 230754.0, 232068.83965580232, 31947.361052778815, 32493.350132997206, 32729.67270327314, 32828.507572386436, 32985.67014329826, 33320.83339583335, 33579.328413432086, 33732.156696082304, 33775.66224337725, 33814.49278260828, 13539.864601354057, 13626.93186534061, 13627.0, 13629.522966696119, 13632.727345453035, 11114.610988615359, 11119.777604447865, 11141.777164456666, 11173.329600224013, 11611.0, 7786.338161256356, 7851.450398472166, 7866.921330786733, 7926.405519586054, 7947.642356093989, 3161.0832858470785, 3163.8711481516843, 3177.0468859342104, 3198.4722520784276, 3230.2085988932863, 881.1672969044191, 898.034612791252, 901.3600343755876, 927.675313640234, 1032.4321623107412, 28224.15327540136, 30468.390632187675, 32144.35711285761, 32461.513077303858, 32702.0, 948.9952550237205, 975.317277905469, 1006.3810756384917, 1032.0041160280216, 1044.8537204791335, 14382.424703011762, 15032.774508382383, 15144.772828407582, 15232.162231077396, 15308.617284567752, 422904.0, 423013.0, 425103.0, 426440.0, 427405.0, 49638.25542616864, 50029.0, 50240.24639630409, 50307.24539131916, 50320.24519632208, 1190.4166958190597, 1220.9084318676134, 1230.3417671545858, 1235.086036333125, 1312.4094157628915, 26680.733192668602, 28215.0, 28233.15300540987, 28694.282642934093, 28980.565291520223, 44149.77925110354, 44416.11167776691, 44558.3316250263, 44786.3282050763, 45271.773641131585, 360026.0, 360528.0, 360976.0, 361654.0, 361690.0, 25141.497170056864, 25162.496750065264, 25306.240812775646, 26154.0, 26428.207153785417, 42708.145837083706, 42961.14077718365, 43093.784531077144, 43193.0, 43895.0, 36677.63322366742, 36713.81643091767, 37085.814570926974, 37231.0, 37630.811845940596, 35756.66474207174, 36368.45447318239, 36825.447618286285, 36838.63161368352, 37071.8146409277, 31948.20129496781, 36457.270854583294, 36830.44754328633, 36998.63001369952, 37144.0, 32046.35907281888, 33282.66717332796, 33767.662323376455, 34061.14847128842, 34116.829415852764, 25573.23280301594, 26118.216453506426, 26161.215163545123, 26186.73813261843, 26601.0], "value": 16579.921289546393, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.1301474072781, 375.7520036775727, 379.76644363716315, 384.55199692358406, 392.3408673428639, 15804.288807003684, 16246.512604621865, 17055.658886822257, 17070.23183956722, 17083.487495375157, 15111.697766044672, 15869.206539673, 15872.920635396837, 16044.679106417894, 16208.594785130348, 4651.325557794118, 4790.137775200463, 4813.061453016663, 4813.49458306878, 4814.711117332954, 3315.6187038490643, 5183.974080129613, 5512.090505066659, 5532.723363831812, 5605.747741351649, 5525.254090697765, 5553.416891226424, 5557.777688892439, 5576.079946808792, 5597.356304025028, 5912.881742365172, 6092.11664308675, 6092.695365231765, 6124.0813877918445, 6135.938640613604, 4529.116822219668, 4891.6820406673805, 5422.322209723785, 5423.755930983115, 5440.564754819605, 12052.156349055569, 12245.816312755316, 12565.748685026248, 12569.497220111185, 12613.684657883627, 1696.180873211714, 1863.6924907390264, 2002.4693456233963, 2173.206779525462, 2181.5636872625537, 9228.0, 9445.386049906803, 9541.809163816753, 9671.613135474572, 9916.0, 1648.9917550412292, 1656.097426902341, 1665.883388162829, 1668.9499315020448, 1709.6324290277526, 67896.6605166976, 69416.3058369415, 71544.0, 71790.0, 72350.0, 10156.593736250466, 10177.796444071077, 10333.121684656888, 10754.731131721614, 11104.222704410613, 13927.23400212998, 14042.0, 14115.576532704035, 14166.433342666178, 14233.43066277358, 7245.0, 7410.0, 7423.294786995227, 7492.475526713078, 7525.661345239478, 7011.754588589375, 7038.612876291853, 7166.534175278694, 7231.132264128233, 7249.456290778213, 4296.4414626098405, 4337.696361254745, 4359.498657654347, 4435.6673249505775, 4590.862274131781, 1720.8451239388264, 1744.8973986346423, 1861.5811442425618, 1863.1988245054756, 1876.9249230030646, 800.9078955920144, 833.358314098141, 853.4836423963537, 860.2902605350611, 888.4092078767676, 16479.17604119813, 16688.6662266754, 16856.57858553546, 17222.655546888993, 17521.474355769347, 834.845553572591, 854.43607219235, 863.3697400897255, 896.4979611417497, 953.7806304549854, 9157.0, 9504.524773761284, 9670.129688328085, 9685.031496850259, 9766.36518626287, 356276.0, 359296.0, 379533.0, 387591.0, 394517.0, 69303.30696692968, 75267.24732752712, 75658.0, 76833.0114240364, 80064.19935800567, 869.7058982140064, 880.933929955256, 895.4940458640978, 896.2202883491404, 906.3655441191192, 15046.172460514339, 15289.6177595561, 15578.0, 15629.14039727826, 15680.451184208498, 35616.28767424689, 35869.64130358663, 36689.44965825461, 36729.0, 37692.05769855776, 50979.74510127425, 51376.229356558935, 51586.74206628943, 51792.74103629609, 51836.0, 7838.529688218725, 7848.254415830487, 7901.604919754104, 7934.841303174019, 7965.0, 11472.426378680866, 11710.0, 11764.000059994996, 11894.107941904218, 12019.879801201876, 10048.748781280527, 10071.949640251752, 10118.443485608363, 10342.948285258526, 10577.9471102644, 10378.377297362182, 10434.843477347998, 10528.315659482108, 10631.94684026575, 10715.946420267848, 10265.897341026493, 10291.794164116825, 10475.895241047492, 10480.213983951387, 10536.104431123134, 6409.583377080475, 6717.9328206719265, 7731.110922244014, 7868.0, 7998.720044798404, 9475.0, 10437.373757574569, 10566.0, 10680.786384272427, 10710.946445268035], "value": 8103.622993714061, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1388.9583312500622, 1407.2769191614227, 1494.760838265877, 1666.566692659908, 1694.949151525454, 6902.344277293661, 7613.276738709814, 8019.959900200498, 8401.957990210049, 8408.915910840897, 7756.96121519393, 7988.121306656263, 8018.398620103487, 8032.678692852279, 8068.233517815798, 2238.697775800262, 2260.446190683285, 2277.2598905355744, 2277.7152855893014, 2280.2817112609473, 2235.1506427557506, 2247.5954328220914, 2270.330252575486, 2271.522980174157, 2276.829237807163, 2222.2666520048347, 2224.4550085229143, 2229.7435794883554, 2232.944176395595, 2237.7538470768204, 2194.3416974907545, 2201.416624594484, 2202.702635144251, 2211.1155537784853, 2212.889355532217, 2186.7813218678166, 2206.5145667953025, 2208.624533829237, 2214.878181700022, 2221.944451388712, 7905.169957154473, 8041.6381262843315, 8052.838943221162, 8081.151479094669, 8108.310793582553, 4773.904521909577, 4922.852314430573, 4930.605551555867, 4938.0, 4941.50584941503, 2966.7478264347556, 3097.6127984002, 3138.074268090919, 3143.779935404523, 3163.3040731039137, 957.8850537935423, 978.33473238198, 990.8612794208816, 993.6323560282742, 994.2791476179784, 11052.281601695944, 11150.944245278803, 11262.943685281603, 11266.774664506664, 11280.097592192606, 4373.0, 4494.235979883428, 4531.77341132942, 4590.563896429834, 4608.470025947059, 9451.0, 9523.523823808782, 9523.666671666459, 9532.571034303335, 9589.328746987783, 4946.480619534897, 4981.0, 4998.2002879539095, 5014.774335154927, 5024.296598476216, 3736.439534069857, 4239.745615263094, 4367.956320436819, 4398.472183337956, 4404.185225733249, 3736.906577335534, 3777.506845481969, 3867.690584753213, 3887.9611203888167, 3997.1605962747567, 1233.2785320587557, 1244.4213440750095, 1259.2444533279959, 1259.924404535731, 1264.9241045537112, 803.7950322667682, 825.6573521988428, 830.0409041766085, 830.3274347778319, 833.7998880268692, 5037.244413338029, 5067.5185857343495, 5076.340075790124, 5112.795488180505, 5144.0, 426.10305307328247, 430.1246962431437, 432.42487491636047, 435.8561674647359, 441.6819889679426, 3393.389189945784, 3403.8127902965575, 3423.7089847362754, 3464.2378676691087, 3497.1082373994977, 9745.951270243604, 10034.046765557261, 10038.347507411994, 10144.036316549917, 10144.188464922789, 9770.0, 9994.400335979864, 10007.199424046059, 10016.54925528353, 10033.097021267975, 7492.138404083491, 7514.173440921603, 7566.848663026819, 7633.770986870402, 7659.617019149132, 5110.3356563646485, 5247.65916668331, 5256.553192978487, 5388.54197393226, 5405.324334458192, 9089.681861134828, 9111.544422778701, 9121.726348209564, 9170.220531254918, 9315.767105822408, 9188.95405522968, 9312.44125352481, 9334.346595738505, 9346.299027573095, 9380.733600963782, 6097.603655762361, 6759.357861003196, 6972.616506092214, 7003.719851206099, 7087.539309944837, 7767.3786097113225, 7778.6888524460655, 7782.0, 7805.102413222325, 7877.212278772077, 6931.7227310907, 7189.5686258824635, 7211.134663840373, 7233.674484648309, 7347.19180890091, 6960.47796415281, 6998.370146686822, 6999.6850141742725, 7106.543158652567, 7171.4621403395995, 5944.5838791284195, 6081.027035674271, 6100.633961962297, 6120.08198770188, 6145.938540614537, 4370.431843860278, 4402.229609818205, 4443.377927090274, 4557.339185818104, 4576.725396476222, 4554.2485489895125, 4588.013577080944, 4605.539446055368, 4659.790309436015, 4669.7898594564], "value": 4177.963139663221, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.92331993681637, 302.4631279478925, 309.7599360495616, 312.03736472980853, 320.42003972809204, 5009.223570346602, 5069.619778516612, 5108.69347839129, 5236.2407450919645, 5277.920831187531, 5136.229565565167, 5144.17693169093, 5173.560247378978, 5185.144451165553, 5226.973865130679, 3983.382575700771, 3997.180577981514, 3997.800109994503, 4016.3975403689533, 4027.2750904837117, 3896.47397601323, 3963.0, 3988.6410223079915, 4018.3168861293652, 4034.253663072326, 3927.0, 3929.489166408363, 3930.1353702185475, 3930.6219737059096, 3955.5846636103083, 3931.331673615478, 3944.9211015779524, 3947.3881548359764, 3966.8809935701975, 3984.9639093835813, 3426.6059403168706, 3435.9828200859088, 3447.5862896452336, 3464.064702530303, 3487.232808782064, 4890.657653964224, 5060.228919878014, 5065.341505604285, 5073.1122053640465, 5078.390593128811, 4514.864554063383, 4553.0, 4565.288016993627, 4567.246404343279, 4578.9542104579195, 5395.730213489349, 5420.430854760233, 5430.15832545956, 5438.374586922476, 5451.700156491392, 3727.422249551324, 3755.286495565834, 3776.4320262221677, 3790.2040571480024, 3843.1160833008566, 5630.8029218977135, 5658.43415658435, 5681.630694004876, 5685.744141513642, 5743.138529220567, 3869.187470631199, 3871.554771201348, 3895.337792575269, 3899.454076429302, 3951.8419263229725, 3872.6514613684903, 3946.546147193052, 3985.4818873546255, 3990.7030215180184, 4009.51885773709, 4533.7279763213655, 4542.364069030338, 4545.181867263925, 4546.136234115574, 4571.222892108283, 5411.891762164734, 5417.702026388586, 5436.70098144598, 5449.918251226235, 5504.137848318932, 1315.5066849931275, 1348.8786009259213, 1375.848656647768, 1377.1805775563523, 1378.8690074442911, 898.4770813471104, 904.2043002158059, 909.704346087511, 932.9626814927327, 933.4492649336923, 4186.6859985501205, 4221.176870510282, 4223.606209950709, 4233.661307095425, 4234.449521562239, 4842.322074909515, 4875.317455556225, 4886.3403440535785, 4924.089043526959, 4941.604671626261, 4163.3130533462245, 4197.0, 4216.177845320133, 4222.59885310895, 4224.704270701021, 2480.822428439705, 2639.2214296782495, 2659.880305386262, 2667.7594918363056, 2689.354554906808, 4592.977035114803, 4653.488116307203, 4684.446976397871, 4709.858704238878, 4718.9292160617615, 4970.229614409773, 5013.222950442687, 5016.369679854062, 5026.84919452417, 5033.47148549397, 4834.444038935497, 5192.701824543864, 5199.584033277329, 5218.3737951444555, 5225.059489291964, 5523.861903452445, 5632.915506267327, 5692.914606280826, 5698.489900176373, 5717.22817419643, 5304.602154838325, 5518.392976772471, 5529.612927095226, 5557.833265002057, 5576.442355764391, 5164.8565845175335, 5216.895662086813, 5233.142234506695, 5248.868778280574, 5278.445763194963, 3785.2051069275763, 3813.790241536631, 3832.1760821423527, 3852.2680690668685, 3857.40210267409, 5396.946030539644, 5628.521575666115, 5655.519280861173, 5664.527222921987, 5668.0, 5398.165962869525, 5404.486573775485, 5405.405405405324, 5425.104857698436, 5466.316710411199, 5433.592480563894, 5466.0, 5473.768402109494, 5478.506934375925, 5500.972495137658, 5094.7707353169935, 5316.122839731555, 5325.680459172462, 5340.359156901197, 5374.623776335619, 5465.426130256425, 5470.398256191896, 5518.91721624184, 5520.503154716095, 5531.28966806254, 5208.244804503402, 5399.514043735925, 5416.674999500043, 5419.620626556103, 5441.204402547229], "value": 3980.6119953103075, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.8182581615876, 710.2435905760365, 711.9964400178, 721.6355740351122, 779.7154038775847, 12148.939255303721, 12958.611241662742, 13038.348082595856, 13054.2820144892, 13073.954083673307, 13063.216207027584, 13292.667683307922, 13327.866721332784, 13329.533466328681, 13347.132436391628, 626.6960524145786, 759.3090287838069, 772.2624893226969, 781.4295564238109, 789.4000559574736, 772.2779201446638, 775.7362496751103, 777.0791611939869, 782.886481460188, 784.9803754906116, 823.3577809308749, 823.390690888744, 825.0800357601291, 825.7027470110755, 827.5365795154732, 815.6248125862052, 820.1347578304886, 823.4194892600702, 823.7734622978669, 826.243986752121, 593.0955293177896, 595.074658905402, 598.3597550620838, 602.9457348838625, 603.4478452216217, 11372.545098196062, 11383.601573944872, 11407.144464165138, 11414.086873050135, 11422.543098276059, 13323.0, 13467.0, 13606.523771667944, 13823.377947992263, 13850.376733047036, 10749.247552671317, 10921.890781092166, 10927.235093543455, 11053.668389948314, 11086.334819910831, 3309.5697559317136, 3365.074604483762, 3377.5440315557576, 3455.740819438527, 3460.9480857787153, 59490.702546487424, 59532.10701839432, 62301.68849155725, 62337.0, 63314.683426582575, 9907.851382229272, 10158.0, 10282.07461328469, 10490.842637360445, 10493.790124197625, 18194.090295485174, 18485.353012644493, 18680.159392827354, 18693.345732899284, 18735.812641873406, 6941.895871561931, 6952.895706564405, 6963.860722785617, 7096.148462184571, 7242.130944286614, 3928.0965377962657, 3952.7825969571372, 3983.1237127831832, 4014.3175660137263, 4069.674426045909, 2984.0749367696085, 3052.252198211452, 3056.862441190152, 3071.0326247232497, 3080.122165182912, 494.44622023334097, 514.5754752329343, 541.5207541325955, 551.3824516541499, 551.4210079416597, 488.32610996824155, 597.2892258212713, 641.9614823110628, 644.5359341274275, 652.8302641313293, 8075.7482590198615, 8146.144654811278, 8190.631421586043, 8237.232289950614, 8360.163983601591, 469.34291991211893, 601.3373023589778, 611.7797592866565, 632.4529282170889, 650.4731167754135, 3930.9606903931167, 3933.862314819025, 3949.624785645359, 3960.881173564798, 4027.7583344999393, 57140.428595714344, 97000.51499742597, 98276.0, 99075.50462247642, 100556.0, 84934.5753271242, 87837.12162878417, 88082.55958720166, 88319.0, 88612.0, 76897.231027689, 78415.0, 79442.60278698686, 79924.20075799283, 81305.0, 7661.15727270011, 7673.501222420525, 7682.347000504796, 7730.381569474316, 7780.572068536285, 46205.306920395546, 46214.0, 46302.0, 46943.29585056158, 47998.520014799404, 39350.80324598473, 53845.461545384045, 58976.41023589709, 65418.0, 65840.6707966457, 11625.12811539121, 11644.53421863116, 11869.881301187223, 11983.580574679845, 12082.758344832879, 13548.79676804829, 13695.109817861807, 13768.24274664863, 14315.212663303619, 14716.337764800395, 12061.638150855488, 12246.816297755719, 12304.630861074182, 12694.619161425171, 12740.426680799572, 12273.202241854251, 12444.128910976146, 12968.092233543939, 13132.671683207614, 13315.667108321983, 11213.159013074215, 11318.886811131782, 11469.139814513777, 11980.400979951142, 13141.934290328487, 9774.75563110928, 9830.606775728891, 10066.295359324777, 10099.343542669703, 10210.540525676213, 9245.399049061789, 9457.148856602938, 9735.123838854537, 9760.46317452547, 9894.554745036347], "value": 6642.908271258197, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1588.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 109.0, 115.0, 114.0, 115.0, 117.0, 116.0, 113.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 135.0, 156.0, 186.0, 132.0, 166.0, 158.0, 133.0, 193.0, 137.0], "value": 155.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 164.0, 172.0, 163.0, 164.0, 166.0, 165.0, 165.0, 166.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 155.0, 78.0, 76.0, 77.0, 76.0, 177.0, 78.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 141.0, 86.0, 86.0, 87.0, 135.0, 87.0, 86.0, 142.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 119.0, 119.0, 118.0, 118.0, 118.0, 118.0, 119.0, 121.0], "value": 118.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 147.0, 150.0, 148.0, 151.0, 147.0, 148.0, 148.0, 147.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 97.0, 95.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 67.0, 63.0], "value": 63.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 66.0, 66.0, 64.0, 66.0, 65.0, 65.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 82.0, 81.0, 86.0, 85.0, 84.0, 84.0, 84.0, 108.0, 84.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 156.0, 145.0, 130.0, 147.0, 135.0, 137.0, 139.0, 137.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 171.0, 172.0, 179.0, 170.0, 172.0, 169.0, 171.0, 174.0], "value": 172.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 69.0, 68.0, 73.0, 67.0, 67.0, 67.0, 68.0, 66.0], "value": 68.7, "unit": "score"}]}]} 08:18:34 INFO - Return code: 0 08:18:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:18:34 ERROR - # TBPL SUCCESS # 08:18:34 INFO - Running post-action listener: _resource_record_post_action 08:18:34 INFO - ##### 08:18:34 INFO - ##### Finished run-tests step (success) 08:18:34 INFO - ##### 08:18:34 INFO - Running post-run listener: _resource_record_post_run 08:18:34 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 304439296; Read time: 164; Write time: 206372 08:18:34 INFO - TinderboxPrint: CPU usage
13.5% 08:18:34 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 164 08:18:34 INFO - TinderboxPrint: I/O write bytes / time
304,439,296 / 206,372 08:18:34 INFO - TinderboxPrint: CPU idle
8,273.1 (86.5%) 08:18:34 INFO - TinderboxPrint: CPU user
1,237.2 (12.9%) 08:18:34 INFO - TinderboxPrint: Swap in / out
0 / 0 08:18:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 14241792; Read time: 0; Write time: 1968 08:18:34 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 290197504; Read time: 164; Write time: 204404 08:18:34 INFO - Running post-run listener: _upload_blobber_files 08:18:34 INFO - Blob upload gear active. 08:18:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:18:34 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 08:18:34 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:18:34 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:18:35 INFO - (blobuploader) - INFO - Open directory for files ... 08:18:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:18:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:18:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:18:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:18:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:18:36 INFO - (blobuploader) - INFO - Done attempting. 08:18:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:18:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:18:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:18:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:18:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:18:40 INFO - (blobuploader) - INFO - Done attempting. 08:18:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:18:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:18:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:18:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:18:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:18:40 INFO - (blobuploader) - INFO - Done attempting. 08:18:40 INFO - (blobuploader) - INFO - Iteration through files over. 08:18:40 INFO - Return code: 0 08:18:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:18:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:18:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c31ed636d7188872af81b7ec2504a52e02241660e146e8a833a2b2b752247ff22c91c383c56ec78c20d72fc9d25724f28d394e034b270f5f2ae5a46c21a222aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b749df276581cf466588c115450f0fd8893eef8ab1d17e4b7d5430dfed71b24950208107b2eaf23d2f9d0f943a35d78ff7f44610b5d0bfe294d65e2a3732096", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72786e30fc45c5d2b840d2a9e18feac38655c974ecadb0d8000daca857a94f89b81bff9c88e5ba36a9f74f94f0e5e721ff8d90749ad3a1a469e8ff64a8bd64eb"} 08:18:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:18:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:18:40 INFO - Contents: 08:18:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c31ed636d7188872af81b7ec2504a52e02241660e146e8a833a2b2b752247ff22c91c383c56ec78c20d72fc9d25724f28d394e034b270f5f2ae5a46c21a222aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b749df276581cf466588c115450f0fd8893eef8ab1d17e4b7d5430dfed71b24950208107b2eaf23d2f9d0f943a35d78ff7f44610b5d0bfe294d65e2a3732096", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72786e30fc45c5d2b840d2a9e18feac38655c974ecadb0d8000daca857a94f89b81bff9c88e5ba36a9f74f94f0e5e721ff8d90749ad3a1a469e8ff64a8bd64eb"} 08:18:40 INFO - Running post-run listener: copy_logs_to_upload_dir 08:18:40 INFO - Copying logs to upload dir... 08:18:40 INFO - mkdir: /builds/slave/test/build/upload/logs 08:18:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1334.010555 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2016-06-22 08:18:40.627661) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 08:18:40.631138) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354 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/Firefox-Non-PGO/sha512/c31ed636d7188872af81b7ec2504a52e02241660e146e8a833a2b2b752247ff22c91c383c56ec78c20d72fc9d25724f28d394e034b270f5f2ae5a46c21a222aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b749df276581cf466588c115450f0fd8893eef8ab1d17e4b7d5430dfed71b24950208107b2eaf23d2f9d0f943a35d78ff7f44610b5d0bfe294d65e2a3732096", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72786e30fc45c5d2b840d2a9e18feac38655c974ecadb0d8000daca857a94f89b81bff9c88e5ba36a9f74f94f0e5e721ff8d90749ad3a1a469e8ff64a8bd64eb"} build_url:https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011385 build_url: 'https://queue.taskcluster.net/v1/task/ZUWBZ5PyTNu82csJ2TDMrQ/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/Firefox-Non-PGO/sha512/c31ed636d7188872af81b7ec2504a52e02241660e146e8a833a2b2b752247ff22c91c383c56ec78c20d72fc9d25724f28d394e034b270f5f2ae5a46c21a222aa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2b749df276581cf466588c115450f0fd8893eef8ab1d17e4b7d5430dfed71b24950208107b2eaf23d2f9d0f943a35d78ff7f44610b5d0bfe294d65e2a3732096", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72786e30fc45c5d2b840d2a9e18feac38655c974ecadb0d8000daca857a94f89b81bff9c88e5ba36a9f74f94f0e5e721ff8d90749ad3a1a469e8ff64a8bd64eb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-22 08:18:40.657594) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 08:18:40.658045) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466606157.94407-411891354 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-22 08:18:40.746357) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 08:18:40.746772) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-22 08:18:40.747102) ========= ========= Total master_lag: 0.18 =========