builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1467042056.99 results: success (0) buildid: 20160627060026 builduid: a337bc2e0ea446ec85254e32dcacb904 revision: 15cc9baf2b6f43859d4a34d7de14a7b31093cf76 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 08:40:56.989778) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-27 08:40:56.990259) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 08:40:56.990556) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-27 08:40:57.005520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:40:57.005901) ========= 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=6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-27 08:40:57-- 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% 89.0M=0s 2016-06-27 08:40:57 (89.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120006 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:40:57.140181) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:40:57.140533) ========= 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=6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013790 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:40:57.190869) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:40:57.191263) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 15cc9baf2b6f43859d4a34d7de14a7b31093cf76 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 15cc9baf2b6f43859d4a34d7de14a7b31093cf76 --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=6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-27 08:40:57,489 truncating revision to first 12 chars 2016-06-27 08:40:57,490 Setting DEBUG logging. 2016-06-27 08:40:57,490 attempt 1/10 2016-06-27 08:40:57,490 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/15cc9baf2b6f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-27 08:40:58,103 unpacking tar archive at: mozilla-aurora-15cc9baf2b6f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.967882 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 08:40:58.173000) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 08:40:58.173324) ========= script_repo_revision: 15cc9baf2b6f43859d4a34d7de14a7b31093cf76 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-27 08:40:58.173721) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 08:40:58.173989) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-27 08:40:58.182215) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-27 08:40:58.182588) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:40:58 INFO - MultiFileLogger online at 20160627 08:40:58 in /builds/slave/test 08:40:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:40:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:40:58 INFO - {'append_to_log': False, 08:40:58 INFO - 'base_work_dir': '/builds/slave/test', 08:40:58 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:40:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:40:58 INFO - 'branch': 'Mozilla-Aurora', 08:40:58 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:58 INFO - 'config_files': ('talos/linux_config.py',), 08:40:58 INFO - 'default_actions': ('clobber', 08:40:58 INFO - 'read-buildbot-config', 08:40:58 INFO - 'download-and-extract', 08:40:58 INFO - 'populate-webroot', 08:40:58 INFO - 'create-virtualenv', 08:40:58 INFO - 'install', 08:40:58 INFO - 'run-tests'), 08:40:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:58 INFO - 'download_minidump_stackwalk': True, 08:40:58 INFO - 'download_symbols': 'ondemand', 08:40:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:40:58 INFO - 'tooltool.py': '/tools/tooltool.py', 08:40:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:40:58 INFO - '/tools/misc-python/virtualenv.py')}, 08:40:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:58 INFO - 'installer_path': 'installer.exe', 08:40:58 INFO - 'log_level': 'info', 08:40:58 INFO - 'log_name': 'talos', 08:40:58 INFO - 'log_to_console': True, 08:40:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:40:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:40:58 INFO - 'opt_config_files': (), 08:40:58 INFO - 'pip_index': False, 08:40:58 INFO - 'sps_profile': False, 08:40:58 INFO - 'sps_profile_interval': 0, 08:40:58 INFO - 'suite': 'dromaeojs', 08:40:58 INFO - 'system_bits': '32', 08:40:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:58 INFO - 'title': 'talos-linux64-ix-050', 08:40:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:58 INFO - 'use_talos_json': True, 08:40:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:40:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:58 INFO - 'work_dir': 'build'} 08:40:58 INFO - ##### 08:40:58 INFO - ##### Running clobber step. 08:40:58 INFO - ##### 08:40:58 INFO - Running pre-action listener: _resource_record_pre_action 08:40:58 INFO - Running main action method: clobber 08:40:58 INFO - rmtree: /builds/slave/test/build 08:40:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:40:59 INFO - Running post-action listener: _resource_record_post_action 08:40:59 INFO - ##### 08:40:59 INFO - ##### Finished clobber step (success) 08:40:59 INFO - ##### 08:40:59 INFO - ##### 08:40:59 INFO - ##### Running read-buildbot-config step. 08:40:59 INFO - ##### 08:40:59 INFO - Running pre-action listener: _resource_record_pre_action 08:40:59 INFO - Running main action method: read_buildbot_config 08:40:59 INFO - Using buildbot properties: 08:40:59 INFO - { 08:40:59 INFO - "project": "", 08:40:59 INFO - "product": "firefox", 08:40:59 INFO - "script_repo_revision": "production", 08:40:59 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:40:59 INFO - "repository": "", 08:40:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:40:59 INFO - "buildid": "20160627060026", 08:40:59 INFO - "pgo_build": "True", 08:40:59 INFO - "basedir": "/builds/slave/test", 08:40:59 INFO - "buildnumber": 318, 08:40:59 INFO - "slavename": "talos-linux64-ix-050", 08:40:59 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:40:59 INFO - "platform": "ubuntu64_hw", 08:40:59 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:40:59 INFO - "branch": "mozilla-aurora", 08:40:59 INFO - "repo_path": "releases/mozilla-aurora", 08:40:59 INFO - "revision": "15cc9baf2b6f43859d4a34d7de14a7b31093cf76", 08:40:59 INFO - "stage_platform": "linux64-pgo", 08:40:59 INFO - "builduid": "a337bc2e0ea446ec85254e32dcacb904", 08:40:59 INFO - "slavebuilddir": "test" 08:40:59 INFO - } 08:40:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 08:40:59 INFO - Running post-action listener: _resource_record_post_action 08:40:59 INFO - ##### 08:40:59 INFO - ##### Finished read-buildbot-config step (success) 08:40:59 INFO - ##### 08:40:59 INFO - ##### 08:40:59 INFO - ##### Running download-and-extract step. 08:40:59 INFO - ##### 08:40:59 INFO - Running pre-action listener: _resource_record_pre_action 08:40:59 INFO - Running main action method: download_and_extract 08:40:59 INFO - mkdir: /builds/slave/test/build/tests 08:40:59 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')]} 08:40:59 INFO - https://queue.taskcluster.net/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:40:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 08:40:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 08:40:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 08:40:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:41:02 INFO - Downloaded 1361 bytes. 08:41:02 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 08:41:02 INFO - Using the following test package requirements: 08:41:02 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 08:41:02 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:41:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:41:02 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:41:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:41:02 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:41:02 INFO - u'jsshell-linux-x86_64.zip'], 08:41:02 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:41:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:41:02 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 08:41:02 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:41:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:41:02 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:41:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:41:02 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:41:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:41:02 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 08:41:02 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:41:02 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:41:02 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')]} 08:41:02 INFO - https://queue.taskcluster.net/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:41:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 08:41:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 08:41:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 08:41:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:41:03 INFO - Downloaded 24522577 bytes. 08:41:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:41:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:41:04 INFO - Return code: 0 08:41:04 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:41:04 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')]} 08:41:04 INFO - https://queue.taskcluster.net/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:41:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 08:41:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 08:41:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 08:41:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:41:05 INFO - Downloaded 24522577 bytes. 08:41:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:41:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:41:06 INFO - Return code: 0 08:41:06 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')]} 08:41:06 INFO - https://queue.taskcluster.net/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:41:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 08:41:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 08:41:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 08:41:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:41:07 INFO - Downloaded 10833369 bytes. 08:41:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:41:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:41:08 INFO - Return code: 0 08:41:08 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')]} 08:41:08 INFO - https://queue.taskcluster.net/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:41:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 08:41:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 08:41:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 08:41:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:41:09 INFO - Downloaded 63609656 bytes. 08:41:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 08:41:09 INFO - mkdir: /builds/slave/test/properties 08:41:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:41:09 INFO - Writing to file /builds/slave/test/properties/build_url 08:41:09 INFO - Contents: 08:41:09 INFO - build_url:https://queue.taskcluster.net/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 08:41:10 INFO - Running post-action listener: _resource_record_post_action 08:41:10 INFO - Running post-action listener: set_extra_try_arguments 08:41:10 INFO - ##### 08:41:10 INFO - ##### Finished download-and-extract step (success) 08:41:10 INFO - ##### 08:41:10 INFO - ##### 08:41:10 INFO - ##### Running populate-webroot step. 08:41:10 INFO - ##### 08:41:10 INFO - Running pre-action listener: _resource_record_pre_action 08:41:10 INFO - Running main action method: populate_webroot 08:41:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:41:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:41:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:41:10 INFO - '--tppagecycles', 08:41:10 INFO - '7'], 08:41:10 INFO - 'tests': ['tsvgm']}}, 08:41:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:41:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:41:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:41:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:41:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:41:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:41:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:10 INFO - 'talos_options': ['--disable-e10s'], 08:41:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:41:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:10 INFO - 'talos_options': ['--disable-e10s'], 08:41:10 INFO - 'tests': ['damp', 'tps']}, 08:41:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:10 INFO - 'tests': ['damp', 'tps']}, 08:41:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:41:10 INFO - 'tests': ['dromaeo_dom']}, 08:41:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:41:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:41:10 INFO - 'tests': ['a11yr', 08:41:10 INFO - 'ts_paint', 08:41:10 INFO - 'tpaint', 08:41:10 INFO - 'sessionrestore', 08:41:10 INFO - 'sessionrestore_no_auto_restore', 08:41:10 INFO - 'tabpaint']}, 08:41:10 INFO - 'other-e10s': {'tests': ['a11yr', 08:41:10 INFO - 'ts_paint', 08:41:10 INFO - 'tpaint', 08:41:10 INFO - 'sessionrestore', 08:41:10 INFO - 'sessionrestore_no_auto_restore', 08:41:10 INFO - 'tabpaint']}, 08:41:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:41:10 INFO - 'ts_paint', 08:41:10 INFO - 'tpaint', 08:41:10 INFO - 'sessionrestore', 08:41:10 INFO - 'sessionrestore_no_auto_restore', 08:41:10 INFO - 'tabpaint']}, 08:41:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:41:10 INFO - 'ts_paint', 08:41:10 INFO - 'tpaint', 08:41:10 INFO - 'sessionrestore', 08:41:10 INFO - 'sessionrestore_no_auto_restore', 08:41:10 INFO - 'tabpaint']}, 08:41:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:41:10 INFO - 'tests': ['a11yr', 08:41:10 INFO - 'ts_paint', 08:41:10 INFO - 'tpaint', 08:41:10 INFO - 'sessionrestore', 08:41:10 INFO - 'sessionrestore_no_auto_restore', 08:41:10 INFO - 'tabpaint']}, 08:41:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:41:10 INFO - 'tests': ['a11yr', 08:41:10 INFO - 'ts_paint', 08:41:10 INFO - 'tpaint', 08:41:10 INFO - 'sessionrestore', 08:41:10 INFO - 'sessionrestore_no_auto_restore', 08:41:10 INFO - 'tabpaint']}, 08:41:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:41:10 INFO - 'tests': ['tsvgx', 08:41:10 INFO - 'tsvgr_opacity', 08:41:10 INFO - 'tart', 08:41:10 INFO - 'tscrollx', 08:41:10 INFO - 'cart']}, 08:41:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:41:10 INFO - 'tsvgr_opacity', 08:41:10 INFO - 'tart', 08:41:10 INFO - 'tscrollx', 08:41:10 INFO - 'cart']}, 08:41:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:10 INFO - 'talos_options': ['--disable-e10s'], 08:41:10 INFO - 'tests': ['tp5o']}, 08:41:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:10 INFO - 'tests': ['tp5o']}, 08:41:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:10 INFO - 'talos_options': ['--disable-e10s', 08:41:10 INFO - '--xperf_path', 08:41:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:10 INFO - 'tests': ['tp5n']}, 08:41:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:41:10 INFO - 'talos_options': ['--xperf_path', 08:41:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:41:10 INFO - 'tests': ['tp5n']}}, 08:41:10 INFO - 'talos.zip': {'path': '', 08:41:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:41:10 INFO - Running post-action listener: _resource_record_post_action 08:41:10 INFO - ##### 08:41:10 INFO - ##### Finished populate-webroot step (success) 08:41:10 INFO - ##### 08:41:10 INFO - ##### 08:41:10 INFO - ##### Running create-virtualenv step. 08:41:10 INFO - ##### 08:41:10 INFO - Running pre-action listener: _resource_record_pre_action 08:41:10 INFO - Running main action method: create_virtualenv 08:41:10 INFO - Creating virtualenv /builds/slave/test/build/venv 08:41:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:41:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:41:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:41:10 INFO - Using real prefix '/usr' 08:41:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:41:10 INFO - Installing distribute.............................................................................................................................................................................................done. 08:41:12 INFO - Installing pip.................done. 08:41:12 INFO - Return code: 0 08:41:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd424e6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14342e0>, '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 0x13a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a05d0>, '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': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', '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 08:41:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:41:12 INFO - Using env: {'DISPLAY': ':0', 08:41:12 INFO - 'HOME': '/home/cltbld', 08:41:12 INFO - 'LANG': 'en_US.UTF-8', 08:41:12 INFO - 'LANGUAGE': 'en_US:en', 08:41:12 INFO - 'LOGNAME': 'cltbld', 08:41:12 INFO - 'MAIL': '/var/mail/cltbld', 08:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:12 INFO - 'MOZ_NO_REMOTE': '1', 08:41:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:12 INFO - 'NO_EM_RESTART': '1', 08:41:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:12 INFO - 'PWD': '/builds/slave/test', 08:41:12 INFO - 'SHELL': '/bin/bash', 08:41:12 INFO - 'SHLVL': '1', 08:41:12 INFO - 'TERM': 'linux', 08:41:12 INFO - 'TMOUT': '86400', 08:41:12 INFO - 'USER': 'cltbld', 08:41:12 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', 08:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:12 INFO - '_': '/tools/buildbot/bin/python'} 08:41:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:12 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 08:41:12 INFO - Cleaning up... 08:41:12 INFO - Return code: 0 08:41:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd424e6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14342e0>, '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 0x13a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a05d0>, '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': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', '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 08:41:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:41:12 INFO - Using env: {'DISPLAY': ':0', 08:41:12 INFO - 'HOME': '/home/cltbld', 08:41:12 INFO - 'LANG': 'en_US.UTF-8', 08:41:12 INFO - 'LANGUAGE': 'en_US:en', 08:41:12 INFO - 'LOGNAME': 'cltbld', 08:41:12 INFO - 'MAIL': '/var/mail/cltbld', 08:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:12 INFO - 'MOZ_NO_REMOTE': '1', 08:41:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:12 INFO - 'NO_EM_RESTART': '1', 08:41:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:12 INFO - 'PWD': '/builds/slave/test', 08:41:12 INFO - 'SHELL': '/bin/bash', 08:41:12 INFO - 'SHLVL': '1', 08:41:12 INFO - 'TERM': 'linux', 08:41:12 INFO - 'TMOUT': '86400', 08:41:12 INFO - 'USER': 'cltbld', 08:41:12 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', 08:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:12 INFO - '_': '/tools/buildbot/bin/python'} 08:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:13 INFO - Downloading/unpacking psutil>=3.1.1 08:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:41:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:15 INFO - Installing collected packages: psutil 08:41:15 INFO - Running setup.py install for psutil 08:41:15 INFO - building 'psutil._psutil_linux' extension 08:41:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:41:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:41:15 INFO - building 'psutil._psutil_posix' extension 08:41:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:41:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:41:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:15 INFO - Successfully installed psutil 08:41:15 INFO - Cleaning up... 08:41:15 INFO - Return code: 0 08:41:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd424e6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14342e0>, '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 0x13a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a05d0>, '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': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', '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 08:41:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:41:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:41:15 INFO - Using env: {'DISPLAY': ':0', 08:41:15 INFO - 'HOME': '/home/cltbld', 08:41:15 INFO - 'LANG': 'en_US.UTF-8', 08:41:15 INFO - 'LANGUAGE': 'en_US:en', 08:41:15 INFO - 'LOGNAME': 'cltbld', 08:41:15 INFO - 'MAIL': '/var/mail/cltbld', 08:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:15 INFO - 'MOZ_NO_REMOTE': '1', 08:41:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:15 INFO - 'NO_EM_RESTART': '1', 08:41:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:15 INFO - 'PWD': '/builds/slave/test', 08:41:15 INFO - 'SHELL': '/bin/bash', 08:41:15 INFO - 'SHLVL': '1', 08:41:15 INFO - 'TERM': 'linux', 08:41:15 INFO - 'TMOUT': '86400', 08:41:15 INFO - 'USER': 'cltbld', 08:41:15 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', 08:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:15 INFO - '_': '/tools/buildbot/bin/python'} 08:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:41:15 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 08:41:15 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 08:41:15 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 08:41:15 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 08:41:15 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 08:41:15 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 08:41:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:41:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:41:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:41:17 INFO - Installing collected packages: mozsystemmonitor 08:41:17 INFO - Running setup.py install for mozsystemmonitor 08:41:17 INFO - Successfully installed mozsystemmonitor 08:41:17 INFO - Cleaning up... 08:41:18 INFO - Return code: 0 08:41:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd424e6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14342e0>, '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 0x13a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a05d0>, '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': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', '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 08:41:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:41:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:41:18 INFO - Using env: {'DISPLAY': ':0', 08:41:18 INFO - 'HOME': '/home/cltbld', 08:41:18 INFO - 'LANG': 'en_US.UTF-8', 08:41:18 INFO - 'LANGUAGE': 'en_US:en', 08:41:18 INFO - 'LOGNAME': 'cltbld', 08:41:18 INFO - 'MAIL': '/var/mail/cltbld', 08:41:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:18 INFO - 'MOZ_NO_REMOTE': '1', 08:41:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:18 INFO - 'NO_EM_RESTART': '1', 08:41:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:18 INFO - 'PWD': '/builds/slave/test', 08:41:18 INFO - 'SHELL': '/bin/bash', 08:41:18 INFO - 'SHLVL': '1', 08:41:18 INFO - 'TERM': 'linux', 08:41:18 INFO - 'TMOUT': '86400', 08:41:18 INFO - 'USER': 'cltbld', 08:41:18 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', 08:41:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:18 INFO - '_': '/tools/buildbot/bin/python'} 08:41:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:18 INFO - Downloading/unpacking jsonschema==2.5.1 08:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:41:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:20 INFO - Downloading functools32-3.2.3-2.tar.gz 08:41:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:41:20 INFO - warning: no files found matching '*.txt' 08:41:20 INFO - no previously-included directories found matching 'build' 08:41:20 INFO - no previously-included directories found matching 'dist' 08:41:20 INFO - no previously-included directories found matching '.git*' 08:41:20 INFO - Installing collected packages: jsonschema, functools32 08:41:20 INFO - Running setup.py install for functools32 08:41:20 INFO - warning: no files found matching '*.txt' 08:41:20 INFO - no previously-included directories found matching 'build' 08:41:20 INFO - no previously-included directories found matching 'dist' 08:41:20 INFO - no previously-included directories found matching '.git*' 08:41:20 INFO - Successfully installed jsonschema functools32 08:41:20 INFO - Cleaning up... 08:41:20 INFO - Return code: 0 08:41:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd424e6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14342e0>, '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 0x13a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a05d0>, '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': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', '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 08:41:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:41:20 INFO - Using env: {'DISPLAY': ':0', 08:41:20 INFO - 'HOME': '/home/cltbld', 08:41:20 INFO - 'LANG': 'en_US.UTF-8', 08:41:20 INFO - 'LANGUAGE': 'en_US:en', 08:41:20 INFO - 'LOGNAME': 'cltbld', 08:41:20 INFO - 'MAIL': '/var/mail/cltbld', 08:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:20 INFO - 'MOZ_NO_REMOTE': '1', 08:41:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:20 INFO - 'NO_EM_RESTART': '1', 08:41:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:20 INFO - 'PWD': '/builds/slave/test', 08:41:20 INFO - 'SHELL': '/bin/bash', 08:41:20 INFO - 'SHLVL': '1', 08:41:20 INFO - 'TERM': 'linux', 08:41:20 INFO - 'TMOUT': '86400', 08:41:20 INFO - 'USER': 'cltbld', 08:41:20 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', 08:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:20 INFO - '_': '/tools/buildbot/bin/python'} 08:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:20 INFO - Downloading/unpacking blobuploader==1.2.4 08:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:22 INFO - Downloading blobuploader-1.2.4.tar.gz 08:41:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:41:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:41:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:23 INFO - Downloading docopt-0.6.1.tar.gz 08:41:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:41:23 INFO - Installing collected packages: blobuploader, requests, docopt 08:41:23 INFO - Running setup.py install for blobuploader 08:41:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:41:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:41:23 INFO - Running setup.py install for requests 08:41:23 INFO - Running setup.py install for docopt 08:41:24 INFO - Successfully installed blobuploader requests docopt 08:41:24 INFO - Cleaning up... 08:41:24 INFO - Return code: 0 08:41:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd424e6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14342e0>, '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 0x13a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a05d0>, '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': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', '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 08:41:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:41:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:24 INFO - Using env: {'DISPLAY': ':0', 08:41:24 INFO - 'HOME': '/home/cltbld', 08:41:24 INFO - 'LANG': 'en_US.UTF-8', 08:41:24 INFO - 'LANGUAGE': 'en_US:en', 08:41:24 INFO - 'LOGNAME': 'cltbld', 08:41:24 INFO - 'MAIL': '/var/mail/cltbld', 08:41:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:24 INFO - 'MOZ_NO_REMOTE': '1', 08:41:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:24 INFO - 'NO_EM_RESTART': '1', 08:41:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:24 INFO - 'PWD': '/builds/slave/test', 08:41:24 INFO - 'SHELL': '/bin/bash', 08:41:24 INFO - 'SHLVL': '1', 08:41:24 INFO - 'TERM': 'linux', 08:41:24 INFO - 'TMOUT': '86400', 08:41:24 INFO - 'USER': 'cltbld', 08:41:24 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', 08:41:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:24 INFO - '_': '/tools/buildbot/bin/python'} 08:41:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:24 INFO - Running setup.py (path:/tmp/pip-xvpjXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:24 INFO - Running setup.py (path:/tmp/pip-R07740-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:24 INFO - Running setup.py (path:/tmp/pip-Bbk7T9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:24 INFO - Running setup.py (path:/tmp/pip-k6VINM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:24 INFO - Running setup.py (path:/tmp/pip-P9hKdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:24 INFO - Running setup.py (path:/tmp/pip-YEjFFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:24 INFO - Running setup.py (path:/tmp/pip-2KirbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:24 INFO - Running setup.py (path:/tmp/pip-njVyzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:24 INFO - Running setup.py (path:/tmp/pip-Wz8YUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:24 INFO - Running setup.py (path:/tmp/pip-COj6zX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:25 INFO - Running setup.py (path:/tmp/pip-qw8EoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:25 INFO - Running setup.py (path:/tmp/pip-hZ7iC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:25 INFO - Running setup.py (path:/tmp/pip-8CHhlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:25 INFO - Running setup.py (path:/tmp/pip-d9i2jP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:25 INFO - Running setup.py (path:/tmp/pip-Xaah6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:25 INFO - Running setup.py (path:/tmp/pip-Yr13Dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:25 INFO - Running setup.py (path:/tmp/pip-fJe_mE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:41:25 INFO - Running setup.py install for manifestparser 08:41:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:41:25 INFO - Running setup.py install for mozcrash 08:41:25 INFO - Running setup.py install for mozdebug 08:41:25 INFO - Running setup.py install for mozdevice 08:41:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:41:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:41:25 INFO - Running setup.py install for mozfile 08:41:26 INFO - Running setup.py install for mozhttpd 08:41:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:41:26 INFO - Running setup.py install for mozinfo 08:41:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:41:26 INFO - Running setup.py install for mozInstall 08:41:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:41:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:41:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:41:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:41:26 INFO - Running setup.py install for mozleak 08:41:26 INFO - Running setup.py install for mozlog 08:41:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:41:26 INFO - Running setup.py install for moznetwork 08:41:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:41:26 INFO - Running setup.py install for mozprocess 08:41:26 INFO - Running setup.py install for mozprofile 08:41:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:41:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:41:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:41:26 INFO - Running setup.py install for mozrunner 08:41:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:41:26 INFO - Running setup.py install for mozscreenshot 08:41:27 INFO - Running setup.py install for moztest 08:41:27 INFO - Running setup.py install for mozversion 08:41:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:41:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:41:27 INFO - Cleaning up... 08:41:27 INFO - Return code: 0 08:41:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:41:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd424e6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14342e0>, '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 0x13a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a05d0>, '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': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', '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 08:41:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:27 INFO - Using env: {'DISPLAY': ':0', 08:41:27 INFO - 'HOME': '/home/cltbld', 08:41:27 INFO - 'LANG': 'en_US.UTF-8', 08:41:27 INFO - 'LANGUAGE': 'en_US:en', 08:41:27 INFO - 'LOGNAME': 'cltbld', 08:41:27 INFO - 'MAIL': '/var/mail/cltbld', 08:41:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:27 INFO - 'MOZ_NO_REMOTE': '1', 08:41:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:27 INFO - 'NO_EM_RESTART': '1', 08:41:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:27 INFO - 'PWD': '/builds/slave/test', 08:41:27 INFO - 'SHELL': '/bin/bash', 08:41:27 INFO - 'SHLVL': '1', 08:41:27 INFO - 'TERM': 'linux', 08:41:27 INFO - 'TMOUT': '86400', 08:41:27 INFO - 'USER': 'cltbld', 08:41:27 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', 08:41:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:27 INFO - '_': '/tools/buildbot/bin/python'} 08:41:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:27 INFO - Running setup.py (path:/tmp/pip-gBmoUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:27 INFO - Running setup.py (path:/tmp/pip-Q0Ew8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:27 INFO - Running setup.py (path:/tmp/pip-2cn7AC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:27 INFO - Running setup.py (path:/tmp/pip-t4CHsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:27 INFO - Running setup.py (path:/tmp/pip-GhQJ4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:27 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)) 08:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:27 INFO - Running setup.py (path:/tmp/pip-skoDp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:27 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)) 08:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:27 INFO - Running setup.py (path:/tmp/pip-PjDENr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:28 INFO - Running setup.py (path:/tmp/pip-sxHqh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:28 INFO - Running setup.py (path:/tmp/pip-b459i2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:28 INFO - Running setup.py (path:/tmp/pip-JYcmby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:28 INFO - Running setup.py (path:/tmp/pip-NBXhMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:28 INFO - Running setup.py (path:/tmp/pip-0uFEUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:28 INFO - Running setup.py (path:/tmp/pip-K39CG9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:28 INFO - Running setup.py (path:/tmp/pip-RiTwJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:28 INFO - Running setup.py (path:/tmp/pip-huwHMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:28 INFO - Running setup.py (path:/tmp/pip-dz_thq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:28 INFO - Running setup.py (path:/tmp/pip-qTYxku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:30 INFO - Downloading blessings-1.6.tar.gz 08:41:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:41:30 INFO - Installing collected packages: blessings 08:41:30 INFO - Running setup.py install for blessings 08:41:30 INFO - Successfully installed blessings 08:41:30 INFO - Cleaning up... 08:41:30 INFO - Return code: 0 08:41:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:41:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:31 INFO - Reading from file tmpfile_stdout 08:41:31 INFO - Current package versions: 08:41:31 INFO - argparse == 1.2.1 08:41:31 INFO - blessings == 1.6 08:41:31 INFO - blobuploader == 1.2.4 08:41:31 INFO - docopt == 0.6.1 08:41:31 INFO - functools32 == 3.2.3-2 08:41:31 INFO - jsonschema == 2.5.1 08:41:31 INFO - manifestparser == 1.1 08:41:31 INFO - mozInstall == 1.12 08:41:31 INFO - mozcrash == 0.17 08:41:31 INFO - mozdebug == 0.1 08:41:31 INFO - mozdevice == 0.48 08:41:31 INFO - mozfile == 1.2 08:41:31 INFO - mozhttpd == 0.7 08:41:31 INFO - mozinfo == 0.9 08:41:31 INFO - mozleak == 0.1 08:41:31 INFO - mozlog == 3.2 08:41:31 INFO - moznetwork == 0.27 08:41:31 INFO - mozprocess == 0.22 08:41:31 INFO - mozprofile == 0.28 08:41:31 INFO - mozrunner == 6.11 08:41:31 INFO - mozscreenshot == 0.1 08:41:31 INFO - mozsystemmonitor == 0.3 08:41:31 INFO - moztest == 0.7 08:41:31 INFO - mozversion == 1.4 08:41:31 INFO - psutil == 3.1.1 08:41:31 INFO - requests == 1.2.3 08:41:31 INFO - wsgiref == 0.1.2 08:41:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd424e6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14342e0>, '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 0x13a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a05d0>, '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': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', '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 08:41:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:41:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:31 INFO - Using env: {'DISPLAY': ':0', 08:41:31 INFO - 'HOME': '/home/cltbld', 08:41:31 INFO - 'LANG': 'en_US.UTF-8', 08:41:31 INFO - 'LANGUAGE': 'en_US:en', 08:41:31 INFO - 'LOGNAME': 'cltbld', 08:41:31 INFO - 'MAIL': '/var/mail/cltbld', 08:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:31 INFO - 'MOZ_NO_REMOTE': '1', 08:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:31 INFO - 'NO_EM_RESTART': '1', 08:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:31 INFO - 'PWD': '/builds/slave/test', 08:41:31 INFO - 'SHELL': '/bin/bash', 08:41:31 INFO - 'SHLVL': '1', 08:41:31 INFO - 'TERM': 'linux', 08:41:31 INFO - 'TMOUT': '86400', 08:41:31 INFO - 'USER': 'cltbld', 08:41:31 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', 08:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:31 INFO - '_': '/tools/buildbot/bin/python'} 08:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:41:31 INFO - Cleaning up... 08:41:31 INFO - Return code: 0 08:41:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd424e6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14342e0>, '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 0x13a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a05d0>, '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': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', '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 08:41:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:41:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:41:31 INFO - Using env: {'DISPLAY': ':0', 08:41:31 INFO - 'HOME': '/home/cltbld', 08:41:31 INFO - 'LANG': 'en_US.UTF-8', 08:41:31 INFO - 'LANGUAGE': 'en_US:en', 08:41:31 INFO - 'LOGNAME': 'cltbld', 08:41:31 INFO - 'MAIL': '/var/mail/cltbld', 08:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:31 INFO - 'MOZ_NO_REMOTE': '1', 08:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:31 INFO - 'NO_EM_RESTART': '1', 08:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:31 INFO - 'PWD': '/builds/slave/test', 08:41:31 INFO - 'SHELL': '/bin/bash', 08:41:31 INFO - 'SHLVL': '1', 08:41:31 INFO - 'TERM': 'linux', 08:41:31 INFO - 'TMOUT': '86400', 08:41:31 INFO - 'USER': 'cltbld', 08:41:31 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', 08:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:31 INFO - '_': '/tools/buildbot/bin/python'} 08:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:41:31 INFO - Cleaning up... 08:41:31 INFO - Return code: 0 08:41:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd424e6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14342e0>, '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 0x13a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a05d0>, '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': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', '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 08:41:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:41:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:41:31 INFO - Using env: {'DISPLAY': ':0', 08:41:31 INFO - 'HOME': '/home/cltbld', 08:41:31 INFO - 'LANG': 'en_US.UTF-8', 08:41:31 INFO - 'LANGUAGE': 'en_US:en', 08:41:31 INFO - 'LOGNAME': 'cltbld', 08:41:31 INFO - 'MAIL': '/var/mail/cltbld', 08:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:31 INFO - 'MOZ_NO_REMOTE': '1', 08:41:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:31 INFO - 'NO_EM_RESTART': '1', 08:41:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:31 INFO - 'PWD': '/builds/slave/test', 08:41:31 INFO - 'SHELL': '/bin/bash', 08:41:31 INFO - 'SHLVL': '1', 08:41:31 INFO - 'TERM': 'linux', 08:41:31 INFO - 'TMOUT': '86400', 08:41:31 INFO - 'USER': 'cltbld', 08:41:31 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', 08:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:31 INFO - '_': '/tools/buildbot/bin/python'} 08:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:31 INFO - Downloading/unpacking flake8 08:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:41:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:41:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:41:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:41:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:41:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:41:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:41:34 INFO - no previously-included directories found matching 'docs/_build' 08:41:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:41:34 INFO - Running setup.py install for pep8 08:41:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:41:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:41:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:41:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:41:34 INFO - no previously-included directories found matching 'docs/_build' 08:41:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:41:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:41:34 INFO - Cleaning up... 08:41:34 INFO - Return code: 0 08:41:34 INFO - Running post-action listener: _resource_record_post_action 08:41:34 INFO - Running post-action listener: _start_resource_monitoring 08:41:34 INFO - Starting resource monitoring. 08:41:34 INFO - ##### 08:41:34 INFO - ##### Finished create-virtualenv step (success) 08:41:34 INFO - ##### 08:41:34 INFO - ##### 08:41:34 INFO - ##### Running install step. 08:41:34 INFO - ##### 08:41:34 INFO - Running pre-action listener: _resource_record_pre_action 08:41:34 INFO - Running main action method: install 08:41:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:34 INFO - Reading from file tmpfile_stdout 08:41:34 INFO - Detecting whether we're running mozinstall >=1.0... 08:41:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:41:34 INFO - Reading from file tmpfile_stdout 08:41:34 INFO - Output received: 08:41:34 INFO - Usage: mozinstall [options] installer 08:41:34 INFO - Options: 08:41:34 INFO - -h, --help show this help message and exit 08:41:34 INFO - -d DEST, --destination=DEST 08:41:34 INFO - Directory to install application into. [default: 08:41:34 INFO - "/builds/slave/test"] 08:41:34 INFO - --app=APP Application being installed. [default: firefox] 08:41:34 INFO - mkdir: /builds/slave/test/build/application 08:41:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:41:50 INFO - Reading from file tmpfile_stdout 08:41:50 INFO - Output received: 08:41:50 INFO - /builds/slave/test/build/application/firefox/firefox 08:41:50 INFO - Running post-action listener: _resource_record_post_action 08:41:50 INFO - ##### 08:41:50 INFO - ##### Finished install step (success) 08:41:50 INFO - ##### 08:41:50 INFO - ##### 08:41:50 INFO - ##### Running run-tests step. 08:41:50 INFO - ##### 08:41:50 INFO - Running pre-action listener: _resource_record_pre_action 08:41:50 INFO - Running main action method: run_tests 08:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:50 INFO - Python 2.7.3 08:41:50 INFO - Return code: 0 08:41:50 INFO - grabbing minidump binary from tooltool 08:41: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')]} 08:41:50 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 0x14342e0>, '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 0x13a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a05d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:50 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 08:41:50 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 08:41:50 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 08:41:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:50 INFO - Return code: 0 08:41:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:41:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:41:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:41:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:41:51 INFO - Return code: 0 08:41:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:41:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:41:51 INFO - Using env: {'DISPLAY': ':0', 08:41:51 INFO - 'HOME': '/home/cltbld', 08:41:51 INFO - 'LANG': 'en_US.UTF-8', 08:41:51 INFO - 'LANGUAGE': 'en_US:en', 08:41:51 INFO - 'LOGNAME': 'cltbld', 08:41:51 INFO - 'MAIL': '/var/mail/cltbld', 08:41:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:51 INFO - 'MOZ_NO_REMOTE': '1', 08:41:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:51 INFO - 'NO_EM_RESTART': '1', 08:41:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:51 INFO - 'PWD': '/builds/slave/test', 08:41:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:51 INFO - 'SHELL': '/bin/bash', 08:41:51 INFO - 'SHLVL': '1', 08:41:51 INFO - 'TERM': 'linux', 08:41:51 INFO - 'TMOUT': '86400', 08:41:51 INFO - 'USER': 'cltbld', 08:41:51 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438', 08:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:51 INFO - '_': '/tools/buildbot/bin/python'} 08:41:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:41:52 INFO - mozversion application_buildid: 20160627060026 08:41:52 INFO - mozversion application_changeset: 15cc9baf2b6f43859d4a34d7de14a7b31093cf76 08:41:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:41:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:52 INFO - mozversion application_name: Firefox 08:41:52 INFO - mozversion application_remotingname: firefox-dev 08:41:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:41:52 INFO - mozversion application_vendor: Mozilla 08:41:52 INFO - mozversion application_version: 49.0a2 08:41:52 INFO - mozversion platform_buildid: 20160627060026 08:41:52 INFO - mozversion platform_changeset: 15cc9baf2b6f43859d4a34d7de14a7b31093cf76 08:41:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:41:52 INFO - mozversion platform_version: 49.0a2 08:41:52 INFO - using testdate: 1467042112 08:41:52 INFO - actual date: 1467042112 08:41:52 INFO - starting webserver on 'localhost:51687' 08:41:52 INFO - SUITE-START | Running 2 tests 08:41:52 INFO - TEST-START | dromaeo_css 08:41:52 INFO - operating with platform_type : linux_ 08:41:52 INFO - Initialising browser for dromaeo_css test... 08:41:52 INFO - TEST-INFO | started process 16092 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3cUDoE/profile http://localhost:51687/getInfo.html) 08:41:55 INFO - PROCESS | 16092 | __metrics Screen width/height:1600/1200 08:41:55 INFO - PROCESS | 16092 | colorDepth:24 08:41:55 INFO - PROCESS | 16092 | Browser inner width/height: 1024/697 08:41:55 INFO - PROCESS | 16092 | __metrics 08:41:56 ERROR - PROCESS | 16092 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:41:56 INFO - PROCESS | 16092 | console.error: PushService: 08:41:56 INFO - PROCESS | 16092 | stateChangeProcessEnqueue: Error transitioning state 08:41:56 INFO - PROCESS | 16092 | UnknownError 08:41:57 INFO - TEST-INFO | 16092: exit 0 08:41:57 INFO - Browser initialized. 08:41:57 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:57 INFO - TEST-INFO | started process 16181 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3cUDoE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:09 INFO - PROCESS | 16181 | RSS: Main: 145559552 08:42:09 INFO - PROCESS | 16181 | 08:43:00 INFO - PROCESS | 16181 | 1467042180451 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:45:08 INFO - PROCESS | 16181 | Cycle 1(1): loaded http://localhost:51687/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51687/tests/dromaeo/cssquery-ext.html) 08:45:09 INFO - PROCESS | 16181 | RSS: Main: 270938112 08:45:09 INFO - PROCESS | 16181 | 08:48:12 INFO - PROCESS | 16181 | Cycle 1(1): loaded http://localhost:51687/tests/dromaeo/cssquery-ext.html (next: http://localhost:51687/tests/dromaeo/cssquery-jquery.html) 08:48:12 INFO - PROCESS | 16181 | RSS: Main: 229740544 08:48:12 INFO - PROCESS | 16181 | 08:51:14 INFO - PROCESS | 16181 | Cycle 1(1): loaded http://localhost:51687/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51687/tests/dromaeo/cssquery-mootools.html) 08:51:15 INFO - PROCESS | 16181 | RSS: Main: 230699008 08:51:15 INFO - PROCESS | 16181 | 08:54:17 INFO - PROCESS | 16181 | Cycle 1(1): loaded http://localhost:51687/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51687/tests/dromaeo/cssquery-prototype.html) 08:54:17 INFO - PROCESS | 16181 | RSS: Main: 225071104 08:54:17 INFO - PROCESS | 16181 | 08:57:20 INFO - PROCESS | 16181 | Cycle 1(1): loaded http://localhost:51687/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51687/tests/dromaeo/cssquery-yui.html) 08:57:20 INFO - PROCESS | 16181 | RSS: Main: 190300160 08:57:20 INFO - PROCESS | 16181 | 09:00:23 INFO - PROCESS | 16181 | Cycle 1(1): loaded http://localhost:51687/tests/dromaeo/cssquery-yui.html (next: http://localhost:51687/tests/dromaeo/cssquery-dojo.html) 09:00:23 INFO - PROCESS | 16181 | RSS: Main: 253812736 09:00:23 INFO - PROCESS | 16181 | 09:00:23 INFO - PROCESS | 16181 | __start_tp_report 09:00:23 INFO - PROCESS | 16181 | _x_x_mozilla_page_load 09:00:23 INFO - PROCESS | 16181 | _x_x_mozilla_page_load_details 09:00:23 INFO - PROCESS | 16181 | |i|pagename|runs| 09:00:23 INFO - PROCESS | 16181 | |0;dojo.html;3374.4094783412897;3395.830208489575;3404.472306792448;3417.060308415187;3451.654834516549;5632.887342253158;5767.509761670263;5778.76884924603;5789.9710501447435;5808.361080281165;5710.714464276791;5751.4248575142465;5759.510441612468;5766.740496677649;5770.740316685748;5078.1874900016;5159.019786240621;5166.121759300909;5218.582513398938;5256.842294731164;5177.870553236162;5189.740512974355;5203.323567936163;5207.453217412174;5298.629095963265;5306.283651707028;5306.495882891119;5311.73441327934;5315.973420132894;5343.198520221959;5079.771410286509;5083.745812709387;5240.109181439165;5242.056429842627;5286.814961476349;5114.769835357418;5149.382074151126;5159.664621799571;5162.819301324435;5169.612279079084;5657.688827114507;5720.399358067385;5728.799492017801;5737.82786516401;5752.913706294409;5893.616914900518;6076.453119219247;6125.509959203253;6147.139400483936;6149.938500614981;6253.187085678878;6293.685315734195;6296.118543403927;6304.968475157641;6311.431971122575;5867;5882.294124705063;5891.587588868823;5892.882142357172;5897.0269905465975;6051.969740151271;6194.752209911553;6258.780942666985;6258.968705156445;6370.235571731329;6080.389719938736;6088.860142295654;6089.706871217611;6124.38756124384;6125.295591007002;5879.147523609053;6187.474064704551;6197.194364732556;6200.348963358782;6200.596961197508;6057.727402266909;6097.75608975636;6098.634081955097;6142.15876619177;6166.1983942087245;6138.447539721357;6190.164327815687;6193.473554747897;6202.317745048041;6207.751689932443;4567.406237189144;4617.976910115428;4696.412948381452;4704.223803072455;4719.693219940693;4125.463689720377;4152.43942067823;4194.622483976456;4201.306784380604;4231.767252801125;5897.056470964625;5909.881802363929;5914.940850591525;5916.1421593868645;5918.556108291809;5957.970210148921;6004.249468816398;6020.638761674226;6210.844728881723;6253.624782513064;5756.769729210785;5772.94227057724;5774.393688662714;5784.392638772868;5819.679917604488;5044.924326135111;5058.924116138261;5061.06205695809;5066.873328166826;5089.745512724349;6130.386961303923;6245.5628106032145;6299.527535434769;6333.65164915934;6362.6500542469685;6224.657643829451;6279.152314437675;6294.24469063697;6298.055291706098;6300.401461861115;6453.322401148;6472.417482426604;6484.092227088306;6488.286288508166;6490.740370385131;5920.585559010828;5973.701314934149;5993.520518358434;6039.577229594062;6112.663803490851;6143.56995010345;6153.2616086068165;6184.381561843779;6188.412100850412;6199.16311297969;5860.677662728591;6004.309504406874;6065.636061836304;6067.848303792441;6090.9390906090375;5983.252093488314;6006.069059295816;6044.455998960115;6095.603785753912;6097.817065488042;5999.550033747573;6000.429959153874;6000.429959153874;6001.549883758823;6006.129111278753;5857;5985.880282394415;6133.6319820810895;6135.53983451234;6149.323574406902;5778.8266352009505;5837.970810146092;5853.882922341444;5912.113183022581;6034.969825150846 09:00:23 INFO - PROCESS | 16181 | |1;ext.html;580.5268706004606;643.83904023994;657.0735263278772;658.515990746801;666.4834753066373;32482.350352992926;35695;35883.461748073736;35888.46167307489;35942;35960.46059309113;44370.55629443705;45723.77138114313;45743.542564574345;50324;9015.864762028576;9129.634814607407;9155.496447695374;9158.038405967378;9161.541922903862;8367.330613550901;8965.596548155349;9070.04764499728;10571.418571978538;10798.946005269963;10941.781164376747;11006.449677516131;11011.119110471143;11019.779604407908;11022.614208502704;10949.069329107035;11015.669529914116;11020.889791102067;11021.83467247992;11027.669169924875;8320.167983201693;10356.585736570529;10695.83956240657;10697.732556686067;11110.944445277722;44133;44343.556564434264;44391.556084439064;44400.555994439965;44466.77766611178;3327.2680010397676;3535.222251104753;3685;3687.870924517656;3755.868544600953;33394.666053339395;33830;33880;34032.829835850665;34188;3776.7167462440425;3826.942595861064;3834.559025712051;3885.7668539887413;3889.1638297765835;356480;356873;358291.9999999974;358912.61631075555;359059;37788.24423511514;38742.80628596839;58341;58755.706221468616;58794.70602647045;37154.44268335977;37231.441528377094;37244.25511489755;37256.25487490235;37289;16288.348466061225;16422.425215117415;16461.753073703905;16474.258658360402;16480.917595411946;12797.872021279854;13588.116772409761;13649.317534123453;13649.931750341384;13651.249181294925;8622.741317760478;8926.73219803394;8963.417377870417;8998.280137588978;9069.138431848964;3359.294548144917;3363.646817084171;3370.646082161387;3375.3924293627383;3425.657434256604;931.1386967055447;961.4615815143542;971.820213260535;1009.1472705563787;1044.3890324160452;33034.339313214085;33985.830070849486;34010.31979360399;34197.005028236985;34449.827750861084;1096.8683757949098;1127.9830802537967;1168.9240199387013;1173.612707806439;1212.4604550974907;17357.913210433868;17652.646947060988;17687.20407581662;17749.29002839872;17766.46700598984;565870;566959;570486;570764;574315;42269.577304226565;42745.78627106907;42778.35832462516;42818.78590607027;42855.785721071195;1330.507712146512;1405.5221224783622;1444.2489905249001;1448.9347979340955;1455.5269537400175;32665.34669306553;33569;34006.65993340134;34209.65790342164;34318.14204644904;51732;56880;59024.40975590361;59071.1139332919;64342;390771;394675;395263;396933;397002;33994.490082649274;39120.6087939117;44278;44802.55197447984;44858.55141448674;43443.34834977541;47453.288200676325;47975;48895;49091.26363104628;39543.604563955145;40900.79549602352;41212.38181427341;41226.38160427536;42124;40823;41879.581204188784;44205.77897110494;45524;46306.536934630225;42373.57626423697;42805.78597106995;43187.56812431961;43615.34576981284;44695.10609787851;38240.426393603564;39363.60636393714;39683.801580993066;39789;39838.20323593454;29486.852565737034;29602.40795184041;29791.55312670268;29833.701662983094;30090.84954575213 09:00:23 INFO - PROCESS | 16181 | |2;jquery.html;424.9043965107853;427.64505460467825;434.58714221489583;436.4587910990373;436.68762181093484;19482.220711171554;19790.30733924311;20372.388828335155;20883.477913052142;20904.477388065305;17016.319347226126;19431.805681943177;19577.608447831033;20192.29326973556;20249.696254556195;5709.828705138842;5941.673207973559;5974.850628734294;5984.73068711909;5988.670623115727;4212.1996820604145;5806.941930580703;5827.417258274181;6206.441420272175;6497.480201583886;6490.221173459192;6530.738770449177;6542.1495205623205;6570.441512471421;6584.8024559263295;6468.935310646881;6479.060536222245;6579.769708060219;6583.440407565338;6640.93359066408;3894.415837624351;5510.614257002011;5773.595848290622;5800.419958004208;5906.645601263938;23391.181308654286;23619.645705314433;23846.880765596063;23849;23865.40336491584;2143.7963393477594;2152.967705484419;2255.6165451873057;2932;3184.96815031849;10516.421596812172;10547.78904421915;10756.515956781963;10853.51159197838;11188.38463884486;2003.5091402606308;2026.0983862181336;2054.7123402723632;2095.2666566701687;2118.258609486683;55938.44061559373;55998.440015600136;56804.71597641985;71433.64283178603;83100.99999999939;11629.651110466699;11661.825072623917;11739;11848.585299514649;11887.583934562248;16422.1788910554;16658;16665.083420411993;16674.916625416794;16682.499525014267;8688.913110868936;8706.344564907637;8714.259287960595;8880.289576833839;8942.37403381757;7901.960490197513;8062.959685201537;8087.83824323522;8237.711680091168;8509.489430634181;4920.286558449005;5009.7495125243595;5030.622703297267;5038.420581633086;5164.948350516522;1786.147412948345;1908.9911186508498;2016.546277087673;2033.0952726036771;2055.7019232211246;900.8648702694649;916.8441364967971;937.2923442800778;950.3062764182185;968.4044312747609;18626.906865465586;19431.708524372145;19432.70850937237;19467.51331216731;19772.70340944887;973.4986481961795;1024.0425202435747;1047.3872784421046;1071.8981696738797;1080.5137688040413;10946.562137514411;11229.494672739584;11325.15061370384;11341.546338146547;11415.42922853854;424594;436729;437614;438446;440167;89686.55156724175;91436.54281728681;91909.54045229865;92059;94106;1022.7698767777339;1032.3650954662978;1035.7203555040096;1058.5077938758361;1059.1050562274866;17202.65594688124;17288.22203000843;17368.263173683037;17597.208125634123;17738.11309434549;39224.80387598044;39759.403608946464;39846.60153398429;41473.37789933093;43827.56172438235;55393.44606554044;56090;59702.77579217272;60310;60624.39375606187;9100.954495227481;9119;9210.078992101004;9212.769680758034;9486.430814151174;10895.945520272347;14305;14341.139531628136;14361.928190358982;14451.421943122157;12239.143259971717;12322.075844311892;12654.114212005072;12662.493500260254;12740.299283539494;11666.70833229176;11771.941140294244;11988.040956723615;12330.81503777462;12523.311217883103;12682.492700291885;12908.870911291142;12955.805662914876;12990.285534295705;13062;8937.59780809878;9017.825241176724;9072.682456114004;9174.750512917575;9315.34792564514;11760.88239117598;12331.568395106127;12548.686282843002;12693.174943628635;12726.17279876805 09:00:23 INFO - PROCESS | 16181 | |3;mootools.html;1434.4979257259968;1514.7349213887571;1546.404634215827;1666.7833181686387;1810.9185086671098;8667.653293868238;9017.64735289706;9028.638854445822;9246.722598322045;9275.350725449221;8986.326025548078;9165.49589772564;9180.036096209902;9185.816283674323;9196.908030919689;2416.2509622017187;2443.059422122487;2445.572024895645;2446.0949448704005;2446.804255659543;2290.4731911660247;2292.587334279829;2295.104909085458;2310.410845234463;2332.790048895599;2439.146298795425;2459.077845807822;2463.5072985402903;2479.231438254147;2493.5386953413677;2361.8346715729904;2373.703287089114;2377.892994815229;2387.8089752819733;2400.7239167495613;2314.4676724353494;2355.4935688826986;2357.964630530543;2363.1374548289923;2365.9408514787096;8367.665293388258;9084.31867609932;9267.25861931044;9304.813903721955;9323.953380233123;5603.327600687903;5746.482816546531;5756.539476841843;5770.422957704238;5771.307443106812;3529.699975502085;3591.28174365128;3612.476190952297;3652.817359132059;3656.1590834108306;1206.5957904102136;1212.4180393411125;1220.9633710988685;1225.9632211033595;1226.6442731607824;13727.519536816164;13738.65653358664;13743.793843092462;13799.17204967695;13821.101628394123;4934.087193869074;5092.9236061459105;5095.97452012745;5121.180611102206;5126.92309615356;11425.371604561662;11451.427428628534;11480.368579728196;11486.310821350746;11516.654500365003;5659.5755318351285;5726.3700992890745;5727.455891690282;5737.827865163968;5746.741396637078;5064.518870707277;5262.8947421052135;5263.315768950012;5337.466253374631;5339;4176.728512646669;4203.201391735622;4206.516250631216;4232.894177645522;4310.4180935573295;1269.4160686084504;1274.5602767045355;1314.6779039135472;1332.7134666046848;1344.8386193656825;962.8940816510178;1000.4097582426404;1006.4967516241879;1027.5838285494387;1038.901304376083;6107.236595425572;6392.904106438407;6476.6114033158165;6494.935050649433;6543.8364040898405;489.0927329803235;490.49724032866595;493.15177894022224;496.4415033087776;509.19292920721074;4510.255807791677;4527.47933987589;4530.546945305443;4558.658100642465;4558.817647294071;11629.24409913353;11997.940010299893;12016;12032.458539365749;12055.698607534881;11424.714382140346;11871.525138994344;11965.940170299093;11991.100667449977;12048.457819398149;8905.866412003825;9045.59294831721;9092.18170364657;9104.8634270486;9109.77225569366;6509.283978762238;6793.694283757144;6798.354156355138;6803.591784492946;6868.381845633917;10965.342079475256;11225.71935701614;11253.437328133397;11308.49111789955;11422.771544568895;11238.943805280922;11424.82862757076;11467.254628449124;11576.24754390962;11587.826182607436;8452.197041281068;8486.448380855225;8544;8566.528840913561;8600.311975041857;9016.143466370946;9041.819163616823;9105.863412048691;9114.36199466031;9132.178103970675;8207.753767386988;8223.05434874973;8284.544350060805;8405.36959728035;8546.658133674831;8033.477823941425;8118.18818118207;8139.633716482891;8149.307308878811;8216.507009579444;7259.382952449101;7310.159331676925;7345.375643070399;7350.338469537767;7363.595002274927;5304.9204261936875;5469.261649677402;5495.395506494362;5601.187827764869;5630.690312032713;4569.360289559398;5361.571074313967;5514.862128446821;5684.062129748545;5815.621984570989 09:00:23 INFO - PROCESS | 16181 | |4;prototype.html;351.8029903254176;359.2688878132999;359.7661520011992;362.96007439181693;364.4114754671205;5596.972015139923;5639.548836093113;5639.915401268984;5659.518940890019;5720.742566584503;5318.734063296839;5506.504414602685;5554.666719996803;5568.638038527492;5578.86052848678;4314.834994551461;4345.587169218935;4361.542038086003;4363.825446982117;4388.714733542325;4331.870043898688;4354.6065259117095;4359.564043595647;4359.803808828595;4378.846740364088;4326.317683036522;4326.675499337546;4330;4337.696361254713;4368.497622773374;4230.498173148534;4295.78521073945;4299.290617048183;4306.698531102824;4313.245182093121;3796.886093417202;3813.4470501777087;3842.615738426135;3850.1144736710435;3859.671927886133;5295.258663787073;5337.332833395825;5341.359036915556;5373.435789242112;5390.757415916293;4822;4957.7769000395065;5023.497650234984;5036.8415264489;5048.444671086178;5786.42135786418;5815.360310365856;5819;5828.737706803162;5870.178175055453;4323.329883868006;4323.956760432387;4327.199468098381;4328.394024836525;4330.610245077958;5656.91514627281;5822.970885145632;5940.46535811779;6015.488683461911;6043.214382130339;4338.891527711769;4347.913021744564;4379.49635791888;4381.474223093185;4407.845725399596;4221.873343799691;4429.446319210098;4476.127155204769;4493.393391892118;4506.459224893034;4912.035185925658;5014.924776128361;5019.824306149268;5037.697738135724;5051.343325367752;5802.593818432753;5806;5814.622049566765;5839.854003649858;5854.326752423526;1483.8574297790856;1543.961400964985;1555.214616618623;1556.3930067273773;1574.6614477887308;993.9712397668378;1001.9649312274036;1022.3916769522272;1022.8033201154518;1033.26121822897;4954.3063971044085;4989.902221511262;4992.876602764349;5053.700566242351;5068.974655126701;5272.367315922037;5302.867428314245;5303.628745987821;5306.336707911511;5322.520973112439;4812.590929771009;5019.974900125476;5043.193089105725;5110.926705391835;5133.948660513422;2860.856957152134;2872;2872.974552940172;2880.6975267597018;2884.7980641355325;5520.972395137998;5532.695701736443;5536.8062117826485;5551.306086739158;5571.0807716726285;5218;5296.894062118736;5368.0943265141095;5403.729813509309;5425.860569280417;5443.646162999393;5452.672839629635;5455.481729235717;5460.290162278879;5477.575830284075;5247.763850626808;5253.896681696733;5301.0916070213925;5327.227552005015;5329.813456529158;5658.236138121301;5692.743826527899;5856.385079566584;5871.119332100048;6009.789657361971;6187.453136715821;6207.65857877803;6217.595856269328;6226.782062627786;6256.718447669775;4259.744415334966;4278.9358159628255;4283.78581070939;4315.813151383395;4326.156399502067;5815.4184581543195;5985.730642121202;6020.247469066367;6044.90932636002;6062.242219722535;5850.853728656818;5889.734961926638;5898.587098903035;5932.16949627044;5955.213435969105;5678.346990096192;5835.920354734388;5847.8245652630485;5924.6149000314845;5924.851878703067;5718.771249149988;5738.598298119092;5762.94237057624;5769.74036168365;5779.335376431764;5860.882782344244;5877.382874798084;5880.617759845596;5889.146073819358;5909.793157239648;5522.944770552243;5760.358297885083;5766.308043034863;5773.653580785166;5814.505767009682 09:00:23 INFO - PROCESS | 16181 | |5;yui.html;768.7078910014195;769.8267889724813;789.7630710786763;830.2942498875952;855.059434621916;15753.60615984601;16731.07979061151;16902.74645880313;16987.23557439915;17006.149692515355;15417.69164616707;15512.767308490353;15599.922000389983;15609.141497217677;15619.297131629075;706.9222385537587;828.2173346187855;856.447591303612;858.0775666158873;860.3934226370425;843.1315744782884;847.3221422861717;849.5242664108089;849.7918010087507;850.5492089192737;746.4215233194291;905.9909400905973;909.2634965677789;910.1262787723794;910.1626503616689;881.6825942660637;900.2842740021698;901.7700486375998;901.989771455967;903.3450748207563;667.4893706314673;667.5260564998856;667.5660820466687;667.9165104361955;668.0613737698493;15524.534263972098;15560.066396016162;15581.376744930189;15626.218689065501;15645.843541564665;14709.70580588393;14757.18835464049;14759.18824464654;14844.628884277872;15013.549593512213;11671.600434570253;13090.214587124708;13208.801867971988;13264.336783160803;13323.733525329537;3745.962540374616;4618.261078227468;4663.417072865892;4686.695364801311;4780.306855505967;77487.61256193739;78468;78525.60737196277;79086.20913790846;79087.6045619774;11476.368799715929;11806.88193118075;12024.495820949169;12302.384880755926;12514.31171285588;21576.56846863054;21579.13683452644;21594.676079858815;21618.243361482273;21650.783492165192;8679.045305016569;8681.869771953427;8716.477011379338;8960.955195224113;9070.909290907139;5078.5937125029905;5098.362704661918;5147.382314122255;5182.689038657692;5270.025045366619;3400.2009527760956;3488.703460205911;3492.1793378556017;4032.5967403259438;4232.470941132358;676.3338111959715;717.6196615793638;732.1360794262821;733.1312394812164;777.4014009212874;673.9123913891162;699.888017917141;763.6601712238;763.8510490454419;766.2184571736798;10815.78368432627;11000.779984400428;11063;11210.159238057178;11275.436228188557;686.989695154573;731.572030362244;748.3489364253026;758.6472290384997;770.5107256891802;4832.323474713543;4950.784717229011;4978.452370239271;5063.3417655704525;5239.266502689627;75187.62406188043;75277.62361188159;117192.41403792927;122284;123850;69713.65143174252;90212;101718;103632.48183759184;106121.46939265254;60069;93649.5317523408;94104.05895940954;94475.52762236145;94917;9905.851412228967;9931.404115753077;10002.349847259904;10153.898461015295;10247.590096396061;53409.73295133655;54380.45619543754;55090;55294.44705552893;56514.71742641261;50589;77246.22753772615;78966.6051669738;80305.5984720096;82661.58669206615;13363.26502042397;13463.932680336928;13532.255725935169;13728.45086196541;13734;14998.250087495364;15380.38478460849;15547.611309717347;15571.29929153168;15618;14186;14481.420743170154;14885.181315027778;15247.466338678536;15504.534863954099;14238.786418203528;14762.114273143647;15032.248387580796;15243.390264389744;15287.923560382127;14431.206283654079;14531.854681453051;14630.049046811922;14723.92638036803;15060;11382.317060976367;11562.537498499965;11768;11815.232009919328;11826.881731182579;11388.772224555629;11484.94257528707;11630.88369116298;11714.648560543197;11767.411629418666 09:00:23 INFO - PROCESS | 16181 | __end_tp_report 09:00:23 INFO - PROCESS | 16181 | __start_cc_report 09:00:23 INFO - PROCESS | 16181 | _x_x_mozilla_cycle_collect,1053 09:00:23 INFO - PROCESS | 16181 | __end_cc_report 09:00:23 INFO - PROCESS | 16181 | __startTimestamp1467043223555__endTimestamp 09:00:23 INFO - PROCESS | 16181 | 09:00:23 INFO - PROCESS | 16181 | ------- Summary: start ------- 09:00:23 INFO - PROCESS | 16181 | Number of tests: 6 09:00:23 INFO - PROCESS | 16181 | 09:00:23 INFO - PROCESS | 16181 | [#0] dojo.html Cycles:165 Average:5715.19 Median:5918.56 stddev:658.08 (11.1%) stddev-sans-first:633.96 09:00:23 INFO - PROCESS | 16181 | Values: 3374.4 3395.8 3404.5 3417.1 3451.7 5632.9 5767.5 5778.8 5790.0 5808.4 5710.7 5751.4 5759.5 5766.7 5770.7 5078.2 5159.0 5166.1 5218.6 5256.8 5177.9 5189.7 5203.3 5207.5 5298.6 5306.3 5306.5 5311.7 5316.0 5343.2 5079.8 5083.7 5240.1 5242.1 5286.8 5114.8 5149.4 5159.7 5162.8 5169.6 5657.7 5720.4 5728.8 5737.8 5752.9 5893.6 6076.5 6125.5 6147.1 6149.9 6253.2 6293.7 6296.1 6305.0 6311.4 5867.0 5882.3 5891.6 5892.9 5897.0 6052.0 6194.8 6258.8 6259.0 6370.2 6080.4 6088.9 6089.7 6124.4 6125.3 5879.1 6187.5 6197.2 6200.3 6200.6 6057.7 6097.8 6098.6 6142.2 6166.2 6138.4 6190.2 6193.5 6202.3 6207.8 4567.4 4618.0 4696.4 4704.2 4719.7 4125.5 4152.4 4194.6 4201.3 4231.8 5897.1 5909.9 5914.9 5916.1 5918.6 5958.0 6004.2 6020.6 6210.8 6253.6 5756.8 5772.9 5774.4 5784.4 5819.7 5044.9 5058.9 5061.1 5066.9 5089.7 6130.4 6245.6 6299.5 6333.7 6362.7 6224.7 6279.2 6294.2 6298.1 6300.4 6453.3 6472.4 6484.1 6488.3 6490.7 5920.6 5973.7 5993.5 6039.6 6112.7 6143.6 6153.3 6184.4 6188.4 6199.2 5860.7 6004.3 6065.6 6067.8 6090.9 5983.3 6006.1 6044.5 6095.6 6097.8 5999.6 6000.4 6000.4 6001.5 6006.1 5857.0 5985.9 6133.6 6135.5 6149.3 5778.8 5838.0 5853.9 5912.1 6035.0 09:00:23 INFO - PROCESS | 16181 | 09:00:23 INFO - PROCESS | 16181 | [#1] ext.html Cycles:180 Average:59585.03 Median:20782.48 stddev:119592.27 (575.4%) stddev-sans-first:119845.71 09:00:23 INFO - PROCESS | 16181 | Values: 580.5 643.8 657.1 658.5 666.5 32482.4 35695.0 35883.5 35888.5 35942.0 35960.5 44370.6 45723.8 45743.5 50324.0 9015.9 9129.6 9155.5 9158.0 9161.5 8367.3 8965.6 9070.0 10571.4 10798.9 10941.8 11006.4 11011.1 11019.8 11022.6 10949.1 11015.7 11020.9 11021.8 11027.7 8320.2 10356.6 10695.8 10697.7 11110.9 44133.0 44343.6 44391.6 44400.6 44466.8 3327.3 3535.2 3685.0 3687.9 3755.9 33394.7 33830.0 33880.0 34032.8 34188.0 3776.7 3826.9 3834.6 3885.8 3889.2 356480.0 356873.0 358292.0 358912.6 359059.0 37788.2 38742.8 58341.0 58755.7 58794.7 37154.4 37231.4 37244.3 37256.3 37289.0 16288.3 16422.4 16461.8 16474.3 16480.9 12797.9 13588.1 13649.3 13649.9 13651.2 8622.7 8926.7 8963.4 8998.3 9069.1 3359.3 3363.6 3370.6 3375.4 3425.7 931.1 961.5 971.8 1009.1 1044.4 33034.3 33985.8 34010.3 34197.0 34449.8 1096.9 1128.0 1168.9 1173.6 1212.5 17357.9 17652.6 17687.2 17749.3 17766.5 565870.0 566959.0 570486.0 570764.0 574315.0 42269.6 42745.8 42778.4 42818.8 42855.8 1330.5 1405.5 1444.2 1448.9 1455.5 32665.3 33569.0 34006.7 34209.7 34318.1 51732.0 56880.0 59024.4 59071.1 64342.0 390771.0 394675.0 395263.0 396933.0 397002.0 33994.5 39120.6 44278.0 44802.6 44858.6 43443.3 47453.3 47975.0 48895.0 49091.3 39543.6 40900.8 41212.4 41226.4 42124.0 40823.0 41879.6 44205.8 45524.0 46306.5 42373.6 42805.8 43187.6 43615.3 44695.1 38240.4 39363.6 39683.8 39789.0 39838.2 29486.9 29602.4 29791.6 29833.7 30090.8 09:00:23 INFO - PROCESS | 16181 | 09:00:23 INFO - PROCESS | 16181 | [#2] jquery.html Cycles:180 Average:27381.32 Median:23857.20 stddev:71802.13 (301.0%) stddev-sans-first:71975.03 09:00:23 INFO - PROCESS | 16181 | Values: 424.9 427.6 434.6 436.5 436.7 19482.2 19790.3 20372.4 20883.5 20904.5 17016.3 19431.8 19577.6 20192.3 20249.7 5709.8 5941.7 5974.9 5984.7 5988.7 4212.2 5806.9 5827.4 6206.4 6497.5 6490.2 6530.7 6542.1 6570.4 6584.8 6468.9 6479.1 6579.8 6583.4 6640.9 3894.4 5510.6 5773.6 5800.4 5906.6 23391.2 23619.6 23846.9 23849.0 23865.4 2143.8 2153.0 2255.6 2932.0 3185.0 10516.4 10547.8 10756.5 10853.5 11188.4 2003.5 2026.1 2054.7 2095.3 2118.3 55938.4 55998.4 56804.7 71433.6 83101.0 11629.7 11661.8 11739.0 11848.6 11887.6 16422.2 16658.0 16665.1 16674.9 16682.5 8688.9 8706.3 8714.3 8880.3 8942.4 7902.0 8063.0 8087.8 8237.7 8509.5 4920.3 5009.7 5030.6 5038.4 5164.9 1786.1 1909.0 2016.5 2033.1 2055.7 900.9 916.8 937.3 950.3 968.4 18626.9 19431.7 19432.7 19467.5 19772.7 973.5 1024.0 1047.4 1071.9 1080.5 10946.6 11229.5 11325.2 11341.5 11415.4 424594.0 436729.0 437614.0 438446.0 440167.0 89686.6 91436.5 91909.5 92059.0 94106.0 1022.8 1032.4 1035.7 1058.5 1059.1 17202.7 17288.2 17368.3 17597.2 17738.1 39224.8 39759.4 39846.6 41473.4 43827.6 55393.4 56090.0 59702.8 60310.0 60624.4 9101.0 9119.0 9210.1 9212.8 9486.4 10895.9 14305.0 14341.1 14361.9 14451.4 12239.1 12322.1 12654.1 12662.5 12740.3 11666.7 11771.9 11988.0 12330.8 12523.3 12682.5 12908.9 12955.8 12990.3 13062.0 8937.6 9017.8 9072.7 9174.8 9315.3 11760.9 12331.6 12548.7 12693.2 12726.2 09:00:23 INFO - PROCESS | 16181 | 09:00:23 INFO - PROCESS | 16181 | [#3] mootools.html Cycles:180 Average:6255.95 Median:489.79 stddev:3660.33 (747.3%) stddev-sans-first:3652.66 09:00:23 INFO - PROCESS | 16181 | Values: 1434.5 1514.7 1546.4 1666.8 1810.9 8667.7 9017.6 9028.6 9246.7 9275.4 8986.3 9165.5 9180.0 9185.8 9196.9 2416.3 2443.1 2445.6 2446.1 2446.8 2290.5 2292.6 2295.1 2310.4 2332.8 2439.1 2459.1 2463.5 2479.2 2493.5 2361.8 2373.7 2377.9 2387.8 2400.7 2314.5 2355.5 2358.0 2363.1 2365.9 8367.7 9084.3 9267.3 9304.8 9324.0 5603.3 5746.5 5756.5 5770.4 5771.3 3529.7 3591.3 3612.5 3652.8 3656.2 1206.6 1212.4 1221.0 1226.0 1226.6 13727.5 13738.7 13743.8 13799.2 13821.1 4934.1 5092.9 5096.0 5121.2 5126.9 11425.4 11451.4 11480.4 11486.3 11516.7 5659.6 5726.4 5727.5 5737.8 5746.7 5064.5 5262.9 5263.3 5337.5 5339.0 4176.7 4203.2 4206.5 4232.9 4310.4 1269.4 1274.6 1314.7 1332.7 1344.8 962.9 1000.4 1006.5 1027.6 1038.9 6107.2 6392.9 6476.6 6494.9 6543.8 489.1 490.5 493.2 496.4 509.2 4510.3 4527.5 4530.5 4558.7 4558.8 11629.2 11997.9 12016.0 12032.5 12055.7 11424.7 11871.5 11965.9 11991.1 12048.5 8905.9 9045.6 9092.2 9104.9 9109.8 6509.3 6793.7 6798.4 6803.6 6868.4 10965.3 11225.7 11253.4 11308.5 11422.8 11238.9 11424.8 11467.3 11576.2 11587.8 8452.2 8486.4 8544.0 8566.5 8600.3 9016.1 9041.8 9105.9 9114.4 9132.2 8207.8 8223.1 8284.5 8405.4 8546.7 8033.5 8118.2 8139.6 8149.3 8216.5 7259.4 7310.2 7345.4 7350.3 7363.6 5304.9 5469.3 5495.4 5601.2 5630.7 4569.4 5361.6 5514.9 5684.1 5815.6 09:00:23 INFO - PROCESS | 16181 | 09:00:23 INFO - PROCESS | 16181 | [#4] prototype.html Cycles:180 Average:4792.21 Median:5301.98 stddev:1373.80 (25.9%) stddev-sans-first:1336.61 09:00:23 INFO - PROCESS | 16181 | Values: 351.8 359.3 359.8 363.0 364.4 5597.0 5639.5 5639.9 5659.5 5720.7 5318.7 5506.5 5554.7 5568.6 5578.9 4314.8 4345.6 4361.5 4363.8 4388.7 4331.9 4354.6 4359.6 4359.8 4378.8 4326.3 4326.7 4330.0 4337.7 4368.5 4230.5 4295.8 4299.3 4306.7 4313.2 3796.9 3813.4 3842.6 3850.1 3859.7 5295.3 5337.3 5341.4 5373.4 5390.8 4822.0 4957.8 5023.5 5036.8 5048.4 5786.4 5815.4 5819.0 5828.7 5870.2 4323.3 4324.0 4327.2 4328.4 4330.6 5656.9 5823.0 5940.5 6015.5 6043.2 4338.9 4347.9 4379.5 4381.5 4407.8 4221.9 4429.4 4476.1 4493.4 4506.5 4912.0 5014.9 5019.8 5037.7 5051.3 5802.6 5806.0 5814.6 5839.9 5854.3 1483.9 1544.0 1555.2 1556.4 1574.7 994.0 1002.0 1022.4 1022.8 1033.3 4954.3 4989.9 4992.9 5053.7 5069.0 5272.4 5302.9 5303.6 5306.3 5322.5 4812.6 5020.0 5043.2 5110.9 5133.9 2860.9 2872.0 2873.0 2880.7 2884.8 5521.0 5532.7 5536.8 5551.3 5571.1 5218.0 5296.9 5368.1 5403.7 5425.9 5443.6 5452.7 5455.5 5460.3 5477.6 5247.8 5253.9 5301.1 5327.2 5329.8 5658.2 5692.7 5856.4 5871.1 6009.8 6187.5 6207.7 6217.6 6226.8 6256.7 4259.7 4278.9 4283.8 4315.8 4326.2 5815.4 5985.7 6020.2 6044.9 6062.2 5850.9 5889.7 5898.6 5932.2 5955.2 5678.3 5835.9 5847.8 5924.6 5924.9 5718.8 5738.6 5762.9 5769.7 5779.3 5860.9 5877.4 5880.6 5889.1 5909.8 5522.9 5760.4 5766.3 5773.7 5814.5 09:00:23 INFO - PROCESS | 16181 | 09:00:23 INFO - PROCESS | 16181 | [#5] yui.html Cycles:180 Average:20923.22 Median:4640.84 stddev:29194.93 (629.1%) stddev-sans-first:29237.60 09:00:23 INFO - PROCESS | 16181 | Values: 768.7 769.8 789.8 830.3 855.1 15753.6 16731.1 16902.7 16987.2 17006.1 15417.7 15512.8 15599.9 15609.1 15619.3 706.9 828.2 856.4 858.1 860.4 843.1 847.3 849.5 849.8 850.5 746.4 906.0 909.3 910.1 910.2 881.7 900.3 901.8 902.0 903.3 667.5 667.5 667.6 667.9 668.1 15524.5 15560.1 15581.4 15626.2 15645.8 14709.7 14757.2 14759.2 14844.6 15013.5 11671.6 13090.2 13208.8 13264.3 13323.7 3746.0 4618.3 4663.4 4686.7 4780.3 77487.6 78468.0 78525.6 79086.2 79087.6 11476.4 11806.9 12024.5 12302.4 12514.3 21576.6 21579.1 21594.7 21618.2 21650.8 8679.0 8681.9 8716.5 8961.0 9070.9 5078.6 5098.4 5147.4 5182.7 5270.0 3400.2 3488.7 3492.2 4032.6 4232.5 676.3 717.6 732.1 733.1 777.4 673.9 699.9 763.7 763.9 766.2 10815.8 11000.8 11063.0 11210.2 11275.4 687.0 731.6 748.3 758.6 770.5 4832.3 4950.8 4978.5 5063.3 5239.3 75187.6 75277.6 117192.4 122284.0 123850.0 69713.7 90212.0 101718.0 103632.5 106121.5 60069.0 93649.5 94104.1 94475.5 94917.0 9905.9 9931.4 10002.3 10153.9 10247.6 53409.7 54380.5 55090.0 55294.4 56514.7 50589.0 77246.2 78966.6 80305.6 82661.6 13363.3 13463.9 13532.3 13728.5 13734.0 14998.3 15380.4 15547.6 15571.3 15618.0 14186.0 14481.4 14885.2 15247.5 15504.5 14238.8 14762.1 15032.2 15243.4 15287.9 14431.2 14531.9 14630.0 14723.9 15060.0 11382.3 11562.5 11768.0 11815.2 11826.9 11388.8 11484.9 11630.9 11714.6 11767.4 09:00:23 INFO - PROCESS | 16181 | -------- Summary: end -------- 09:00:23 INFO - PROCESS | 16181 | 09:00:24 INFO - TEST-INFO | 16181: exit 0 09:00:24 INFO - TEST-OK | dromaeo_css | took 1112167ms 09:00:24 INFO - TEST-START | kraken 09:00:24 INFO - operating with platform_type : linux_ 09:00:24 INFO - Initialising browser for kraken test... 09:00:24 INFO - TEST-INFO | started process 16374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6zryPK/profile http://localhost:51687/getInfo.html) 09:00:27 INFO - PROCESS | 16374 | __metrics Screen width/height:1600/1200 09:00:27 INFO - PROCESS | 16374 | colorDepth:24 09:00:27 INFO - PROCESS | 16374 | Browser inner width/height: 1024/697 09:00:27 INFO - PROCESS | 16374 | __metrics 09:00:28 ERROR - PROCESS | 16374 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:00:29 INFO - PROCESS | 16374 | console.error: PushService: 09:00:29 INFO - PROCESS | 16374 | stateChangeProcessEnqueue: Error transitioning state 09:00:29 INFO - PROCESS | 16374 | UnknownError 09:00:29 INFO - TEST-INFO | 16374: exit 0 09:00:29 INFO - Browser initialized. 09:00:29 INFO - Running cycle 1/1 for kraken test... 09:00:29 INFO - TEST-INFO | started process 16465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6zryPK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:41 INFO - PROCESS | 16465 | RSS: Main: 145235968 09:00:41 INFO - PROCESS | 16465 | 09:00:44 INFO - PROCESS | 16465 | Cycle 1(1): loaded http://localhost:51687/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51687/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:44 INFO - PROCESS | 16465 | RSS: Main: 194793472 09:00:44 INFO - PROCESS | 16465 | 09:00:47 INFO - PROCESS | 16465 | Cycle 1(1): loaded http://localhost:51687/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51687/tests/kraken/driver.html?testName=audio-dft) 09:00:48 INFO - PROCESS | 16465 | RSS: Main: 193064960 09:00:48 INFO - PROCESS | 16465 | 09:00:51 INFO - PROCESS | 16465 | Cycle 1(1): loaded http://localhost:51687/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51687/tests/kraken/driver.html?testName=audio-fft) 09:00:51 INFO - PROCESS | 16465 | RSS: Main: 278847488 09:00:51 INFO - PROCESS | 16465 | 09:00:53 INFO - PROCESS | 16465 | Cycle 1(1): loaded http://localhost:51687/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51687/tests/kraken/driver.html?testName=audio-oscillator) 09:00:54 INFO - PROCESS | 16465 | RSS: Main: 187904000 09:00:54 INFO - PROCESS | 16465 | 09:00:56 INFO - PROCESS | 16465 | Cycle 1(1): loaded http://localhost:51687/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51687/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:00:57 INFO - PROCESS | 16465 | RSS: Main: 188903424 09:00:57 INFO - PROCESS | 16465 | 09:01:00 INFO - PROCESS | 16465 | Cycle 1(1): loaded http://localhost:51687/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51687/tests/kraken/driver.html?testName=imaging-darkroom) 09:01:00 INFO - PROCESS | 16465 | RSS: Main: 223195136 09:01:00 INFO - PROCESS | 16465 | 09:01:04 INFO - PROCESS | 16465 | Cycle 1(1): loaded http://localhost:51687/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51687/tests/kraken/driver.html?testName=imaging-desaturate) 09:01:04 INFO - PROCESS | 16465 | RSS: Main: 222593024 09:01:04 INFO - PROCESS | 16465 | 09:01:07 INFO - PROCESS | 16465 | Cycle 1(1): loaded http://localhost:51687/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51687/tests/kraken/driver.html?testName=json-parse-financial) 09:01:07 INFO - PROCESS | 16465 | RSS: Main: 223113216 09:01:07 INFO - PROCESS | 16465 | 09:01:09 INFO - PROCESS | 16465 | Cycle 1(1): loaded http://localhost:51687/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51687/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:01:10 INFO - PROCESS | 16465 | RSS: Main: 201117696 09:01:10 INFO - PROCESS | 16465 | 09:01:11 INFO - PROCESS | 16465 | Cycle 1(1): loaded http://localhost:51687/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51687/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:01:12 INFO - PROCESS | 16465 | RSS: Main: 201744384 09:01:12 INFO - PROCESS | 16465 | 09:01:14 INFO - PROCESS | 16465 | Cycle 1(1): loaded http://localhost:51687/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51687/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:01:15 INFO - PROCESS | 16465 | RSS: Main: 210599936 09:01:15 INFO - PROCESS | 16465 | 09:01:17 INFO - PROCESS | 16465 | Cycle 1(1): loaded http://localhost:51687/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51687/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:01:18 INFO - PROCESS | 16465 | RSS: Main: 216506368 09:01:18 INFO - PROCESS | 16465 | 09:01:20 INFO - PROCESS | 16465 | Cycle 1(1): loaded http://localhost:51687/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51687/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:01:21 INFO - PROCESS | 16465 | RSS: Main: 216899584 09:01:21 INFO - PROCESS | 16465 | 09:01:22 INFO - PROCESS | 16465 | Cycle 1(1): loaded http://localhost:51687/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51687/tests/kraken/driver.html?testName=ai-astar) 09:01:23 INFO - PROCESS | 16465 | RSS: Main: 258371584 09:01:23 INFO - PROCESS | 16465 | 09:01:23 INFO - PROCESS | 16465 | __start_tp_report 09:01:23 INFO - PROCESS | 16465 | _x_x_mozilla_page_load 09:01:23 INFO - PROCESS | 16465 | _x_x_mozilla_page_load_details 09:01:23 INFO - PROCESS | 16465 | |i|pagename|runs| 09:01:23 INFO - PROCESS | 16465 | |0;ai-astar;110;104;110;109;109;110;111;112;109;110 09:01:23 INFO - PROCESS | 16465 | |1;audio-beat-detection;159;125;132;177;128;152;147;131;178;123 09:01:23 INFO - PROCESS | 16465 | |2;audio-dft;161;163;162;162;164;162;160;162;162;161 09:01:23 INFO - PROCESS | 16465 | |3;audio-fft;75;76;75;115;76;76;76;74;97;75 09:01:23 INFO - PROCESS | 16465 | |4;audio-oscillator;84;84;112;84;86;84;117;84;85;124 09:01:23 INFO - PROCESS | 16465 | |5;imaging-gaussian-blur;116;117;117;117;116;116;117;116;116;117 09:01:23 INFO - PROCESS | 16465 | |6;imaging-darkroom;146;146;145;147;146;146;145;147;145;146 09:01:23 INFO - PROCESS | 16465 | |7;imaging-desaturate;95;95;94;94;95;95;95;95;95;94 09:01:23 INFO - PROCESS | 16465 | |8;json-parse-financial;49;50;52;51;51;52;51;51;51;51 09:01:23 INFO - PROCESS | 16465 | |9;json-stringify-tinderbox;59;59;59;59;60;59;58;59;59;60 09:01:23 INFO - PROCESS | 16465 | |10;stanford-crypto-aes;75;77;77;76;76;82;76;77;110;76 09:01:23 INFO - PROCESS | 16465 | |11;stanford-crypto-ccm;118;117;119;121;117;117;115;115;133;117 09:01:23 INFO - PROCESS | 16465 | |12;stanford-crypto-pbkdf2;155;157;156;162;155;157;159;154;153;151 09:01:23 INFO - PROCESS | 16465 | |13;stanford-crypto-sha256-iterative;60;61;62;62;61;60;61;60;62;62 09:01:23 INFO - PROCESS | 16465 | __end_tp_report 09:01:23 INFO - PROCESS | 16465 | __start_cc_report 09:01:23 INFO - PROCESS | 16465 | _x_x_mozilla_cycle_collect,1549 09:01:23 INFO - PROCESS | 16465 | __end_cc_report 09:01:23 INFO - PROCESS | 16465 | __startTimestamp1467043283215__endTimestamp 09:01:23 INFO - PROCESS | 16465 | 09:01:23 INFO - PROCESS | 16465 | ------- Summary: start ------- 09:01:23 INFO - PROCESS | 16465 | Number of tests: 14 09:01:23 INFO - PROCESS | 16465 | 09:01:23 INFO - PROCESS | 16465 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:2.12 (1.9%) stddev-sans-first:2.24 09:01:23 INFO - PROCESS | 16465 | Values: 110.0 104.0 110.0 109.0 109.0 110.0 111.0 112.0 109.0 110.0 09:01:23 INFO - PROCESS | 16465 | 09:01:23 INFO - PROCESS | 16465 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:149.50 stddev:20.82 (13.9%) stddev-sans-first:21.47 09:01:23 INFO - PROCESS | 16465 | Values: 159.0 125.0 132.0 177.0 128.0 152.0 147.0 131.0 178.0 123.0 09:01:23 INFO - PROCESS | 16465 | 09:01:23 INFO - PROCESS | 16465 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 09:01:23 INFO - PROCESS | 16465 | Values: 161.0 163.0 162.0 162.0 164.0 162.0 160.0 162.0 162.0 161.0 09:01:23 INFO - PROCESS | 16465 | 09:01:23 INFO - PROCESS | 16465 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:13.61 (17.9%) stddev-sans-first:14.23 09:01:23 INFO - PROCESS | 16465 | Values: 75.0 76.0 75.0 115.0 76.0 76.0 76.0 74.0 97.0 75.0 09:01:23 INFO - PROCESS | 16465 | 09:01:23 INFO - PROCESS | 16465 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:84.00 stddev:16.32 (19.4%) stddev-sans-first:16.87 09:01:23 INFO - PROCESS | 16465 | Values: 84.0 84.0 112.0 84.0 86.0 84.0 117.0 84.0 85.0 124.0 09:01:23 INFO - PROCESS | 16465 | 09:01:23 INFO - PROCESS | 16465 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:01:23 INFO - PROCESS | 16465 | Values: 116.0 117.0 117.0 117.0 116.0 116.0 117.0 116.0 116.0 117.0 09:01:23 INFO - PROCESS | 16465 | 09:01:23 INFO - PROCESS | 16465 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 09:01:23 INFO - PROCESS | 16465 | Values: 146.0 146.0 145.0 147.0 146.0 146.0 145.0 147.0 145.0 146.0 09:01:23 INFO - PROCESS | 16465 | 09:01:23 INFO - PROCESS | 16465 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:01:23 INFO - PROCESS | 16465 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 09:01:23 INFO - PROCESS | 16465 | 09:01:23 INFO - PROCESS | 16465 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:51.00 stddev:0.88 (1.7%) stddev-sans-first:0.60 09:01:23 INFO - PROCESS | 16465 | Values: 49.0 50.0 52.0 51.0 51.0 52.0 51.0 51.0 51.0 51.0 09:01:23 INFO - PROCESS | 16465 | 09:01:23 INFO - PROCESS | 16465 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 09:01:23 INFO - PROCESS | 16465 | Values: 59.0 59.0 59.0 59.0 60.0 59.0 58.0 59.0 59.0 60.0 09:01:23 INFO - PROCESS | 16465 | 09:01:23 INFO - PROCESS | 16465 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:76.50 stddev:10.64 (13.9%) stddev-sans-first:11.12 09:01:23 INFO - PROCESS | 16465 | Values: 75.0 77.0 77.0 76.0 76.0 82.0 76.0 77.0 110.0 76.0 09:01:23 INFO - PROCESS | 16465 | 09:01:23 INFO - PROCESS | 16465 | [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:117.50 stddev:5.26 (4.5%) stddev-sans-first:5.57 09:01:23 INFO - PROCESS | 16465 | Values: 118.0 117.0 119.0 121.0 117.0 117.0 115.0 115.0 133.0 117.0 09:01:23 INFO - PROCESS | 16465 | 09:01:23 INFO - PROCESS | 16465 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.90 Median:156.50 stddev:3.11 (2.0%) stddev-sans-first:3.28 09:01:23 INFO - PROCESS | 16465 | Values: 155.0 157.0 156.0 162.0 155.0 157.0 159.0 154.0 153.0 151.0 09:01:23 INFO - PROCESS | 16465 | 09:01:23 INFO - PROCESS | 16465 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:61.50 stddev:0.88 (1.4%) stddev-sans-first:0.83 09:01:23 INFO - PROCESS | 16465 | Values: 60.0 61.0 62.0 62.0 61.0 60.0 61.0 60.0 62.0 62.0 09:01:23 INFO - PROCESS | 16465 | -------- Summary: end -------- 09:01:23 INFO - PROCESS | 16465 | 09:01:24 INFO - TEST-INFO | 16465: exit 0 09:01:24 INFO - TEST-OK | kraken | took 59924ms 09:01:24 INFO - SUITE-END | took 1172s 09:01:24 INFO - Completed test suite (00:19:32) 09:01:24 INFO - javascript benchmark 09:01:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3374.4094783412897, 3395.830208489575, 3404.472306792448, 3417.060308415187, 3451.654834516549, 5632.887342253158, 5767.509761670263, 5778.76884924603, 5789.9710501447435, 5808.361080281165, 5710.714464276791, 5751.4248575142465, 5759.510441612468, 5766.740496677649, 5770.740316685748, 5078.1874900016, 5159.019786240621, 5166.121759300909, 5218.582513398938, 5256.842294731164, 5177.870553236162, 5189.740512974355, 5203.323567936163, 5207.453217412174, 5298.629095963265, 5306.283651707028, 5306.495882891119, 5311.73441327934, 5315.973420132894, 5343.198520221959, 5079.771410286509, 5083.745812709387, 5240.109181439165, 5242.056429842627, 5286.814961476349, 5114.769835357418, 5149.382074151126, 5159.664621799571, 5162.819301324435, 5169.612279079084, 5657.688827114507, 5720.399358067385, 5728.799492017801, 5737.82786516401, 5752.913706294409, 5893.616914900518, 6076.453119219247, 6125.509959203253, 6147.139400483936, 6149.938500614981, 6253.187085678878, 6293.685315734195, 6296.118543403927, 6304.968475157641, 6311.431971122575, 5867.0, 5882.294124705063, 5891.587588868823, 5892.882142357172, 5897.0269905465975, 6051.969740151271, 6194.752209911553, 6258.780942666985, 6258.968705156445, 6370.235571731329, 6080.389719938736, 6088.860142295654, 6089.706871217611, 6124.38756124384, 6125.295591007002, 5879.147523609053, 6187.474064704551, 6197.194364732556, 6200.348963358782, 6200.596961197508, 6057.727402266909, 6097.75608975636, 6098.634081955097, 6142.15876619177, 6166.1983942087245, 6138.447539721357, 6190.164327815687, 6193.473554747897, 6202.317745048041, 6207.751689932443, 4567.406237189144, 4617.976910115428, 4696.412948381452, 4704.223803072455, 4719.693219940693, 4125.463689720377, 4152.43942067823, 4194.622483976456, 4201.306784380604, 4231.767252801125, 5897.056470964625, 5909.881802363929, 5914.940850591525, 5916.1421593868645, 5918.556108291809, 5957.970210148921, 6004.249468816398, 6020.638761674226, 6210.844728881723, 6253.624782513064, 5756.769729210785, 5772.94227057724, 5774.393688662714, 5784.392638772868, 5819.679917604488, 5044.924326135111, 5058.924116138261, 5061.06205695809, 5066.873328166826, 5089.745512724349, 6130.386961303923, 6245.5628106032145, 6299.527535434769, 6333.65164915934, 6362.6500542469685, 6224.657643829451, 6279.152314437675, 6294.24469063697, 6298.055291706098, 6300.401461861115, 6453.322401148, 6472.417482426604, 6484.092227088306, 6488.286288508166, 6490.740370385131, 5920.585559010828, 5973.701314934149, 5993.520518358434, 6039.577229594062, 6112.663803490851, 6143.56995010345, 6153.2616086068165, 6184.381561843779, 6188.412100850412, 6199.16311297969, 5860.677662728591, 6004.309504406874, 6065.636061836304, 6067.848303792441, 6090.9390906090375, 5983.252093488314, 6006.069059295816, 6044.455998960115, 6095.603785753912, 6097.817065488042, 5999.550033747573, 6000.429959153874, 6000.429959153874, 6001.549883758823, 6006.129111278753, 5857.0, 5985.880282394415, 6133.6319820810895, 6135.53983451234, 6149.323574406902, 5778.8266352009505, 5837.970810146092, 5853.882922341444, 5912.113183022581, 6034.969825150846], "value": 5670.903074616218, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.5268706004606, 643.83904023994, 657.0735263278772, 658.515990746801, 666.4834753066373, 32482.350352992926, 35695.0, 35883.461748073736, 35888.46167307489, 35942.0, 35960.46059309113, 44370.55629443705, 45723.77138114313, 45743.542564574345, 50324.0, 9015.864762028576, 9129.634814607407, 9155.496447695374, 9158.038405967378, 9161.541922903862, 8367.330613550901, 8965.596548155349, 9070.04764499728, 10571.418571978538, 10798.946005269963, 10941.781164376747, 11006.449677516131, 11011.119110471143, 11019.779604407908, 11022.614208502704, 10949.069329107035, 11015.669529914116, 11020.889791102067, 11021.83467247992, 11027.669169924875, 8320.167983201693, 10356.585736570529, 10695.83956240657, 10697.732556686067, 11110.944445277722, 44133.0, 44343.556564434264, 44391.556084439064, 44400.555994439965, 44466.77766611178, 3327.2680010397676, 3535.222251104753, 3685.0, 3687.870924517656, 3755.868544600953, 33394.666053339395, 33830.0, 33880.0, 34032.829835850665, 34188.0, 3776.7167462440425, 3826.942595861064, 3834.559025712051, 3885.7668539887413, 3889.1638297765835, 356480.0, 356873.0, 358291.9999999974, 358912.61631075555, 359059.0, 37788.24423511514, 38742.80628596839, 58341.0, 58755.706221468616, 58794.70602647045, 37154.44268335977, 37231.441528377094, 37244.25511489755, 37256.25487490235, 37289.0, 16288.348466061225, 16422.425215117415, 16461.753073703905, 16474.258658360402, 16480.917595411946, 12797.872021279854, 13588.116772409761, 13649.317534123453, 13649.931750341384, 13651.249181294925, 8622.741317760478, 8926.73219803394, 8963.417377870417, 8998.280137588978, 9069.138431848964, 3359.294548144917, 3363.646817084171, 3370.646082161387, 3375.3924293627383, 3425.657434256604, 931.1386967055447, 961.4615815143542, 971.820213260535, 1009.1472705563787, 1044.3890324160452, 33034.339313214085, 33985.830070849486, 34010.31979360399, 34197.005028236985, 34449.827750861084, 1096.8683757949098, 1127.9830802537967, 1168.9240199387013, 1173.612707806439, 1212.4604550974907, 17357.913210433868, 17652.646947060988, 17687.20407581662, 17749.29002839872, 17766.46700598984, 565870.0, 566959.0, 570486.0, 570764.0, 574315.0, 42269.577304226565, 42745.78627106907, 42778.35832462516, 42818.78590607027, 42855.785721071195, 1330.507712146512, 1405.5221224783622, 1444.2489905249001, 1448.9347979340955, 1455.5269537400175, 32665.34669306553, 33569.0, 34006.65993340134, 34209.65790342164, 34318.14204644904, 51732.0, 56880.0, 59024.40975590361, 59071.1139332919, 64342.0, 390771.0, 394675.0, 395263.0, 396933.0, 397002.0, 33994.490082649274, 39120.6087939117, 44278.0, 44802.55197447984, 44858.55141448674, 43443.34834977541, 47453.288200676325, 47975.0, 48895.0, 49091.26363104628, 39543.604563955145, 40900.79549602352, 41212.38181427341, 41226.38160427536, 42124.0, 40823.0, 41879.581204188784, 44205.77897110494, 45524.0, 46306.536934630225, 42373.57626423697, 42805.78597106995, 43187.56812431961, 43615.34576981284, 44695.10609787851, 38240.426393603564, 39363.60636393714, 39683.801580993066, 39789.0, 39838.20323593454, 29486.852565737034, 29602.40795184041, 29791.55312670268, 29833.701662983094, 30090.84954575213], "value": 19595.73217493827, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.9043965107853, 427.64505460467825, 434.58714221489583, 436.4587910990373, 436.68762181093484, 19482.220711171554, 19790.30733924311, 20372.388828335155, 20883.477913052142, 20904.477388065305, 17016.319347226126, 19431.805681943177, 19577.608447831033, 20192.29326973556, 20249.696254556195, 5709.828705138842, 5941.673207973559, 5974.850628734294, 5984.73068711909, 5988.670623115727, 4212.1996820604145, 5806.941930580703, 5827.417258274181, 6206.441420272175, 6497.480201583886, 6490.221173459192, 6530.738770449177, 6542.1495205623205, 6570.441512471421, 6584.8024559263295, 6468.935310646881, 6479.060536222245, 6579.769708060219, 6583.440407565338, 6640.93359066408, 3894.415837624351, 5510.614257002011, 5773.595848290622, 5800.419958004208, 5906.645601263938, 23391.181308654286, 23619.645705314433, 23846.880765596063, 23849.0, 23865.40336491584, 2143.7963393477594, 2152.967705484419, 2255.6165451873057, 2932.0, 3184.96815031849, 10516.421596812172, 10547.78904421915, 10756.515956781963, 10853.51159197838, 11188.38463884486, 2003.5091402606308, 2026.0983862181336, 2054.7123402723632, 2095.2666566701687, 2118.258609486683, 55938.44061559373, 55998.440015600136, 56804.71597641985, 71433.64283178603, 83100.99999999939, 11629.651110466699, 11661.825072623917, 11739.0, 11848.585299514649, 11887.583934562248, 16422.1788910554, 16658.0, 16665.083420411993, 16674.916625416794, 16682.499525014267, 8688.913110868936, 8706.344564907637, 8714.259287960595, 8880.289576833839, 8942.37403381757, 7901.960490197513, 8062.959685201537, 8087.83824323522, 8237.711680091168, 8509.489430634181, 4920.286558449005, 5009.7495125243595, 5030.622703297267, 5038.420581633086, 5164.948350516522, 1786.147412948345, 1908.9911186508498, 2016.546277087673, 2033.0952726036771, 2055.7019232211246, 900.8648702694649, 916.8441364967971, 937.2923442800778, 950.3062764182185, 968.4044312747609, 18626.906865465586, 19431.708524372145, 19432.70850937237, 19467.51331216731, 19772.70340944887, 973.4986481961795, 1024.0425202435747, 1047.3872784421046, 1071.8981696738797, 1080.5137688040413, 10946.562137514411, 11229.494672739584, 11325.15061370384, 11341.546338146547, 11415.42922853854, 424594.0, 436729.0, 437614.0, 438446.0, 440167.0, 89686.55156724175, 91436.54281728681, 91909.54045229865, 92059.0, 94106.0, 1022.7698767777339, 1032.3650954662978, 1035.7203555040096, 1058.5077938758361, 1059.1050562274866, 17202.65594688124, 17288.22203000843, 17368.263173683037, 17597.208125634123, 17738.11309434549, 39224.80387598044, 39759.403608946464, 39846.60153398429, 41473.37789933093, 43827.56172438235, 55393.44606554044, 56090.0, 59702.77579217272, 60310.0, 60624.39375606187, 9100.954495227481, 9119.0, 9210.078992101004, 9212.769680758034, 9486.430814151174, 10895.945520272347, 14305.0, 14341.139531628136, 14361.928190358982, 14451.421943122157, 12239.143259971717, 12322.075844311892, 12654.114212005072, 12662.493500260254, 12740.299283539494, 11666.70833229176, 11771.941140294244, 11988.040956723615, 12330.81503777462, 12523.311217883103, 12682.492700291885, 12908.870911291142, 12955.805662914876, 12990.285534295705, 13062.0, 8937.59780809878, 9017.825241176724, 9072.682456114004, 9174.750512917575, 9315.34792564514, 11760.88239117598, 12331.568395106127, 12548.686282843002, 12693.174943628635, 12726.17279876805], "value": 9504.966247345568, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1434.4979257259968, 1514.7349213887571, 1546.404634215827, 1666.7833181686387, 1810.9185086671098, 8667.653293868238, 9017.64735289706, 9028.638854445822, 9246.722598322045, 9275.350725449221, 8986.326025548078, 9165.49589772564, 9180.036096209902, 9185.816283674323, 9196.908030919689, 2416.2509622017187, 2443.059422122487, 2445.572024895645, 2446.0949448704005, 2446.804255659543, 2290.4731911660247, 2292.587334279829, 2295.104909085458, 2310.410845234463, 2332.790048895599, 2439.146298795425, 2459.077845807822, 2463.5072985402903, 2479.231438254147, 2493.5386953413677, 2361.8346715729904, 2373.703287089114, 2377.892994815229, 2387.8089752819733, 2400.7239167495613, 2314.4676724353494, 2355.4935688826986, 2357.964630530543, 2363.1374548289923, 2365.9408514787096, 8367.665293388258, 9084.31867609932, 9267.25861931044, 9304.813903721955, 9323.953380233123, 5603.327600687903, 5746.482816546531, 5756.539476841843, 5770.422957704238, 5771.307443106812, 3529.699975502085, 3591.28174365128, 3612.476190952297, 3652.817359132059, 3656.1590834108306, 1206.5957904102136, 1212.4180393411125, 1220.9633710988685, 1225.9632211033595, 1226.6442731607824, 13727.519536816164, 13738.65653358664, 13743.793843092462, 13799.17204967695, 13821.101628394123, 4934.087193869074, 5092.9236061459105, 5095.97452012745, 5121.180611102206, 5126.92309615356, 11425.371604561662, 11451.427428628534, 11480.368579728196, 11486.310821350746, 11516.654500365003, 5659.5755318351285, 5726.3700992890745, 5727.455891690282, 5737.827865163968, 5746.741396637078, 5064.518870707277, 5262.8947421052135, 5263.315768950012, 5337.466253374631, 5339.0, 4176.728512646669, 4203.201391735622, 4206.516250631216, 4232.894177645522, 4310.4180935573295, 1269.4160686084504, 1274.5602767045355, 1314.6779039135472, 1332.7134666046848, 1344.8386193656825, 962.8940816510178, 1000.4097582426404, 1006.4967516241879, 1027.5838285494387, 1038.901304376083, 6107.236595425572, 6392.904106438407, 6476.6114033158165, 6494.935050649433, 6543.8364040898405, 489.0927329803235, 490.49724032866595, 493.15177894022224, 496.4415033087776, 509.19292920721074, 4510.255807791677, 4527.47933987589, 4530.546945305443, 4558.658100642465, 4558.817647294071, 11629.24409913353, 11997.940010299893, 12016.0, 12032.458539365749, 12055.698607534881, 11424.714382140346, 11871.525138994344, 11965.940170299093, 11991.100667449977, 12048.457819398149, 8905.866412003825, 9045.59294831721, 9092.18170364657, 9104.8634270486, 9109.77225569366, 6509.283978762238, 6793.694283757144, 6798.354156355138, 6803.591784492946, 6868.381845633917, 10965.342079475256, 11225.71935701614, 11253.437328133397, 11308.49111789955, 11422.771544568895, 11238.943805280922, 11424.82862757076, 11467.254628449124, 11576.24754390962, 11587.826182607436, 8452.197041281068, 8486.448380855225, 8544.0, 8566.528840913561, 8600.311975041857, 9016.143466370946, 9041.819163616823, 9105.863412048691, 9114.36199466031, 9132.178103970675, 8207.753767386988, 8223.05434874973, 8284.544350060805, 8405.36959728035, 8546.658133674831, 8033.477823941425, 8118.18818118207, 8139.633716482891, 8149.307308878811, 8216.507009579444, 7259.382952449101, 7310.159331676925, 7345.375643070399, 7350.338469537767, 7363.595002274927, 5304.9204261936875, 5469.261649677402, 5495.395506494362, 5601.187827764869, 5630.690312032713, 4569.360289559398, 5361.571074313967, 5514.862128446821, 5684.062129748545, 5815.621984570989], "value": 4872.905372502786, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.8029903254176, 359.2688878132999, 359.7661520011992, 362.96007439181693, 364.4114754671205, 5596.972015139923, 5639.548836093113, 5639.915401268984, 5659.518940890019, 5720.742566584503, 5318.734063296839, 5506.504414602685, 5554.666719996803, 5568.638038527492, 5578.86052848678, 4314.834994551461, 4345.587169218935, 4361.542038086003, 4363.825446982117, 4388.714733542325, 4331.870043898688, 4354.6065259117095, 4359.564043595647, 4359.803808828595, 4378.846740364088, 4326.317683036522, 4326.675499337546, 4330.0, 4337.696361254713, 4368.497622773374, 4230.498173148534, 4295.78521073945, 4299.290617048183, 4306.698531102824, 4313.245182093121, 3796.886093417202, 3813.4470501777087, 3842.615738426135, 3850.1144736710435, 3859.671927886133, 5295.258663787073, 5337.332833395825, 5341.359036915556, 5373.435789242112, 5390.757415916293, 4822.0, 4957.7769000395065, 5023.497650234984, 5036.8415264489, 5048.444671086178, 5786.42135786418, 5815.360310365856, 5819.0, 5828.737706803162, 5870.178175055453, 4323.329883868006, 4323.956760432387, 4327.199468098381, 4328.394024836525, 4330.610245077958, 5656.91514627281, 5822.970885145632, 5940.46535811779, 6015.488683461911, 6043.214382130339, 4338.891527711769, 4347.913021744564, 4379.49635791888, 4381.474223093185, 4407.845725399596, 4221.873343799691, 4429.446319210098, 4476.127155204769, 4493.393391892118, 4506.459224893034, 4912.035185925658, 5014.924776128361, 5019.824306149268, 5037.697738135724, 5051.343325367752, 5802.593818432753, 5806.0, 5814.622049566765, 5839.854003649858, 5854.326752423526, 1483.8574297790856, 1543.961400964985, 1555.214616618623, 1556.3930067273773, 1574.6614477887308, 993.9712397668378, 1001.9649312274036, 1022.3916769522272, 1022.8033201154518, 1033.26121822897, 4954.3063971044085, 4989.902221511262, 4992.876602764349, 5053.700566242351, 5068.974655126701, 5272.367315922037, 5302.867428314245, 5303.628745987821, 5306.336707911511, 5322.520973112439, 4812.590929771009, 5019.974900125476, 5043.193089105725, 5110.926705391835, 5133.948660513422, 2860.856957152134, 2872.0, 2872.974552940172, 2880.6975267597018, 2884.7980641355325, 5520.972395137998, 5532.695701736443, 5536.8062117826485, 5551.306086739158, 5571.0807716726285, 5218.0, 5296.894062118736, 5368.0943265141095, 5403.729813509309, 5425.860569280417, 5443.646162999393, 5452.672839629635, 5455.481729235717, 5460.290162278879, 5477.575830284075, 5247.763850626808, 5253.896681696733, 5301.0916070213925, 5327.227552005015, 5329.813456529158, 5658.236138121301, 5692.743826527899, 5856.385079566584, 5871.119332100048, 6009.789657361971, 6187.453136715821, 6207.65857877803, 6217.595856269328, 6226.782062627786, 6256.718447669775, 4259.744415334966, 4278.9358159628255, 4283.78581070939, 4315.813151383395, 4326.156399502067, 5815.4184581543195, 5985.730642121202, 6020.247469066367, 6044.90932636002, 6062.242219722535, 5850.853728656818, 5889.734961926638, 5898.587098903035, 5932.16949627044, 5955.213435969105, 5678.346990096192, 5835.920354734388, 5847.8245652630485, 5924.6149000314845, 5924.851878703067, 5718.771249149988, 5738.598298119092, 5762.94237057624, 5769.74036168365, 5779.335376431764, 5860.882782344244, 5877.382874798084, 5880.617759845596, 5889.146073819358, 5909.793157239648, 5522.944770552243, 5760.358297885083, 5766.308043034863, 5773.653580785166, 5814.505767009682], "value": 4363.569971571252, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.7078910014195, 769.8267889724813, 789.7630710786763, 830.2942498875952, 855.059434621916, 15753.60615984601, 16731.07979061151, 16902.74645880313, 16987.23557439915, 17006.149692515355, 15417.69164616707, 15512.767308490353, 15599.922000389983, 15609.141497217677, 15619.297131629075, 706.9222385537587, 828.2173346187855, 856.447591303612, 858.0775666158873, 860.3934226370425, 843.1315744782884, 847.3221422861717, 849.5242664108089, 849.7918010087507, 850.5492089192737, 746.4215233194291, 905.9909400905973, 909.2634965677789, 910.1262787723794, 910.1626503616689, 881.6825942660637, 900.2842740021698, 901.7700486375998, 901.989771455967, 903.3450748207563, 667.4893706314673, 667.5260564998856, 667.5660820466687, 667.9165104361955, 668.0613737698493, 15524.534263972098, 15560.066396016162, 15581.376744930189, 15626.218689065501, 15645.843541564665, 14709.70580588393, 14757.18835464049, 14759.18824464654, 14844.628884277872, 15013.549593512213, 11671.600434570253, 13090.214587124708, 13208.801867971988, 13264.336783160803, 13323.733525329537, 3745.962540374616, 4618.261078227468, 4663.417072865892, 4686.695364801311, 4780.306855505967, 77487.61256193739, 78468.0, 78525.60737196277, 79086.20913790846, 79087.6045619774, 11476.368799715929, 11806.88193118075, 12024.495820949169, 12302.384880755926, 12514.31171285588, 21576.56846863054, 21579.13683452644, 21594.676079858815, 21618.243361482273, 21650.783492165192, 8679.045305016569, 8681.869771953427, 8716.477011379338, 8960.955195224113, 9070.909290907139, 5078.5937125029905, 5098.362704661918, 5147.382314122255, 5182.689038657692, 5270.025045366619, 3400.2009527760956, 3488.703460205911, 3492.1793378556017, 4032.5967403259438, 4232.470941132358, 676.3338111959715, 717.6196615793638, 732.1360794262821, 733.1312394812164, 777.4014009212874, 673.9123913891162, 699.888017917141, 763.6601712238, 763.8510490454419, 766.2184571736798, 10815.78368432627, 11000.779984400428, 11063.0, 11210.159238057178, 11275.436228188557, 686.989695154573, 731.572030362244, 748.3489364253026, 758.6472290384997, 770.5107256891802, 4832.323474713543, 4950.784717229011, 4978.452370239271, 5063.3417655704525, 5239.266502689627, 75187.62406188043, 75277.62361188159, 117192.41403792927, 122284.0, 123850.0, 69713.65143174252, 90212.0, 101718.0, 103632.48183759184, 106121.46939265254, 60069.0, 93649.5317523408, 94104.05895940954, 94475.52762236145, 94917.0, 9905.851412228967, 9931.404115753077, 10002.349847259904, 10153.898461015295, 10247.590096396061, 53409.73295133655, 54380.45619543754, 55090.0, 55294.44705552893, 56514.71742641261, 50589.0, 77246.22753772615, 78966.6051669738, 80305.5984720096, 82661.58669206615, 13363.26502042397, 13463.932680336928, 13532.255725935169, 13728.45086196541, 13734.0, 14998.250087495364, 15380.38478460849, 15547.611309717347, 15571.29929153168, 15618.0, 14186.0, 14481.420743170154, 14885.181315027778, 15247.466338678536, 15504.534863954099, 14238.786418203528, 14762.114273143647, 15032.248387580796, 15243.390264389744, 15287.923560382127, 14431.206283654079, 14531.854681453051, 14630.049046811922, 14723.92638036803, 15060.0, 11382.317060976367, 11562.537498499965, 11768.0, 11815.232009919328, 11826.881731182579, 11388.772224555629, 11484.94257528707, 11630.88369116298, 11714.648560543197, 11767.411629418666], "value": 7941.4071142771345, "unit": "score"}], "name": "dromaeo_css", "value": 7502.776739532342, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 110.0, 109.0, 109.0, 110.0, 111.0, 112.0, 109.0, 110.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 125.0, 132.0, 177.0, 128.0, 152.0, 147.0, 131.0, 178.0, 123.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 162.0, 164.0, 162.0, 160.0, 162.0, 162.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 115.0, 76.0, 76.0, 76.0, 74.0, 97.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 112.0, 84.0, 86.0, 84.0, 117.0, 84.0, 85.0, 124.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 145.0, 147.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 52.0, 51.0, 51.0, 52.0, 51.0, 51.0, 51.0, 51.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 59.0, 58.0, 59.0, 59.0, 60.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 76.0, 76.0, 82.0, 76.0, 77.0, 110.0, 76.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 121.0, 117.0, 117.0, 115.0, 115.0, 133.0, 117.0], "value": 118.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 157.0, 156.0, 162.0, 155.0, 157.0, 159.0, 154.0, 153.0, 151.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 62.0, 62.0, 61.0, 60.0, 61.0, 60.0, 62.0, 62.0], "value": 61.1, "unit": "score"}], "name": "kraken", "value": 1475.6000000000001, "alertThreshold": 2.0}]} 09:01:24 INFO - Return code: 0 09:01:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:01:24 ERROR - # TBPL SUCCESS # 09:01:24 INFO - Running post-action listener: _resource_record_post_action 09:01:24 INFO - ##### 09:01:24 INFO - ##### Finished run-tests step (success) 09:01:24 INFO - ##### 09:01:24 INFO - Running post-run listener: _resource_record_post_run 09:01:24 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 507297792; Read time: 96; Write time: 377252 09:01:24 INFO - TinderboxPrint: CPU usage
13.1% 09:01:24 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 96 09:01:24 INFO - TinderboxPrint: I/O write bytes / time
507,297,792 / 377,252 09:01:24 INFO - TinderboxPrint: CPU idle
8,243.7 (86.9%) 09:01:24 INFO - TinderboxPrint: CPU user
1,201.5 (12.7%) 09:01:24 INFO - TinderboxPrint: Swap in / out
0 / 0 09:01:24 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 258957312; Read time: 0; Write time: 241712 09:01:24 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 247750656; Read time: 96; Write time: 135528 09:01:25 INFO - Running post-run listener: _upload_blobber_files 09:01:25 INFO - Blob upload gear active. 09:01:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:01:25 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 09:01:25 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:01:25 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:01:25 INFO - (blobuploader) - INFO - Open directory for files ... 09:01:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:01:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:01:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:26 INFO - (blobuploader) - INFO - Done attempting. 09:01:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:01:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:01:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:30 INFO - (blobuploader) - INFO - Done attempting. 09:01:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:01:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:01:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:31 INFO - (blobuploader) - INFO - Done attempting. 09:01:31 INFO - (blobuploader) - INFO - Iteration through files over. 09:01:31 INFO - Return code: 0 09:01:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:01:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:01:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c312ca3cc34060257b454e77332a8694a1f96f44329fc8dd02708f84cfaf58e7c13363fd4a84cd19bb08cc17d40f3e16b3b75a1e8776a4ee7b5e227b3cb3495", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c19216894f45df28f001fe18e01b7711ac1cb057ed43686a18dc0390c683680cd3ce0107f398520f3b4d0ba462d85040bebba51d570d0c1505f3e1b879585d1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6736f8fa85250d1cde3d8447ab3b7767cd8a4a767ed14ca2f43817e8f0d1bc6e57c3bc7288ac077ecb47ab4b740c7e0ceab8514149bc1afcdb61066087c7e7c1"} 09:01:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:01:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:01:31 INFO - Contents: 09:01:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c312ca3cc34060257b454e77332a8694a1f96f44329fc8dd02708f84cfaf58e7c13363fd4a84cd19bb08cc17d40f3e16b3b75a1e8776a4ee7b5e227b3cb3495", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c19216894f45df28f001fe18e01b7711ac1cb057ed43686a18dc0390c683680cd3ce0107f398520f3b4d0ba462d85040bebba51d570d0c1505f3e1b879585d1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6736f8fa85250d1cde3d8447ab3b7767cd8a4a767ed14ca2f43817e8f0d1bc6e57c3bc7288ac077ecb47ab4b740c7e0ceab8514149bc1afcdb61066087c7e7c1"} 09:01:31 INFO - Running post-run listener: copy_logs_to_upload_dir 09:01:31 INFO - Copying logs to upload dir... 09:01:31 INFO - mkdir: /builds/slave/test/build/upload/logs 09:01:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.627283 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-06-27 09:01:30.819289) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 09:01:30.822997) ========= 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=6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c312ca3cc34060257b454e77332a8694a1f96f44329fc8dd02708f84cfaf58e7c13363fd4a84cd19bb08cc17d40f3e16b3b75a1e8776a4ee7b5e227b3cb3495", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c19216894f45df28f001fe18e01b7711ac1cb057ed43686a18dc0390c683680cd3ce0107f398520f3b4d0ba462d85040bebba51d570d0c1505f3e1b879585d1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6736f8fa85250d1cde3d8447ab3b7767cd8a4a767ed14ca2f43817e8f0d1bc6e57c3bc7288ac077ecb47ab4b740c7e0ceab8514149bc1afcdb61066087c7e7c1"} build_url:https://queue.taskcluster.net/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011284 build_url: 'https://queue.taskcluster.net/v1/task/Hp_IJycRSnmcXHAhhvyfrA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c312ca3cc34060257b454e77332a8694a1f96f44329fc8dd02708f84cfaf58e7c13363fd4a84cd19bb08cc17d40f3e16b3b75a1e8776a4ee7b5e227b3cb3495", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c19216894f45df28f001fe18e01b7711ac1cb057ed43686a18dc0390c683680cd3ce0107f398520f3b4d0ba462d85040bebba51d570d0c1505f3e1b879585d1a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6736f8fa85250d1cde3d8447ab3b7767cd8a4a767ed14ca2f43817e8f0d1bc6e57c3bc7288ac077ecb47ab4b740c7e0ceab8514149bc1afcdb61066087c7e7c1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-27 09:01:30.852368) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:01:30.852701) ========= 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=6dbc10da6d83fee962c624be000001a8-1467042056.533529-2010693438 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-27 09:01:30.937046) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 09:01:30.937792) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-27 09:01:30.938455) ========= ========= Total master_lag: 0.17 =========