builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-019 starttime: 1465318565.72 results: success (0) buildid: 20160607070918 builduid: 3dedf474d03f422cb049d1195ace538d revision: 448365b11e377ebf1c572d54e45bbd36c45af03a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 09:56:05.725326) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 09:56:05.726347) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 09:56:05.727014) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 09:56:05.746723) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 09:56:05.747409) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 09:56:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.2M=0s 2016-06-07 09:56:06 (42.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.346934 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 09:56:06.112016) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 09:56:06.112418) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014795 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 09:56:06.162786) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 09:56:06.163271) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 448365b11e377ebf1c572d54e45bbd36c45af03a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 448365b11e377ebf1c572d54e45bbd36c45af03a --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=78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 09:56:06,460 truncating revision to first 12 chars 2016-06-07 09:56:06,460 Setting DEBUG logging. 2016-06-07 09:56:06,460 attempt 1/10 2016-06-07 09:56:06,460 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/448365b11e37?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 09:56:07,707 unpacking tar archive at: mozilla-inbound-448365b11e37/testing/mozharness/ program finished with exit code 0 elapsedTime=1.564953 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 09:56:07.741896) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 09:56:07.742227) ========= script_repo_revision: 448365b11e377ebf1c572d54e45bbd36c45af03a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 09:56:07.742674) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 09:56:07.742992) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 09:56:07.759547) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-07 09:56:07.759850) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:56:08 INFO - MultiFileLogger online at 20160607 09:56:08 in /builds/slave/test 09:56:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:56:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:56:08 INFO - {'append_to_log': False, 09:56:08 INFO - 'base_work_dir': '/builds/slave/test', 09:56:08 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:56:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:56:08 INFO - 'branch': 'Mozilla-Inbound', 09:56:08 INFO - 'buildbot_json_path': 'buildprops.json', 09:56:08 INFO - 'config_files': ('talos/linux_config.py',), 09:56:08 INFO - 'default_actions': ('clobber', 09:56:08 INFO - 'read-buildbot-config', 09:56:08 INFO - 'download-and-extract', 09:56:08 INFO - 'populate-webroot', 09:56:08 INFO - 'create-virtualenv', 09:56:08 INFO - 'install', 09:56:08 INFO - 'run-tests'), 09:56:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:56:08 INFO - 'download_minidump_stackwalk': True, 09:56:08 INFO - 'download_symbols': 'ondemand', 09:56:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:56:08 INFO - 'tooltool.py': '/tools/tooltool.py', 09:56:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:56:08 INFO - '/tools/misc-python/virtualenv.py')}, 09:56:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:56:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:56:08 INFO - 'installer_path': 'installer.exe', 09:56:08 INFO - 'log_level': 'info', 09:56:08 INFO - 'log_name': 'talos', 09:56:08 INFO - 'log_to_console': True, 09:56:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:56:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:56:08 INFO - 'opt_config_files': (), 09:56:08 INFO - 'pip_index': False, 09:56:08 INFO - 'sps_profile': False, 09:56:08 INFO - 'sps_profile_interval': 0, 09:56:08 INFO - 'suite': 'dromaeojs-e10s', 09:56:08 INFO - 'system_bits': '32', 09:56:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:56:08 INFO - 'title': 'talos-linux64-ix-019', 09:56:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:56:08 INFO - 'use_talos_json': True, 09:56:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:56:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:56:08 INFO - 'work_dir': 'build'} 09:56:08 INFO - ##### 09:56:08 INFO - ##### Running clobber step. 09:56:08 INFO - ##### 09:56:08 INFO - Running pre-action listener: _resource_record_pre_action 09:56:08 INFO - Running main action method: clobber 09:56:08 INFO - rmtree: /builds/slave/test/build 09:56:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:56:09 INFO - Running post-action listener: _resource_record_post_action 09:56:09 INFO - ##### 09:56:09 INFO - ##### Finished clobber step (success) 09:56:09 INFO - ##### 09:56:09 INFO - ##### 09:56:09 INFO - ##### Running read-buildbot-config step. 09:56:09 INFO - ##### 09:56:09 INFO - Running pre-action listener: _resource_record_pre_action 09:56:09 INFO - Running main action method: read_buildbot_config 09:56:09 INFO - Using buildbot properties: 09:56:09 INFO - { 09:56:09 INFO - "project": "", 09:56:09 INFO - "product": "firefox", 09:56:09 INFO - "script_repo_revision": "production", 09:56:09 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 09:56:09 INFO - "repository": "", 09:56:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 09:56:09 INFO - "buildid": "20160607070918", 09:56:09 INFO - "pgo_build": "True", 09:56:09 INFO - "basedir": "/builds/slave/test", 09:56:09 INFO - "buildnumber": 823, 09:56:09 INFO - "slavename": "talos-linux64-ix-019", 09:56:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:56:09 INFO - "platform": "ubuntu64_hw", 09:56:09 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:56:09 INFO - "branch": "mozilla-inbound", 09:56:09 INFO - "repo_path": "integration/mozilla-inbound", 09:56:09 INFO - "revision": "448365b11e377ebf1c572d54e45bbd36c45af03a", 09:56:09 INFO - "stage_platform": "linux64-pgo", 09:56:09 INFO - "builduid": "3dedf474d03f422cb049d1195ace538d", 09:56:09 INFO - "slavebuilddir": "test" 09:56:09 INFO - } 09:56:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:56:09 INFO - Running post-action listener: _resource_record_post_action 09:56:09 INFO - ##### 09:56:09 INFO - ##### Finished read-buildbot-config step (success) 09:56:09 INFO - ##### 09:56:09 INFO - ##### 09:56:09 INFO - ##### Running download-and-extract step. 09:56:09 INFO - ##### 09:56:09 INFO - Running pre-action listener: _resource_record_pre_action 09:56:09 INFO - Running main action method: download_and_extract 09:56:09 INFO - mkdir: /builds/slave/test/build/tests 09:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:09 INFO - https://queue.taskcluster.net/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:56:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:56:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:56:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZFqHKwhQfGpALr822c2MA/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 09:56:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZFqHKwhQfGpALr822c2MA/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 09:56:12 INFO - Downloaded 1361 bytes. 09:56:12 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:56:12 INFO - Using the following test package requirements: 09:56:12 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:56:12 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:56:12 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:56:12 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:12 INFO - u'jsshell-linux-x86_64.zip'], 09:56:12 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:56:12 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:56:12 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:56:12 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:56:12 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:56:12 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:12 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:56:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:56: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')]} 09:56:12 INFO - https://queue.taskcluster.net/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:56:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:56:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:56:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZFqHKwhQfGpALr822c2MA/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 09:56:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZFqHKwhQfGpALr822c2MA/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 09:56:17 INFO - Downloaded 24440614 bytes. 09:56:17 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'] 09:56:17 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 09:56:18 INFO - Return code: 0 09:56:18 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 09:56: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')]} 09:56:18 INFO - https://queue.taskcluster.net/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:56:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:56:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:56:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZFqHKwhQfGpALr822c2MA/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 09:56:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZFqHKwhQfGpALr822c2MA/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 09:56:20 INFO - Downloaded 24440614 bytes. 09:56:20 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'] 09:56:20 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 09:56:22 INFO - Return code: 0 09:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:22 INFO - https://queue.taskcluster.net/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:56:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:56:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:56:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZFqHKwhQfGpALr822c2MA/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 09:56:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZFqHKwhQfGpALr822c2MA/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 09:56:23 INFO - Downloaded 10833369 bytes. 09:56:23 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'] 09:56:23 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 09:56:23 INFO - Return code: 0 09:56:23 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')]} 09:56:23 INFO - https://queue.taskcluster.net/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:56:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:56:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:56:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZFqHKwhQfGpALr822c2MA/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 09:56:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GZFqHKwhQfGpALr822c2MA/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 09:56:25 INFO - Downloaded 59177516 bytes. 09:56:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:56:25 INFO - mkdir: /builds/slave/test/properties 09:56:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:56:25 INFO - Writing to file /builds/slave/test/properties/build_url 09:56:25 INFO - Contents: 09:56:25 INFO - build_url:https://queue.taskcluster.net/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:56:26 INFO - Running post-action listener: _resource_record_post_action 09:56:26 INFO - Running post-action listener: set_extra_try_arguments 09:56:26 INFO - ##### 09:56:26 INFO - ##### Finished download-and-extract step (success) 09:56:26 INFO - ##### 09:56:26 INFO - ##### 09:56:26 INFO - ##### Running populate-webroot step. 09:56:26 INFO - ##### 09:56:26 INFO - Running pre-action listener: _resource_record_pre_action 09:56:26 INFO - Running main action method: populate_webroot 09:56:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:56:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:56:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:56:26 INFO - '--tppagecycles', 09:56:26 INFO - '7'], 09:56:26 INFO - 'tests': ['tsvgm']}}, 09:56:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:56:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:56:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:56:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:56:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:56:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:56:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:26 INFO - 'talos_options': ['--disable-e10s'], 09:56:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:56:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:26 INFO - 'talos_options': ['--disable-e10s'], 09:56:26 INFO - 'tests': ['damp', 'tps']}, 09:56:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:26 INFO - 'tests': ['damp', 'tps']}, 09:56:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:56:26 INFO - 'tests': ['dromaeo_dom']}, 09:56:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:56:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:56:26 INFO - 'tests': ['a11yr', 09:56:26 INFO - 'ts_paint', 09:56:26 INFO - 'tpaint', 09:56:26 INFO - 'sessionrestore', 09:56:26 INFO - 'sessionrestore_no_auto_restore', 09:56:26 INFO - 'tabpaint']}, 09:56:26 INFO - 'other-e10s': {'tests': ['a11yr', 09:56:26 INFO - 'ts_paint', 09:56:26 INFO - 'tpaint', 09:56:26 INFO - 'sessionrestore', 09:56:26 INFO - 'sessionrestore_no_auto_restore', 09:56:26 INFO - 'tabpaint']}, 09:56:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:56:26 INFO - 'ts_paint', 09:56:26 INFO - 'tpaint', 09:56:26 INFO - 'sessionrestore', 09:56:26 INFO - 'sessionrestore_no_auto_restore', 09:56:26 INFO - 'tabpaint']}, 09:56:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:56:26 INFO - 'ts_paint', 09:56:26 INFO - 'tpaint', 09:56:26 INFO - 'sessionrestore', 09:56:26 INFO - 'sessionrestore_no_auto_restore', 09:56:26 INFO - 'tabpaint']}, 09:56:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:56:26 INFO - 'tests': ['a11yr', 09:56:26 INFO - 'ts_paint', 09:56:26 INFO - 'tpaint', 09:56:26 INFO - 'sessionrestore', 09:56:26 INFO - 'sessionrestore_no_auto_restore', 09:56:26 INFO - 'tabpaint']}, 09:56:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:56:26 INFO - 'tests': ['a11yr', 09:56:26 INFO - 'ts_paint', 09:56:26 INFO - 'tpaint', 09:56:26 INFO - 'sessionrestore', 09:56:26 INFO - 'sessionrestore_no_auto_restore', 09:56:26 INFO - 'tabpaint']}, 09:56:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:56:26 INFO - 'tests': ['tsvgx', 09:56:26 INFO - 'tsvgr_opacity', 09:56:26 INFO - 'tart', 09:56:26 INFO - 'tscrollx', 09:56:26 INFO - 'cart']}, 09:56:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:56:26 INFO - 'tsvgr_opacity', 09:56:26 INFO - 'tart', 09:56:26 INFO - 'tscrollx', 09:56:26 INFO - 'cart']}, 09:56:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:26 INFO - 'talos_options': ['--disable-e10s'], 09:56:26 INFO - 'tests': ['tp5o']}, 09:56:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:26 INFO - 'tests': ['tp5o']}, 09:56:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:26 INFO - 'talos_options': ['--disable-e10s', 09:56:26 INFO - '--xperf_path', 09:56:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:26 INFO - 'tests': ['tp5n']}, 09:56:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:56:26 INFO - 'talos_options': ['--xperf_path', 09:56:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:56:26 INFO - 'tests': ['tp5n']}}, 09:56:26 INFO - 'talos.zip': {'path': '', 09:56:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:56:26 INFO - Running post-action listener: _resource_record_post_action 09:56:26 INFO - ##### 09:56:26 INFO - ##### Finished populate-webroot step (success) 09:56:26 INFO - ##### 09:56:26 INFO - ##### 09:56:26 INFO - ##### Running create-virtualenv step. 09:56:26 INFO - ##### 09:56:26 INFO - Running pre-action listener: _resource_record_pre_action 09:56:26 INFO - Running main action method: create_virtualenv 09:56:26 INFO - Creating virtualenv /builds/slave/test/build/venv 09:56:26 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 09:56:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:56:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:56:26 INFO - Using real prefix '/usr' 09:56:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:56:26 INFO - Installing distribute.............................................................................................................................................................................................done. 09:56:28 INFO - Installing pip.................done. 09:56:28 INFO - Return code: 0 09:56:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:28 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 0x7f2d7b85cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd17350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', '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 09:56:28 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 09:56:28 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 09:56:28 INFO - Using env: {'DISPLAY': ':0', 09:56:28 INFO - 'HOME': '/home/cltbld', 09:56:28 INFO - 'LANG': 'en_US.UTF-8', 09:56:28 INFO - 'LANGUAGE': 'en_US:en', 09:56:28 INFO - 'LOGNAME': 'cltbld', 09:56:28 INFO - 'MAIL': '/var/mail/cltbld', 09:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:28 INFO - 'MOZ_NO_REMOTE': '1', 09:56:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:28 INFO - 'NO_EM_RESTART': '1', 09:56:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:28 INFO - 'PWD': '/builds/slave/test', 09:56:28 INFO - 'SHELL': '/bin/bash', 09:56:28 INFO - 'SHLVL': '1', 09:56:28 INFO - 'TERM': 'linux', 09:56:28 INFO - 'TMOUT': '86400', 09:56:28 INFO - 'USER': 'cltbld', 09:56:28 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', 09:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:28 INFO - '_': '/tools/buildbot/bin/python'} 09:56:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:28 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 09:56:28 INFO - Cleaning up... 09:56:28 INFO - Return code: 0 09:56:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:28 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 0x7f2d7b85cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd17350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', '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 09:56:28 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 09:56:28 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 09:56:28 INFO - Using env: {'DISPLAY': ':0', 09:56:28 INFO - 'HOME': '/home/cltbld', 09:56:28 INFO - 'LANG': 'en_US.UTF-8', 09:56:28 INFO - 'LANGUAGE': 'en_US:en', 09:56:28 INFO - 'LOGNAME': 'cltbld', 09:56:28 INFO - 'MAIL': '/var/mail/cltbld', 09:56:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:28 INFO - 'MOZ_NO_REMOTE': '1', 09:56:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:28 INFO - 'NO_EM_RESTART': '1', 09:56:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:28 INFO - 'PWD': '/builds/slave/test', 09:56:28 INFO - 'SHELL': '/bin/bash', 09:56:28 INFO - 'SHLVL': '1', 09:56:28 INFO - 'TERM': 'linux', 09:56:28 INFO - 'TMOUT': '86400', 09:56:28 INFO - 'USER': 'cltbld', 09:56:28 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', 09:56:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:28 INFO - '_': '/tools/buildbot/bin/python'} 09:56:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:29 INFO - Downloading/unpacking psutil>=3.1.1 09:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:56:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:31 INFO - Installing collected packages: psutil 09:56:31 INFO - Running setup.py install for psutil 09:56:31 INFO - building 'psutil._psutil_linux' extension 09:56:31 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 09:56:31 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 09:56:31 INFO - building 'psutil._psutil_posix' extension 09:56:31 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 09:56:31 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 09:56:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:56:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:56:31 INFO - Successfully installed psutil 09:56:31 INFO - Cleaning up... 09:56:31 INFO - Return code: 0 09:56:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:56: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')]} 09:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56: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')]} 09:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2d7b85cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd17350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', '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 09:56: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:56: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 mozsystemmonitor==0.3 09:56:31 INFO - Using env: {'DISPLAY': ':0', 09:56:31 INFO - 'HOME': '/home/cltbld', 09:56:31 INFO - 'LANG': 'en_US.UTF-8', 09:56:31 INFO - 'LANGUAGE': 'en_US:en', 09:56:31 INFO - 'LOGNAME': 'cltbld', 09:56:31 INFO - 'MAIL': '/var/mail/cltbld', 09:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:31 INFO - 'MOZ_NO_REMOTE': '1', 09:56:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:31 INFO - 'NO_EM_RESTART': '1', 09:56:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:31 INFO - 'PWD': '/builds/slave/test', 09:56:31 INFO - 'SHELL': '/bin/bash', 09:56:31 INFO - 'SHLVL': '1', 09:56:31 INFO - 'TERM': 'linux', 09:56:31 INFO - 'TMOUT': '86400', 09:56:31 INFO - 'USER': 'cltbld', 09:56:31 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', 09:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:31 INFO - '_': '/tools/buildbot/bin/python'} 09:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:56: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 09:56: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 09:56: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 09:56: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 09:56: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 09:56: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 09:56:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:56:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:56:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:56:33 INFO - Installing collected packages: mozsystemmonitor 09:56:33 INFO - Running setup.py install for mozsystemmonitor 09:56:33 INFO - Successfully installed mozsystemmonitor 09:56:33 INFO - Cleaning up... 09:56:33 INFO - Return code: 0 09:56:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:33 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 0x7f2d7b85cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd17350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', '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 09:56:33 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 09:56:33 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 09:56:33 INFO - Using env: {'DISPLAY': ':0', 09:56:33 INFO - 'HOME': '/home/cltbld', 09:56:33 INFO - 'LANG': 'en_US.UTF-8', 09:56:33 INFO - 'LANGUAGE': 'en_US:en', 09:56:33 INFO - 'LOGNAME': 'cltbld', 09:56:33 INFO - 'MAIL': '/var/mail/cltbld', 09:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:33 INFO - 'MOZ_NO_REMOTE': '1', 09:56:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:33 INFO - 'NO_EM_RESTART': '1', 09:56:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:33 INFO - 'PWD': '/builds/slave/test', 09:56:33 INFO - 'SHELL': '/bin/bash', 09:56:33 INFO - 'SHLVL': '1', 09:56:33 INFO - 'TERM': 'linux', 09:56:33 INFO - 'TMOUT': '86400', 09:56:33 INFO - 'USER': 'cltbld', 09:56:33 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', 09:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:33 INFO - '_': '/tools/buildbot/bin/python'} 09:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:34 INFO - Downloading/unpacking jsonschema==2.5.1 09:56: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 09:56: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 09:56: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 09:56: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 09:56: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 09:56: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 09:56:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:56:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:36 INFO - Downloading functools32-3.2.3-2.tar.gz 09:56:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:56:36 INFO - warning: no files found matching '*.txt' 09:56:36 INFO - no previously-included directories found matching 'build' 09:56:36 INFO - no previously-included directories found matching 'dist' 09:56:36 INFO - no previously-included directories found matching '.git*' 09:56:36 INFO - Installing collected packages: jsonschema, functools32 09:56:36 INFO - Running setup.py install for functools32 09:56:36 INFO - warning: no files found matching '*.txt' 09:56:36 INFO - no previously-included directories found matching 'build' 09:56:36 INFO - no previously-included directories found matching 'dist' 09:56:36 INFO - no previously-included directories found matching '.git*' 09:56:36 INFO - Successfully installed jsonschema functools32 09:56:36 INFO - Cleaning up... 09:56:36 INFO - Return code: 0 09:56:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2d7b85cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd17350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', '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 09:56:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:56:36 INFO - Using env: {'DISPLAY': ':0', 09:56:36 INFO - 'HOME': '/home/cltbld', 09:56:36 INFO - 'LANG': 'en_US.UTF-8', 09:56:36 INFO - 'LANGUAGE': 'en_US:en', 09:56:36 INFO - 'LOGNAME': 'cltbld', 09:56:36 INFO - 'MAIL': '/var/mail/cltbld', 09:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:36 INFO - 'MOZ_NO_REMOTE': '1', 09:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:36 INFO - 'NO_EM_RESTART': '1', 09:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:36 INFO - 'PWD': '/builds/slave/test', 09:56:36 INFO - 'SHELL': '/bin/bash', 09:56:36 INFO - 'SHLVL': '1', 09:56:36 INFO - 'TERM': 'linux', 09:56:36 INFO - 'TMOUT': '86400', 09:56:36 INFO - 'USER': 'cltbld', 09:56:36 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', 09:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:36 INFO - '_': '/tools/buildbot/bin/python'} 09:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:36 INFO - Downloading/unpacking blobuploader==1.2.4 09:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:38 INFO - Downloading blobuploader-1.2.4.tar.gz 09:56:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:56:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:56:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:56:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:56:39 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 09:56:39 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 09:56:39 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 09:56:39 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 09:56:39 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 09:56:39 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 09:56:39 INFO - Downloading docopt-0.6.1.tar.gz 09:56:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:56:39 INFO - Installing collected packages: blobuploader, requests, docopt 09:56:39 INFO - Running setup.py install for blobuploader 09:56:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:56:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:56:39 INFO - Running setup.py install for requests 09:56:39 INFO - Running setup.py install for docopt 09:56:39 INFO - Successfully installed blobuploader requests docopt 09:56:39 INFO - Cleaning up... 09:56:39 INFO - Return code: 0 09:56:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56:39 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')]} 09:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:39 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')]} 09:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:39 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 0x7f2d7b85cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd17350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', '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 09:56:39 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 09:56:39 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 09:56:39 INFO - Using env: {'DISPLAY': ':0', 09:56:39 INFO - 'HOME': '/home/cltbld', 09:56:39 INFO - 'LANG': 'en_US.UTF-8', 09:56:39 INFO - 'LANGUAGE': 'en_US:en', 09:56:39 INFO - 'LOGNAME': 'cltbld', 09:56:39 INFO - 'MAIL': '/var/mail/cltbld', 09:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:39 INFO - 'MOZ_NO_REMOTE': '1', 09:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:39 INFO - 'NO_EM_RESTART': '1', 09:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:39 INFO - 'PWD': '/builds/slave/test', 09:56:39 INFO - 'SHELL': '/bin/bash', 09:56:39 INFO - 'SHLVL': '1', 09:56:39 INFO - 'TERM': 'linux', 09:56:39 INFO - 'TMOUT': '86400', 09:56:39 INFO - 'USER': 'cltbld', 09:56:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', 09:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:39 INFO - '_': '/tools/buildbot/bin/python'} 09:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:56:40 INFO - Running setup.py (path:/tmp/pip-szooQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:56:40 INFO - Running setup.py (path:/tmp/pip-7FwKy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:56:40 INFO - Running setup.py (path:/tmp/pip-vT3z_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:56:40 INFO - Running setup.py (path:/tmp/pip-Q1ECDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:56:40 INFO - Running setup.py (path:/tmp/pip-UXxN44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:56:40 INFO - Running setup.py (path:/tmp/pip-Qf6ls4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:56:40 INFO - Running setup.py (path:/tmp/pip-OUbqbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:56:40 INFO - Running setup.py (path:/tmp/pip-xpMFEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:56:40 INFO - Running setup.py (path:/tmp/pip-kLhZXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:56:40 INFO - Running setup.py (path:/tmp/pip-CFOmXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:56:40 INFO - Running setup.py (path:/tmp/pip-C1SZ0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:56:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:56:40 INFO - Running setup.py (path:/tmp/pip-6WLjSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:56:41 INFO - Running setup.py (path:/tmp/pip-1ykScN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:56:41 INFO - Running setup.py (path:/tmp/pip-v8AMtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:41 INFO - Running setup.py (path:/tmp/pip-2lUxb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:56:41 INFO - Running setup.py (path:/tmp/pip-BW0Ydm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:56:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:56:41 INFO - Running setup.py (path:/tmp/pip-0BMwah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:56:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:56:41 INFO - Running setup.py install for manifestparser 09:56:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:56:41 INFO - Running setup.py install for mozcrash 09:56:41 INFO - Running setup.py install for mozdebug 09:56:41 INFO - Running setup.py install for mozdevice 09:56:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:56:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:56:41 INFO - Running setup.py install for mozfile 09:56:41 INFO - Running setup.py install for mozhttpd 09:56:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:56:42 INFO - Running setup.py install for mozinfo 09:56:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:56:42 INFO - Running setup.py install for mozInstall 09:56:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:56:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:56:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:56:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:56:42 INFO - Running setup.py install for mozleak 09:56:42 INFO - Running setup.py install for mozlog 09:56:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:56:42 INFO - Running setup.py install for moznetwork 09:56:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:56:42 INFO - Running setup.py install for mozprocess 09:56:42 INFO - Running setup.py install for mozprofile 09:56:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:56:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:56:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:56:42 INFO - Running setup.py install for mozrunner 09:56:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:56:42 INFO - Running setup.py install for mozscreenshot 09:56:42 INFO - Running setup.py install for moztest 09:56:43 INFO - Running setup.py install for mozversion 09:56:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:56:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:56:43 INFO - Cleaning up... 09:56:43 INFO - Return code: 0 09:56:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09: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')]} 09:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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')]} 09:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:43 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 0x7f2d7b85cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd17350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', '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 09:56:43 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 09:56:43 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 09:56:43 INFO - Using env: {'DISPLAY': ':0', 09:56:43 INFO - 'HOME': '/home/cltbld', 09:56:43 INFO - 'LANG': 'en_US.UTF-8', 09:56:43 INFO - 'LANGUAGE': 'en_US:en', 09:56:43 INFO - 'LOGNAME': 'cltbld', 09:56:43 INFO - 'MAIL': '/var/mail/cltbld', 09:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:43 INFO - 'MOZ_NO_REMOTE': '1', 09:56:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:43 INFO - 'NO_EM_RESTART': '1', 09:56:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:43 INFO - 'PWD': '/builds/slave/test', 09:56:43 INFO - 'SHELL': '/bin/bash', 09:56:43 INFO - 'SHLVL': '1', 09:56:43 INFO - 'TERM': 'linux', 09:56:43 INFO - 'TMOUT': '86400', 09:56:43 INFO - 'USER': 'cltbld', 09:56:43 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', 09:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:43 INFO - '_': '/tools/buildbot/bin/python'} 09:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:56:43 INFO - Running setup.py (path:/tmp/pip-B84QrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:56:43 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)) 09:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:56:43 INFO - Running setup.py (path:/tmp/pip-BBCkLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:56:43 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)) 09:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:56:43 INFO - Running setup.py (path:/tmp/pip-HmKanz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:56:43 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)) 09:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:56:43 INFO - Running setup.py (path:/tmp/pip-8_67Mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:56:43 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)) 09:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:56:43 INFO - Running setup.py (path:/tmp/pip-8ZvTWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:56:43 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)) 09:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:56:43 INFO - Running setup.py (path:/tmp/pip-ul10nF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:56:43 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)) 09:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:56:43 INFO - Running setup.py (path:/tmp/pip-ZvvOTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:56:43 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)) 09:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:56:43 INFO - Running setup.py (path:/tmp/pip-4RGvho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:56:43 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)) 09:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:56:43 INFO - Running setup.py (path:/tmp/pip-_VDEnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:56:44 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)) 09:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:56:44 INFO - Running setup.py (path:/tmp/pip-iqZ0iI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:56:44 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)) 09:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:56:44 INFO - Running setup.py (path:/tmp/pip-9BYVEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:56:44 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)) 09:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:56:44 INFO - Running setup.py (path:/tmp/pip-m9F0i9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:56:44 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)) 09:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:56:44 INFO - Running setup.py (path:/tmp/pip-4zaopY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:56:44 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)) 09:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:56:44 INFO - Running setup.py (path:/tmp/pip-35y7fg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:56:44 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)) 09:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:44 INFO - Running setup.py (path:/tmp/pip-EN1F69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:56:44 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)) 09:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:56:44 INFO - Running setup.py (path:/tmp/pip-guwtnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:56:44 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)) 09:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:56:44 INFO - Running setup.py (path:/tmp/pip-PnYtRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:56:44 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)) 09:56:44 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)) 09:56:44 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)) 09:56:44 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)) 09:56:44 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)) 09:56:44 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)) 09:56:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:56:44 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 09:56:44 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 09:56:44 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 09:56:44 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 09:56:44 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 09:56:44 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 09:56:46 INFO - Downloading blessings-1.6.tar.gz 09:56:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:56:46 INFO - Installing collected packages: blessings 09:56:46 INFO - Running setup.py install for blessings 09:56:46 INFO - Successfully installed blessings 09:56:46 INFO - Cleaning up... 09:56:46 INFO - Return code: 0 09:56:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:56:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:56:46 INFO - Reading from file tmpfile_stdout 09:56:46 INFO - Current package versions: 09:56:46 INFO - argparse == 1.2.1 09:56:46 INFO - blessings == 1.6 09:56:46 INFO - blobuploader == 1.2.4 09:56:46 INFO - docopt == 0.6.1 09:56:46 INFO - functools32 == 3.2.3-2 09:56:46 INFO - jsonschema == 2.5.1 09:56:46 INFO - manifestparser == 1.1 09:56:46 INFO - mozInstall == 1.12 09:56:46 INFO - mozcrash == 0.17 09:56:46 INFO - mozdebug == 0.1 09:56:46 INFO - mozdevice == 0.48 09:56:46 INFO - mozfile == 1.2 09:56:46 INFO - mozhttpd == 0.7 09:56:46 INFO - mozinfo == 0.9 09:56:46 INFO - mozleak == 0.1 09:56:46 INFO - mozlog == 3.2 09:56:46 INFO - moznetwork == 0.27 09:56:46 INFO - mozprocess == 0.22 09:56:46 INFO - mozprofile == 0.28 09:56:46 INFO - mozrunner == 6.11 09:56:46 INFO - mozscreenshot == 0.1 09:56:46 INFO - mozsystemmonitor == 0.3 09:56:46 INFO - moztest == 0.7 09:56:46 INFO - mozversion == 1.4 09:56:46 INFO - psutil == 3.1.1 09:56:46 INFO - requests == 1.2.3 09:56:46 INFO - wsgiref == 0.1.2 09:56:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:56:46 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')]} 09:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:46 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')]} 09:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:46 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 0x7f2d7b85cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd17350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', '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 09:56:46 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 09:56:46 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 09:56:46 INFO - Using env: {'DISPLAY': ':0', 09:56:46 INFO - 'HOME': '/home/cltbld', 09:56:46 INFO - 'LANG': 'en_US.UTF-8', 09:56:46 INFO - 'LANGUAGE': 'en_US:en', 09:56:46 INFO - 'LOGNAME': 'cltbld', 09:56:46 INFO - 'MAIL': '/var/mail/cltbld', 09:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:46 INFO - 'MOZ_NO_REMOTE': '1', 09:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:46 INFO - 'NO_EM_RESTART': '1', 09:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:46 INFO - 'PWD': '/builds/slave/test', 09:56:46 INFO - 'SHELL': '/bin/bash', 09:56:46 INFO - 'SHLVL': '1', 09:56:46 INFO - 'TERM': 'linux', 09:56:46 INFO - 'TMOUT': '86400', 09:56:46 INFO - 'USER': 'cltbld', 09:56:46 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', 09:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:46 INFO - '_': '/tools/buildbot/bin/python'} 09:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:47 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)) 09:56:47 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)) 09:56:47 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)) 09:56:47 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)) 09:56:47 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)) 09:56:47 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)) 09:56:47 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)) 09:56:47 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)) 09:56:47 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)) 09:56:47 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)) 09:56:47 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)) 09:56:47 INFO - Cleaning up... 09:56:47 INFO - Return code: 0 09:56:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:56:47 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')]} 09:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:47 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')]} 09:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:47 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 0x7f2d7b85cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd17350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', '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 09:56:47 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 09:56:47 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 09:56:47 INFO - Using env: {'DISPLAY': ':0', 09:56:47 INFO - 'HOME': '/home/cltbld', 09:56:47 INFO - 'LANG': 'en_US.UTF-8', 09:56:47 INFO - 'LANGUAGE': 'en_US:en', 09:56:47 INFO - 'LOGNAME': 'cltbld', 09:56:47 INFO - 'MAIL': '/var/mail/cltbld', 09:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:47 INFO - 'MOZ_NO_REMOTE': '1', 09:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:47 INFO - 'NO_EM_RESTART': '1', 09:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:47 INFO - 'PWD': '/builds/slave/test', 09:56:47 INFO - 'SHELL': '/bin/bash', 09:56:47 INFO - 'SHLVL': '1', 09:56:47 INFO - 'TERM': 'linux', 09:56:47 INFO - 'TMOUT': '86400', 09:56:47 INFO - 'USER': 'cltbld', 09:56:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', 09:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:47 INFO - '_': '/tools/buildbot/bin/python'} 09:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:56:47 INFO - Cleaning up... 09:56:47 INFO - Return code: 0 09:56:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:56:47 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')]} 09:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:47 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')]} 09:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:56:47 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 0x7f2d7b85cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc4c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd17350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', '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 09:56:47 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 09:56:47 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 09:56:47 INFO - Using env: {'DISPLAY': ':0', 09:56:47 INFO - 'HOME': '/home/cltbld', 09:56:47 INFO - 'LANG': 'en_US.UTF-8', 09:56:47 INFO - 'LANGUAGE': 'en_US:en', 09:56:47 INFO - 'LOGNAME': 'cltbld', 09:56:47 INFO - 'MAIL': '/var/mail/cltbld', 09:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:56:47 INFO - 'MOZ_NO_REMOTE': '1', 09:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:56:47 INFO - 'NO_EM_RESTART': '1', 09:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:56:47 INFO - 'PWD': '/builds/slave/test', 09:56:47 INFO - 'SHELL': '/bin/bash', 09:56:47 INFO - 'SHLVL': '1', 09:56:47 INFO - 'TERM': 'linux', 09:56:47 INFO - 'TMOUT': '86400', 09:56:47 INFO - 'USER': 'cltbld', 09:56:47 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', 09:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:56:47 INFO - '_': '/tools/buildbot/bin/python'} 09:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:56:47 INFO - Downloading/unpacking flake8 09:56:47 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 09:56:47 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 09:56:47 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 09:56:47 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 09:56:47 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 09:56:47 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 09:56:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:56:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:56:49 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 09:56:49 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 09:56:49 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 09:56:49 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 09:56:49 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 09:56:49 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 09:56:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:56:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:56:49 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 09:56:49 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 09:56:49 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 09:56:49 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 09:56:49 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 09:56:49 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 09:56:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:56:49 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 09:56:49 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 09:56:49 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 09:56:49 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 09:56:49 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 09:56:49 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 09:56:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:56:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:56:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:56:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:56:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:56:50 INFO - no previously-included directories found matching 'docs/_build' 09:56:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:56:50 INFO - Running setup.py install for pep8 09:56:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:56:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:56:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:56:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:56:50 INFO - no previously-included directories found matching 'docs/_build' 09:56:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:56:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:56:50 INFO - Cleaning up... 09:56:50 INFO - Return code: 0 09:56:50 INFO - Running post-action listener: _resource_record_post_action 09:56:50 INFO - Running post-action listener: _start_resource_monitoring 09:56:50 INFO - Starting resource monitoring. 09:56:50 INFO - ##### 09:56:50 INFO - ##### Finished create-virtualenv step (success) 09:56:50 INFO - ##### 09:56:50 INFO - ##### 09:56:50 INFO - ##### Running install step. 09:56:50 INFO - ##### 09:56:50 INFO - Running pre-action listener: _resource_record_pre_action 09:56:50 INFO - Running main action method: install 09:56:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:56:50 INFO - Reading from file tmpfile_stdout 09:56:50 INFO - Detecting whether we're running mozinstall >=1.0... 09:56:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:56:50 INFO - Reading from file tmpfile_stdout 09:56:50 INFO - Output received: 09:56:50 INFO - Usage: mozinstall [options] installer 09:56:50 INFO - Options: 09:56:50 INFO - -h, --help show this help message and exit 09:56:50 INFO - -d DEST, --destination=DEST 09:56:50 INFO - Directory to install application into. [default: 09:56:50 INFO - "/builds/slave/test"] 09:56:50 INFO - --app=APP Application being installed. [default: firefox] 09:56:50 INFO - mkdir: /builds/slave/test/build/application 09:56:50 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'] 09:56:50 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 09:57:07 INFO - Reading from file tmpfile_stdout 09:57:07 INFO - Output received: 09:57:07 INFO - /builds/slave/test/build/application/firefox/firefox 09:57:07 INFO - Running post-action listener: _resource_record_post_action 09:57:07 INFO - ##### 09:57:07 INFO - ##### Finished install step (success) 09:57:07 INFO - ##### 09:57:07 INFO - ##### 09:57:07 INFO - ##### Running run-tests step. 09:57:07 INFO - ##### 09:57:07 INFO - Running pre-action listener: _resource_record_pre_action 09:57:07 INFO - Running main action method: run_tests 09:57:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:57:07 INFO - Python 2.7.3 09:57:07 INFO - Return code: 0 09:57:07 INFO - grabbing minidump binary from tooltool 09:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:07 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 0xda61c0>, '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 0xda70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda7550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:57:07 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 09:57:07 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 09:57:07 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 09:57:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:57:07 INFO - Return code: 0 09:57:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:57:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:57:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:57:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:57:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:57:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:57:08 INFO - Return code: 0 09:57:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 09:57:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 09:57:08 INFO - Using env: {'DISPLAY': ':0', 09:57:08 INFO - 'HOME': '/home/cltbld', 09:57:08 INFO - 'LANG': 'en_US.UTF-8', 09:57:08 INFO - 'LANGUAGE': 'en_US:en', 09:57:08 INFO - 'LOGNAME': 'cltbld', 09:57:08 INFO - 'MAIL': '/var/mail/cltbld', 09:57:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:57:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:08 INFO - 'MOZ_NO_REMOTE': '1', 09:57:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:57:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:08 INFO - 'NO_EM_RESTART': '1', 09:57:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:08 INFO - 'PWD': '/builds/slave/test', 09:57:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:57:08 INFO - 'SHELL': '/bin/bash', 09:57:08 INFO - 'SHLVL': '1', 09:57:08 INFO - 'TERM': 'linux', 09:57:08 INFO - 'TMOUT': '86400', 09:57:08 INFO - 'USER': 'cltbld', 09:57:08 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573', 09:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:08 INFO - '_': '/tools/buildbot/bin/python'} 09:57:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 09:57:08 INFO - mozversion application_buildid: 20160607070918 09:57:08 INFO - mozversion application_changeset: 448365b11e377ebf1c572d54e45bbd36c45af03a 09:57:08 INFO - mozversion application_display_name: Nightly 09:57:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:57:08 INFO - mozversion application_name: Firefox 09:57:08 INFO - mozversion application_remotingname: firefox 09:57:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:57:08 INFO - mozversion application_vendor: Mozilla 09:57:08 INFO - mozversion application_version: 50.0a1 09:57:08 INFO - mozversion platform_buildid: 20160607070918 09:57:08 INFO - mozversion platform_changeset: 448365b11e377ebf1c572d54e45bbd36c45af03a 09:57:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:57:08 INFO - mozversion platform_version: 50.0a1 09:57:08 INFO - using testdate: 1465318628 09:57:08 INFO - actual date: 1465318628 09:57:08 INFO - starting webserver on 'localhost:44524' 09:57:08 INFO - SUITE-START | Running 2 tests 09:57:08 INFO - TEST-START | dromaeo_css 09:57:08 INFO - operating with platform_type : linux_ 09:57:08 INFO - Initialising browser for dromaeo_css test... 09:57:08 INFO - TEST-INFO | started process 18131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTwo82u/profile http://localhost:44524/getInfo.html) 09:57:13 INFO - PROCESS | 18131 | __metrics Screen width/height:1600/1200 09:57:13 INFO - PROCESS | 18131 | colorDepth:24 09:57:13 INFO - PROCESS | 18131 | Browser inner width/height: 1024/697 09:57:13 INFO - PROCESS | 18131 | __metrics 09:57:14 ERROR - PROCESS | 18131 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 09:57:15 INFO - TEST-INFO | 18131: exit 0 09:57:15 INFO - Browser initialized. 09:57:15 INFO - Running cycle 1/1 for dromaeo_css test... 09:57:15 INFO - TEST-INFO | started process 18251 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTwo82u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:57:27 INFO - PROCESS | 18251 | RSS: Main: 167366656 09:57:27 INFO - PROCESS | 18251 | 09:58:16 INFO - PROCESS | 18251 | 1465318696942 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] 10:00:25 INFO - PROCESS | 18251 | Cycle 1(1): loaded http://localhost:44524/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44524/tests/dromaeo/cssquery-ext.html) 10:00:26 INFO - PROCESS | 18251 | RSS: Main: 170987520 10:00:26 INFO - PROCESS | 18251 | 10:03:28 INFO - PROCESS | 18251 | Cycle 1(1): loaded http://localhost:44524/tests/dromaeo/cssquery-ext.html (next: http://localhost:44524/tests/dromaeo/cssquery-jquery.html) 10:03:28 INFO - PROCESS | 18251 | RSS: Main: 170184704 10:03:28 INFO - PROCESS | 18251 | 10:06:30 INFO - PROCESS | 18251 | Cycle 1(1): loaded http://localhost:44524/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44524/tests/dromaeo/cssquery-mootools.html) 10:06:31 INFO - PROCESS | 18251 | RSS: Main: 172097536 10:06:31 INFO - PROCESS | 18251 | 10:09:33 INFO - PROCESS | 18251 | Cycle 1(1): loaded http://localhost:44524/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44524/tests/dromaeo/cssquery-prototype.html) 10:09:33 INFO - PROCESS | 18251 | RSS: Main: 168837120 10:09:33 INFO - PROCESS | 18251 | 10:12:36 INFO - PROCESS | 18251 | Cycle 1(1): loaded http://localhost:44524/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44524/tests/dromaeo/cssquery-yui.html) 10:12:36 INFO - PROCESS | 18251 | RSS: Main: 170921984 10:12:36 INFO - PROCESS | 18251 | 10:15:39 INFO - PROCESS | 18251 | Cycle 1(1): loaded http://localhost:44524/tests/dromaeo/cssquery-yui.html (next: http://localhost:44524/tests/dromaeo/cssquery-dojo.html) 10:15:39 INFO - PROCESS | 18251 | RSS: Main: 172384256 10:15:39 INFO - PROCESS | 18251 | 10:15:39 INFO - PROCESS | 18251 | __start_tp_report 10:15:39 INFO - PROCESS | 18251 | _x_x_mozilla_page_load 10:15:39 INFO - PROCESS | 18251 | _x_x_mozilla_page_load_details 10:15:39 INFO - PROCESS | 18251 | |i|pagename|runs| 10:15:39 INFO - PROCESS | 18251 | |0;dojo.html;3124.7500199984;3156.8263745493987;3162.8892988745397;3178.729807966323;3200.055983484872;5343.064963631364;5407.945920540794;5416.2958815353995;5480.506754392104;5545.195946587743;5425.565954723623;5487.533559647435;5512.972435137829;5559.749811258493;5561.4716601922755;4979.278004689327;4991.925121123186;5120.462351453081;5147.6911385317;5153.201253805666;5034.874128146807;5211.504907033845;5247.47525247476;5249.790008399659;5252.448492908228;4959.57843583294;4964.0816448956875;4982.451930287665;5006.799728010875;5038.118329292396;5048.772805223737;5060.418051924039;5060.7722652480725;5063.088644044071;5104.923426148611;5006.098902197603;5035.647504674675;5043.268726034741;5052.621053421009;5078.339815823956;5361.115415956362;5405.918911216335;5409.0534156522845;5409.9459005409835;5455.399906010336;5886.440788125121;5927.911081333784;5934.762609495615;5935.643861368331;5953.047512397996;5731.226284451587;5900.911486327708;5925.170476133345;5939.198208241875;5947.672877991708;5531.059719847595;5572.080606699889;5594.692291923902;5596.86007849807;5641.774329026834;6076.179715738319;6116.92953733095;6157.568970172135;6160.414760597736;6167.537434692416;5650.152477128464;5713.285839270091;5750.2237197978575;5846.444587764156;5897.852553686106;5880.882382352414;5889.293284805851;5893.970530147321;5900.1739756434135;5920.79277225295;5711.714414279352;5824.068149096124;5866.823995280149;5892.469677729025;5894.410558944157;5865;5929.555283353766;5932.228810254725;5944.494717948936;5976.193213916153;4489.910201796011;4497.88755281114;4511.142882852248;4513.458384993822;4515.051839113823;3935.2719746846924;3946.4869566956113;3982.7212095153063;3999.3800960851113;4009.51885773709;5614.242077319591;5640.069388550925;5649.68926709035;5664.575156863251;5678.829635110953;5961.195238642815;5965.582409231312;5970.522358211333;5989.401059893976;6007.939920600826;5516.282883225155;5647.802326918538;5667.064934285879;5676.120201368794;5735.971320143372;5097.566706829887;5109.74451277442;5111.335526381621;5115.360579927509;5136.101182293084;5954.672493012926;6127.908081378783;6130.172426722335;6133.202683651097;6134.171886795226;5864.912026319608;5888.17565540816;5889;5942.168096466412;5943.465088142088;6032.758689652364;6079.574429789872;6091.360407157184;6101.938980610137;6121;5516.724163791714;5790.276215473066;5799.478046975623;5846.94153058464;5859;5893.793717219876;5964.970175149097;5974.61165024272;5987.7604895805425;6032.638041717511;5769.134629805562;5782.10377391505;5782.1615865698395;5798.072308430631;5806.158107074366;5554.861128471821;5639.407862174577;5671.120976248523;5771.68255745938;5779.508741756998;5452.863678408072;5488.451154884479;5544.140658197985;5548.389677135593;5669.886602267849;5653.689047102449;5717.571182161271;5748.223989761329;5756.65460072397;5762.855928601818;5433.429489903503;5609.27079479665;5610.074337734228;5624.6625202487985;5625.437456254342 10:15:39 INFO - PROCESS | 18251 | |1;ext.html;575.9546423241816;629.8299459146028;636.6752955992444;650.8665723526677;655.6426747422655;42268.78865605671;43714;43848;44044.119117617665;46909;44960.77519612406;45287.54712452875;45460.3180952286;45477.0904581909;45619.77190114053;8793.648254069829;8988.460692358447;8992.23565996891;9007.189352958232;9017.504037277948;8842.5136617486;8916.554172291391;8945.776355591097;8947.731568052968;8954.14935581122;9021.819563608724;9059.818803623924;9077.863832042525;9077.95461022694;9108.817823643556;8953.05992870749;8960.238379737697;8994.955025224832;9011.684591039348;9018.864717029217;8668.436551624125;8745.300375969971;8748.168923952215;8761.824763504757;8762.342824288204;42538.78730606327;42708;42992.78503607493;43133.78433107846;43270.78364608188;3481.495183198447;3638.3814751492046;3810.1046254130256;4049.2104039712267;4264.488261408651;32243.6775632243;32409.83795081033;32857.835710821535;33064.83467582671;33888;4154.31453810121;4186.623203911662;4243.130158317537;4254.659627229814;4332.501762297345;331397;333180;333587.3320633406;334174;334725;59213.70393148093;59293;59583.40416595865;59690;59799.103013454835;35229.47155792665;35254.82372588121;35440.822795885855;37717.43423848644;38018.42972355417;17331;17527.73708394375;17675.204615792063;17691.93848369102;17703.29186832538;12606.243625382507;12770.425330859947;12834.80747788784;12859.614211573667;12901.419436125398;19722.30971915976;19724.90137549332;19779.90110049469;19942;20037.599248014958;7335.743248986367;7337.523061001018;7355.117385913724;7356.926430735732;7539.698412063456;1062.6493257225097;1153.8730739618636;1187.4597058338436;1195.9282443053444;1246;32718.345633087203;33328;33437.33125337528;33512.32975340528;33753;1123.775244951013;1186.887245711656;1212.1030437476381;1218.8049912014035;1253.724180680249;17314.826851731574;17377.595424592815;17487;17542.386016489618;17721.379751708628;560783;561669;571107;571110;571850;58176.70911645415;58630.413695863346;58794;58846;58943.41056589465;1399.3423091147145;1433.4552869909367;1444.1046551138152;1444.7182799354234;1454.978175327371;30826.53760193554;32061;32628.510572340958;32829;33256.501152483215;51141.23288150755;51725.48274517206;52069;52119.47880521146;52218.47781522136;433798;435507;436179;436546;437002;27533.31166720848;27847.721522785323;28218.435631286848;28274.151775446768;28474.85762571174;48518.5148148514;48593.5140648589;48983.510164897896;49176.2623560654;49917.25124123068;41314.1737165261;42248.78875605603;42384.576154238064;43109.35335970025;43330.783346083066;41646.70897696902;42287.3508162697;42361.78819105885;42565;42650.36024459574;36080.63919360773;40862.182756345304;41006.79496602498;42175;42906;35593.28813423665;36766.63233367739;37381.25237495181;37701.24597507979;37782.43326350162;28618;28784.136475905758;28788.42423151567;28979.710202898543;29229.415411692073 10:15:39 INFO - PROCESS | 18251 | |2;jquery.html;381.883525524715;391.4656493885843;393.44327776196684;402.6074577287145;414.0146451445559;18274;19610.705839412385;19781.307654232103;19841.503962400948;20798.48003799906;12080.637580872566;12756.55352062678;12800.295983720891;19496.610067798636;19657.410277691655;5076.796928122871;5143.202803565453;5299.046171689114;5317.096093664067;5345.224942383372;5187.922181167285;5233.921491177635;5244.344456942882;5254.81608143715;5257.973710131463;5057.620678449112;5164.793408263684;5223.190405487137;5234.7120908350025;5244.527992480676;5220.29526013987;5223.843284701465;5244.134717771563;5253.684778913277;5259.342582177228;4879.780409881564;5066.341375621146;5089.440161582223;5102.260172275;5121.308623335839;13532.391042403115;13682.31588420585;14323.427062917472;14326.856731432656;14332.856671433257;2135.444784356063;2230.052227803177;2342.8945697443655;2404.483036147219;2593.6628238328894;10274.589016439333;10363.79272414555;10584.153267738562;11559.364234967074;13112.147710398793;1798.3975368251652;1897.943061708151;1916.3867562380044;1919.654462196804;1921.2411097616364;81535.5923220386;84423;84615.576922115;86957;87877.12122878754;10895.673129806119;11179;11426.600068997544;11865.88134118665;11918.642440726791;15699.215039247993;15762.921185394229;15783.447579334668;15787.526374208792;15791.842081579267;8153.22544358285;8198.42611017235;8208.384371172186;8425.536595487307;8479.109693482218;7973.60131993398;8021.478603890729;8113.6754529818145;8175.918240817516;8257.504549727035;4398.560143985575;4535.319702044654;4583.593613353017;4591.380163677927;4675.064987002613;1973.457299242691;1987.125664707524;2018.7072874433125;2021.8079282468143;2056.6812144117685;899.5457294066455;1025.4206373399006;1066.5253961986841;1083.7778255457613;1098.9395583242838;18987.71518427225;19697.901510492644;19965.700514492295;20042.39872803818;20078.89960550188;1012.0335079998583;1048.5858086055964;1051.0488008352454;1068.2842495528014;1080.6433876820631;10540.209484288709;11249.887501125047;11276;11284.379359135326;11289.830652540219;485197;487212;495336;497723;501412;56095.43904560984;76411.23588764152;93342.53328733314;97689.51155244178;98505.50747246218;954.2795189631784;963.9710808675751;983.1544871410581;987.1707765477033;1014.60430432133;17623.559411014314;17677.116144192994;18176.727349090037;18406.35577754772;18488.260469581604;40100.7994960035;41853.372199417645;42502.57497424986;42503.3624495639;44082.33876491791;57193.714031429576;57255.42744572501;59926.70036649789;61179.69410152921;61301.38698612957;8366.539840308842;8421.957460418911;8458.915410846059;8719.433236839584;9012.143846334588;11577.305361678325;12945.676358091123;13049.28228947417;13143.737125257632;13197.406116724962;11501.137414694098;11639.5344186235;12095.75808483843;12320.753584928072;12333.075019373404;10525.78948421012;11379.155211197201;11490.310581365145;11510.654680359603;11682.94158529202;11472.885271147516;12244.938775306422;12354.567590134302;12481.875181248071;12824.935875320936;7653.885191722017;7978.680852765824;8017.037955445384;8119.350451963947;8337.583120843812;8802.779930501789;12083.214591051554;12095.57665481704;12131.332776697367;12321.322327272086 10:15:39 INFO - PROCESS | 18251 | |3;mootools.html;1481.2963842174968;1484.7698606715956;1501.9624509387263;1549.9535013949583;1576.5349221979516;7803.3367163791145;8263.91736082639;8715.869261961068;8978.640854365825;8980.101989801025;8571.957140214306;8591.398602097841;8601.612927418266;8625.353098517606;8639.611217495212;2289.427643089228;2323.2797832671927;2326.081197926818;2327.290176496168;2333.0551126793675;2239.54089411671;2242.932712018642;2318.026428899866;2321.1759825262043;2328.906843726249;2245.9438514037197;2247.0225451928463;2278.04322184682;2313.838031337807;2318.7449380568123;2249.089118906837;2251.2570851618925;2260.4461906832767;2261.2876943762662;2262.0273282488524;2184.923527676524;2185.0604240176717;2202.5815095131875;2207.812335951446;2215.590115828577;8478.23695867375;8568.357373197035;8602.2688071514;8603.526806025666;8694.521801300925;4949.7030178189425;4997.6501644884875;5000.599832047033;5004.724740139291;5009.874753131201;3021.305099827052;3107.300857307088;3240.0279916025097;3243.8053716777067;3259.7718159728593;1063.8191507443676;1067.503610820972;1073.3452593917705;1092.2136062035322;1095.0308976555805;11563.306201627845;11570.074394048455;11615.361155136465;11617.419129043514;11646.59236926712;4296.914061718748;4337.37108119321;4401.6478681705385;4415.757133357696;4435.046465010038;9840.507974601242;9884.209263258923;9924;9931.255155863339;9947.651832185838;5026.421961474477;5087.745612719349;5090.083784918676;5098.439171691111;5099.388073431212;4120.093579412524;4582.335561343653;4596.5863072323655;4693.084848454587;4694.835680751157;3838.558565764917;3839.9616003839606;3975.284448799244;4003.579624139482;4006.6794656427414;1199.5201919232202;1212.0485418946084;1214.8906598406186;1219.762146381447;1221.3770976801895;959.2853324273461;974.4056125763278;976.829054915387;994.1053052252886;1011.0546638892512;5707.885842283131;5832.825015249549;5837.708114594253;5940.108983652487;6088.086786981989;429.954854740254;431.38958373901204;444.5732097186672;450.9301058335963;454.99317510237375;4031.7984100794843;4076.4089207065404;4114.979425102915;4141.233871733739;4197.076643138505;10237.539310731036;10492.21308401873;10587.205959553065;10666.573337066586;10671.35971841692;10478.476076196159;10484.475776211159;10490.527926243338;10492.685219443429;10522.421266830397;7708.383329333752;7995.920040799518;8043.034835819856;8096.797580060545;8107.270345668918;6063.575549711654;6200.7519699211525;6230.221222347207;6352.301246862934;6417.743290268337;9786.902130978884;9802.65690700822;9934.503274836085;9961.053699898497;10044.045815647502;9986.550605222928;10153.796924061626;10200.540975655966;10283.94858025735;10672.83990740155;7106.467014973794;7255.310745479171;7417;7611.467197296136;7740.690372385042;8353.874691879748;8357.582120894052;8364.163583641588;8403;8425.536595487307;7338.743143989935;7543.3965282778345;7569.205233450409;7587.430942679432;7626.122995855548;7260.854782904418;7326.3772579329225;7436.405087593088;7464.962675186589;7473.215312392121;6801.2178599461695;6816.693248803716;6817.488688348294;6842.93157068423;6868.862622747417;4838.274258861199;5006.949930500648;5049.2173713074535;5124.846254612367;5145.279660847559;4956.553910148104;5043.092243396224;5107.361579802525;5223.21651752225;5249.2651028855225 10:15:39 INFO - PROCESS | 18251 | |4;prototype.html;321.41342050757356;336.7558520072947;340.4433750817414;343.24828625310573;346.3920818962723;5370.7046112463795;5407.756650950707;5610.859728506784;5618.803341883035;5727.770889164433;5524.751386187621;5542.115680668572;5570.384588469349;5587.329520457541;5598.244237028;4344.131173765251;4369.1480161368545;4381.693281470299;4392.736435813861;4397.890052748691;4147.294959856817;4378.956210437903;4400.317950717644;4432.445944256968;4436.2458382074965;4212.978935105336;4252.447181866353;4276.337167739005;4297.183535128332;4331.7400955942585;4268.59448352406;4312.137572485515;4342.761148136851;4353.9129217415475;4362.411074504965;3725.9879664980876;3777.924441511182;3822.6750726188307;3823.254465379252;3838.9616103838885;5378.220158077096;5401.864953376197;5406.351237851443;5428.805662754227;5429.511343979021;4934.481879402647;4937.80248790048;4943.382077240345;4953.727544985024;4973.254011898208;5486.259354987065;5779.826605201851;5783.103618939072;5820.214271073435;5859.8535036624;4061.289274376972;4100;4118.670506359484;4133.524644665842;4144.91710165798;6036.245469316335;6056.788012419544;6096.957519231063;6098.871708733898;6126.816195514097;4164.68764842638;4228.809703563347;4245.257080010986;4259.233337999128;4291.914161716811;4233.428487154257;4251.341042138473;4275.679324050709;4282.528921818597;4290.914181716348;4894.363732714724;4916.483769204254;4932.136876046749;4947.455779864212;4969.2546118081855;5771.1820776456125;5905.586608937419;5921.555883308769;5934.910976335358;5953.3451320354725;1457.358762144653;1485.7771334299725;1492.5895378770708;1492.604459818149;1496.5211132437732;908.8454962656365;932.5896605493562;933.1927882381826;933.495912207414;950.619752099152;5009.474005229471;5088.59291256706;5095.274028394791;5105.5149760772665;5130.716831010164;5406.378266499324;5425.829668132778;5433.185022246695;5444.891102177934;5479.315085614298;4936.012817216214;4957.7769000395065;5054.393472783289;5123.641345105807;5129.743512824344;2857.4570831542355;2883.370895444067;2890.479713651521;2905.288204389938;2908.7963842531244;5440.939016891668;5499;5552.666839989613;5568.6101972862325;5605.831825045255;5491;5712.742926568314;6120.969395152996;6157.168782214344;6217.316095229521;6167.722452489649;6175.783847565313;6223.595466294767;6240.906386404207;6260.593061450991;5915.674637894785;5984.31180414258;5998.920194364881;6060.454559089703;6154.723037463235;5950.821475355746;5967.180010096962;5971.970140149271;5978.252718410199;5996.310424301087;5669.943300567106;6156.753729850935;6258.280297765815;6279.654618995816;6288.8427789303805;4070.3487442009136;4158.625723684762;4178.477690288714;4179.644730197846;4190.958090419057;6028.57799953999;6032.457078862748;6054.788082417094;6106.297775755845;6119.84700382494;5683.1529752829665;5784.946344047802;5852.678102704393;5876.853078673067;5909.793157239476;5795.710214489174;5798.362180160263;5830.970845145747;5851.273874207204;5904.261967254093;5663.762813688488;5697.116946873241;5773.53811695055;5800.187973683604;5800.622959507618;5655.321361436654;5892.175095486721;5918.260217472816;5938.673372964528;6009.609375390585;5779.624324418899;5819.428754236248;5848.824535263949;5856.4143585641095;5884.176215329771 10:15:39 INFO - PROCESS | 18251 | |5;yui.html;724.713738073461;763.8510490454361;779.2091027606976;779.4894344204546;814.8492528882153;14799.186044767546;15964.920175399136;15987.84012159878;16074.59813504663;16087;14426.35081421336;14532.636684082903;14554.19951902645;14564.344604492797;14588.197649129293;676.8375589858423;793.0562630469751;803.7428023032618;810.748667912946;819.4427789103407;818.7134502923959;823;824.756696774453;827.4125370986577;827.9047909490425;872.8036191856813;876.9254613357872;877.3288434347729;879.8460269452852;880.1110878013188;878.8901387326584;879.2043200903192;879.463527248378;879.6657270237301;880.2473884828476;632.8196464007735;635.6726285962733;636.0808631527444;637.6715991264456;638.9712462939179;14637.780433293508;14701.117932924059;14715.190664513448;14803.111813291236;14807.777883331652;15039;15105.39578416862;15114.697706045927;15256.771148432783;15449.382024718998;12098.81851772224;12221.938890305491;12265.448054837554;12340.074494412955;12788.744225115539;3698.745352928585;3786.924261514782;3888.1251718363424;3964.108075682977;4046.7774272415004;72449.63775181091;74519.62740186318;74524.62737686277;74689.62655186743;75451;11430.485628146753;11614.6515604532;11669.941650291694;11682.065434765198;11968.222065565711;20358.389248322575;20391;20417;20449;20468.590628187354;8274.917250827535;8375.413721039591;8443.620037098346;8505.957470212734;8647.351448641377;4751.358566593465;4765.9523404766205;4791.520847915181;4796.736179510161;4832.226843705061;3419.230673098533;3511.3504001759757;3517.2437925846066;3518.7185025197923;3519.8240087995496;605.7879742090233;614.744880874441;622.4273668225244;625.1435533319382;633.6071635585967;583.3029529712038;620.6307247187916;666.7766298290127;679.741698154698;683.7094234950126;7709.498882572615;7782.766517004499;7808.297253247235;7867.685292588232;7975.7607271781935;563.9915401268984;632.867097909435;697.5117417807555;697.8137166816331;740.7333359990399;4322.416473776;4324.891877703019;4417.182821178092;4453.933191002137;4554.180247555471;64766.67616661981;113569;115434.422827887;116138;119361.40319298522;96740;97030;97411.51294243483;97446;100659.49670251601;86074;86388.56805716056;88469;89834;91196.54401727949;8230.588470576567;8305.709300174465;8388.664453421794;8412.101584967975;8449.155084491747;52180;52522.212166818295;52579;52766.73616631892;54982;69996;76731.23268767464;77011.61494192493;77585.61207193928;78123;10611.522481488506;10681.465926703479;10764.3541387517;10891.01980821698;11270.661880143609;12462.376881156088;12540.372981350714;12586.748265034465;13236.536721214712;13385.933070334586;11348.943255284;11396.772064558829;11830.171887968105;12029.338386388832;12123.515059397525;11656.825147622623;11675.649730508097;11997.16019878635;12086.456109474919;12169.2698438094;11873.168878178445;11889.46497407636;11916.463759130687;12136.211146275464;12645.683857903627;9830.950845245728;9930.05664461875;10018.39889606626;10339.948300258451;10357.585696572052;10339.844902326622;10569.471526423495;10639.787204256027;10660.200484963503;10697.946510267398 10:15:39 INFO - PROCESS | 18251 | __end_tp_report 10:15:39 INFO - PROCESS | 18251 | __start_cc_report 10:15:39 INFO - PROCESS | 18251 | _x_x_mozilla_cycle_collect,360 10:15:39 INFO - PROCESS | 18251 | __end_cc_report 10:15:39 INFO - PROCESS | 18251 | __startTimestamp1465319739847__endTimestamp 10:15:39 INFO - PROCESS | 18251 | 10:15:39 INFO - PROCESS | 18251 | ------- Summary: start ------- 10:15:39 INFO - PROCESS | 18251 | Number of tests: 6 10:15:39 INFO - PROCESS | 18251 | 10:15:39 INFO - PROCESS | 18251 | [#0] dojo.html Cycles:165 Average:5481.41 Median:5650.15 stddev:625.19 (11.1%) stddev-sans-first:599.15 10:15:39 INFO - PROCESS | 18251 | Values: 3124.8 3156.8 3162.9 3178.7 3200.1 5343.1 5407.9 5416.3 5480.5 5545.2 5425.6 5487.5 5513.0 5559.7 5561.5 4979.3 4991.9 5120.5 5147.7 5153.2 5034.9 5211.5 5247.5 5249.8 5252.4 4959.6 4964.1 4982.5 5006.8 5038.1 5048.8 5060.4 5060.8 5063.1 5104.9 5006.1 5035.6 5043.3 5052.6 5078.3 5361.1 5405.9 5409.1 5409.9 5455.4 5886.4 5927.9 5934.8 5935.6 5953.0 5731.2 5900.9 5925.2 5939.2 5947.7 5531.1 5572.1 5594.7 5596.9 5641.8 6076.2 6116.9 6157.6 6160.4 6167.5 5650.2 5713.3 5750.2 5846.4 5897.9 5880.9 5889.3 5894.0 5900.2 5920.8 5711.7 5824.1 5866.8 5892.5 5894.4 5865.0 5929.6 5932.2 5944.5 5976.2 4489.9 4497.9 4511.1 4513.5 4515.1 3935.3 3946.5 3982.7 3999.4 4009.5 5614.2 5640.1 5649.7 5664.6 5678.8 5961.2 5965.6 5970.5 5989.4 6007.9 5516.3 5647.8 5667.1 5676.1 5736.0 5097.6 5109.7 5111.3 5115.4 5136.1 5954.7 6127.9 6130.2 6133.2 6134.2 5864.9 5888.2 5889.0 5942.2 5943.5 6032.8 6079.6 6091.4 6101.9 6121.0 5516.7 5790.3 5799.5 5846.9 5859.0 5893.8 5965.0 5974.6 5987.8 6032.6 5769.1 5782.1 5782.2 5798.1 5806.2 5554.9 5639.4 5671.1 5771.7 5779.5 5452.9 5488.5 5544.1 5548.4 5669.9 5653.7 5717.6 5748.2 5756.7 5762.9 5433.4 5609.3 5610.1 5624.7 5625.4 10:15:39 INFO - PROCESS | 18251 | 10:15:39 INFO - PROCESS | 18251 | [#1] ext.html Cycles:180 Average:60406.08 Median:42373.18 stddev:120982.27 (285.5%) stddev-sans-first:121238.26 10:15:39 INFO - PROCESS | 18251 | Values: 576.0 629.8 636.7 650.9 655.6 42268.8 43714.0 43848.0 44044.1 46909.0 44960.8 45287.5 45460.3 45477.1 45619.8 8793.6 8988.5 8992.2 9007.2 9017.5 8842.5 8916.6 8945.8 8947.7 8954.1 9021.8 9059.8 9077.9 9078.0 9108.8 8953.1 8960.2 8995.0 9011.7 9018.9 8668.4 8745.3 8748.2 8761.8 8762.3 42538.8 42708.0 42992.8 43133.8 43270.8 3481.5 3638.4 3810.1 4049.2 4264.5 32243.7 32409.8 32857.8 33064.8 33888.0 4154.3 4186.6 4243.1 4254.7 4332.5 331397.0 333180.0 333587.3 334174.0 334725.0 59213.7 59293.0 59583.4 59690.0 59799.1 35229.5 35254.8 35440.8 37717.4 38018.4 17331.0 17527.7 17675.2 17691.9 17703.3 12606.2 12770.4 12834.8 12859.6 12901.4 19722.3 19724.9 19779.9 19942.0 20037.6 7335.7 7337.5 7355.1 7356.9 7539.7 1062.6 1153.9 1187.5 1195.9 1246.0 32718.3 33328.0 33437.3 33512.3 33753.0 1123.8 1186.9 1212.1 1218.8 1253.7 17314.8 17377.6 17487.0 17542.4 17721.4 560783.0 561669.0 571107.0 571110.0 571850.0 58176.7 58630.4 58794.0 58846.0 58943.4 1399.3 1433.5 1444.1 1444.7 1455.0 30826.5 32061.0 32628.5 32829.0 33256.5 51141.2 51725.5 52069.0 52119.5 52218.5 433798.0 435507.0 436179.0 436546.0 437002.0 27533.3 27847.7 28218.4 28274.2 28474.9 48518.5 48593.5 48983.5 49176.3 49917.3 41314.2 42248.8 42384.6 43109.4 43330.8 41646.7 42287.4 42361.8 42565.0 42650.4 36080.6 40862.2 41006.8 42175.0 42906.0 35593.3 36766.6 37381.3 37701.2 37782.4 28618.0 28784.1 28788.4 28979.7 29229.4 10:15:39 INFO - PROCESS | 18251 | 10:15:39 INFO - PROCESS | 18251 | [#2] jquery.html Cycles:180 Average:28720.47 Median:2286.47 stddev:81372.99 (3558.9%) stddev-sans-first:81573.44 10:15:39 INFO - PROCESS | 18251 | Values: 381.9 391.5 393.4 402.6 414.0 18274.0 19610.7 19781.3 19841.5 20798.5 12080.6 12756.6 12800.3 19496.6 19657.4 5076.8 5143.2 5299.0 5317.1 5345.2 5187.9 5233.9 5244.3 5254.8 5258.0 5057.6 5164.8 5223.2 5234.7 5244.5 5220.3 5223.8 5244.1 5253.7 5259.3 4879.8 5066.3 5089.4 5102.3 5121.3 13532.4 13682.3 14323.4 14326.9 14332.9 2135.4 2230.1 2342.9 2404.5 2593.7 10274.6 10363.8 10584.2 11559.4 13112.1 1798.4 1897.9 1916.4 1919.7 1921.2 81535.6 84423.0 84615.6 86957.0 87877.1 10895.7 11179.0 11426.6 11865.9 11918.6 15699.2 15762.9 15783.4 15787.5 15791.8 8153.2 8198.4 8208.4 8425.5 8479.1 7973.6 8021.5 8113.7 8175.9 8257.5 4398.6 4535.3 4583.6 4591.4 4675.1 1973.5 1987.1 2018.7 2021.8 2056.7 899.5 1025.4 1066.5 1083.8 1098.9 18987.7 19697.9 19965.7 20042.4 20078.9 1012.0 1048.6 1051.0 1068.3 1080.6 10540.2 11249.9 11276.0 11284.4 11289.8 485197.0 487212.0 495336.0 497723.0 501412.0 56095.4 76411.2 93342.5 97689.5 98505.5 954.3 964.0 983.2 987.2 1014.6 17623.6 17677.1 18176.7 18406.4 18488.3 40100.8 41853.4 42502.6 42503.4 44082.3 57193.7 57255.4 59926.7 61179.7 61301.4 8366.5 8422.0 8458.9 8719.4 9012.1 11577.3 12945.7 13049.3 13143.7 13197.4 11501.1 11639.5 12095.8 12320.8 12333.1 10525.8 11379.2 11490.3 11510.7 11682.9 11472.9 12244.9 12354.6 12481.9 12824.9 7653.9 7978.7 8017.0 8119.4 8337.6 8802.8 12083.2 12095.6 12131.3 12321.3 10:15:39 INFO - PROCESS | 18251 | 10:15:39 INFO - PROCESS | 18251 | [#3] mootools.html Cycles:180 Average:5640.76 Median:4766.55 stddev:3216.52 (67.5%) stddev-sans-first:3210.36 10:15:39 INFO - PROCESS | 18251 | Values: 1481.3 1484.8 1502.0 1550.0 1576.5 7803.3 8263.9 8715.9 8978.6 8980.1 8572.0 8591.4 8601.6 8625.4 8639.6 2289.4 2323.3 2326.1 2327.3 2333.1 2239.5 2242.9 2318.0 2321.2 2328.9 2245.9 2247.0 2278.0 2313.8 2318.7 2249.1 2251.3 2260.4 2261.3 2262.0 2184.9 2185.1 2202.6 2207.8 2215.6 8478.2 8568.4 8602.3 8603.5 8694.5 4949.7 4997.7 5000.6 5004.7 5009.9 3021.3 3107.3 3240.0 3243.8 3259.8 1063.8 1067.5 1073.3 1092.2 1095.0 11563.3 11570.1 11615.4 11617.4 11646.6 4296.9 4337.4 4401.6 4415.8 4435.0 9840.5 9884.2 9924.0 9931.3 9947.7 5026.4 5087.7 5090.1 5098.4 5099.4 4120.1 4582.3 4596.6 4693.1 4694.8 3838.6 3840.0 3975.3 4003.6 4006.7 1199.5 1212.0 1214.9 1219.8 1221.4 959.3 974.4 976.8 994.1 1011.1 5707.9 5832.8 5837.7 5940.1 6088.1 430.0 431.4 444.6 450.9 455.0 4031.8 4076.4 4115.0 4141.2 4197.1 10237.5 10492.2 10587.2 10666.6 10671.4 10478.5 10484.5 10490.5 10492.7 10522.4 7708.4 7995.9 8043.0 8096.8 8107.3 6063.6 6200.8 6230.2 6352.3 6417.7 9786.9 9802.7 9934.5 9961.1 10044.0 9986.6 10153.8 10200.5 10283.9 10672.8 7106.5 7255.3 7417.0 7611.5 7740.7 8353.9 8357.6 8364.2 8403.0 8425.5 7338.7 7543.4 7569.2 7587.4 7626.1 7260.9 7326.4 7436.4 7465.0 7473.2 6801.2 6816.7 6817.5 6842.9 6868.9 4838.3 5006.9 5049.2 5124.8 5145.3 4956.6 5043.1 5107.4 5223.2 5249.3 10:15:39 INFO - PROCESS | 18251 | 10:15:39 INFO - PROCESS | 18251 | [#4] prototype.html Cycles:180 Average:4840.28 Median:5442.92 stddev:1440.35 (26.5%) stddev-sans-first:1403.88 10:15:39 INFO - PROCESS | 18251 | Values: 321.4 336.8 340.4 343.2 346.4 5370.7 5407.8 5610.9 5618.8 5727.8 5524.8 5542.1 5570.4 5587.3 5598.2 4344.1 4369.1 4381.7 4392.7 4397.9 4147.3 4379.0 4400.3 4432.4 4436.2 4213.0 4252.4 4276.3 4297.2 4331.7 4268.6 4312.1 4342.8 4353.9 4362.4 3726.0 3777.9 3822.7 3823.3 3839.0 5378.2 5401.9 5406.4 5428.8 5429.5 4934.5 4937.8 4943.4 4953.7 4973.3 5486.3 5779.8 5783.1 5820.2 5859.9 4061.3 4100.0 4118.7 4133.5 4144.9 6036.2 6056.8 6097.0 6098.9 6126.8 4164.7 4228.8 4245.3 4259.2 4291.9 4233.4 4251.3 4275.7 4282.5 4290.9 4894.4 4916.5 4932.1 4947.5 4969.3 5771.2 5905.6 5921.6 5934.9 5953.3 1457.4 1485.8 1492.6 1492.6 1496.5 908.8 932.6 933.2 933.5 950.6 5009.5 5088.6 5095.3 5105.5 5130.7 5406.4 5425.8 5433.2 5444.9 5479.3 4936.0 4957.8 5054.4 5123.6 5129.7 2857.5 2883.4 2890.5 2905.3 2908.8 5440.9 5499.0 5552.7 5568.6 5605.8 5491.0 5712.7 6121.0 6157.2 6217.3 6167.7 6175.8 6223.6 6240.9 6260.6 5915.7 5984.3 5998.9 6060.5 6154.7 5950.8 5967.2 5972.0 5978.3 5996.3 5669.9 6156.8 6258.3 6279.7 6288.8 4070.3 4158.6 4178.5 4179.6 4191.0 6028.6 6032.5 6054.8 6106.3 6119.8 5683.2 5784.9 5852.7 5876.9 5909.8 5795.7 5798.4 5831.0 5851.3 5904.3 5663.8 5697.1 5773.5 5800.2 5800.6 5655.3 5892.2 5918.3 5938.7 6009.6 5779.6 5819.4 5848.8 5856.4 5884.2 10:15:39 INFO - PROCESS | 18251 | 10:15:39 INFO - PROCESS | 18251 | [#5] yui.html Cycles:180 Average:20223.20 Median:4794.13 stddev:29531.39 (616.0%) stddev-sans-first:29577.94 10:15:39 INFO - PROCESS | 18251 | Values: 724.7 763.9 779.2 779.5 814.8 14799.2 15964.9 15987.8 16074.6 16087.0 14426.4 14532.6 14554.2 14564.3 14588.2 676.8 793.1 803.7 810.7 819.4 818.7 823.0 824.8 827.4 827.9 872.8 876.9 877.3 879.8 880.1 878.9 879.2 879.5 879.7 880.2 632.8 635.7 636.1 637.7 639.0 14637.8 14701.1 14715.2 14803.1 14807.8 15039.0 15105.4 15114.7 15256.8 15449.4 12098.8 12221.9 12265.4 12340.1 12788.7 3698.7 3786.9 3888.1 3964.1 4046.8 72449.6 74519.6 74524.6 74689.6 75451.0 11430.5 11614.7 11669.9 11682.1 11968.2 20358.4 20391.0 20417.0 20449.0 20468.6 8274.9 8375.4 8443.6 8506.0 8647.4 4751.4 4766.0 4791.5 4796.7 4832.2 3419.2 3511.4 3517.2 3518.7 3519.8 605.8 614.7 622.4 625.1 633.6 583.3 620.6 666.8 679.7 683.7 7709.5 7782.8 7808.3 7867.7 7975.8 564.0 632.9 697.5 697.8 740.7 4322.4 4324.9 4417.2 4453.9 4554.2 64766.7 113569.0 115434.4 116138.0 119361.4 96740.0 97030.0 97411.5 97446.0 100659.5 86074.0 86388.6 88469.0 89834.0 91196.5 8230.6 8305.7 8388.7 8412.1 8449.2 52180.0 52522.2 52579.0 52766.7 54982.0 69996.0 76731.2 77011.6 77585.6 78123.0 10611.5 10681.5 10764.4 10891.0 11270.7 12462.4 12540.4 12586.7 13236.5 13385.9 11348.9 11396.8 11830.2 12029.3 12123.5 11656.8 11675.6 11997.2 12086.5 12169.3 11873.2 11889.5 11916.5 12136.2 12645.7 9831.0 9930.1 10018.4 10339.9 10357.6 10339.8 10569.5 10639.8 10660.2 10697.9 10:15:39 INFO - PROCESS | 18251 | -------- Summary: end -------- 10:15:39 INFO - PROCESS | 18251 | 10:15:40 INFO - TEST-INFO | 18251: exit 0 10:15:40 INFO - TEST-OK | dromaeo_css | took 1111672ms 10:15:40 INFO - TEST-START | kraken 10:15:40 INFO - operating with platform_type : linux_ 10:15:40 INFO - Initialising browser for kraken test... 10:15:40 INFO - TEST-INFO | started process 18482 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw4P_Eq/profile http://localhost:44524/getInfo.html) 10:15:45 INFO - PROCESS | 18482 | __metrics Screen width/height:1600/1200 10:15:45 INFO - PROCESS | 18482 | colorDepth:24 10:15:45 INFO - PROCESS | 18482 | Browser inner width/height: 1024/697 10:15:45 INFO - PROCESS | 18482 | __metrics 10:15:45 ERROR - PROCESS | 18482 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 10:15:46 INFO - TEST-INFO | 18482: exit 0 10:15:46 INFO - Browser initialized. 10:15:46 INFO - Running cycle 1/1 for kraken test... 10:15:46 INFO - TEST-INFO | started process 18601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw4P_Eq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:15:58 INFO - PROCESS | 18601 | RSS: Main: 166924288 10:15:58 INFO - PROCESS | 18601 | 10:16:01 INFO - PROCESS | 18601 | Cycle 1(1): loaded http://localhost:44524/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44524/tests/kraken/driver.html?testName=audio-beat-detection) 10:16:01 INFO - PROCESS | 18601 | RSS: Main: 172175360 10:16:01 INFO - PROCESS | 18601 | 10:16:04 INFO - PROCESS | 18601 | Cycle 1(1): loaded http://localhost:44524/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44524/tests/kraken/driver.html?testName=audio-dft) 10:16:05 INFO - PROCESS | 18601 | RSS: Main: 171659264 10:16:05 INFO - PROCESS | 18601 | 10:16:08 INFO - PROCESS | 18601 | Cycle 1(1): loaded http://localhost:44524/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44524/tests/kraken/driver.html?testName=audio-fft) 10:16:08 INFO - PROCESS | 18601 | RSS: Main: 166346752 10:16:08 INFO - PROCESS | 18601 | 10:16:10 INFO - PROCESS | 18601 | Cycle 1(1): loaded http://localhost:44524/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44524/tests/kraken/driver.html?testName=audio-oscillator) 10:16:11 INFO - PROCESS | 18601 | RSS: Main: 167333888 10:16:11 INFO - PROCESS | 18601 | 10:16:13 INFO - PROCESS | 18601 | Cycle 1(1): loaded http://localhost:44524/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44524/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:16:14 INFO - PROCESS | 18601 | RSS: Main: 167268352 10:16:14 INFO - PROCESS | 18601 | 10:16:17 INFO - PROCESS | 18601 | Cycle 1(1): loaded http://localhost:44524/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44524/tests/kraken/driver.html?testName=imaging-darkroom) 10:16:18 INFO - PROCESS | 18601 | RSS: Main: 167317504 10:16:18 INFO - PROCESS | 18601 | 10:16:21 INFO - PROCESS | 18601 | Cycle 1(1): loaded http://localhost:44524/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44524/tests/kraken/driver.html?testName=imaging-desaturate) 10:16:22 INFO - PROCESS | 18601 | RSS: Main: 165498880 10:16:22 INFO - PROCESS | 18601 | 10:16:24 INFO - PROCESS | 18601 | Cycle 1(1): loaded http://localhost:44524/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44524/tests/kraken/driver.html?testName=json-parse-financial) 10:16:25 INFO - PROCESS | 18601 | RSS: Main: 167731200 10:16:25 INFO - PROCESS | 18601 | 10:16:27 INFO - PROCESS | 18601 | Cycle 1(1): loaded http://localhost:44524/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44524/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:16:27 INFO - PROCESS | 18601 | RSS: Main: 167989248 10:16:27 INFO - PROCESS | 18601 | 10:16:29 INFO - PROCESS | 18601 | Cycle 1(1): loaded http://localhost:44524/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44524/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:16:30 INFO - PROCESS | 18601 | RSS: Main: 168083456 10:16:30 INFO - PROCESS | 18601 | 10:16:32 INFO - PROCESS | 18601 | Cycle 1(1): loaded http://localhost:44524/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44524/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:16:32 INFO - PROCESS | 18601 | RSS: Main: 168206336 10:16:32 INFO - PROCESS | 18601 | 10:16:35 INFO - PROCESS | 18601 | Cycle 1(1): loaded http://localhost:44524/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44524/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:16:36 INFO - PROCESS | 18601 | RSS: Main: 168456192 10:16:36 INFO - PROCESS | 18601 | 10:16:38 INFO - PROCESS | 18601 | Cycle 1(1): loaded http://localhost:44524/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44524/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:16:39 INFO - PROCESS | 18601 | RSS: Main: 168235008 10:16:39 INFO - PROCESS | 18601 | 10:16:41 INFO - PROCESS | 18601 | Cycle 1(1): loaded http://localhost:44524/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44524/tests/kraken/driver.html?testName=ai-astar) 10:16:41 INFO - PROCESS | 18601 | RSS: Main: 169013248 10:16:41 INFO - PROCESS | 18601 | 10:16:41 INFO - PROCESS | 18601 | __start_tp_report 10:16:41 INFO - PROCESS | 18601 | _x_x_mozilla_page_load 10:16:41 INFO - PROCESS | 18601 | _x_x_mozilla_page_load_details 10:16:41 INFO - PROCESS | 18601 | |i|pagename|runs| 10:16:41 INFO - PROCESS | 18601 | |0;ai-astar;111;106;111;111;111;113;111;110;115;112 10:16:41 INFO - PROCESS | 18601 | |1;audio-beat-detection;156;129;155;176;136;155;154;130;191;126 10:16:41 INFO - PROCESS | 18601 | |2;audio-dft;162;162;162;166;163;165;175;163;163;162 10:16:41 INFO - PROCESS | 18601 | |3;audio-fft;74;76;76;162;74;79;75;77;157;75 10:16:41 INFO - PROCESS | 18601 | |4;audio-oscillator;85;85;153;85;86;86;140;85;85;152 10:16:41 INFO - PROCESS | 18601 | |5;imaging-gaussian-blur;117;118;117;118;117;117;117;118;118;116 10:16:41 INFO - PROCESS | 18601 | |6;imaging-darkroom;151;147;149;147;147;148;148;148;146;147 10:16:41 INFO - PROCESS | 18601 | |7;imaging-desaturate;94;97;96;95;96;96;96;96;96;94 10:16:41 INFO - PROCESS | 18601 | |8;json-parse-financial;55;54;53;52;56;54;53;53;53;58 10:16:41 INFO - PROCESS | 18601 | |9;json-stringify-tinderbox;62;62;69;61;62;62;61;62;62;62 10:16:41 INFO - PROCESS | 18601 | |10;stanford-crypto-aes;78;80;79;85;80;81;81;82;103;81 10:16:41 INFO - PROCESS | 18601 | |11;stanford-crypto-ccm;126;125;120;121;125;130;132;131;144;132 10:16:41 INFO - PROCESS | 18601 | |12;stanford-crypto-pbkdf2;166;169;165;164;162;159;162;172;166;160 10:16:41 INFO - PROCESS | 18601 | |13;stanford-crypto-sha256-iterative;69;64;65;62;63;64;64;63;62;69 10:16:41 INFO - PROCESS | 18601 | __end_tp_report 10:16:41 INFO - PROCESS | 18601 | __start_cc_report 10:16:41 INFO - PROCESS | 18601 | _x_x_mozilla_cycle_collect,883 10:16:41 INFO - PROCESS | 18601 | __end_cc_report 10:16:41 INFO - PROCESS | 18601 | __startTimestamp1465319801468__endTimestamp 10:16:41 INFO - PROCESS | 18601 | 10:16:41 INFO - PROCESS | 18601 | ------- Summary: start ------- 10:16:41 INFO - PROCESS | 18601 | Number of tests: 14 10:16:41 INFO - PROCESS | 18601 | 10:16:41 INFO - PROCESS | 18601 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:2.28 (2.1%) stddev-sans-first:2.42 10:16:41 INFO - PROCESS | 18601 | Values: 111.0 106.0 111.0 111.0 111.0 113.0 111.0 110.0 115.0 112.0 10:16:41 INFO - PROCESS | 18601 | 10:16:41 INFO - PROCESS | 18601 | [#1] audio-beat-detection Cycles:10 Average:150.80 Median:155.00 stddev:21.25 (13.7%) stddev-sans-first:22.46 10:16:41 INFO - PROCESS | 18601 | Values: 156.0 129.0 155.0 176.0 136.0 155.0 154.0 130.0 191.0 126.0 10:16:41 INFO - PROCESS | 18601 | 10:16:41 INFO - PROCESS | 18601 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.00 stddev:4.00 (2.5%) stddev-sans-first:4.16 10:16:41 INFO - PROCESS | 18601 | Values: 162.0 162.0 162.0 166.0 163.0 165.0 175.0 163.0 163.0 162.0 10:16:41 INFO - PROCESS | 18601 | 10:16:41 INFO - PROCESS | 18601 | [#3] audio-fft Cycles:10 Average:92.50 Median:75.50 stddev:35.36 (46.8%) stddev-sans-first:36.87 10:16:41 INFO - PROCESS | 18601 | Values: 74.0 76.0 76.0 162.0 74.0 79.0 75.0 77.0 157.0 75.0 10:16:41 INFO - PROCESS | 18601 | 10:16:41 INFO - PROCESS | 18601 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:85.00 stddev:30.65 (36.1%) stddev-sans-first:31.71 10:16:41 INFO - PROCESS | 18601 | Values: 85.0 85.0 153.0 85.0 86.0 86.0 140.0 85.0 85.0 152.0 10:16:41 INFO - PROCESS | 18601 | 10:16:41 INFO - PROCESS | 18601 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 10:16:41 INFO - PROCESS | 18601 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 116.0 10:16:41 INFO - PROCESS | 18601 | 10:16:41 INFO - PROCESS | 18601 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.40 (0.9%) stddev-sans-first:0.88 10:16:41 INFO - PROCESS | 18601 | Values: 151.0 147.0 149.0 147.0 147.0 148.0 148.0 148.0 146.0 147.0 10:16:41 INFO - PROCESS | 18601 | 10:16:41 INFO - PROCESS | 18601 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.97 (1.0%) stddev-sans-first:0.83 10:16:41 INFO - PROCESS | 18601 | Values: 94.0 97.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 94.0 10:16:41 INFO - PROCESS | 18601 | 10:16:41 INFO - PROCESS | 18601 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.79 (3.3%) stddev-sans-first:1.87 10:16:41 INFO - PROCESS | 18601 | Values: 55.0 54.0 53.0 52.0 56.0 54.0 53.0 53.0 53.0 58.0 10:16:41 INFO - PROCESS | 18601 | 10:16:41 INFO - PROCESS | 18601 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.00 stddev:2.32 (3.7%) stddev-sans-first:2.46 10:16:41 INFO - PROCESS | 18601 | Values: 62.0 62.0 69.0 61.0 62.0 62.0 61.0 62.0 62.0 62.0 10:16:41 INFO - PROCESS | 18601 | 10:16:41 INFO - PROCESS | 18601 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:81.00 stddev:7.27 (9.0%) stddev-sans-first:7.49 10:16:41 INFO - PROCESS | 18601 | Values: 78.0 80.0 79.0 85.0 80.0 81.0 81.0 82.0 103.0 81.0 10:16:41 INFO - PROCESS | 18601 | 10:16:41 INFO - PROCESS | 18601 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:130.50 stddev:6.93 (5.3%) stddev-sans-first:7.29 10:16:41 INFO - PROCESS | 18601 | Values: 126.0 125.0 120.0 121.0 125.0 130.0 132.0 131.0 144.0 132.0 10:16:41 INFO - PROCESS | 18601 | 10:16:41 INFO - PROCESS | 18601 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:165.50 stddev:4.01 (2.4%) stddev-sans-first:4.21 10:16:41 INFO - PROCESS | 18601 | Values: 166.0 169.0 165.0 164.0 162.0 159.0 162.0 172.0 166.0 160.0 10:16:41 INFO - PROCESS | 18601 | 10:16:41 INFO - PROCESS | 18601 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.00 stddev:2.55 (4.0%) stddev-sans-first:2.12 10:16:41 INFO - PROCESS | 18601 | Values: 69.0 64.0 65.0 62.0 63.0 64.0 64.0 63.0 62.0 69.0 10:16:41 INFO - PROCESS | 18601 | -------- Summary: end -------- 10:16:41 INFO - PROCESS | 18601 | 10:16:42 INFO - TEST-INFO | 18601: exit 0 10:16:42 INFO - TEST-OK | kraken | took 61869ms 10:16:42 INFO - SUITE-END | took 1173s 10:16:42 INFO - Completed test suite (00:19:33) 10:16:42 INFO - javascript benchmark 10:16:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7210.534771103314, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3124.7500199984, 3156.8263745493987, 3162.8892988745397, 3178.729807966323, 3200.055983484872, 5343.064963631364, 5407.945920540794, 5416.2958815353995, 5480.506754392104, 5545.195946587743, 5425.565954723623, 5487.533559647435, 5512.972435137829, 5559.749811258493, 5561.4716601922755, 4979.278004689327, 4991.925121123186, 5120.462351453081, 5147.6911385317, 5153.201253805666, 5034.874128146807, 5211.504907033845, 5247.47525247476, 5249.790008399659, 5252.448492908228, 4959.57843583294, 4964.0816448956875, 4982.451930287665, 5006.799728010875, 5038.118329292396, 5048.772805223737, 5060.418051924039, 5060.7722652480725, 5063.088644044071, 5104.923426148611, 5006.098902197603, 5035.647504674675, 5043.268726034741, 5052.621053421009, 5078.339815823956, 5361.115415956362, 5405.918911216335, 5409.0534156522845, 5409.9459005409835, 5455.399906010336, 5886.440788125121, 5927.911081333784, 5934.762609495615, 5935.643861368331, 5953.047512397996, 5731.226284451587, 5900.911486327708, 5925.170476133345, 5939.198208241875, 5947.672877991708, 5531.059719847595, 5572.080606699889, 5594.692291923902, 5596.86007849807, 5641.774329026834, 6076.179715738319, 6116.92953733095, 6157.568970172135, 6160.414760597736, 6167.537434692416, 5650.152477128464, 5713.285839270091, 5750.2237197978575, 5846.444587764156, 5897.852553686106, 5880.882382352414, 5889.293284805851, 5893.970530147321, 5900.1739756434135, 5920.79277225295, 5711.714414279352, 5824.068149096124, 5866.823995280149, 5892.469677729025, 5894.410558944157, 5865.0, 5929.555283353766, 5932.228810254725, 5944.494717948936, 5976.193213916153, 4489.910201796011, 4497.88755281114, 4511.142882852248, 4513.458384993822, 4515.051839113823, 3935.2719746846924, 3946.4869566956113, 3982.7212095153063, 3999.3800960851113, 4009.51885773709, 5614.242077319591, 5640.069388550925, 5649.68926709035, 5664.575156863251, 5678.829635110953, 5961.195238642815, 5965.582409231312, 5970.522358211333, 5989.401059893976, 6007.939920600826, 5516.282883225155, 5647.802326918538, 5667.064934285879, 5676.120201368794, 5735.971320143372, 5097.566706829887, 5109.74451277442, 5111.335526381621, 5115.360579927509, 5136.101182293084, 5954.672493012926, 6127.908081378783, 6130.172426722335, 6133.202683651097, 6134.171886795226, 5864.912026319608, 5888.17565540816, 5889.0, 5942.168096466412, 5943.465088142088, 6032.758689652364, 6079.574429789872, 6091.360407157184, 6101.938980610137, 6121.0, 5516.724163791714, 5790.276215473066, 5799.478046975623, 5846.94153058464, 5859.0, 5893.793717219876, 5964.970175149097, 5974.61165024272, 5987.7604895805425, 6032.638041717511, 5769.134629805562, 5782.10377391505, 5782.1615865698395, 5798.072308430631, 5806.158107074366, 5554.861128471821, 5639.407862174577, 5671.120976248523, 5771.68255745938, 5779.508741756998, 5452.863678408072, 5488.451154884479, 5544.140658197985, 5548.389677135593, 5669.886602267849, 5653.689047102449, 5717.571182161271, 5748.223989761329, 5756.65460072397, 5762.855928601818, 5433.429489903503, 5609.27079479665, 5610.074337734228, 5624.6625202487985, 5625.437456254342], "value": 5438.733076801301, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.9546423241816, 629.8299459146028, 636.6752955992444, 650.8665723526677, 655.6426747422655, 42268.78865605671, 43714.0, 43848.0, 44044.119117617665, 46909.0, 44960.77519612406, 45287.54712452875, 45460.3180952286, 45477.0904581909, 45619.77190114053, 8793.648254069829, 8988.460692358447, 8992.23565996891, 9007.189352958232, 9017.504037277948, 8842.5136617486, 8916.554172291391, 8945.776355591097, 8947.731568052968, 8954.14935581122, 9021.819563608724, 9059.818803623924, 9077.863832042525, 9077.95461022694, 9108.817823643556, 8953.05992870749, 8960.238379737697, 8994.955025224832, 9011.684591039348, 9018.864717029217, 8668.436551624125, 8745.300375969971, 8748.168923952215, 8761.824763504757, 8762.342824288204, 42538.78730606327, 42708.0, 42992.78503607493, 43133.78433107846, 43270.78364608188, 3481.495183198447, 3638.3814751492046, 3810.1046254130256, 4049.2104039712267, 4264.488261408651, 32243.6775632243, 32409.83795081033, 32857.835710821535, 33064.83467582671, 33888.0, 4154.31453810121, 4186.623203911662, 4243.130158317537, 4254.659627229814, 4332.501762297345, 331397.0, 333180.0, 333587.3320633406, 334174.0, 334725.0, 59213.70393148093, 59293.0, 59583.40416595865, 59690.0, 59799.103013454835, 35229.47155792665, 35254.82372588121, 35440.822795885855, 37717.43423848644, 38018.42972355417, 17331.0, 17527.73708394375, 17675.204615792063, 17691.93848369102, 17703.29186832538, 12606.243625382507, 12770.425330859947, 12834.80747788784, 12859.614211573667, 12901.419436125398, 19722.30971915976, 19724.90137549332, 19779.90110049469, 19942.0, 20037.599248014958, 7335.743248986367, 7337.523061001018, 7355.117385913724, 7356.926430735732, 7539.698412063456, 1062.6493257225097, 1153.8730739618636, 1187.4597058338436, 1195.9282443053444, 1246.0, 32718.345633087203, 33328.0, 33437.33125337528, 33512.32975340528, 33753.0, 1123.775244951013, 1186.887245711656, 1212.1030437476381, 1218.8049912014035, 1253.724180680249, 17314.826851731574, 17377.595424592815, 17487.0, 17542.386016489618, 17721.379751708628, 560783.0, 561669.0, 571107.0, 571110.0, 571850.0, 58176.70911645415, 58630.413695863346, 58794.0, 58846.0, 58943.41056589465, 1399.3423091147145, 1433.4552869909367, 1444.1046551138152, 1444.7182799354234, 1454.978175327371, 30826.53760193554, 32061.0, 32628.510572340958, 32829.0, 33256.501152483215, 51141.23288150755, 51725.48274517206, 52069.0, 52119.47880521146, 52218.47781522136, 433798.0, 435507.0, 436179.0, 436546.0, 437002.0, 27533.31166720848, 27847.721522785323, 28218.435631286848, 28274.151775446768, 28474.85762571174, 48518.5148148514, 48593.5140648589, 48983.510164897896, 49176.2623560654, 49917.25124123068, 41314.1737165261, 42248.78875605603, 42384.576154238064, 43109.35335970025, 43330.783346083066, 41646.70897696902, 42287.3508162697, 42361.78819105885, 42565.0, 42650.36024459574, 36080.63919360773, 40862.182756345304, 41006.79496602498, 42175.0, 42906.0, 35593.28813423665, 36766.63233367739, 37381.25237495181, 37701.24597507979, 37782.43326350162, 28618.0, 28784.136475905758, 28788.42423151567, 28979.710202898543, 29229.415411692073], "value": 20316.433901201726, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.883525524715, 391.4656493885843, 393.44327776196684, 402.6074577287145, 414.0146451445559, 18274.0, 19610.705839412385, 19781.307654232103, 19841.503962400948, 20798.48003799906, 12080.637580872566, 12756.55352062678, 12800.295983720891, 19496.610067798636, 19657.410277691655, 5076.796928122871, 5143.202803565453, 5299.046171689114, 5317.096093664067, 5345.224942383372, 5187.922181167285, 5233.921491177635, 5244.344456942882, 5254.81608143715, 5257.973710131463, 5057.620678449112, 5164.793408263684, 5223.190405487137, 5234.7120908350025, 5244.527992480676, 5220.29526013987, 5223.843284701465, 5244.134717771563, 5253.684778913277, 5259.342582177228, 4879.780409881564, 5066.341375621146, 5089.440161582223, 5102.260172275, 5121.308623335839, 13532.391042403115, 13682.31588420585, 14323.427062917472, 14326.856731432656, 14332.856671433257, 2135.444784356063, 2230.052227803177, 2342.8945697443655, 2404.483036147219, 2593.6628238328894, 10274.589016439333, 10363.79272414555, 10584.153267738562, 11559.364234967074, 13112.147710398793, 1798.3975368251652, 1897.943061708151, 1916.3867562380044, 1919.654462196804, 1921.2411097616364, 81535.5923220386, 84423.0, 84615.576922115, 86957.0, 87877.12122878754, 10895.673129806119, 11179.0, 11426.600068997544, 11865.88134118665, 11918.642440726791, 15699.215039247993, 15762.921185394229, 15783.447579334668, 15787.526374208792, 15791.842081579267, 8153.22544358285, 8198.42611017235, 8208.384371172186, 8425.536595487307, 8479.109693482218, 7973.60131993398, 8021.478603890729, 8113.6754529818145, 8175.918240817516, 8257.504549727035, 4398.560143985575, 4535.319702044654, 4583.593613353017, 4591.380163677927, 4675.064987002613, 1973.457299242691, 1987.125664707524, 2018.7072874433125, 2021.8079282468143, 2056.6812144117685, 899.5457294066455, 1025.4206373399006, 1066.5253961986841, 1083.7778255457613, 1098.9395583242838, 18987.71518427225, 19697.901510492644, 19965.700514492295, 20042.39872803818, 20078.89960550188, 1012.0335079998583, 1048.5858086055964, 1051.0488008352454, 1068.2842495528014, 1080.6433876820631, 10540.209484288709, 11249.887501125047, 11276.0, 11284.379359135326, 11289.830652540219, 485197.0, 487212.0, 495336.0, 497723.0, 501412.0, 56095.43904560984, 76411.23588764152, 93342.53328733314, 97689.51155244178, 98505.50747246218, 954.2795189631784, 963.9710808675751, 983.1544871410581, 987.1707765477033, 1014.60430432133, 17623.559411014314, 17677.116144192994, 18176.727349090037, 18406.35577754772, 18488.260469581604, 40100.7994960035, 41853.372199417645, 42502.57497424986, 42503.3624495639, 44082.33876491791, 57193.714031429576, 57255.42744572501, 59926.70036649789, 61179.69410152921, 61301.38698612957, 8366.539840308842, 8421.957460418911, 8458.915410846059, 8719.433236839584, 9012.143846334588, 11577.305361678325, 12945.676358091123, 13049.28228947417, 13143.737125257632, 13197.406116724962, 11501.137414694098, 11639.5344186235, 12095.75808483843, 12320.753584928072, 12333.075019373404, 10525.78948421012, 11379.155211197201, 11490.310581365145, 11510.654680359603, 11682.94158529202, 11472.885271147516, 12244.938775306422, 12354.567590134302, 12481.875181248071, 12824.935875320936, 7653.885191722017, 7978.680852765824, 8017.037955445384, 8119.350451963947, 8337.583120843812, 8802.779930501789, 12083.214591051554, 12095.57665481704, 12131.332776697367, 12321.322327272086], "value": 8996.924498107177, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1481.2963842174968, 1484.7698606715956, 1501.9624509387263, 1549.9535013949583, 1576.5349221979516, 7803.3367163791145, 8263.91736082639, 8715.869261961068, 8978.640854365825, 8980.101989801025, 8571.957140214306, 8591.398602097841, 8601.612927418266, 8625.353098517606, 8639.611217495212, 2289.427643089228, 2323.2797832671927, 2326.081197926818, 2327.290176496168, 2333.0551126793675, 2239.54089411671, 2242.932712018642, 2318.026428899866, 2321.1759825262043, 2328.906843726249, 2245.9438514037197, 2247.0225451928463, 2278.04322184682, 2313.838031337807, 2318.7449380568123, 2249.089118906837, 2251.2570851618925, 2260.4461906832767, 2261.2876943762662, 2262.0273282488524, 2184.923527676524, 2185.0604240176717, 2202.5815095131875, 2207.812335951446, 2215.590115828577, 8478.23695867375, 8568.357373197035, 8602.2688071514, 8603.526806025666, 8694.521801300925, 4949.7030178189425, 4997.6501644884875, 5000.599832047033, 5004.724740139291, 5009.874753131201, 3021.305099827052, 3107.300857307088, 3240.0279916025097, 3243.8053716777067, 3259.7718159728593, 1063.8191507443676, 1067.503610820972, 1073.3452593917705, 1092.2136062035322, 1095.0308976555805, 11563.306201627845, 11570.074394048455, 11615.361155136465, 11617.419129043514, 11646.59236926712, 4296.914061718748, 4337.37108119321, 4401.6478681705385, 4415.757133357696, 4435.046465010038, 9840.507974601242, 9884.209263258923, 9924.0, 9931.255155863339, 9947.651832185838, 5026.421961474477, 5087.745612719349, 5090.083784918676, 5098.439171691111, 5099.388073431212, 4120.093579412524, 4582.335561343653, 4596.5863072323655, 4693.084848454587, 4694.835680751157, 3838.558565764917, 3839.9616003839606, 3975.284448799244, 4003.579624139482, 4006.6794656427414, 1199.5201919232202, 1212.0485418946084, 1214.8906598406186, 1219.762146381447, 1221.3770976801895, 959.2853324273461, 974.4056125763278, 976.829054915387, 994.1053052252886, 1011.0546638892512, 5707.885842283131, 5832.825015249549, 5837.708114594253, 5940.108983652487, 6088.086786981989, 429.954854740254, 431.38958373901204, 444.5732097186672, 450.9301058335963, 454.99317510237375, 4031.7984100794843, 4076.4089207065404, 4114.979425102915, 4141.233871733739, 4197.076643138505, 10237.539310731036, 10492.21308401873, 10587.205959553065, 10666.573337066586, 10671.35971841692, 10478.476076196159, 10484.475776211159, 10490.527926243338, 10492.685219443429, 10522.421266830397, 7708.383329333752, 7995.920040799518, 8043.034835819856, 8096.797580060545, 8107.270345668918, 6063.575549711654, 6200.7519699211525, 6230.221222347207, 6352.301246862934, 6417.743290268337, 9786.902130978884, 9802.65690700822, 9934.503274836085, 9961.053699898497, 10044.045815647502, 9986.550605222928, 10153.796924061626, 10200.540975655966, 10283.94858025735, 10672.83990740155, 7106.467014973794, 7255.310745479171, 7417.0, 7611.467197296136, 7740.690372385042, 8353.874691879748, 8357.582120894052, 8364.163583641588, 8403.0, 8425.536595487307, 7338.743143989935, 7543.3965282778345, 7569.205233450409, 7587.430942679432, 7626.122995855548, 7260.854782904418, 7326.3772579329225, 7436.405087593088, 7464.962675186589, 7473.215312392121, 6801.2178599461695, 6816.693248803716, 6817.488688348294, 6842.93157068423, 6868.862622747417, 4838.274258861199, 5006.949930500648, 5049.2173713074535, 5124.846254612367, 5145.279660847559, 4956.553910148104, 5043.092243396224, 5107.361579802525, 5223.21651752225, 5249.2651028855225], "value": 4436.883634772706, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.41342050757356, 336.7558520072947, 340.4433750817414, 343.24828625310573, 346.3920818962723, 5370.7046112463795, 5407.756650950707, 5610.859728506784, 5618.803341883035, 5727.770889164433, 5524.751386187621, 5542.115680668572, 5570.384588469349, 5587.329520457541, 5598.244237028, 4344.131173765251, 4369.1480161368545, 4381.693281470299, 4392.736435813861, 4397.890052748691, 4147.294959856817, 4378.956210437903, 4400.317950717644, 4432.445944256968, 4436.2458382074965, 4212.978935105336, 4252.447181866353, 4276.337167739005, 4297.183535128332, 4331.7400955942585, 4268.59448352406, 4312.137572485515, 4342.761148136851, 4353.9129217415475, 4362.411074504965, 3725.9879664980876, 3777.924441511182, 3822.6750726188307, 3823.254465379252, 3838.9616103838885, 5378.220158077096, 5401.864953376197, 5406.351237851443, 5428.805662754227, 5429.511343979021, 4934.481879402647, 4937.80248790048, 4943.382077240345, 4953.727544985024, 4973.254011898208, 5486.259354987065, 5779.826605201851, 5783.103618939072, 5820.214271073435, 5859.8535036624, 4061.289274376972, 4100.0, 4118.670506359484, 4133.524644665842, 4144.91710165798, 6036.245469316335, 6056.788012419544, 6096.957519231063, 6098.871708733898, 6126.816195514097, 4164.68764842638, 4228.809703563347, 4245.257080010986, 4259.233337999128, 4291.914161716811, 4233.428487154257, 4251.341042138473, 4275.679324050709, 4282.528921818597, 4290.914181716348, 4894.363732714724, 4916.483769204254, 4932.136876046749, 4947.455779864212, 4969.2546118081855, 5771.1820776456125, 5905.586608937419, 5921.555883308769, 5934.910976335358, 5953.3451320354725, 1457.358762144653, 1485.7771334299725, 1492.5895378770708, 1492.604459818149, 1496.5211132437732, 908.8454962656365, 932.5896605493562, 933.1927882381826, 933.495912207414, 950.619752099152, 5009.474005229471, 5088.59291256706, 5095.274028394791, 5105.5149760772665, 5130.716831010164, 5406.378266499324, 5425.829668132778, 5433.185022246695, 5444.891102177934, 5479.315085614298, 4936.012817216214, 4957.7769000395065, 5054.393472783289, 5123.641345105807, 5129.743512824344, 2857.4570831542355, 2883.370895444067, 2890.479713651521, 2905.288204389938, 2908.7963842531244, 5440.939016891668, 5499.0, 5552.666839989613, 5568.6101972862325, 5605.831825045255, 5491.0, 5712.742926568314, 6120.969395152996, 6157.168782214344, 6217.316095229521, 6167.722452489649, 6175.783847565313, 6223.595466294767, 6240.906386404207, 6260.593061450991, 5915.674637894785, 5984.31180414258, 5998.920194364881, 6060.454559089703, 6154.723037463235, 5950.821475355746, 5967.180010096962, 5971.970140149271, 5978.252718410199, 5996.310424301087, 5669.943300567106, 6156.753729850935, 6258.280297765815, 6279.654618995816, 6288.8427789303805, 4070.3487442009136, 4158.625723684762, 4178.477690288714, 4179.644730197846, 4190.958090419057, 6028.57799953999, 6032.457078862748, 6054.788082417094, 6106.297775755845, 6119.84700382494, 5683.1529752829665, 5784.946344047802, 5852.678102704393, 5876.853078673067, 5909.793157239476, 5795.710214489174, 5798.362180160263, 5830.970845145747, 5851.273874207204, 5904.261967254093, 5663.762813688488, 5697.116946873241, 5773.53811695055, 5800.187973683604, 5800.622959507618, 5655.321361436654, 5892.175095486721, 5918.260217472816, 5938.673372964528, 6009.609375390585, 5779.624324418899, 5819.428754236248, 5848.824535263949, 5856.4143585641095, 5884.176215329771], "value": 4376.434421870488, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.713738073461, 763.8510490454361, 779.2091027606976, 779.4894344204546, 814.8492528882153, 14799.186044767546, 15964.920175399136, 15987.84012159878, 16074.59813504663, 16087.0, 14426.35081421336, 14532.636684082903, 14554.19951902645, 14564.344604492797, 14588.197649129293, 676.8375589858423, 793.0562630469751, 803.7428023032618, 810.748667912946, 819.4427789103407, 818.7134502923959, 823.0, 824.756696774453, 827.4125370986577, 827.9047909490425, 872.8036191856813, 876.9254613357872, 877.3288434347729, 879.8460269452852, 880.1110878013188, 878.8901387326584, 879.2043200903192, 879.463527248378, 879.6657270237301, 880.2473884828476, 632.8196464007735, 635.6726285962733, 636.0808631527444, 637.6715991264456, 638.9712462939179, 14637.780433293508, 14701.117932924059, 14715.190664513448, 14803.111813291236, 14807.777883331652, 15039.0, 15105.39578416862, 15114.697706045927, 15256.771148432783, 15449.382024718998, 12098.81851772224, 12221.938890305491, 12265.448054837554, 12340.074494412955, 12788.744225115539, 3698.745352928585, 3786.924261514782, 3888.1251718363424, 3964.108075682977, 4046.7774272415004, 72449.63775181091, 74519.62740186318, 74524.62737686277, 74689.62655186743, 75451.0, 11430.485628146753, 11614.6515604532, 11669.941650291694, 11682.065434765198, 11968.222065565711, 20358.389248322575, 20391.0, 20417.0, 20449.0, 20468.590628187354, 8274.917250827535, 8375.413721039591, 8443.620037098346, 8505.957470212734, 8647.351448641377, 4751.358566593465, 4765.9523404766205, 4791.520847915181, 4796.736179510161, 4832.226843705061, 3419.230673098533, 3511.3504001759757, 3517.2437925846066, 3518.7185025197923, 3519.8240087995496, 605.7879742090233, 614.744880874441, 622.4273668225244, 625.1435533319382, 633.6071635585967, 583.3029529712038, 620.6307247187916, 666.7766298290127, 679.741698154698, 683.7094234950126, 7709.498882572615, 7782.766517004499, 7808.297253247235, 7867.685292588232, 7975.7607271781935, 563.9915401268984, 632.867097909435, 697.5117417807555, 697.8137166816331, 740.7333359990399, 4322.416473776, 4324.891877703019, 4417.182821178092, 4453.933191002137, 4554.180247555471, 64766.67616661981, 113569.0, 115434.422827887, 116138.0, 119361.40319298522, 96740.0, 97030.0, 97411.51294243483, 97446.0, 100659.49670251601, 86074.0, 86388.56805716056, 88469.0, 89834.0, 91196.54401727949, 8230.588470576567, 8305.709300174465, 8388.664453421794, 8412.101584967975, 8449.155084491747, 52180.0, 52522.212166818295, 52579.0, 52766.73616631892, 54982.0, 69996.0, 76731.23268767464, 77011.61494192493, 77585.61207193928, 78123.0, 10611.522481488506, 10681.465926703479, 10764.3541387517, 10891.01980821698, 11270.661880143609, 12462.376881156088, 12540.372981350714, 12586.748265034465, 13236.536721214712, 13385.933070334586, 11348.943255284, 11396.772064558829, 11830.171887968105, 12029.338386388832, 12123.515059397525, 11656.825147622623, 11675.649730508097, 11997.16019878635, 12086.456109474919, 12169.2698438094, 11873.168878178445, 11889.46497407636, 11916.463759130687, 12136.211146275464, 12645.683857903627, 9830.950845245728, 9930.05664461875, 10018.39889606626, 10339.948300258451, 10357.585696572052, 10339.844902326622, 10569.471526423495, 10639.787204256027, 10660.200484963503, 10697.946510267398], "value": 7279.846281527666, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 106.0, 111.0, 111.0, 111.0, 113.0, 111.0, 110.0, 115.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 129.0, 155.0, 176.0, 136.0, 155.0, 154.0, 130.0, 191.0, 126.0], "value": 150.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 166.0, 163.0, 165.0, 175.0, 163.0, 163.0, 162.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 162.0, 74.0, 79.0, 75.0, 77.0, 157.0, 75.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 153.0, 85.0, 86.0, 86.0, 140.0, 85.0, 85.0, 152.0], "value": 104.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 116.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 147.0, 149.0, 147.0, 147.0, 148.0, 148.0, 148.0, 146.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 94.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 52.0, 56.0, 54.0, 53.0, 53.0, 53.0, 58.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 69.0, 61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 80.0, 79.0, 85.0, 80.0, 81.0, 81.0, 82.0, 103.0, 81.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 125.0, 120.0, 121.0, 125.0, 130.0, 132.0, 131.0, 144.0, 132.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 169.0, 165.0, 164.0, 162.0, 159.0, 162.0, 172.0, 166.0, 160.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 64.0, 65.0, 62.0, 63.0, 64.0, 64.0, 63.0, 62.0, 69.0], "value": 64.5, "unit": "score"}]}]} 10:16:42 INFO - Return code: 0 10:16:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:16:42 ERROR - # TBPL SUCCESS # 10:16:42 INFO - Running post-action listener: _resource_record_post_action 10:16:42 INFO - ##### 10:16:42 INFO - ##### Finished run-tests step (success) 10:16:42 INFO - ##### 10:16:42 INFO - Running post-run listener: _resource_record_post_run 10:16:42 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540905472; Read time: 112; Write time: 485028 10:16:42 INFO - TinderboxPrint: CPU usage
13.5% 10:16:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 112 10:16:42 INFO - TinderboxPrint: I/O write bytes / time
540,905,472 / 485,028 10:16:42 INFO - TinderboxPrint: CPU idle
8,227.5 (86.5%) 10:16:42 INFO - TinderboxPrint: CPU user
1,227.2 (12.9%) 10:16:42 INFO - TinderboxPrint: Swap in / out
0 / 0 10:16:42 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 238419968; Read time: 0; Write time: 254116 10:16:42 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292556800; Read time: 112; Write time: 229796 10:16:43 INFO - Running post-run listener: _upload_blobber_files 10:16:43 INFO - Blob upload gear active. 10:16:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:16:43 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 10:16:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:16:43 INFO - (blobuploader) - INFO - Open directory for files ... 10:16:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:16:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:16:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:44 INFO - (blobuploader) - INFO - Done attempting. 10:16:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:16:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:16:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:45 INFO - (blobuploader) - INFO - Done attempting. 10:16:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:16:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:16:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:16:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:16:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:16:49 INFO - (blobuploader) - INFO - Done attempting. 10:16:49 INFO - (blobuploader) - INFO - Iteration through files over. 10:16:49 INFO - Return code: 0 10:16:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:16:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:16:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1576e98c6630b9d239989890ed6c254edba0a183085157bce406cb2e026b2a81c038b52b7597d1d2d89a0632c6954315cbf015acc92c621c91635ed58f5f4f77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/706b8c126c50eadac90368e47074a1d24f82f3d507dfddae2c59800b3aa5b85d3f6296202647d1d747b2f171dbf9e1872e90369c95ec8044432515a5816329a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7ae7a4d3e73ee37d44c2c82eacc731eb1da4441807cff546f735c07df81e4c989116bd7cb16bbd3df78eca6cb189aa6e8e7d07e621d003f087c9d43c6335c19f"} 10:16:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:16:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:16:49 INFO - Contents: 10:16:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1576e98c6630b9d239989890ed6c254edba0a183085157bce406cb2e026b2a81c038b52b7597d1d2d89a0632c6954315cbf015acc92c621c91635ed58f5f4f77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/706b8c126c50eadac90368e47074a1d24f82f3d507dfddae2c59800b3aa5b85d3f6296202647d1d747b2f171dbf9e1872e90369c95ec8044432515a5816329a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7ae7a4d3e73ee37d44c2c82eacc731eb1da4441807cff546f735c07df81e4c989116bd7cb16bbd3df78eca6cb189aa6e8e7d07e621d003f087c9d43c6335c19f"} 10:16:49 INFO - Running post-run listener: copy_logs_to_upload_dir 10:16:49 INFO - Copying logs to upload dir... 10:16:49 INFO - mkdir: /builds/slave/test/build/upload/logs 10:16:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.273948 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-07 10:16:49.048520) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 10:16:49.051748) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1576e98c6630b9d239989890ed6c254edba0a183085157bce406cb2e026b2a81c038b52b7597d1d2d89a0632c6954315cbf015acc92c621c91635ed58f5f4f77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/706b8c126c50eadac90368e47074a1d24f82f3d507dfddae2c59800b3aa5b85d3f6296202647d1d747b2f171dbf9e1872e90369c95ec8044432515a5816329a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7ae7a4d3e73ee37d44c2c82eacc731eb1da4441807cff546f735c07df81e4c989116bd7cb16bbd3df78eca6cb189aa6e8e7d07e621d003f087c9d43c6335c19f"} build_url:https://queue.taskcluster.net/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011392 build_url: 'https://queue.taskcluster.net/v1/task/GZFqHKwhQfGpALr822c2MA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1576e98c6630b9d239989890ed6c254edba0a183085157bce406cb2e026b2a81c038b52b7597d1d2d89a0632c6954315cbf015acc92c621c91635ed58f5f4f77", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/706b8c126c50eadac90368e47074a1d24f82f3d507dfddae2c59800b3aa5b85d3f6296202647d1d747b2f171dbf9e1872e90369c95ec8044432515a5816329a2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7ae7a4d3e73ee37d44c2c82eacc731eb1da4441807cff546f735c07df81e4c989116bd7cb16bbd3df78eca6cb189aa6e8e7d07e621d003f087c9d43c6335c19f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 10:16:49.077823) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 10:16:49.078268) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1465316740.240518-952996573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004716 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 10:16:49.160679) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 10:16:49.161054) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 10:16:49.161419) ========= ========= Total master_lag: 0.17 =========