builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1465330165.44 results: success (0) buildid: 20160607103140 builduid: e49edca8524e42f099a12c7075b24fc5 revision: 7ec7b62eb5bc420a2f940f89bc59075f78ce184d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 13:09:25.438318) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 13:09:25.438800) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 13:09:25.439074) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 13:09:25.454255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 13:09:25.454534) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 13:09:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-06-07 13:09:25 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079192 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 13:09:25.547058) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 13:09:25.547372) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015303 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 13:09:25.596858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 13:09:25.597162) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7ec7b62eb5bc420a2f940f89bc59075f78ce184d --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 7ec7b62eb5bc420a2f940f89bc59075f78ce184d --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=9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 13:09:25,906 truncating revision to first 12 chars 2016-06-07 13:09:25,907 Setting DEBUG logging. 2016-06-07 13:09:25,907 attempt 1/10 2016-06-07 13:09:25,907 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7ec7b62eb5bc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 13:09:27,377 unpacking tar archive at: mozilla-inbound-7ec7b62eb5bc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.812977 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 13:09:27.425472) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 13:09:27.426061) ========= script_repo_revision: 7ec7b62eb5bc420a2f940f89bc59075f78ce184d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 13:09:27.426799) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 13:09:27.427338) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 13:09:27.439201) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-07 13:09:27.439971) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:09:27 INFO - MultiFileLogger online at 20160607 13:09:27 in /builds/slave/test 13:09:27 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 13:09:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:09:27 INFO - {'append_to_log': False, 13:09:27 INFO - 'base_work_dir': '/builds/slave/test', 13:09:27 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:09:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:09:27 INFO - 'branch': 'Mozilla-Inbound', 13:09:27 INFO - 'buildbot_json_path': 'buildprops.json', 13:09:27 INFO - 'config_files': ('talos/linux_config.py',), 13:09:27 INFO - 'default_actions': ('clobber', 13:09:27 INFO - 'read-buildbot-config', 13:09:27 INFO - 'download-and-extract', 13:09:27 INFO - 'populate-webroot', 13:09:27 INFO - 'create-virtualenv', 13:09:27 INFO - 'install', 13:09:27 INFO - 'run-tests'), 13:09:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:09:27 INFO - 'download_minidump_stackwalk': True, 13:09:27 INFO - 'download_symbols': 'ondemand', 13:09:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:09:27 INFO - 'tooltool.py': '/tools/tooltool.py', 13:09:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:09:27 INFO - '/tools/misc-python/virtualenv.py')}, 13:09:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:09:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:09:27 INFO - 'installer_path': 'installer.exe', 13:09:27 INFO - 'log_level': 'info', 13:09:27 INFO - 'log_name': 'talos', 13:09:27 INFO - 'log_to_console': True, 13:09:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:09:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:09:27 INFO - 'opt_config_files': (), 13:09:27 INFO - 'pip_index': False, 13:09:27 INFO - 'sps_profile': False, 13:09:27 INFO - 'sps_profile_interval': 0, 13:09:27 INFO - 'suite': 'dromaeojs-e10s', 13:09:27 INFO - 'system_bits': '32', 13:09:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:09:27 INFO - 'title': 'talos-linux64-ix-022', 13:09:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:09:27 INFO - 'use_talos_json': True, 13:09:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:09:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:09:27 INFO - 'work_dir': 'build'} 13:09:27 INFO - ##### 13:09:27 INFO - ##### Running clobber step. 13:09:27 INFO - ##### 13:09:27 INFO - Running pre-action listener: _resource_record_pre_action 13:09:27 INFO - Running main action method: clobber 13:09:27 INFO - rmtree: /builds/slave/test/build 13:09:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:09:28 INFO - Running post-action listener: _resource_record_post_action 13:09:28 INFO - ##### 13:09:28 INFO - ##### Finished clobber step (success) 13:09:28 INFO - ##### 13:09:28 INFO - ##### 13:09:28 INFO - ##### Running read-buildbot-config step. 13:09:28 INFO - ##### 13:09:28 INFO - Running pre-action listener: _resource_record_pre_action 13:09:28 INFO - Running main action method: read_buildbot_config 13:09:28 INFO - Using buildbot properties: 13:09:28 INFO - { 13:09:28 INFO - "project": "", 13:09:28 INFO - "product": "firefox", 13:09:28 INFO - "script_repo_revision": "production", 13:09:28 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 13:09:28 INFO - "repository": "", 13:09:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 13:09:28 INFO - "buildid": "20160607103140", 13:09:28 INFO - "pgo_build": "True", 13:09:28 INFO - "basedir": "/builds/slave/test", 13:09:28 INFO - "buildnumber": 669, 13:09:28 INFO - "slavename": "talos-linux64-ix-022", 13:09:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:09:28 INFO - "platform": "ubuntu64_hw", 13:09:28 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:09:28 INFO - "branch": "mozilla-inbound", 13:09:28 INFO - "repo_path": "integration/mozilla-inbound", 13:09:28 INFO - "revision": "7ec7b62eb5bc420a2f940f89bc59075f78ce184d", 13:09:28 INFO - "stage_platform": "linux64-pgo", 13:09:28 INFO - "builduid": "e49edca8524e42f099a12c7075b24fc5", 13:09:28 INFO - "slavebuilddir": "test" 13:09:28 INFO - } 13:09:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 13:09:28 INFO - Running post-action listener: _resource_record_post_action 13:09:28 INFO - ##### 13:09:28 INFO - ##### Finished read-buildbot-config step (success) 13:09:28 INFO - ##### 13:09:28 INFO - ##### 13:09:28 INFO - ##### Running download-and-extract step. 13:09:28 INFO - ##### 13:09:28 INFO - Running pre-action listener: _resource_record_pre_action 13:09:28 INFO - Running main action method: download_and_extract 13:09:28 INFO - mkdir: /builds/slave/test/build/tests 13:09: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')]} 13:09:28 INFO - https://queue.taskcluster.net/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 13:09:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:09:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:09:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/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 13:09:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/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 13:09:30 INFO - Downloaded 1361 bytes. 13:09:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 13:09:31 INFO - Using the following test package requirements: 13:09:31 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:09:31 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:09:31 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:09:31 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:31 INFO - u'jsshell-linux-x86_64.zip'], 13:09:31 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:09:31 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 13:09:31 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:09:31 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:09:31 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:09:31 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 13:09:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:09:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:09: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')]} 13:09:31 INFO - https://queue.taskcluster.net/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:09:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:09:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:09:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/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 13:09:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/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 13:09:33 INFO - Downloaded 24450420 bytes. 13:09:33 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'] 13:09:33 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 13:09:34 INFO - Return code: 0 13:09:34 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 13:09:34 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')]} 13:09:34 INFO - https://queue.taskcluster.net/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:09:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:09:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 13:09:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/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 13:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/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 13:09:35 INFO - Downloaded 24450420 bytes. 13:09:35 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'] 13:09:35 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 13:09:37 INFO - Return code: 0 13:09:37 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')]} 13:09:37 INFO - https://queue.taskcluster.net/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:09:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:09:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 13:09:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/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 13:09:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/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 13:09:37 INFO - Downloaded 10833369 bytes. 13:09:37 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'] 13:09:37 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 13:09:38 INFO - Return code: 0 13:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:38 INFO - https://queue.taskcluster.net/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:09:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:09:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:09:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/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 13:09:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/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 13:09:39 INFO - Downloaded 59233050 bytes. 13:09:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:09:39 INFO - mkdir: /builds/slave/test/properties 13:09:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:09:39 INFO - Writing to file /builds/slave/test/properties/build_url 13:09:39 INFO - Contents: 13:09:39 INFO - build_url:https://queue.taskcluster.net/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 13:09:40 INFO - Running post-action listener: _resource_record_post_action 13:09:40 INFO - Running post-action listener: set_extra_try_arguments 13:09:40 INFO - ##### 13:09:40 INFO - ##### Finished download-and-extract step (success) 13:09:40 INFO - ##### 13:09:40 INFO - ##### 13:09:40 INFO - ##### Running populate-webroot step. 13:09:40 INFO - ##### 13:09:40 INFO - Running pre-action listener: _resource_record_pre_action 13:09:40 INFO - Running main action method: populate_webroot 13:09:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:09:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:09:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:09:40 INFO - '--tppagecycles', 13:09:40 INFO - '7'], 13:09:40 INFO - 'tests': ['tsvgm']}}, 13:09:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:09:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:09:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:09:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:09:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:09:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:09:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:40 INFO - 'talos_options': ['--disable-e10s'], 13:09:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:09:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:09:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:40 INFO - 'talos_options': ['--disable-e10s'], 13:09:40 INFO - 'tests': ['damp', 'tps']}, 13:09:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:40 INFO - 'tests': ['damp', 'tps']}, 13:09:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:09:40 INFO - 'tests': ['dromaeo_dom']}, 13:09:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:09:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:09:40 INFO - 'tests': ['a11yr', 13:09:40 INFO - 'ts_paint', 13:09:40 INFO - 'tpaint', 13:09:40 INFO - 'sessionrestore', 13:09:40 INFO - 'sessionrestore_no_auto_restore', 13:09:40 INFO - 'tabpaint']}, 13:09:40 INFO - 'other-e10s': {'tests': ['a11yr', 13:09:40 INFO - 'ts_paint', 13:09:40 INFO - 'tpaint', 13:09:40 INFO - 'sessionrestore', 13:09:40 INFO - 'sessionrestore_no_auto_restore', 13:09:40 INFO - 'tabpaint']}, 13:09:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:09:40 INFO - 'ts_paint', 13:09:40 INFO - 'tpaint', 13:09:40 INFO - 'sessionrestore', 13:09:40 INFO - 'sessionrestore_no_auto_restore', 13:09:40 INFO - 'tabpaint']}, 13:09:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:09:40 INFO - 'ts_paint', 13:09:40 INFO - 'tpaint', 13:09:40 INFO - 'sessionrestore', 13:09:40 INFO - 'sessionrestore_no_auto_restore', 13:09:40 INFO - 'tabpaint']}, 13:09:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:09:40 INFO - 'tests': ['a11yr', 13:09:40 INFO - 'ts_paint', 13:09:40 INFO - 'tpaint', 13:09:40 INFO - 'sessionrestore', 13:09:40 INFO - 'sessionrestore_no_auto_restore', 13:09:40 INFO - 'tabpaint']}, 13:09:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:09:40 INFO - 'tests': ['a11yr', 13:09:40 INFO - 'ts_paint', 13:09:40 INFO - 'tpaint', 13:09:40 INFO - 'sessionrestore', 13:09:40 INFO - 'sessionrestore_no_auto_restore', 13:09:40 INFO - 'tabpaint']}, 13:09:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:09:40 INFO - 'tests': ['tsvgx', 13:09:40 INFO - 'tsvgr_opacity', 13:09:40 INFO - 'tart', 13:09:40 INFO - 'tscrollx', 13:09:40 INFO - 'cart']}, 13:09:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:09:40 INFO - 'tsvgr_opacity', 13:09:40 INFO - 'tart', 13:09:40 INFO - 'tscrollx', 13:09:40 INFO - 'cart']}, 13:09:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:40 INFO - 'talos_options': ['--disable-e10s'], 13:09:40 INFO - 'tests': ['tp5o']}, 13:09:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:40 INFO - 'tests': ['tp5o']}, 13:09:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:40 INFO - 'talos_options': ['--disable-e10s', 13:09:40 INFO - '--xperf_path', 13:09:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:09:40 INFO - 'tests': ['tp5n']}, 13:09:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:40 INFO - 'talos_options': ['--xperf_path', 13:09:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:09:40 INFO - 'tests': ['tp5n']}}, 13:09:40 INFO - 'talos.zip': {'path': '', 13:09:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:09:40 INFO - Running post-action listener: _resource_record_post_action 13:09:40 INFO - ##### 13:09:40 INFO - ##### Finished populate-webroot step (success) 13:09:40 INFO - ##### 13:09:40 INFO - ##### 13:09:40 INFO - ##### Running create-virtualenv step. 13:09:40 INFO - ##### 13:09:40 INFO - Running pre-action listener: _resource_record_pre_action 13:09:40 INFO - Running main action method: create_virtualenv 13:09:40 INFO - Creating virtualenv /builds/slave/test/build/venv 13:09:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:09:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:09:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:09:40 INFO - Using real prefix '/usr' 13:09:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:09:40 INFO - Installing distribute.............................................................................................................................................................................................done. 13:09:42 INFO - Installing pip.................done. 13:09:42 INFO - Return code: 0 13:09:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c8a0f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e44020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed62e0>, '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 0x1e42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e425d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', '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 13:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:09:42 INFO - Using env: {'DISPLAY': ':0', 13:09:42 INFO - 'HOME': '/home/cltbld', 13:09:42 INFO - 'LANG': 'en_US.UTF-8', 13:09:42 INFO - 'LANGUAGE': 'en_US:en', 13:09:42 INFO - 'LOGNAME': 'cltbld', 13:09:42 INFO - 'MAIL': '/var/mail/cltbld', 13:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:42 INFO - 'MOZ_NO_REMOTE': '1', 13:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:42 INFO - 'NO_EM_RESTART': '1', 13:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:42 INFO - 'PWD': '/builds/slave/test', 13:09:42 INFO - 'SHELL': '/bin/bash', 13:09:42 INFO - 'SHLVL': '1', 13:09:42 INFO - 'TERM': 'linux', 13:09:42 INFO - 'TMOUT': '86400', 13:09:42 INFO - 'USER': 'cltbld', 13:09:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', 13:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:42 INFO - '_': '/tools/buildbot/bin/python'} 13:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:09:43 INFO - Cleaning up... 13:09:43 INFO - Return code: 0 13:09:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:09: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')]} 13:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09: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')]} 13:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c8a0f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e44020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed62e0>, '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 0x1e42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e425d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', '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 13:09:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:09:43 INFO - Using env: {'DISPLAY': ':0', 13:09:43 INFO - 'HOME': '/home/cltbld', 13:09:43 INFO - 'LANG': 'en_US.UTF-8', 13:09:43 INFO - 'LANGUAGE': 'en_US:en', 13:09:43 INFO - 'LOGNAME': 'cltbld', 13:09:43 INFO - 'MAIL': '/var/mail/cltbld', 13:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:43 INFO - 'MOZ_NO_REMOTE': '1', 13:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:43 INFO - 'NO_EM_RESTART': '1', 13:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:43 INFO - 'PWD': '/builds/slave/test', 13:09:43 INFO - 'SHELL': '/bin/bash', 13:09:43 INFO - 'SHLVL': '1', 13:09:43 INFO - 'TERM': 'linux', 13:09:43 INFO - 'TMOUT': '86400', 13:09:43 INFO - 'USER': 'cltbld', 13:09:43 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', 13:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:43 INFO - '_': '/tools/buildbot/bin/python'} 13:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:43 INFO - Downloading/unpacking psutil>=3.1.1 13:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:09:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:09:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:09:45 INFO - Installing collected packages: psutil 13:09:45 INFO - Running setup.py install for psutil 13:09:45 INFO - building 'psutil._psutil_linux' extension 13:09:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:09:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:09:45 INFO - building 'psutil._psutil_posix' extension 13:09:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:09:45 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:09:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:09:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:09:45 INFO - Successfully installed psutil 13:09:45 INFO - Cleaning up... 13:09:45 INFO - Return code: 0 13:09:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c8a0f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e44020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed62e0>, '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 0x1e42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e425d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', '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 13:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:09:45 INFO - Using env: {'DISPLAY': ':0', 13:09:45 INFO - 'HOME': '/home/cltbld', 13:09:45 INFO - 'LANG': 'en_US.UTF-8', 13:09:45 INFO - 'LANGUAGE': 'en_US:en', 13:09:45 INFO - 'LOGNAME': 'cltbld', 13:09:45 INFO - 'MAIL': '/var/mail/cltbld', 13:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:45 INFO - 'MOZ_NO_REMOTE': '1', 13:09:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:45 INFO - 'NO_EM_RESTART': '1', 13:09:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:45 INFO - 'PWD': '/builds/slave/test', 13:09:45 INFO - 'SHELL': '/bin/bash', 13:09:45 INFO - 'SHLVL': '1', 13:09:45 INFO - 'TERM': 'linux', 13:09:45 INFO - 'TMOUT': '86400', 13:09:45 INFO - 'USER': 'cltbld', 13:09:45 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', 13:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:45 INFO - '_': '/tools/buildbot/bin/python'} 13:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:09:48 INFO - Installing collected packages: mozsystemmonitor 13:09:48 INFO - Running setup.py install for mozsystemmonitor 13:09:48 INFO - Successfully installed mozsystemmonitor 13:09:48 INFO - Cleaning up... 13:09:48 INFO - Return code: 0 13:09:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c8a0f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e44020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed62e0>, '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 0x1e42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e425d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', '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 13:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:09:48 INFO - Using env: {'DISPLAY': ':0', 13:09:48 INFO - 'HOME': '/home/cltbld', 13:09:48 INFO - 'LANG': 'en_US.UTF-8', 13:09:48 INFO - 'LANGUAGE': 'en_US:en', 13:09:48 INFO - 'LOGNAME': 'cltbld', 13:09:48 INFO - 'MAIL': '/var/mail/cltbld', 13:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:48 INFO - 'MOZ_NO_REMOTE': '1', 13:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:48 INFO - 'NO_EM_RESTART': '1', 13:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:48 INFO - 'PWD': '/builds/slave/test', 13:09:48 INFO - 'SHELL': '/bin/bash', 13:09:48 INFO - 'SHLVL': '1', 13:09:48 INFO - 'TERM': 'linux', 13:09:48 INFO - 'TMOUT': '86400', 13:09:48 INFO - 'USER': 'cltbld', 13:09:48 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', 13:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:48 INFO - '_': '/tools/buildbot/bin/python'} 13:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:48 INFO - Downloading/unpacking jsonschema==2.5.1 13:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:09:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:50 INFO - Downloading functools32-3.2.3-2.tar.gz 13:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:09:50 INFO - warning: no files found matching '*.txt' 13:09:50 INFO - no previously-included directories found matching 'build' 13:09:50 INFO - no previously-included directories found matching 'dist' 13:09:50 INFO - no previously-included directories found matching '.git*' 13:09:50 INFO - Installing collected packages: jsonschema, functools32 13:09:50 INFO - Running setup.py install for functools32 13:09:50 INFO - warning: no files found matching '*.txt' 13:09:50 INFO - no previously-included directories found matching 'build' 13:09:50 INFO - no previously-included directories found matching 'dist' 13:09:50 INFO - no previously-included directories found matching '.git*' 13:09:50 INFO - Successfully installed jsonschema functools32 13:09:50 INFO - Cleaning up... 13:09:50 INFO - Return code: 0 13:09:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c8a0f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e44020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed62e0>, '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 0x1e42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e425d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', '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 13:09:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:09:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:09:50 INFO - Using env: {'DISPLAY': ':0', 13:09:50 INFO - 'HOME': '/home/cltbld', 13:09:50 INFO - 'LANG': 'en_US.UTF-8', 13:09:50 INFO - 'LANGUAGE': 'en_US:en', 13:09:50 INFO - 'LOGNAME': 'cltbld', 13:09:50 INFO - 'MAIL': '/var/mail/cltbld', 13:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:50 INFO - 'MOZ_NO_REMOTE': '1', 13:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:50 INFO - 'NO_EM_RESTART': '1', 13:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:50 INFO - 'PWD': '/builds/slave/test', 13:09:50 INFO - 'SHELL': '/bin/bash', 13:09:50 INFO - 'SHLVL': '1', 13:09:50 INFO - 'TERM': 'linux', 13:09:50 INFO - 'TMOUT': '86400', 13:09:50 INFO - 'USER': 'cltbld', 13:09:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', 13:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:50 INFO - '_': '/tools/buildbot/bin/python'} 13:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:51 INFO - Downloading/unpacking blobuploader==1.2.4 13:09:51 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 13:09:51 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 13:09:51 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 13:09:51 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 13:09:51 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 13:09:51 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 13:09:52 INFO - Downloading blobuploader-1.2.4.tar.gz 13:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:09:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:09:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:53 INFO - Downloading docopt-0.6.1.tar.gz 13:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:09:53 INFO - Installing collected packages: blobuploader, requests, docopt 13:09:53 INFO - Running setup.py install for blobuploader 13:09:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:09:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:09:53 INFO - Running setup.py install for requests 13:09:54 INFO - Running setup.py install for docopt 13:09:54 INFO - Successfully installed blobuploader requests docopt 13:09:54 INFO - Cleaning up... 13:09:54 INFO - Return code: 0 13:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c8a0f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e44020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed62e0>, '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 0x1e42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e425d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', '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 13:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:09:54 INFO - Using env: {'DISPLAY': ':0', 13:09:54 INFO - 'HOME': '/home/cltbld', 13:09:54 INFO - 'LANG': 'en_US.UTF-8', 13:09:54 INFO - 'LANGUAGE': 'en_US:en', 13:09:54 INFO - 'LOGNAME': 'cltbld', 13:09:54 INFO - 'MAIL': '/var/mail/cltbld', 13:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:54 INFO - 'MOZ_NO_REMOTE': '1', 13:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:54 INFO - 'NO_EM_RESTART': '1', 13:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:54 INFO - 'PWD': '/builds/slave/test', 13:09:54 INFO - 'SHELL': '/bin/bash', 13:09:54 INFO - 'SHLVL': '1', 13:09:54 INFO - 'TERM': 'linux', 13:09:54 INFO - 'TMOUT': '86400', 13:09:54 INFO - 'USER': 'cltbld', 13:09:54 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', 13:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:54 INFO - '_': '/tools/buildbot/bin/python'} 13:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:09:54 INFO - Running setup.py (path:/tmp/pip-9xXsGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:09:54 INFO - Running setup.py (path:/tmp/pip-6wuOFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:09:54 INFO - Running setup.py (path:/tmp/pip-qYB8oN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:09:54 INFO - Running setup.py (path:/tmp/pip-AhCOhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:09:54 INFO - Running setup.py (path:/tmp/pip-y6S3Cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:09:54 INFO - Running setup.py (path:/tmp/pip-EKyTVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:09:55 INFO - Running setup.py (path:/tmp/pip-oQzTQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:09:55 INFO - Running setup.py (path:/tmp/pip-YmVDNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:09:55 INFO - Running setup.py (path:/tmp/pip-Atw9y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:09:55 INFO - Running setup.py (path:/tmp/pip-R4c6Y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:09:55 INFO - Running setup.py (path:/tmp/pip-CL2Tsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:09:55 INFO - Running setup.py (path:/tmp/pip-Dq6tF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:09:55 INFO - Running setup.py (path:/tmp/pip-EEHw7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:09:55 INFO - Running setup.py (path:/tmp/pip-BeQJAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:55 INFO - Running setup.py (path:/tmp/pip-6MZub7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:55 INFO - Running setup.py (path:/tmp/pip-h7N1OE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:55 INFO - Running setup.py (path:/tmp/pip-hnnVt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:09:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:09:55 INFO - Running setup.py install for manifestparser 13:09:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:09:55 INFO - Running setup.py install for mozcrash 13:09:56 INFO - Running setup.py install for mozdebug 13:09:56 INFO - Running setup.py install for mozdevice 13:09:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:09:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:09:56 INFO - Running setup.py install for mozfile 13:09:56 INFO - Running setup.py install for mozhttpd 13:09:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:09:56 INFO - Running setup.py install for mozinfo 13:09:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:09:56 INFO - Running setup.py install for mozInstall 13:09:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:09:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:09:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:09:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:09:56 INFO - Running setup.py install for mozleak 13:09:56 INFO - Running setup.py install for mozlog 13:09:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:09:56 INFO - Running setup.py install for moznetwork 13:09:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:09:56 INFO - Running setup.py install for mozprocess 13:09:57 INFO - Running setup.py install for mozprofile 13:09:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:09:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:09:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:09:57 INFO - Running setup.py install for mozrunner 13:09:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:09:57 INFO - Running setup.py install for mozscreenshot 13:09:57 INFO - Running setup.py install for moztest 13:09:57 INFO - Running setup.py install for mozversion 13:09:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:09:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:09:57 INFO - Cleaning up... 13:09:57 INFO - Return code: 0 13:09:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c8a0f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e44020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed62e0>, '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 0x1e42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e425d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', '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 13:09:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:09:57 INFO - Using env: {'DISPLAY': ':0', 13:09:57 INFO - 'HOME': '/home/cltbld', 13:09:57 INFO - 'LANG': 'en_US.UTF-8', 13:09:57 INFO - 'LANGUAGE': 'en_US:en', 13:09:57 INFO - 'LOGNAME': 'cltbld', 13:09:57 INFO - 'MAIL': '/var/mail/cltbld', 13:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:57 INFO - 'MOZ_NO_REMOTE': '1', 13:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:57 INFO - 'NO_EM_RESTART': '1', 13:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:57 INFO - 'PWD': '/builds/slave/test', 13:09:57 INFO - 'SHELL': '/bin/bash', 13:09:57 INFO - 'SHLVL': '1', 13:09:57 INFO - 'TERM': 'linux', 13:09:57 INFO - 'TMOUT': '86400', 13:09:57 INFO - 'USER': 'cltbld', 13:09:57 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', 13:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:57 INFO - '_': '/tools/buildbot/bin/python'} 13:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:09:57 INFO - Running setup.py (path:/tmp/pip-eTGDkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:09:57 INFO - Running setup.py (path:/tmp/pip-IsL9TI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:09:58 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)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:09:58 INFO - Running setup.py (path:/tmp/pip-tfGM4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:09:58 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)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:09:58 INFO - Running setup.py (path:/tmp/pip-OaZSBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:09:58 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)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:09:58 INFO - Running setup.py (path:/tmp/pip-2GZnSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:09:58 INFO - Running setup.py (path:/tmp/pip-CynwaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:09:58 INFO - Running setup.py (path:/tmp/pip-zDmRh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:09:58 INFO - Running setup.py (path:/tmp/pip-E6cMxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:09:58 INFO - Running setup.py (path:/tmp/pip-InDZog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:09:58 INFO - Running setup.py (path:/tmp/pip-qwqZAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:09:58 INFO - Running setup.py (path:/tmp/pip-C8BfCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:09:58 INFO - Running setup.py (path:/tmp/pip-4EK09A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:09:58 INFO - Running setup.py (path:/tmp/pip-xZxFM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:09:58 INFO - Running setup.py (path:/tmp/pip-K5_jFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:58 INFO - Running setup.py (path:/tmp/pip-s5rFvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:09:58 INFO - Running setup.py (path:/tmp/pip-1VikLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:09:59 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)) 13:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:09:59 INFO - Running setup.py (path:/tmp/pip-mSmf4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:09:59 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)) 13:09:59 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)) 13:09:59 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)) 13:09:59 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)) 13:09:59 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)) 13:09:59 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)) 13:09:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:09:59 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 13:09:59 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 13:09:59 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 13:09:59 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 13:09:59 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 13:09:59 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 13:10:00 INFO - Downloading blessings-1.6.tar.gz 13:10:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:10:01 INFO - Installing collected packages: blessings 13:10:01 INFO - Running setup.py install for blessings 13:10:01 INFO - Successfully installed blessings 13:10:01 INFO - Cleaning up... 13:10:01 INFO - Return code: 0 13:10:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:10:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:10:01 INFO - Reading from file tmpfile_stdout 13:10:01 INFO - Current package versions: 13:10:01 INFO - argparse == 1.2.1 13:10:01 INFO - blessings == 1.6 13:10:01 INFO - blobuploader == 1.2.4 13:10:01 INFO - docopt == 0.6.1 13:10:01 INFO - functools32 == 3.2.3-2 13:10:01 INFO - jsonschema == 2.5.1 13:10:01 INFO - manifestparser == 1.1 13:10:01 INFO - mozInstall == 1.12 13:10:01 INFO - mozcrash == 0.17 13:10:01 INFO - mozdebug == 0.1 13:10:01 INFO - mozdevice == 0.48 13:10:01 INFO - mozfile == 1.2 13:10:01 INFO - mozhttpd == 0.7 13:10:01 INFO - mozinfo == 0.9 13:10:01 INFO - mozleak == 0.1 13:10:01 INFO - mozlog == 3.2 13:10:01 INFO - moznetwork == 0.27 13:10:01 INFO - mozprocess == 0.22 13:10:01 INFO - mozprofile == 0.28 13:10:01 INFO - mozrunner == 6.11 13:10:01 INFO - mozscreenshot == 0.1 13:10:01 INFO - mozsystemmonitor == 0.3 13:10:01 INFO - moztest == 0.7 13:10:01 INFO - mozversion == 1.4 13:10:01 INFO - psutil == 3.1.1 13:10:01 INFO - requests == 1.2.3 13:10:01 INFO - wsgiref == 0.1.2 13:10:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c8a0f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e44020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed62e0>, '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 0x1e42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e425d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', '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 13:10:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:10:01 INFO - Using env: {'DISPLAY': ':0', 13:10:01 INFO - 'HOME': '/home/cltbld', 13:10:01 INFO - 'LANG': 'en_US.UTF-8', 13:10:01 INFO - 'LANGUAGE': 'en_US:en', 13:10:01 INFO - 'LOGNAME': 'cltbld', 13:10:01 INFO - 'MAIL': '/var/mail/cltbld', 13:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:01 INFO - 'MOZ_NO_REMOTE': '1', 13:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:01 INFO - 'NO_EM_RESTART': '1', 13:10:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:01 INFO - 'PWD': '/builds/slave/test', 13:10:01 INFO - 'SHELL': '/bin/bash', 13:10:01 INFO - 'SHLVL': '1', 13:10:01 INFO - 'TERM': 'linux', 13:10:01 INFO - 'TMOUT': '86400', 13:10:01 INFO - 'USER': 'cltbld', 13:10:01 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', 13:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:01 INFO - '_': '/tools/buildbot/bin/python'} 13:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:10:01 INFO - Cleaning up... 13:10:01 INFO - Return code: 0 13:10:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c8a0f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e44020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed62e0>, '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 0x1e42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e425d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', '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 13:10:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:10:01 INFO - Using env: {'DISPLAY': ':0', 13:10:01 INFO - 'HOME': '/home/cltbld', 13:10:01 INFO - 'LANG': 'en_US.UTF-8', 13:10:01 INFO - 'LANGUAGE': 'en_US:en', 13:10:01 INFO - 'LOGNAME': 'cltbld', 13:10:01 INFO - 'MAIL': '/var/mail/cltbld', 13:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:01 INFO - 'MOZ_NO_REMOTE': '1', 13:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:01 INFO - 'NO_EM_RESTART': '1', 13:10:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:01 INFO - 'PWD': '/builds/slave/test', 13:10:01 INFO - 'SHELL': '/bin/bash', 13:10:01 INFO - 'SHLVL': '1', 13:10:01 INFO - 'TERM': 'linux', 13:10:01 INFO - 'TMOUT': '86400', 13:10:01 INFO - 'USER': 'cltbld', 13:10:01 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', 13:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:01 INFO - '_': '/tools/buildbot/bin/python'} 13:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:10:01 INFO - Cleaning up... 13:10:01 INFO - Return code: 0 13:10:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c8a0f9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d778a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e44020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed62e0>, '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 0x1e42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e425d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', '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 13:10:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:10:01 INFO - Using env: {'DISPLAY': ':0', 13:10:01 INFO - 'HOME': '/home/cltbld', 13:10:01 INFO - 'LANG': 'en_US.UTF-8', 13:10:01 INFO - 'LANGUAGE': 'en_US:en', 13:10:01 INFO - 'LOGNAME': 'cltbld', 13:10:01 INFO - 'MAIL': '/var/mail/cltbld', 13:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:01 INFO - 'MOZ_NO_REMOTE': '1', 13:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:01 INFO - 'NO_EM_RESTART': '1', 13:10:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:01 INFO - 'PWD': '/builds/slave/test', 13:10:01 INFO - 'SHELL': '/bin/bash', 13:10:01 INFO - 'SHLVL': '1', 13:10:01 INFO - 'TERM': 'linux', 13:10:01 INFO - 'TMOUT': '86400', 13:10:01 INFO - 'USER': 'cltbld', 13:10:01 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', 13:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:01 INFO - '_': '/tools/buildbot/bin/python'} 13:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:02 INFO - Downloading/unpacking flake8 13:10:02 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 13:10:02 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 13:10:02 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 13:10:02 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 13:10:02 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 13:10:02 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 13:10:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:10:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:10:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:10:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:10:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:10:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:10:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:10:04 INFO - no previously-included directories found matching 'docs/_build' 13:10:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:10:04 INFO - Running setup.py install for pep8 13:10:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:10:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:10:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:10:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:10:04 INFO - no previously-included directories found matching 'docs/_build' 13:10:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:10:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:10:04 INFO - Cleaning up... 13:10:04 INFO - Return code: 0 13:10:04 INFO - Running post-action listener: _resource_record_post_action 13:10:04 INFO - Running post-action listener: _start_resource_monitoring 13:10:04 INFO - Starting resource monitoring. 13:10:04 INFO - ##### 13:10:04 INFO - ##### Finished create-virtualenv step (success) 13:10:04 INFO - ##### 13:10:04 INFO - ##### 13:10:04 INFO - ##### Running install step. 13:10:04 INFO - ##### 13:10:04 INFO - Running pre-action listener: _resource_record_pre_action 13:10:04 INFO - Running main action method: install 13:10:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:10:05 INFO - Reading from file tmpfile_stdout 13:10:05 INFO - Detecting whether we're running mozinstall >=1.0... 13:10:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:10:05 INFO - Reading from file tmpfile_stdout 13:10:05 INFO - Output received: 13:10:05 INFO - Usage: mozinstall [options] installer 13:10:05 INFO - Options: 13:10:05 INFO - -h, --help show this help message and exit 13:10:05 INFO - -d DEST, --destination=DEST 13:10:05 INFO - Directory to install application into. [default: 13:10:05 INFO - "/builds/slave/test"] 13:10:05 INFO - --app=APP Application being installed. [default: firefox] 13:10:05 INFO - mkdir: /builds/slave/test/build/application 13:10:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:10:22 INFO - Reading from file tmpfile_stdout 13:10:22 INFO - Output received: 13:10:22 INFO - /builds/slave/test/build/application/firefox/firefox 13:10:22 INFO - Running post-action listener: _resource_record_post_action 13:10:22 INFO - ##### 13:10:22 INFO - ##### Finished install step (success) 13:10:22 INFO - ##### 13:10:22 INFO - ##### 13:10:22 INFO - ##### Running run-tests step. 13:10:22 INFO - ##### 13:10:22 INFO - Running pre-action listener: _resource_record_pre_action 13:10:22 INFO - Running main action method: run_tests 13:10:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:10:22 INFO - Python 2.7.3 13:10:22 INFO - Return code: 0 13:10:22 INFO - grabbing minidump binary from tooltool 13:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:10:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ed62e0>, '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 0x1e42140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e425d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:10:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:10:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:10:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:10:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:10:22 INFO - Return code: 0 13:10:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:10:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:10:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:10:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:10:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:10:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:10:23 INFO - Return code: 0 13:10:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 13:10:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 13:10:23 INFO - Using env: {'DISPLAY': ':0', 13:10:23 INFO - 'HOME': '/home/cltbld', 13:10:23 INFO - 'LANG': 'en_US.UTF-8', 13:10:23 INFO - 'LANGUAGE': 'en_US:en', 13:10:23 INFO - 'LOGNAME': 'cltbld', 13:10:23 INFO - 'MAIL': '/var/mail/cltbld', 13:10:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:10:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:23 INFO - 'MOZ_NO_REMOTE': '1', 13:10:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:10:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:23 INFO - 'NO_EM_RESTART': '1', 13:10:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:23 INFO - 'PWD': '/builds/slave/test', 13:10:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:10:23 INFO - 'SHELL': '/bin/bash', 13:10:23 INFO - 'SHLVL': '1', 13:10:23 INFO - 'TERM': 'linux', 13:10:23 INFO - 'TMOUT': '86400', 13:10:23 INFO - 'USER': 'cltbld', 13:10:23 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484', 13:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:23 INFO - '_': '/tools/buildbot/bin/python'} 13:10:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 13:10:23 INFO - mozversion application_buildid: 20160607103140 13:10:23 INFO - mozversion application_changeset: 7ec7b62eb5bc420a2f940f89bc59075f78ce184d 13:10:23 INFO - mozversion application_display_name: Nightly 13:10:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:10:23 INFO - mozversion application_name: Firefox 13:10:23 INFO - mozversion application_remotingname: firefox 13:10:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:10:23 INFO - mozversion application_vendor: Mozilla 13:10:23 INFO - mozversion application_version: 50.0a1 13:10:23 INFO - mozversion platform_buildid: 20160607103140 13:10:23 INFO - mozversion platform_changeset: 7ec7b62eb5bc420a2f940f89bc59075f78ce184d 13:10:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:10:23 INFO - mozversion platform_version: 50.0a1 13:10:23 INFO - using testdate: 1465330223 13:10:23 INFO - actual date: 1465330223 13:10:23 INFO - starting webserver on 'localhost:60077' 13:10:23 INFO - SUITE-START | Running 2 tests 13:10:23 INFO - TEST-START | dromaeo_css 13:10:23 INFO - operating with platform_type : linux_ 13:10:23 INFO - Initialising browser for dromaeo_css test... 13:10:23 INFO - TEST-INFO | started process 2633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEu1HEY/profile http://localhost:60077/getInfo.html) 13:10:28 INFO - PROCESS | 2633 | __metrics Screen width/height:1600/1200 13:10:28 INFO - PROCESS | 2633 | colorDepth:24 13:10:28 INFO - PROCESS | 2633 | Browser inner width/height: 1024/697 13:10:28 INFO - PROCESS | 2633 | __metrics 13:10:29 ERROR - PROCESS | 2633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 13:10:29 INFO - TEST-INFO | 2633: exit 0 13:10:29 INFO - Browser initialized. 13:10:29 INFO - Running cycle 1/1 for dromaeo_css test... 13:10:29 INFO - TEST-INFO | started process 2851 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEu1HEY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:10:41 INFO - PROCESS | 2851 | RSS: Main: 167485440 13:10:41 INFO - PROCESS | 2851 | 13:11:31 INFO - PROCESS | 2851 | 1465330291360 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] 13:13:38 INFO - PROCESS | 2851 | Cycle 1(1): loaded http://localhost:60077/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60077/tests/dromaeo/cssquery-ext.html) 13:13:39 INFO - PROCESS | 2851 | RSS: Main: 170233856 13:13:39 INFO - PROCESS | 2851 | 13:16:41 INFO - PROCESS | 2851 | Cycle 1(1): loaded http://localhost:60077/tests/dromaeo/cssquery-ext.html (next: http://localhost:60077/tests/dromaeo/cssquery-jquery.html) 13:16:42 INFO - PROCESS | 2851 | RSS: Main: 169828352 13:16:42 INFO - PROCESS | 2851 | 13:19:44 INFO - PROCESS | 2851 | Cycle 1(1): loaded http://localhost:60077/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60077/tests/dromaeo/cssquery-mootools.html) 13:19:44 INFO - PROCESS | 2851 | RSS: Main: 171094016 13:19:44 INFO - PROCESS | 2851 | 13:22:46 INFO - PROCESS | 2851 | Cycle 1(1): loaded http://localhost:60077/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60077/tests/dromaeo/cssquery-prototype.html) 13:22:47 INFO - PROCESS | 2851 | RSS: Main: 168935424 13:22:47 INFO - PROCESS | 2851 | 13:25:49 INFO - PROCESS | 2851 | Cycle 1(1): loaded http://localhost:60077/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60077/tests/dromaeo/cssquery-yui.html) 13:25:50 INFO - PROCESS | 2851 | RSS: Main: 170631168 13:25:50 INFO - PROCESS | 2851 | 13:28:52 INFO - PROCESS | 2851 | Cycle 1(1): loaded http://localhost:60077/tests/dromaeo/cssquery-yui.html (next: http://localhost:60077/tests/dromaeo/cssquery-dojo.html) 13:28:53 INFO - PROCESS | 2851 | RSS: Main: 172052480 13:28:53 INFO - PROCESS | 2851 | 13:28:53 INFO - PROCESS | 2851 | __start_tp_report 13:28:53 INFO - PROCESS | 2851 | _x_x_mozilla_page_load 13:28:53 INFO - PROCESS | 2851 | _x_x_mozilla_page_load_details 13:28:53 INFO - PROCESS | 2851 | |i|pagename|runs| 13:28:53 INFO - PROCESS | 2851 | |0;dojo.html;3172.4924012158053;3223.8871639492613;3229.4994275887216;3240.6435292117876;3259.2177877309455;5411.918821217685;5418.539424148948;5440.347158340995;5457.154141108124;5537.833864984057;5364.758585863636;5372.140457526796;5412.837614871551;5434.483724046219;5494.478024587658;4893.951060489403;4928;5007.974960125194;5064.875712838053;5114.258432527281;777.9604410131092;4991.825286114987;5018.498150184989;5027.0699920514635;5039.966806804615;4903.926441103386;4920.532549407819;4938.530839570253;4950.405951285851;4962.5533701966815;4899.044686286175;4956.801727930914;4961.032598643266;4971.751412429364;5014.6991180529285;4899.118158731427;4945.67853089548;4981.651284410093;4988.725620090893;4990.076835785391;5371;5421.268128802601;5442.755076021588;5447.155690867922;5447.5641948644015;5654.717264136777;5744.396838331999;5873.970630146865;5875.471207591338;5883.882322353529;5837.562182836305;5931.940680593182;5941.821745347646;5947.613405128653;6007.128966299906;5518.944810551923;5544.833654990357;5545.334559852843;5559.388467268597;5572.804951826666;5862.472377486047;6055.939440605625;6056.394360563909;6068.605540639845;6104.847378815565;5829.446202610745;5833.854153646193;5834.5624078194305;5835.35811060783;5879.323877754113;5852.853678658068;5904;5906.49794767441;5908.881822363529;5920.319163296276;5681.829545113653;5718;5727.971360143256;5729.541636669056;5765.509931655773;5689.857753556194;5777.133429985452;5792.9710351447975;5800.216970708901;5859.091840764689;4483.708558943658;4484.932726009112;4489.506154323022;4496.550344965477;4517.412736344254;3913.5890731473355;3935.114599215211;3945.368741001426;3960.2277555876904;4018.136100738297;5652.802151924663;5659.603827732019;5659.943400566024;5706.28671416073;5738.368779434259;5884.293884733859;5929.080992446092;5941.346451890288;5951.9702401488585;5979.312379076462;5502.724863756796;5579.302587176603;5602.747876345574;5662.7734890603915;5677.347105082886;5071.3153724247495;5084;5086.694798312039;5101.7194054327365;5123.205903085028;6104.511639068864;6138.907916381258;6140.140380346755;6142.877142457126;6144.047672610753;5751.913721294268;5850.063989761617;5863.94136058651;5915.64506129625;5919.7632094717455;6153.784617538365;6155.169052177898;6168.321484636596;6175.042868355412;6179.62922224668;5821.621594596338;5848.824535263949;5854.853628659318;5862.618929769551;5878;5756.913646295226;5861.032929566573;5896.233489646319;5916.142159386951;5984.940150598438;5796.507296879644;5802.100674395476;5815.505682017076;5826.650400975955;5827.358990511125;5624.550035997028;5722.599418040863;5796.21751063601;5801.129830525455;5809.62237454581;5533.446655334435;5585.776568937359;5604.047311956896;5605.719714014202;5627.690477023803;5714.142878568248;5758.971205143947;5789.710514474175;5795.304563452412;5807.186993820953;5522.171674248895;5628.986782379047;5667.688277144796;5670.914936275876;5681.0626246668835 13:28:53 INFO - PROCESS | 2851 | |1;ext.html;603.300171800711;603.5262319079523;618.9938100618994;634.4226753654173;634.8825467288555;42868;44362.112757744864;44500.33249501256;44514.7774261129;47676.76161619196;45525.7723711381;45964;46181.30728039082;46185.769071154595;46272.07455850881;8827.426217295888;8876.245519130882;9011.909880901205;9020.323475739313;9025.458472491639;8780.25367843734;8850.645974161058;8853.5573221339;8894.021657617657;8935.285177185842;8989.820203595924;9009.95495022524;9048.547572621343;9066;9074.59164337603;8908.287337013024;8928.776780580538;8931.776705582348;9008;9011.459312441242;8752.518611476366;8756.956215218883;8905.73282801517;8910.910890891138;8943.10568943107;42011.36982945258;42385.36421953673;42405.575944240474;42427.36358954587;42556.78721606372;3455.6889879910677;3999.0289771066386;4199;4246.596573325529;4266.06146647737;31321.37357252842;31369.686303136903;31972;32173.1956701082;32515.512267316008;4289.120730250323;4363.694541382105;4376.496702879178;4378.1462614790125;4430.202563538562;323300;323898;324369;324440;324714.9999999976;34016.65983340184;58754.706226468596;58788.412115879146;58961.70519147377;59001.11498327443;34609.13477163091;36440.27119457596;36518.8174059128;36667;36674;14992.250387480583;15003.849961500464;15048.924755376152;15176.165310907785;15179.468718594797;13049.608511744664;13054.934725326313;13094.410751516205;13158.078934474686;13164;8287.337013038943;8371.665133394717;8437.662493500315;8450.239478446847;8453.95773021131;3302.752293577991;3324.6010478742705;3325.8170800605717;3338.349021940698;3363.3273345330545;921.2721949659827;963.7638778499313;981.3425005246502;1036.5698235232294;1065.350136416785;29380.706192937796;30167.547486787716;31588.842055789573;31995.931960037415;32713.34573308568;1099.4173088263233;1142.4116579961326;1153.763478486908;1199.7600479904054;1202.2546021466746;16316.836831631532;16773.412930547373;16799.160041998097;16863.57841053959;17037.65924681524;574999;575108;578476;579150;580304;57747.71126144342;58399.41600584025;58793.70603146957;59152;59205.70397147987;1381.7650999330137;1387.5421111033536;1388.9652758681113;1420.808190894216;1427.022489594631;30543;30693.693063069084;31691.366172676877;32014.199645009063;32215.838920805247;54372.45627543832;56167.71916140556;56308.71845640909;59924;60275.69862150661;482731;485198;485747;488211;490964;43044.35433468563;43289.3506597395;43995.34006989834;44068;44593.77703111464;47884.760576196895;47946.5205347942;48045;49228.261576075674;49431.50568494413;40961.795191023855;41655.7917210412;41788.582114179684;42666;42802.571974281105;40526.39210411787;41062.589374105875;41211.793941030104;41829.372559412244;42147.57852421559;40792.59207407888;41402.1719565613;41776.58223417849;41883;43591.78204109086;34188;36669.816650916575;36865.26269474542;37137;37562.81218593889;28488;28529.28676783097;28784.42431151407;28886.85556572204;29060.418791624474 13:28:53 INFO - PROCESS | 2851 | |2;jquery.html;400.251529639574;401.4620408652405;405.1774896959173;408.69347989008224;415.8066499077928;13663.521776737816;18012.189451474682;18514.53713657159;19816.207351705933;19834.809911405326;18105.366312179078;18304.359347422844;18413.355532556365;18661.440156795285;18978.90510547449;5416.972915135419;5496.285482887219;5635.464630860061;5659.094544872821;5679.545636349082;5587.8603034924245;5599.804006859761;5608.803691870765;5639.971800141014;5641.12562552805;5365.919511207335;5592.5805564582815;5606.8598285043;5640.407757185498;5640.915386269209;5550.833474995757;5588.245586845785;5588.636738611997;5599.776008959657;5602.355729091166;4843.9031219375765;4991.600671946236;5012.523810238022;5016.949830501685;5021.096202683552;21911.67132493014;21981.450463738376;22211.44471388212;22226.777732222796;22516.437089072904;2362.161432691387;2374.4063984004;2378.988929704886;2526.2168727694475;2710.390162213506;13788.103773254707;13960.371783269777;14031.368588413547;14162.150270983773;14428.711425771531;1917.673995420782;1953.6581098307881;1976.7034944758402;2007.1971211515365;2025.1190732031614;73413.26586734118;75054;76271.61864190754;76432.23567764362;76633.61683191604;10285.125764310118;10413.323133996417;10562.419066951237;10592;10739.946300268448;14559.636009099857;14644.04813687107;14656.487022954145;14659.92670036643;14690.853091468949;8206.917930820615;8476.194761497647;8522.531260780592;8616;8679.088695686989;8274.627641756135;8292.087870334259;8327.791805204919;8464.619092140869;8487.490750554864;6383.425491705676;6503.8699226015215;6574.671266436755;6587.706146926536;6591.967040164865;1863.487540926256;1886.9433916982512;1956.4913122587946;1963.2147141143657;1976.6046790641929;1006.1900170362928;1008.5310330696261;1010.9292349535461;1117.0625833814559;1132.1452303510962;17981.291777281138;18098;18950.147243373805;19077.332293369665;19201.32795352156;1037.5331101004579;1047.8428235764543;1057.7144171073767;1067.5409573883305;1073.4203530093819;10517.263791534671;10771.246012779031;10793.568257269779;10834.241603087708;10953.671389858317;501864;508426;509419;514631;515251;76611;79828.60085699534;80062.59968700119;80428;81084;1033.5968972100886;1036.7252678040325;1053.441675911768;1055.2033214922685;1062.6918193723734;16096.275667594751;16503.422380216634;16532.504024879272;16675.833241667428;16852.57868553247;37840;38259.42610860783;38424.80787596044;38655.42016869805;39971.00072498211;51269;52512;52571.474285256656;52901.470985289656;54124.18813717719;7449.664765085476;7877;8457.069722330416;8798.736037918872;8870.09715725079;13026.348682566024;13369;13532.120412173177;13556.389962451516;13683;11492.367919764492;11828.881711182778;11837.230580012272;12032.518699251932;12059.939700301442;11448.656540303804;11558.768824623628;11771.411429428323;11812.17314787991;11943.701407464883;12062.939685301517;12067.456964436446;12117.939410302892;12122.212056216318;12336.383180841101;7907.288344048833;7918;7930.881036784568;8082.87875681877;8168.591570421337;8837.779055523662;11202.271852329572;11707.824382634097;11731.296122232694;11764.941175294069 13:28:53 INFO - PROCESS | 2851 | |3;mootools.html;1518.0436325115177;1523.8704710099644;1711.6491119320533;1786.8213178682142;1836.715309127085;7984.760457186279;8422.241998220159;8653.87019194711;8961.238294744939;8980.820383592332;8774;8889.866652000224;8978.595963181657;9028.68399606014;9038.457692538452;2353.141103497224;2366.065404165354;2384.1059602649007;2384.654225137354;2388.868612226327;2329.499157681098;2358.8230882683783;2367.2779802160335;2369.4668699542635;2369.8222633302485;2330.6387509935985;2343.5664402085667;2345.8357914945877;2377.09670325277;2377.1442280778906;2265.6261716816707;2266.29744779119;2273.9658905116435;2276.2374604507427;2312.826538009639;2285.520040791436;2320.3619004773655;2344.15610380263;2350.2361732437025;2350.894209760565;8868.733937981871;8998.685046023358;9020.233280171193;9049.049849765746;9050.140236677506;5312.442193569658;5377.81177658784;5397.055515284809;5417.783288668488;5459.617826752129;3496;3560.6855543896418;3620.456931460302;3634.8727794527063;3644.344018076745;1107.8116720157593;1135.2961164078242;1170.8068168752231;1188.680564573323;2142.3251675722254;12116.757664846742;12474.376281185996;12560;12580.4338804754;12598.929091027274;4654.092451971833;4689.343491911135;4734.928976065362;4775.9731657693765;4778.426588809365;9942.154916832005;9960.452175130438;9985.950070249603;9996.450195239186;10019.949900250598;5344.465553444625;5352.652077614943;5374.951884382586;5382.219578161144;5393.1370980642905;4187.581241875788;4683.906321873544;4815.374001379868;4815.855524334275;4847.491013443609;3780.5085338906315;3786.7159963002887;3866.7486613370043;3873.825677844504;3898.181381909774;1188.9583864564872;1191.541256616209;1197.6586672798385;1203;1204.6325870609548;779.9860181763685;823.5017814222429;857.0957639690062;863.680438237856;907.4373888189365;5509.834704958857;5814.273215848019;5956.85107872298;6090.573659843857;6373.52198585108;981.6466072213997;995.7062666513395;1026.440589878518;1028.953697083633;1035.177034257767;4047.170330082326;4107.424960505532;4115.464989551399;4125.278076336629;4135.462389889295;11158.218924675195;11433.14251431146;11477.081833453303;11480.885191147981;11543.76912461746;11290.379029153311;11311.660650180507;11372.488238029144;11386.43067846621;11415.543378264943;8042.959785201154;8389.664413423518;8398.076211616717;8455.873161902577;8528.616212270586;5978.581499295182;6178.227721534809;6178.845528861814;6193.783217587363;6256.280527739186;10208.132308753839;10282.126019288444;10284.2801003932;10443.268971171945;10454.895451045391;10400.687979360631;10458.26792124544;10527.420991845522;10565.313254638424;10602.734931626772;7727.072751269883;7775.883361749465;8006.519608823489;8031.116577176389;8076.636551355085;8559.786005349915;8568.614412351335;8573.828523429622;8624.956875215585;8626;7675.347595454449;7861.371090312876;7873.448858580074;7912.723054693289;7926.088499822594;7468.365188958782;7564.735234266775;7571.46999710015;7620.314171724572;8040.356771458152;7195.244499327495;7232.168300645493;7261.5280006799385;7319.231480694663;7328.3404493595835;5053.29253904461;5078.7206703631655;5464.071107911744;5498.670079795225;5565.1930470082425;5094.7962081516325;5158.277841102174;5172.922406163986;5176.223566465061;5198.532132107977 13:28:53 INFO - PROCESS | 2851 | |4;prototype.html;331.6445811300019;338.1411215512598;340.58958954459865;340.7103961632612;343.507067358341;5511.476409741078;5551.306086739158;5709.828705138847;5718.1994520767075;5728.942710572898;5555.2778138841995;5556.388797232301;5557.833265002057;5584.944150558493;5609;4318.69769116162;4327.329263964083;4342;4353.28170851809;4366.410534577839;4075.1034772350185;4285.121550082225;4298.269294219975;4355.629771469429;4357.891052723691;4195.832166713343;4198.622124008839;4202.726822756511;4216.072464057902;4239.300515414953;4238.237117318881;4255.638195777368;4268.381084742695;4280.101178752466;4322.50291216511;3514.8242587870504;3749.15643980105;3759.9436008459893;3760.417135344026;3767.2088861339153;5307.2569840222395;5314.893702125936;5324.787008519655;5330.38700549434;5334.1732031535175;4801.2798080287885;4866.418414015459;4867.221244600847;4888.266759985995;4901.338319326881;5521.861953451155;5734.770609175628;5735.569832262597;5749.856253593652;5774.884502309972;4038.5557588665224;4061.1674606705556;4065.6340929316207;4090.877273681794;4106.281400754886;5980.850478738066;5995.070764031582;6009.1587177795145;6043.335233124353;6055.152278680944;4035.7982100894837;4188.706790524695;4193.1194449165405;4197.139586384784;4214.17823524416;4183.330667093312;4194.266003449445;4197.76912269822;4197.874063778091;4232.957670423318;4908.779104940215;4923.409190897115;4932.482089380635;4944.184209605447;4948.38145231846;5371.597130215249;5795.478406943395;5863.70681465925;5871.55963302754;5885.941140588625;1444.4727674398769;1451.7386870363437;1460.2698650674663;1470.8087948566617;1474.727175472541;903.2864037410503;931.5807886451124;935.7894473743489;960.9423434593947;965.3966271080575;4957.727324997088;4965.808206030527;5015.297858299841;5038.64729468941;5073.467285934924;5193.428722840485;5273.602495338739;5275.472452754694;5314.335708036496;5338.759755810997;5060.291559181717;5084.593232541388;5094.61790365724;5333.973330133324;5805.883882322414;3145.1665308693214;3164.6677098904743;3179.952300715491;3185.4425475542153;3204.214967332972;6103.542234332443;6214.844628884314;6225.688715564203;6253.6560489172625;6265.404786545271;6084.756609735649;6148.508119350441;6150.50795936324;6157.6613286269685;6163.691815409301;6158.784442544489;6175.44421002112;6182.69086545671;6199.256089269316;6268.279147897959;5779.682117483579;5925.229720136354;5925.267081738477;5946.28644562638;6022.90965635507;5757.712114394348;5914.645121292736;5919.082542205792;5922.644641321534;5929.258842644669;6107.206063211754;6133.877322453615;6200.503959683305;6260.968695156495;6280.528960328085;4180.561041090763;4180.6446452050695;4193.475815523059;4214.873553793391;4221.092465120014;5971.641701497924;5985.221921150397;6017.398260173947;6035.78874739382;6125.632462052291;5859.765609375577;5870.5010074144175;5876.911846322223;5896.793612223723;5904.173415721716;5882.382349853375;5889.764409423575;5919.852003699942;5923.289205295392;5923.437273459014;5549.139883318092;5769.653820770767;5770.105633626795;5770.913436298543;5771.384012476513;5853.512257290719;5904.468597826216;5937.940620593911;5953.124765698791;5958.76164953397;5567.638103523258;5774.0761478163295;5823.466791945517;5826.388229236039;5826.446487583673 13:28:53 INFO - PROCESS | 2851 | |5;yui.html;712.7790384980659;718.809515478398;767.6890859202022;817.2644619842141;856.267890953235;15558.144302063381;15816.841831581694;16125.516234512954;16138.112403817786;16279.186040697947;15558.222088895538;16012.279447424864;16157.676846463064;16167.19164041799;16169.272382742776;792.3938187286731;801.2548330053063;803.8432505661399;807.3581502705334;826.7313123234943;807.5316316536395;814.9266566009057;819.8852160697508;819.9180081991783;820.3560205238889;840.8864803251574;841.4530555139147;842.1788755962917;842.3724325377572;843.2242337049929;827.1769589258666;830.9086000539936;832.8667413213857;836.8995720513547;837.3134030095324;600.5855959388008;602.28027507129;604.4137186928672;604.7701873288166;605.1044454207797;15288.694226115414;15330.080195188324;15330.540083797503;15358.539243822703;15360.155191464464;14907.701845963129;14966.326515306728;15080.849191508054;15106.622334441618;15180.772288415683;12116.394180291038;12512.436940337706;12658.936705316415;12743;12884.80672789909;3810.8094595270127;3817.9236415271816;3840.2895464339185;3871;3922.9803850980848;72981;74420.99999999946;74739.25260747377;74821;75471;11138.98396014119;11522.423878806027;11522.423878806194;11625.941870290595;11844.585439509576;21747.23884664029;21808.236711715013;21834.126634934426;21948.89025554894;22085.558288834134;8008.359331253486;8119.756407307672;8450.070492245848;8574.828503429897;8658.740237792876;4726.220173671306;4883.316335713003;4898.289747986522;4999.525045120708;5014.89970200594;3624.52881125452;3734.607866174067;3768.246350729865;3772.4152756322815;3775.169462718198;617.2315467243311;664.5016237821634;695.8851789454683;703.085988215318;705.2172088981226;629.697745082363;633.7940169444948;665.7603262825379;734.4858598980735;773.3117525402396;10023.348482348623;10222.437765922945;10340.638077667245;10372.636957706443;10495.370277783357;609.3479976425183;619.6282230661567;722.2560762414721;724.8477819657826;735.5843948169268;5067.1639179535705;5099.158638824627;5124.333836601218;5126.256692779526;5185.7407129644125;114355;126419.3679031599;128050;129428.3528582351;130259;108553;108698;109380.453097734;109653;113856;62392.68803656044;62509.68745156245;83993.58003210067;96974.51512742533;97741.5112924445;9224.815503690023;9309;9347.626094956398;9379.765505862408;9448.574814133519;54732.17901731557;55818.441815581325;56459.717701412876;56504.434955649915;57013.42986570081;77278.22721772935;80100.59949700447;82794.58602707188;83092.16907830845;83387.16612833794;12131.696707582381;12267.57063502773;12272.938635306766;12440.626781196579;12759.425825837674;13229.404676789374;13274.734505309647;13792.586222413343;14270.286485675468;14761.409543618565;13596;14121.08212966154;14305.356258968579;14320.355583998537;14627.853721462649;13349.332533373487;13415.664608384868;14198.29008549589;14687.926560367558;14754.188519631523;10838.783224335626;13202.669933251746;14530.491432799801;14672.926635366755;14681.045732027384;11390;11492.195546311677;11927.522899083939;11945.701357466132;12238.0761085734;11240.269382490113;11443.25618834773;11644.941775291069;11964.880351196376;12106.636800895987 13:28:53 INFO - PROCESS | 2851 | __end_tp_report 13:28:53 INFO - PROCESS | 2851 | __start_cc_report 13:28:53 INFO - PROCESS | 2851 | _x_x_mozilla_cycle_collect,336 13:28:53 INFO - PROCESS | 2851 | __end_cc_report 13:28:53 INFO - PROCESS | 2851 | __startTimestamp1465331333008__endTimestamp 13:28:53 INFO - PROCESS | 2851 | 13:28:53 INFO - PROCESS | 2851 | ------- Summary: start ------- 13:28:53 INFO - PROCESS | 2851 | Number of tests: 6 13:28:53 INFO - PROCESS | 2851 | 13:28:53 INFO - PROCESS | 2851 | [#0] dojo.html Cycles:165 Average:5434.69 Median:5677.35 stddev:723.98 (12.8%) stddev-sans-first:704.11 13:28:53 INFO - PROCESS | 2851 | Values: 3172.5 3223.9 3229.5 3240.6 3259.2 5411.9 5418.5 5440.3 5457.2 5537.8 5364.8 5372.1 5412.8 5434.5 5494.5 4894.0 4928.0 5008.0 5064.9 5114.3 778.0 4991.8 5018.5 5027.1 5040.0 4903.9 4920.5 4938.5 4950.4 4962.6 4899.0 4956.8 4961.0 4971.8 5014.7 4899.1 4945.7 4981.7 4988.7 4990.1 5371.0 5421.3 5442.8 5447.2 5447.6 5654.7 5744.4 5874.0 5875.5 5883.9 5837.6 5931.9 5941.8 5947.6 6007.1 5518.9 5544.8 5545.3 5559.4 5572.8 5862.5 6055.9 6056.4 6068.6 6104.8 5829.4 5833.9 5834.6 5835.4 5879.3 5852.9 5904.0 5906.5 5908.9 5920.3 5681.8 5718.0 5728.0 5729.5 5765.5 5689.9 5777.1 5793.0 5800.2 5859.1 4483.7 4484.9 4489.5 4496.6 4517.4 3913.6 3935.1 3945.4 3960.2 4018.1 5652.8 5659.6 5659.9 5706.3 5738.4 5884.3 5929.1 5941.3 5952.0 5979.3 5502.7 5579.3 5602.7 5662.8 5677.3 5071.3 5084.0 5086.7 5101.7 5123.2 6104.5 6138.9 6140.1 6142.9 6144.0 5751.9 5850.1 5863.9 5915.6 5919.8 6153.8 6155.2 6168.3 6175.0 6179.6 5821.6 5848.8 5854.9 5862.6 5878.0 5756.9 5861.0 5896.2 5916.1 5984.9 5796.5 5802.1 5815.5 5826.7 5827.4 5624.6 5722.6 5796.2 5801.1 5809.6 5533.4 5585.8 5604.0 5605.7 5627.7 5714.1 5759.0 5789.7 5795.3 5807.2 5522.2 5629.0 5667.7 5670.9 5681.1 13:28:53 INFO - PROCESS | 2851 | 13:28:53 INFO - PROCESS | 2851 | [#1] ext.html Cycles:180 Average:61633.00 Median:42734.29 stddev:126350.59 (295.7%) stddev-sans-first:126621.95 13:28:53 INFO - PROCESS | 2851 | Values: 603.3 603.5 619.0 634.4 634.9 42868.0 44362.1 44500.3 44514.8 47676.8 45525.8 45964.0 46181.3 46185.8 46272.1 8827.4 8876.2 9011.9 9020.3 9025.5 8780.3 8850.6 8853.6 8894.0 8935.3 8989.8 9010.0 9048.5 9066.0 9074.6 8908.3 8928.8 8931.8 9008.0 9011.5 8752.5 8757.0 8905.7 8910.9 8943.1 42011.4 42385.4 42405.6 42427.4 42556.8 3455.7 3999.0 4199.0 4246.6 4266.1 31321.4 31369.7 31972.0 32173.2 32515.5 4289.1 4363.7 4376.5 4378.1 4430.2 323300.0 323898.0 324369.0 324440.0 324715.0 34016.7 58754.7 58788.4 58961.7 59001.1 34609.1 36440.3 36518.8 36667.0 36674.0 14992.3 15003.8 15048.9 15176.2 15179.5 13049.6 13054.9 13094.4 13158.1 13164.0 8287.3 8371.7 8437.7 8450.2 8454.0 3302.8 3324.6 3325.8 3338.3 3363.3 921.3 963.8 981.3 1036.6 1065.4 29380.7 30167.5 31588.8 31995.9 32713.3 1099.4 1142.4 1153.8 1199.8 1202.3 16316.8 16773.4 16799.2 16863.6 17037.7 574999.0 575108.0 578476.0 579150.0 580304.0 57747.7 58399.4 58793.7 59152.0 59205.7 1381.8 1387.5 1389.0 1420.8 1427.0 30543.0 30693.7 31691.4 32014.2 32215.8 54372.5 56167.7 56308.7 59924.0 60275.7 482731.0 485198.0 485747.0 488211.0 490964.0 43044.4 43289.4 43995.3 44068.0 44593.8 47884.8 47946.5 48045.0 49228.3 49431.5 40961.8 41655.8 41788.6 42666.0 42802.6 40526.4 41062.6 41211.8 41829.4 42147.6 40792.6 41402.2 41776.6 41883.0 43591.8 34188.0 36669.8 36865.3 37137.0 37562.8 28488.0 28529.3 28784.4 28886.9 29060.4 13:28:53 INFO - PROCESS | 2851 | 13:28:53 INFO - PROCESS | 2851 | [#2] jquery.html Cycles:180 Average:28815.53 Median:22096.45 stddev:83582.99 (378.3%) stddev-sans-first:83790.23 13:28:53 INFO - PROCESS | 2851 | Values: 400.3 401.5 405.2 408.7 415.8 13663.5 18012.2 18514.5 19816.2 19834.8 18105.4 18304.4 18413.4 18661.4 18978.9 5417.0 5496.3 5635.5 5659.1 5679.5 5587.9 5599.8 5608.8 5640.0 5641.1 5365.9 5592.6 5606.9 5640.4 5640.9 5550.8 5588.2 5588.6 5599.8 5602.4 4843.9 4991.6 5012.5 5016.9 5021.1 21911.7 21981.5 22211.4 22226.8 22516.4 2362.2 2374.4 2379.0 2526.2 2710.4 13788.1 13960.4 14031.4 14162.2 14428.7 1917.7 1953.7 1976.7 2007.2 2025.1 73413.3 75054.0 76271.6 76432.2 76633.6 10285.1 10413.3 10562.4 10592.0 10739.9 14559.6 14644.0 14656.5 14659.9 14690.9 8206.9 8476.2 8522.5 8616.0 8679.1 8274.6 8292.1 8327.8 8464.6 8487.5 6383.4 6503.9 6574.7 6587.7 6592.0 1863.5 1886.9 1956.5 1963.2 1976.6 1006.2 1008.5 1010.9 1117.1 1132.1 17981.3 18098.0 18950.1 19077.3 19201.3 1037.5 1047.8 1057.7 1067.5 1073.4 10517.3 10771.2 10793.6 10834.2 10953.7 501864.0 508426.0 509419.0 514631.0 515251.0 76611.0 79828.6 80062.6 80428.0 81084.0 1033.6 1036.7 1053.4 1055.2 1062.7 16096.3 16503.4 16532.5 16675.8 16852.6 37840.0 38259.4 38424.8 38655.4 39971.0 51269.0 52512.0 52571.5 52901.5 54124.2 7449.7 7877.0 8457.1 8798.7 8870.1 13026.3 13369.0 13532.1 13556.4 13683.0 11492.4 11828.9 11837.2 12032.5 12059.9 11448.7 11558.8 11771.4 11812.2 11943.7 12062.9 12067.5 12117.9 12122.2 12336.4 7907.3 7918.0 7930.9 8082.9 8168.6 8837.8 11202.3 11707.8 11731.3 11764.9 13:28:53 INFO - PROCESS | 2851 | 13:28:53 INFO - PROCESS | 2851 | [#3] mootools.html Cycles:180 Average:5898.04 Median:4796.90 stddev:3361.54 (70.1%) stddev-sans-first:3354.85 13:28:53 INFO - PROCESS | 2851 | Values: 1518.0 1523.9 1711.6 1786.8 1836.7 7984.8 8422.2 8653.9 8961.2 8980.8 8774.0 8889.9 8978.6 9028.7 9038.5 2353.1 2366.1 2384.1 2384.7 2388.9 2329.5 2358.8 2367.3 2369.5 2369.8 2330.6 2343.6 2345.8 2377.1 2377.1 2265.6 2266.3 2274.0 2276.2 2312.8 2285.5 2320.4 2344.2 2350.2 2350.9 8868.7 8998.7 9020.2 9049.0 9050.1 5312.4 5377.8 5397.1 5417.8 5459.6 3496.0 3560.7 3620.5 3634.9 3644.3 1107.8 1135.3 1170.8 1188.7 2142.3 12116.8 12474.4 12560.0 12580.4 12598.9 4654.1 4689.3 4734.9 4776.0 4778.4 9942.2 9960.5 9986.0 9996.5 10019.9 5344.5 5352.7 5375.0 5382.2 5393.1 4187.6 4683.9 4815.4 4815.9 4847.5 3780.5 3786.7 3866.7 3873.8 3898.2 1189.0 1191.5 1197.7 1203.0 1204.6 780.0 823.5 857.1 863.7 907.4 5509.8 5814.3 5956.9 6090.6 6373.5 981.6 995.7 1026.4 1029.0 1035.2 4047.2 4107.4 4115.5 4125.3 4135.5 11158.2 11433.1 11477.1 11480.9 11543.8 11290.4 11311.7 11372.5 11386.4 11415.5 8043.0 8389.7 8398.1 8455.9 8528.6 5978.6 6178.2 6178.8 6193.8 6256.3 10208.1 10282.1 10284.3 10443.3 10454.9 10400.7 10458.3 10527.4 10565.3 10602.7 7727.1 7775.9 8006.5 8031.1 8076.6 8559.8 8568.6 8573.8 8625.0 8626.0 7675.3 7861.4 7873.4 7912.7 7926.1 7468.4 7564.7 7571.5 7620.3 8040.4 7195.2 7232.2 7261.5 7319.2 7328.3 5053.3 5078.7 5464.1 5498.7 5565.2 5094.8 5158.3 5172.9 5176.2 5198.5 13:28:53 INFO - PROCESS | 2851 | 13:28:53 INFO - PROCESS | 2851 | [#4] prototype.html Cycles:180 Average:4847.89 Median:5516.67 stddev:1448.16 (26.3%) stddev-sans-first:1411.99 13:28:53 INFO - PROCESS | 2851 | Values: 331.6 338.1 340.6 340.7 343.5 5511.5 5551.3 5709.8 5718.2 5728.9 5555.3 5556.4 5557.8 5584.9 5609.0 4318.7 4327.3 4342.0 4353.3 4366.4 4075.1 4285.1 4298.3 4355.6 4357.9 4195.8 4198.6 4202.7 4216.1 4239.3 4238.2 4255.6 4268.4 4280.1 4322.5 3514.8 3749.2 3759.9 3760.4 3767.2 5307.3 5314.9 5324.8 5330.4 5334.2 4801.3 4866.4 4867.2 4888.3 4901.3 5521.9 5734.8 5735.6 5749.9 5774.9 4038.6 4061.2 4065.6 4090.9 4106.3 5980.9 5995.1 6009.2 6043.3 6055.2 4035.8 4188.7 4193.1 4197.1 4214.2 4183.3 4194.3 4197.8 4197.9 4233.0 4908.8 4923.4 4932.5 4944.2 4948.4 5371.6 5795.5 5863.7 5871.6 5885.9 1444.5 1451.7 1460.3 1470.8 1474.7 903.3 931.6 935.8 960.9 965.4 4957.7 4965.8 5015.3 5038.6 5073.5 5193.4 5273.6 5275.5 5314.3 5338.8 5060.3 5084.6 5094.6 5334.0 5805.9 3145.2 3164.7 3180.0 3185.4 3204.2 6103.5 6214.8 6225.7 6253.7 6265.4 6084.8 6148.5 6150.5 6157.7 6163.7 6158.8 6175.4 6182.7 6199.3 6268.3 5779.7 5925.2 5925.3 5946.3 6022.9 5757.7 5914.6 5919.1 5922.6 5929.3 6107.2 6133.9 6200.5 6261.0 6280.5 4180.6 4180.6 4193.5 4214.9 4221.1 5971.6 5985.2 6017.4 6035.8 6125.6 5859.8 5870.5 5876.9 5896.8 5904.2 5882.4 5889.8 5919.9 5923.3 5923.4 5549.1 5769.7 5770.1 5770.9 5771.4 5853.5 5904.5 5937.9 5953.1 5958.8 5567.6 5774.1 5823.5 5826.4 5826.4 13:28:53 INFO - PROCESS | 2851 | 13:28:53 INFO - PROCESS | 2851 | [#5] yui.html Cycles:180 Average:21685.08 Median:3814.37 stddev:31885.03 (835.9%) stddev-sans-first:31935.59 13:28:53 INFO - PROCESS | 2851 | Values: 712.8 718.8 767.7 817.3 856.3 15558.1 15816.8 16125.5 16138.1 16279.2 15558.2 16012.3 16157.7 16167.2 16169.3 792.4 801.3 803.8 807.4 826.7 807.5 814.9 819.9 819.9 820.4 840.9 841.5 842.2 842.4 843.2 827.2 830.9 832.9 836.9 837.3 600.6 602.3 604.4 604.8 605.1 15288.7 15330.1 15330.5 15358.5 15360.2 14907.7 14966.3 15080.8 15106.6 15180.8 12116.4 12512.4 12658.9 12743.0 12884.8 3810.8 3817.9 3840.3 3871.0 3923.0 72981.0 74421.0 74739.3 74821.0 75471.0 11139.0 11522.4 11522.4 11625.9 11844.6 21747.2 21808.2 21834.1 21948.9 22085.6 8008.4 8119.8 8450.1 8574.8 8658.7 4726.2 4883.3 4898.3 4999.5 5014.9 3624.5 3734.6 3768.2 3772.4 3775.2 617.2 664.5 695.9 703.1 705.2 629.7 633.8 665.8 734.5 773.3 10023.3 10222.4 10340.6 10372.6 10495.4 609.3 619.6 722.3 724.8 735.6 5067.2 5099.2 5124.3 5126.3 5185.7 114355.0 126419.4 128050.0 129428.4 130259.0 108553.0 108698.0 109380.5 109653.0 113856.0 62392.7 62509.7 83993.6 96974.5 97741.5 9224.8 9309.0 9347.6 9379.8 9448.6 54732.2 55818.4 56459.7 56504.4 57013.4 77278.2 80100.6 82794.6 83092.2 83387.2 12131.7 12267.6 12272.9 12440.6 12759.4 13229.4 13274.7 13792.6 14270.3 14761.4 13596.0 14121.1 14305.4 14320.4 14627.9 13349.3 13415.7 14198.3 14687.9 14754.2 10838.8 13202.7 14530.5 14672.9 14681.0 11390.0 11492.2 11927.5 11945.7 12238.1 11240.3 11443.3 11644.9 11964.9 12106.6 13:28:53 INFO - PROCESS | 2851 | -------- Summary: end -------- 13:28:53 INFO - PROCESS | 2851 | 13:28:53 INFO - TEST-INFO | 2851: exit 0 13:28:53 INFO - TEST-OK | dromaeo_css | took 1110435ms 13:28:53 INFO - TEST-START | kraken 13:28:53 INFO - operating with platform_type : linux_ 13:28:53 INFO - Initialising browser for kraken test... 13:28:53 INFO - TEST-INFO | started process 3097 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJj3EK_/profile http://localhost:60077/getInfo.html) 13:28:58 INFO - PROCESS | 3097 | __metrics Screen width/height:1600/1200 13:28:58 INFO - PROCESS | 3097 | colorDepth:24 13:28:58 INFO - PROCESS | 3097 | Browser inner width/height: 1024/697 13:28:58 INFO - PROCESS | 3097 | __metrics 13:28:59 ERROR - PROCESS | 3097 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 13:29:00 INFO - TEST-INFO | 3097: exit 0 13:29:00 INFO - Browser initialized. 13:29:00 INFO - Running cycle 1/1 for kraken test... 13:29:00 INFO - TEST-INFO | started process 3217 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJj3EK_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:29:12 INFO - PROCESS | 3217 | RSS: Main: 167317504 13:29:12 INFO - PROCESS | 3217 | 13:29:14 INFO - PROCESS | 3217 | Cycle 1(1): loaded http://localhost:60077/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60077/tests/kraken/driver.html?testName=audio-beat-detection) 13:29:15 INFO - PROCESS | 3217 | RSS: Main: 172937216 13:29:15 INFO - PROCESS | 3217 | 13:29:18 INFO - PROCESS | 3217 | Cycle 1(1): loaded http://localhost:60077/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60077/tests/kraken/driver.html?testName=audio-dft) 13:29:18 INFO - PROCESS | 3217 | RSS: Main: 172105728 13:29:18 INFO - PROCESS | 3217 | 13:29:21 INFO - PROCESS | 3217 | Cycle 1(1): loaded http://localhost:60077/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60077/tests/kraken/driver.html?testName=audio-fft) 13:29:22 INFO - PROCESS | 3217 | RSS: Main: 166780928 13:29:22 INFO - PROCESS | 3217 | 13:29:24 INFO - PROCESS | 3217 | Cycle 1(1): loaded http://localhost:60077/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60077/tests/kraken/driver.html?testName=audio-oscillator) 13:29:25 INFO - PROCESS | 3217 | RSS: Main: 167411712 13:29:25 INFO - PROCESS | 3217 | 13:29:27 INFO - PROCESS | 3217 | Cycle 1(1): loaded http://localhost:60077/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60077/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:29:28 INFO - PROCESS | 3217 | RSS: Main: 167661568 13:29:28 INFO - PROCESS | 3217 | 13:29:31 INFO - PROCESS | 3217 | Cycle 1(1): loaded http://localhost:60077/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60077/tests/kraken/driver.html?testName=imaging-darkroom) 13:29:31 INFO - PROCESS | 3217 | RSS: Main: 168484864 13:29:31 INFO - PROCESS | 3217 | 13:29:35 INFO - PROCESS | 3217 | Cycle 1(1): loaded http://localhost:60077/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60077/tests/kraken/driver.html?testName=imaging-desaturate) 13:29:36 INFO - PROCESS | 3217 | RSS: Main: 165904384 13:29:36 INFO - PROCESS | 3217 | 13:29:38 INFO - PROCESS | 3217 | Cycle 1(1): loaded http://localhost:60077/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60077/tests/kraken/driver.html?testName=json-parse-financial) 13:29:39 INFO - PROCESS | 3217 | RSS: Main: 167202816 13:29:39 INFO - PROCESS | 3217 | 13:29:41 INFO - PROCESS | 3217 | Cycle 1(1): loaded http://localhost:60077/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60077/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:29:41 INFO - PROCESS | 3217 | RSS: Main: 167751680 13:29:41 INFO - PROCESS | 3217 | 13:29:43 INFO - PROCESS | 3217 | Cycle 1(1): loaded http://localhost:60077/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60077/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:29:44 INFO - PROCESS | 3217 | RSS: Main: 167870464 13:29:44 INFO - PROCESS | 3217 | 13:29:46 INFO - PROCESS | 3217 | Cycle 1(1): loaded http://localhost:60077/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60077/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:29:46 INFO - PROCESS | 3217 | RSS: Main: 167895040 13:29:46 INFO - PROCESS | 3217 | 13:29:49 INFO - PROCESS | 3217 | Cycle 1(1): loaded http://localhost:60077/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:29:50 INFO - PROCESS | 3217 | RSS: Main: 168222720 13:29:50 INFO - PROCESS | 3217 | 13:29:52 INFO - PROCESS | 3217 | Cycle 1(1): loaded http://localhost:60077/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:29:53 INFO - PROCESS | 3217 | RSS: Main: 167968768 13:29:53 INFO - PROCESS | 3217 | 13:29:55 INFO - PROCESS | 3217 | Cycle 1(1): loaded http://localhost:60077/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60077/tests/kraken/driver.html?testName=ai-astar) 13:29:55 INFO - PROCESS | 3217 | RSS: Main: 168304640 13:29:55 INFO - PROCESS | 3217 | 13:29:55 INFO - PROCESS | 3217 | __start_tp_report 13:29:55 INFO - PROCESS | 3217 | _x_x_mozilla_page_load 13:29:55 INFO - PROCESS | 3217 | _x_x_mozilla_page_load_details 13:29:55 INFO - PROCESS | 3217 | |i|pagename|runs| 13:29:55 INFO - PROCESS | 3217 | |0;ai-astar;112;106;111;110;112;110;114;109;110;110 13:29:55 INFO - PROCESS | 3217 | |1;audio-beat-detection;156;125;157;188;127;156;149;140;193;125 13:29:55 INFO - PROCESS | 3217 | |2;audio-dft;162;161;162;163;162;164;174;164;163;164 13:29:55 INFO - PROCESS | 3217 | |3;audio-fft;73;74;75;152;77;77;76;74;169;76 13:29:55 INFO - PROCESS | 3217 | |4;audio-oscillator;85;86;144;85;86;87;143;86;85;145 13:29:55 INFO - PROCESS | 3217 | |5;imaging-gaussian-blur;117;117;117;117;118;118;118;118;119;117 13:29:55 INFO - PROCESS | 3217 | |6;imaging-darkroom;146;147;147;148;148;147;148;147;147;147 13:29:55 INFO - PROCESS | 3217 | |7;imaging-desaturate;95;96;95;98;95;96;95;95;95;96 13:29:55 INFO - PROCESS | 3217 | |8;json-parse-financial;54;55;54;53;54;56;53;58;57;54 13:29:55 INFO - PROCESS | 3217 | |9;json-stringify-tinderbox;61;63;67;61;62;62;61;61;62;61 13:29:55 INFO - PROCESS | 3217 | |10;stanford-crypto-aes;80;81;86;82;82;80;81;83;105;79 13:29:55 INFO - PROCESS | 3217 | |11;stanford-crypto-ccm;130;133;122;124;121;120;128;123;135;126 13:29:55 INFO - PROCESS | 3217 | |12;stanford-crypto-pbkdf2;163;170;157;160;156;169;160;162;169;156 13:29:55 INFO - PROCESS | 3217 | |13;stanford-crypto-sha256-iterative;64;64;65;62;64;64;63;64;63;62 13:29:55 INFO - PROCESS | 3217 | __end_tp_report 13:29:55 INFO - PROCESS | 3217 | __start_cc_report 13:29:55 INFO - PROCESS | 3217 | _x_x_mozilla_cycle_collect,911 13:29:55 INFO - PROCESS | 3217 | __end_cc_report 13:29:55 INFO - PROCESS | 3217 | __startTimestamp1465331395326__endTimestamp 13:29:55 INFO - PROCESS | 3217 | 13:29:55 INFO - PROCESS | 3217 | ------- Summary: start ------- 13:29:55 INFO - PROCESS | 3217 | Number of tests: 14 13:29:55 INFO - PROCESS | 3217 | 13:29:55 INFO - PROCESS | 3217 | [#0] ai-astar Cycles:10 Average:110.40 Median:110.50 stddev:2.12 (1.9%) stddev-sans-first:2.17 13:29:55 INFO - PROCESS | 3217 | Values: 112.0 106.0 111.0 110.0 112.0 110.0 114.0 109.0 110.0 110.0 13:29:55 INFO - PROCESS | 3217 | 13:29:55 INFO - PROCESS | 3217 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:156.00 stddev:24.19 (15.5%) stddev-sans-first:25.61 13:29:55 INFO - PROCESS | 3217 | Values: 156.0 125.0 157.0 188.0 127.0 156.0 149.0 140.0 193.0 125.0 13:29:55 INFO - PROCESS | 3217 | 13:29:55 INFO - PROCESS | 3217 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:3.70 (2.3%) stddev-sans-first:3.86 13:29:55 INFO - PROCESS | 3217 | Values: 162.0 161.0 162.0 163.0 162.0 164.0 174.0 164.0 163.0 164.0 13:29:55 INFO - PROCESS | 3217 | 13:29:55 INFO - PROCESS | 3217 | [#3] audio-fft Cycles:10 Average:92.30 Median:75.50 stddev:36.19 (47.9%) stddev-sans-first:37.71 13:29:55 INFO - PROCESS | 3217 | Values: 73.0 74.0 75.0 152.0 77.0 77.0 76.0 74.0 169.0 76.0 13:29:55 INFO - PROCESS | 3217 | 13:29:55 INFO - PROCESS | 3217 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:85.50 stddev:28.17 (32.9%) stddev-sans-first:29.09 13:29:55 INFO - PROCESS | 3217 | Values: 85.0 86.0 144.0 85.0 86.0 87.0 143.0 86.0 85.0 145.0 13:29:55 INFO - PROCESS | 3217 | 13:29:55 INFO - PROCESS | 3217 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 13:29:55 INFO - PROCESS | 3217 | Values: 117.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 119.0 117.0 13:29:55 INFO - PROCESS | 3217 | 13:29:55 INFO - PROCESS | 3217 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 13:29:55 INFO - PROCESS | 3217 | Values: 146.0 147.0 147.0 148.0 148.0 147.0 148.0 147.0 147.0 147.0 13:29:55 INFO - PROCESS | 3217 | 13:29:55 INFO - PROCESS | 3217 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.97 (1.0%) stddev-sans-first:1.00 13:29:55 INFO - PROCESS | 3217 | Values: 95.0 96.0 95.0 98.0 95.0 96.0 95.0 95.0 95.0 96.0 13:29:55 INFO - PROCESS | 3217 | 13:29:55 INFO - PROCESS | 3217 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:54.50 stddev:1.69 (3.1%) stddev-sans-first:1.76 13:29:55 INFO - PROCESS | 3217 | Values: 54.0 55.0 54.0 53.0 54.0 56.0 53.0 58.0 57.0 54.0 13:29:55 INFO - PROCESS | 3217 | 13:29:55 INFO - PROCESS | 3217 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:1.85 (3.0%) stddev-sans-first:1.92 13:29:55 INFO - PROCESS | 3217 | Values: 61.0 63.0 67.0 61.0 62.0 62.0 61.0 61.0 62.0 61.0 13:29:55 INFO - PROCESS | 3217 | 13:29:55 INFO - PROCESS | 3217 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:81.50 stddev:7.67 (9.4%) stddev-sans-first:8.00 13:29:55 INFO - PROCESS | 3217 | Values: 80.0 81.0 86.0 82.0 82.0 80.0 81.0 83.0 105.0 79.0 13:29:55 INFO - PROCESS | 3217 | 13:29:55 INFO - PROCESS | 3217 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:127.00 stddev:5.16 (4.1%) stddev-sans-first:5.29 13:29:55 INFO - PROCESS | 3217 | Values: 130.0 133.0 122.0 124.0 121.0 120.0 128.0 123.0 135.0 126.0 13:29:55 INFO - PROCESS | 3217 | 13:29:55 INFO - PROCESS | 3217 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:162.50 stddev:5.45 (3.4%) stddev-sans-first:5.78 13:29:55 INFO - PROCESS | 3217 | Values: 163.0 170.0 157.0 160.0 156.0 169.0 160.0 162.0 169.0 156.0 13:29:55 INFO - PROCESS | 3217 | 13:29:55 INFO - PROCESS | 3217 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 13:29:55 INFO - PROCESS | 3217 | Values: 64.0 64.0 65.0 62.0 64.0 64.0 63.0 64.0 63.0 62.0 13:29:55 INFO - PROCESS | 3217 | -------- Summary: end -------- 13:29:55 INFO - PROCESS | 3217 | 13:29:56 INFO - TEST-INFO | 3217: exit 0 13:29:56 INFO - TEST-OK | kraken | took 62520ms 13:29:56 INFO - SUITE-END | took 1172s 13:29:56 INFO - Completed test suite (00:19:33) 13:29:56 INFO - javascript benchmark 13:29:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7324.332054029414, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3172.4924012158053, 3223.8871639492613, 3229.4994275887216, 3240.6435292117876, 3259.2177877309455, 5411.918821217685, 5418.539424148948, 5440.347158340995, 5457.154141108124, 5537.833864984057, 5364.758585863636, 5372.140457526796, 5412.837614871551, 5434.483724046219, 5494.478024587658, 4893.951060489403, 4928.0, 5007.974960125194, 5064.875712838053, 5114.258432527281, 777.9604410131092, 4991.825286114987, 5018.498150184989, 5027.0699920514635, 5039.966806804615, 4903.926441103386, 4920.532549407819, 4938.530839570253, 4950.405951285851, 4962.5533701966815, 4899.044686286175, 4956.801727930914, 4961.032598643266, 4971.751412429364, 5014.6991180529285, 4899.118158731427, 4945.67853089548, 4981.651284410093, 4988.725620090893, 4990.076835785391, 5371.0, 5421.268128802601, 5442.755076021588, 5447.155690867922, 5447.5641948644015, 5654.717264136777, 5744.396838331999, 5873.970630146865, 5875.471207591338, 5883.882322353529, 5837.562182836305, 5931.940680593182, 5941.821745347646, 5947.613405128653, 6007.128966299906, 5518.944810551923, 5544.833654990357, 5545.334559852843, 5559.388467268597, 5572.804951826666, 5862.472377486047, 6055.939440605625, 6056.394360563909, 6068.605540639845, 6104.847378815565, 5829.446202610745, 5833.854153646193, 5834.5624078194305, 5835.35811060783, 5879.323877754113, 5852.853678658068, 5904.0, 5906.49794767441, 5908.881822363529, 5920.319163296276, 5681.829545113653, 5718.0, 5727.971360143256, 5729.541636669056, 5765.509931655773, 5689.857753556194, 5777.133429985452, 5792.9710351447975, 5800.216970708901, 5859.091840764689, 4483.708558943658, 4484.932726009112, 4489.506154323022, 4496.550344965477, 4517.412736344254, 3913.5890731473355, 3935.114599215211, 3945.368741001426, 3960.2277555876904, 4018.136100738297, 5652.802151924663, 5659.603827732019, 5659.943400566024, 5706.28671416073, 5738.368779434259, 5884.293884733859, 5929.080992446092, 5941.346451890288, 5951.9702401488585, 5979.312379076462, 5502.724863756796, 5579.302587176603, 5602.747876345574, 5662.7734890603915, 5677.347105082886, 5071.3153724247495, 5084.0, 5086.694798312039, 5101.7194054327365, 5123.205903085028, 6104.511639068864, 6138.907916381258, 6140.140380346755, 6142.877142457126, 6144.047672610753, 5751.913721294268, 5850.063989761617, 5863.94136058651, 5915.64506129625, 5919.7632094717455, 6153.784617538365, 6155.169052177898, 6168.321484636596, 6175.042868355412, 6179.62922224668, 5821.621594596338, 5848.824535263949, 5854.853628659318, 5862.618929769551, 5878.0, 5756.913646295226, 5861.032929566573, 5896.233489646319, 5916.142159386951, 5984.940150598438, 5796.507296879644, 5802.100674395476, 5815.505682017076, 5826.650400975955, 5827.358990511125, 5624.550035997028, 5722.599418040863, 5796.21751063601, 5801.129830525455, 5809.62237454581, 5533.446655334435, 5585.776568937359, 5604.047311956896, 5605.719714014202, 5627.690477023803, 5714.142878568248, 5758.971205143947, 5789.710514474175, 5795.304563452412, 5807.186993820953, 5522.171674248895, 5628.986782379047, 5667.688277144796, 5670.914936275876, 5681.0626246668835], "value": 5387.6812804949905, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.300171800711, 603.5262319079523, 618.9938100618994, 634.4226753654173, 634.8825467288555, 42868.0, 44362.112757744864, 44500.33249501256, 44514.7774261129, 47676.76161619196, 45525.7723711381, 45964.0, 46181.30728039082, 46185.769071154595, 46272.07455850881, 8827.426217295888, 8876.245519130882, 9011.909880901205, 9020.323475739313, 9025.458472491639, 8780.25367843734, 8850.645974161058, 8853.5573221339, 8894.021657617657, 8935.285177185842, 8989.820203595924, 9009.95495022524, 9048.547572621343, 9066.0, 9074.59164337603, 8908.287337013024, 8928.776780580538, 8931.776705582348, 9008.0, 9011.459312441242, 8752.518611476366, 8756.956215218883, 8905.73282801517, 8910.910890891138, 8943.10568943107, 42011.36982945258, 42385.36421953673, 42405.575944240474, 42427.36358954587, 42556.78721606372, 3455.6889879910677, 3999.0289771066386, 4199.0, 4246.596573325529, 4266.06146647737, 31321.37357252842, 31369.686303136903, 31972.0, 32173.1956701082, 32515.512267316008, 4289.120730250323, 4363.694541382105, 4376.496702879178, 4378.1462614790125, 4430.202563538562, 323300.0, 323898.0, 324369.0, 324440.0, 324714.9999999976, 34016.65983340184, 58754.706226468596, 58788.412115879146, 58961.70519147377, 59001.11498327443, 34609.13477163091, 36440.27119457596, 36518.8174059128, 36667.0, 36674.0, 14992.250387480583, 15003.849961500464, 15048.924755376152, 15176.165310907785, 15179.468718594797, 13049.608511744664, 13054.934725326313, 13094.410751516205, 13158.078934474686, 13164.0, 8287.337013038943, 8371.665133394717, 8437.662493500315, 8450.239478446847, 8453.95773021131, 3302.752293577991, 3324.6010478742705, 3325.8170800605717, 3338.349021940698, 3363.3273345330545, 921.2721949659827, 963.7638778499313, 981.3425005246502, 1036.5698235232294, 1065.350136416785, 29380.706192937796, 30167.547486787716, 31588.842055789573, 31995.931960037415, 32713.34573308568, 1099.4173088263233, 1142.4116579961326, 1153.763478486908, 1199.7600479904054, 1202.2546021466746, 16316.836831631532, 16773.412930547373, 16799.160041998097, 16863.57841053959, 17037.65924681524, 574999.0, 575108.0, 578476.0, 579150.0, 580304.0, 57747.71126144342, 58399.41600584025, 58793.70603146957, 59152.0, 59205.70397147987, 1381.7650999330137, 1387.5421111033536, 1388.9652758681113, 1420.808190894216, 1427.022489594631, 30543.0, 30693.693063069084, 31691.366172676877, 32014.199645009063, 32215.838920805247, 54372.45627543832, 56167.71916140556, 56308.71845640909, 59924.0, 60275.69862150661, 482731.0, 485198.0, 485747.0, 488211.0, 490964.0, 43044.35433468563, 43289.3506597395, 43995.34006989834, 44068.0, 44593.77703111464, 47884.760576196895, 47946.5205347942, 48045.0, 49228.261576075674, 49431.50568494413, 40961.795191023855, 41655.7917210412, 41788.582114179684, 42666.0, 42802.571974281105, 40526.39210411787, 41062.589374105875, 41211.793941030104, 41829.372559412244, 42147.57852421559, 40792.59207407888, 41402.1719565613, 41776.58223417849, 41883.0, 43591.78204109086, 34188.0, 36669.816650916575, 36865.26269474542, 37137.0, 37562.81218593889, 28488.0, 28529.28676783097, 28784.42431151407, 28886.85556572204, 29060.418791624474], "value": 19438.012044451636, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.251529639574, 401.4620408652405, 405.1774896959173, 408.69347989008224, 415.8066499077928, 13663.521776737816, 18012.189451474682, 18514.53713657159, 19816.207351705933, 19834.809911405326, 18105.366312179078, 18304.359347422844, 18413.355532556365, 18661.440156795285, 18978.90510547449, 5416.972915135419, 5496.285482887219, 5635.464630860061, 5659.094544872821, 5679.545636349082, 5587.8603034924245, 5599.804006859761, 5608.803691870765, 5639.971800141014, 5641.12562552805, 5365.919511207335, 5592.5805564582815, 5606.8598285043, 5640.407757185498, 5640.915386269209, 5550.833474995757, 5588.245586845785, 5588.636738611997, 5599.776008959657, 5602.355729091166, 4843.9031219375765, 4991.600671946236, 5012.523810238022, 5016.949830501685, 5021.096202683552, 21911.67132493014, 21981.450463738376, 22211.44471388212, 22226.777732222796, 22516.437089072904, 2362.161432691387, 2374.4063984004, 2378.988929704886, 2526.2168727694475, 2710.390162213506, 13788.103773254707, 13960.371783269777, 14031.368588413547, 14162.150270983773, 14428.711425771531, 1917.673995420782, 1953.6581098307881, 1976.7034944758402, 2007.1971211515365, 2025.1190732031614, 73413.26586734118, 75054.0, 76271.61864190754, 76432.23567764362, 76633.61683191604, 10285.125764310118, 10413.323133996417, 10562.419066951237, 10592.0, 10739.946300268448, 14559.636009099857, 14644.04813687107, 14656.487022954145, 14659.92670036643, 14690.853091468949, 8206.917930820615, 8476.194761497647, 8522.531260780592, 8616.0, 8679.088695686989, 8274.627641756135, 8292.087870334259, 8327.791805204919, 8464.619092140869, 8487.490750554864, 6383.425491705676, 6503.8699226015215, 6574.671266436755, 6587.706146926536, 6591.967040164865, 1863.487540926256, 1886.9433916982512, 1956.4913122587946, 1963.2147141143657, 1976.6046790641929, 1006.1900170362928, 1008.5310330696261, 1010.9292349535461, 1117.0625833814559, 1132.1452303510962, 17981.291777281138, 18098.0, 18950.147243373805, 19077.332293369665, 19201.32795352156, 1037.5331101004579, 1047.8428235764543, 1057.7144171073767, 1067.5409573883305, 1073.4203530093819, 10517.263791534671, 10771.246012779031, 10793.568257269779, 10834.241603087708, 10953.671389858317, 501864.0, 508426.0, 509419.0, 514631.0, 515251.0, 76611.0, 79828.60085699534, 80062.59968700119, 80428.0, 81084.0, 1033.5968972100886, 1036.7252678040325, 1053.441675911768, 1055.2033214922685, 1062.6918193723734, 16096.275667594751, 16503.422380216634, 16532.504024879272, 16675.833241667428, 16852.57868553247, 37840.0, 38259.42610860783, 38424.80787596044, 38655.42016869805, 39971.00072498211, 51269.0, 52512.0, 52571.474285256656, 52901.470985289656, 54124.18813717719, 7449.664765085476, 7877.0, 8457.069722330416, 8798.736037918872, 8870.09715725079, 13026.348682566024, 13369.0, 13532.120412173177, 13556.389962451516, 13683.0, 11492.367919764492, 11828.881711182778, 11837.230580012272, 12032.518699251932, 12059.939700301442, 11448.656540303804, 11558.768824623628, 11771.411429428323, 11812.17314787991, 11943.701407464883, 12062.939685301517, 12067.456964436446, 12117.939410302892, 12122.212056216318, 12336.383180841101, 7907.288344048833, 7918.0, 7930.881036784568, 8082.87875681877, 8168.591570421337, 8837.779055523662, 11202.271852329572, 11707.824382634097, 11731.296122232694, 11764.941175294069], "value": 9228.909176472493, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1518.0436325115177, 1523.8704710099644, 1711.6491119320533, 1786.8213178682142, 1836.715309127085, 7984.760457186279, 8422.241998220159, 8653.87019194711, 8961.238294744939, 8980.820383592332, 8774.0, 8889.866652000224, 8978.595963181657, 9028.68399606014, 9038.457692538452, 2353.141103497224, 2366.065404165354, 2384.1059602649007, 2384.654225137354, 2388.868612226327, 2329.499157681098, 2358.8230882683783, 2367.2779802160335, 2369.4668699542635, 2369.8222633302485, 2330.6387509935985, 2343.5664402085667, 2345.8357914945877, 2377.09670325277, 2377.1442280778906, 2265.6261716816707, 2266.29744779119, 2273.9658905116435, 2276.2374604507427, 2312.826538009639, 2285.520040791436, 2320.3619004773655, 2344.15610380263, 2350.2361732437025, 2350.894209760565, 8868.733937981871, 8998.685046023358, 9020.233280171193, 9049.049849765746, 9050.140236677506, 5312.442193569658, 5377.81177658784, 5397.055515284809, 5417.783288668488, 5459.617826752129, 3496.0, 3560.6855543896418, 3620.456931460302, 3634.8727794527063, 3644.344018076745, 1107.8116720157593, 1135.2961164078242, 1170.8068168752231, 1188.680564573323, 2142.3251675722254, 12116.757664846742, 12474.376281185996, 12560.0, 12580.4338804754, 12598.929091027274, 4654.092451971833, 4689.343491911135, 4734.928976065362, 4775.9731657693765, 4778.426588809365, 9942.154916832005, 9960.452175130438, 9985.950070249603, 9996.450195239186, 10019.949900250598, 5344.465553444625, 5352.652077614943, 5374.951884382586, 5382.219578161144, 5393.1370980642905, 4187.581241875788, 4683.906321873544, 4815.374001379868, 4815.855524334275, 4847.491013443609, 3780.5085338906315, 3786.7159963002887, 3866.7486613370043, 3873.825677844504, 3898.181381909774, 1188.9583864564872, 1191.541256616209, 1197.6586672798385, 1203.0, 1204.6325870609548, 779.9860181763685, 823.5017814222429, 857.0957639690062, 863.680438237856, 907.4373888189365, 5509.834704958857, 5814.273215848019, 5956.85107872298, 6090.573659843857, 6373.52198585108, 981.6466072213997, 995.7062666513395, 1026.440589878518, 1028.953697083633, 1035.177034257767, 4047.170330082326, 4107.424960505532, 4115.464989551399, 4125.278076336629, 4135.462389889295, 11158.218924675195, 11433.14251431146, 11477.081833453303, 11480.885191147981, 11543.76912461746, 11290.379029153311, 11311.660650180507, 11372.488238029144, 11386.43067846621, 11415.543378264943, 8042.959785201154, 8389.664413423518, 8398.076211616717, 8455.873161902577, 8528.616212270586, 5978.581499295182, 6178.227721534809, 6178.845528861814, 6193.783217587363, 6256.280527739186, 10208.132308753839, 10282.126019288444, 10284.2801003932, 10443.268971171945, 10454.895451045391, 10400.687979360631, 10458.26792124544, 10527.420991845522, 10565.313254638424, 10602.734931626772, 7727.072751269883, 7775.883361749465, 8006.519608823489, 8031.116577176389, 8076.636551355085, 8559.786005349915, 8568.614412351335, 8573.828523429622, 8624.956875215585, 8626.0, 7675.347595454449, 7861.371090312876, 7873.448858580074, 7912.723054693289, 7926.088499822594, 7468.365188958782, 7564.735234266775, 7571.46999710015, 7620.314171724572, 8040.356771458152, 7195.244499327495, 7232.168300645493, 7261.5280006799385, 7319.231480694663, 7328.3404493595835, 5053.29253904461, 5078.7206703631655, 5464.071107911744, 5498.670079795225, 5565.1930470082425, 5094.7962081516325, 5158.277841102174, 5172.922406163986, 5176.223566465061, 5198.532132107977], "value": 4717.520797853696, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.6445811300019, 338.1411215512598, 340.58958954459865, 340.7103961632612, 343.507067358341, 5511.476409741078, 5551.306086739158, 5709.828705138847, 5718.1994520767075, 5728.942710572898, 5555.2778138841995, 5556.388797232301, 5557.833265002057, 5584.944150558493, 5609.0, 4318.69769116162, 4327.329263964083, 4342.0, 4353.28170851809, 4366.410534577839, 4075.1034772350185, 4285.121550082225, 4298.269294219975, 4355.629771469429, 4357.891052723691, 4195.832166713343, 4198.622124008839, 4202.726822756511, 4216.072464057902, 4239.300515414953, 4238.237117318881, 4255.638195777368, 4268.381084742695, 4280.101178752466, 4322.50291216511, 3514.8242587870504, 3749.15643980105, 3759.9436008459893, 3760.417135344026, 3767.2088861339153, 5307.2569840222395, 5314.893702125936, 5324.787008519655, 5330.38700549434, 5334.1732031535175, 4801.2798080287885, 4866.418414015459, 4867.221244600847, 4888.266759985995, 4901.338319326881, 5521.861953451155, 5734.770609175628, 5735.569832262597, 5749.856253593652, 5774.884502309972, 4038.5557588665224, 4061.1674606705556, 4065.6340929316207, 4090.877273681794, 4106.281400754886, 5980.850478738066, 5995.070764031582, 6009.1587177795145, 6043.335233124353, 6055.152278680944, 4035.7982100894837, 4188.706790524695, 4193.1194449165405, 4197.139586384784, 4214.17823524416, 4183.330667093312, 4194.266003449445, 4197.76912269822, 4197.874063778091, 4232.957670423318, 4908.779104940215, 4923.409190897115, 4932.482089380635, 4944.184209605447, 4948.38145231846, 5371.597130215249, 5795.478406943395, 5863.70681465925, 5871.55963302754, 5885.941140588625, 1444.4727674398769, 1451.7386870363437, 1460.2698650674663, 1470.8087948566617, 1474.727175472541, 903.2864037410503, 931.5807886451124, 935.7894473743489, 960.9423434593947, 965.3966271080575, 4957.727324997088, 4965.808206030527, 5015.297858299841, 5038.64729468941, 5073.467285934924, 5193.428722840485, 5273.602495338739, 5275.472452754694, 5314.335708036496, 5338.759755810997, 5060.291559181717, 5084.593232541388, 5094.61790365724, 5333.973330133324, 5805.883882322414, 3145.1665308693214, 3164.6677098904743, 3179.952300715491, 3185.4425475542153, 3204.214967332972, 6103.542234332443, 6214.844628884314, 6225.688715564203, 6253.6560489172625, 6265.404786545271, 6084.756609735649, 6148.508119350441, 6150.50795936324, 6157.6613286269685, 6163.691815409301, 6158.784442544489, 6175.44421002112, 6182.69086545671, 6199.256089269316, 6268.279147897959, 5779.682117483579, 5925.229720136354, 5925.267081738477, 5946.28644562638, 6022.90965635507, 5757.712114394348, 5914.645121292736, 5919.082542205792, 5922.644641321534, 5929.258842644669, 6107.206063211754, 6133.877322453615, 6200.503959683305, 6260.968695156495, 6280.528960328085, 4180.561041090763, 4180.6446452050695, 4193.475815523059, 4214.873553793391, 4221.092465120014, 5971.641701497924, 5985.221921150397, 6017.398260173947, 6035.78874739382, 6125.632462052291, 5859.765609375577, 5870.5010074144175, 5876.911846322223, 5896.793612223723, 5904.173415721716, 5882.382349853375, 5889.764409423575, 5919.852003699942, 5923.289205295392, 5923.437273459014, 5549.139883318092, 5769.653820770767, 5770.105633626795, 5770.913436298543, 5771.384012476513, 5853.512257290719, 5904.468597826216, 5937.940620593911, 5953.124765698791, 5958.76164953397, 5567.638103523258, 5774.0761478163295, 5823.466791945517, 5826.388229236039, 5826.446487583673], "value": 4383.071908549648, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [712.7790384980659, 718.809515478398, 767.6890859202022, 817.2644619842141, 856.267890953235, 15558.144302063381, 15816.841831581694, 16125.516234512954, 16138.112403817786, 16279.186040697947, 15558.222088895538, 16012.279447424864, 16157.676846463064, 16167.19164041799, 16169.272382742776, 792.3938187286731, 801.2548330053063, 803.8432505661399, 807.3581502705334, 826.7313123234943, 807.5316316536395, 814.9266566009057, 819.8852160697508, 819.9180081991783, 820.3560205238889, 840.8864803251574, 841.4530555139147, 842.1788755962917, 842.3724325377572, 843.2242337049929, 827.1769589258666, 830.9086000539936, 832.8667413213857, 836.8995720513547, 837.3134030095324, 600.5855959388008, 602.28027507129, 604.4137186928672, 604.7701873288166, 605.1044454207797, 15288.694226115414, 15330.080195188324, 15330.540083797503, 15358.539243822703, 15360.155191464464, 14907.701845963129, 14966.326515306728, 15080.849191508054, 15106.622334441618, 15180.772288415683, 12116.394180291038, 12512.436940337706, 12658.936705316415, 12743.0, 12884.80672789909, 3810.8094595270127, 3817.9236415271816, 3840.2895464339185, 3871.0, 3922.9803850980848, 72981.0, 74420.99999999946, 74739.25260747377, 74821.0, 75471.0, 11138.98396014119, 11522.423878806027, 11522.423878806194, 11625.941870290595, 11844.585439509576, 21747.23884664029, 21808.236711715013, 21834.126634934426, 21948.89025554894, 22085.558288834134, 8008.359331253486, 8119.756407307672, 8450.070492245848, 8574.828503429897, 8658.740237792876, 4726.220173671306, 4883.316335713003, 4898.289747986522, 4999.525045120708, 5014.89970200594, 3624.52881125452, 3734.607866174067, 3768.246350729865, 3772.4152756322815, 3775.169462718198, 617.2315467243311, 664.5016237821634, 695.8851789454683, 703.085988215318, 705.2172088981226, 629.697745082363, 633.7940169444948, 665.7603262825379, 734.4858598980735, 773.3117525402396, 10023.348482348623, 10222.437765922945, 10340.638077667245, 10372.636957706443, 10495.370277783357, 609.3479976425183, 619.6282230661567, 722.2560762414721, 724.8477819657826, 735.5843948169268, 5067.1639179535705, 5099.158638824627, 5124.333836601218, 5126.256692779526, 5185.7407129644125, 114355.0, 126419.3679031599, 128050.0, 129428.3528582351, 130259.0, 108553.0, 108698.0, 109380.453097734, 109653.0, 113856.0, 62392.68803656044, 62509.68745156245, 83993.58003210067, 96974.51512742533, 97741.5112924445, 9224.815503690023, 9309.0, 9347.626094956398, 9379.765505862408, 9448.574814133519, 54732.17901731557, 55818.441815581325, 56459.717701412876, 56504.434955649915, 57013.42986570081, 77278.22721772935, 80100.59949700447, 82794.58602707188, 83092.16907830845, 83387.16612833794, 12131.696707582381, 12267.57063502773, 12272.938635306766, 12440.626781196579, 12759.425825837674, 13229.404676789374, 13274.734505309647, 13792.586222413343, 14270.286485675468, 14761.409543618565, 13596.0, 14121.08212966154, 14305.356258968579, 14320.355583998537, 14627.853721462649, 13349.332533373487, 13415.664608384868, 14198.29008549589, 14687.926560367558, 14754.188519631523, 10838.783224335626, 13202.669933251746, 14530.491432799801, 14672.926635366755, 14681.045732027384, 11390.0, 11492.195546311677, 11927.522899083939, 11945.701357466132, 12238.0761085734, 11240.269382490113, 11443.25618834773, 11644.941775291069, 11964.880351196376, 12106.636800895987], "value": 7724.493627092087, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 111.0, 110.0, 112.0, 110.0, 114.0, 109.0, 110.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 157.0, 188.0, 127.0, 156.0, 149.0, 140.0, 193.0, 125.0], "value": 151.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 163.0, 162.0, 164.0, 174.0, 164.0, 163.0, 164.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 152.0, 77.0, 77.0, 76.0, 74.0, 169.0, 76.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 144.0, 85.0, 86.0, 87.0, 143.0, 86.0, 85.0, 145.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 119.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 98.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 53.0, 54.0, 56.0, 53.0, 58.0, 57.0, 54.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 67.0, 61.0, 62.0, 62.0, 61.0, 61.0, 62.0, 61.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 86.0, 82.0, 82.0, 80.0, 81.0, 83.0, 105.0, 79.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 133.0, 122.0, 124.0, 121.0, 120.0, 128.0, 123.0, 135.0, 126.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 170.0, 157.0, 160.0, 156.0, 169.0, 160.0, 162.0, 169.0, 156.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 62.0, 64.0, 64.0, 63.0, 64.0, 63.0, 62.0], "value": 63.5, "unit": "score"}]}]} 13:29:56 INFO - Return code: 0 13:29:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:29:56 ERROR - # TBPL SUCCESS # 13:29:56 INFO - Running post-action listener: _resource_record_post_action 13:29:56 INFO - ##### 13:29:56 INFO - ##### Finished run-tests step (success) 13:29:56 INFO - ##### 13:29:56 INFO - Running post-run listener: _resource_record_post_run 13:29:56 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551477248; Read time: 12; Write time: 633880 13:29:56 INFO - TinderboxPrint: CPU usage
13.4% 13:29:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 13:29:56 INFO - TinderboxPrint: I/O write bytes / time
551,477,248 / 633,880 13:29:56 INFO - TinderboxPrint: CPU idle
8,226.1 (86.6%) 13:29:56 INFO - TinderboxPrint: CPU user
1,217.2 (12.8%) 13:29:56 INFO - TinderboxPrint: Swap in / out
0 / 0 13:29:56 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 230596608; Read time: 0; Write time: 300488 13:29:56 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291495936; Read time: 12; Write time: 328320 13:29:57 INFO - Running post-run listener: _upload_blobber_files 13:29:57 INFO - Blob upload gear active. 13:29:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:29:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:29:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:29:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:29:57 INFO - (blobuploader) - INFO - Open directory for files ... 13:29:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:29:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:29:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:29:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:29:58 INFO - (blobuploader) - INFO - Done attempting. 13:29:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:29:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:30:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:30:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:30:02 INFO - (blobuploader) - INFO - Done attempting. 13:30:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:30:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:30:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:30:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:30:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:30:03 INFO - (blobuploader) - INFO - Done attempting. 13:30:03 INFO - (blobuploader) - INFO - Iteration through files over. 13:30:03 INFO - Return code: 0 13:30:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:30:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:30:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/21cddd49bc906ef1020616974f8a56614d1b900e576d71bf36cc20ffe1126de88f18307cdbe441ae562cfd3150c3472cb3c39f8a5c81120f972126d3378ca0d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7f2414cbe9a9c37b8ad0e2760284198d64625eb7260040f3bad3f97a1d87a1c4552ec10641bc60ce23dc45d1e1cf60569debc3b177416fc32397ef7389d13efc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/da20874209129b98d750dd718843cc1b9f1092b44865caeaac0a2a649e33dd1f695a4413e552d94fccbeee0da6cac514dda32bb62182bc74841983f44dcea7ae"} 13:30:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:30:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:30:03 INFO - Contents: 13:30:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/21cddd49bc906ef1020616974f8a56614d1b900e576d71bf36cc20ffe1126de88f18307cdbe441ae562cfd3150c3472cb3c39f8a5c81120f972126d3378ca0d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7f2414cbe9a9c37b8ad0e2760284198d64625eb7260040f3bad3f97a1d87a1c4552ec10641bc60ce23dc45d1e1cf60569debc3b177416fc32397ef7389d13efc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/da20874209129b98d750dd718843cc1b9f1092b44865caeaac0a2a649e33dd1f695a4413e552d94fccbeee0da6cac514dda32bb62182bc74841983f44dcea7ae"} 13:30:03 INFO - Running post-run listener: copy_logs_to_upload_dir 13:30:03 INFO - Copying logs to upload dir... 13:30:03 INFO - mkdir: /builds/slave/test/build/upload/logs 13:30:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.810127 ========= master_lag: 1.45 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-06-07 13:30:04.704266) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 13:30:04.707891) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484 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/21cddd49bc906ef1020616974f8a56614d1b900e576d71bf36cc20ffe1126de88f18307cdbe441ae562cfd3150c3472cb3c39f8a5c81120f972126d3378ca0d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7f2414cbe9a9c37b8ad0e2760284198d64625eb7260040f3bad3f97a1d87a1c4552ec10641bc60ce23dc45d1e1cf60569debc3b177416fc32397ef7389d13efc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/da20874209129b98d750dd718843cc1b9f1092b44865caeaac0a2a649e33dd1f695a4413e552d94fccbeee0da6cac514dda32bb62182bc74841983f44dcea7ae"} build_url:https://queue.taskcluster.net/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/Rz-7dXAlTvGbzbdCDAtfAQ/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/21cddd49bc906ef1020616974f8a56614d1b900e576d71bf36cc20ffe1126de88f18307cdbe441ae562cfd3150c3472cb3c39f8a5c81120f972126d3378ca0d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7f2414cbe9a9c37b8ad0e2760284198d64625eb7260040f3bad3f97a1d87a1c4552ec10641bc60ce23dc45d1e1cf60569debc3b177416fc32397ef7389d13efc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/da20874209129b98d750dd718843cc1b9f1092b44865caeaac0a2a649e33dd1f695a4413e552d94fccbeee0da6cac514dda32bb62182bc74841983f44dcea7ae"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 13:30:04.740580) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 13:30:04.740984) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1465330045.967509-118106484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 13:30:04.790360) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 13:30:04.793738) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 13:30:04.794066) ========= ========= Total master_lag: 1.58 =========