builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1465273779.25 results: success (0) buildid: 20160606184929 builduid: e567472d74654f07a3598ac3ad9c8279 revision: 691f37458b8cd5e51c894bfcf04afe423459aee1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 21:29:39.246476) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 21:29:39.247516) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 21:29:39.248176) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 21:29:39.290561) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 21:29:39.290862) ========= 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=af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 21:29:39-- 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% 37.8M=0s 2016-06-06 21:29:39 (37.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104859 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 21:29:39.413299) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 21:29:39.413977) ========= 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=af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020494 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 21:29:39.474766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 21:29:39.475107) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 691f37458b8cd5e51c894bfcf04afe423459aee1 --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 691f37458b8cd5e51c894bfcf04afe423459aee1 --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=af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 21:29:39,652 truncating revision to first 12 chars 2016-06-06 21:29:39,652 Setting DEBUG logging. 2016-06-06 21:29:39,652 attempt 1/10 2016-06-06 21:29:39,652 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/691f37458b8c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 21:29:39,978 unpacking tar archive at: mozilla-aurora-691f37458b8c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.681109 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 21:29:40.171066) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 21:29:40.171413) ========= script_repo_revision: 691f37458b8cd5e51c894bfcf04afe423459aee1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 21:29:40.171856) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 21:29:40.172197) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 21:29:40.200604) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-06 21:29:40.200934) ========= /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=af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:29:40 INFO - MultiFileLogger online at 20160606 21:29:40 in /builds/slave/test 21:29:40 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 21:29:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:29:40 INFO - {'append_to_log': False, 21:29:40 INFO - 'base_work_dir': '/builds/slave/test', 21:29:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:29:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:29:40 INFO - 'branch': 'Mozilla-Aurora', 21:29:40 INFO - 'buildbot_json_path': 'buildprops.json', 21:29:40 INFO - 'config_files': ('talos/linux_config.py',), 21:29:40 INFO - 'default_actions': ('clobber', 21:29:40 INFO - 'read-buildbot-config', 21:29:40 INFO - 'download-and-extract', 21:29:40 INFO - 'populate-webroot', 21:29:40 INFO - 'create-virtualenv', 21:29:40 INFO - 'install', 21:29:40 INFO - 'run-tests'), 21:29:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:29:40 INFO - 'download_minidump_stackwalk': True, 21:29:40 INFO - 'download_symbols': 'ondemand', 21:29:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:29:40 INFO - 'tooltool.py': '/tools/tooltool.py', 21:29:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:29:40 INFO - '/tools/misc-python/virtualenv.py')}, 21:29:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:29:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:29:40 INFO - 'installer_path': 'installer.exe', 21:29:40 INFO - 'log_level': 'info', 21:29:40 INFO - 'log_name': 'talos', 21:29:40 INFO - 'log_to_console': True, 21:29:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:29:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:29:40 INFO - 'opt_config_files': (), 21:29:40 INFO - 'pip_index': False, 21:29:40 INFO - 'sps_profile': False, 21:29:40 INFO - 'sps_profile_interval': 0, 21:29:40 INFO - 'suite': 'dromaeojs', 21:29:40 INFO - 'system_bits': '32', 21:29:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:29:40 INFO - 'title': 'talos-linux64-ix-020', 21:29:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:29:40 INFO - 'use_talos_json': True, 21:29:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:29:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:29:40 INFO - 'work_dir': 'build'} 21:29:40 INFO - ##### 21:29:40 INFO - ##### Running clobber step. 21:29:40 INFO - ##### 21:29:40 INFO - Running pre-action listener: _resource_record_pre_action 21:29:40 INFO - Running main action method: clobber 21:29:40 INFO - rmtree: /builds/slave/test/build 21:29:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:29:40 INFO - Running post-action listener: _resource_record_post_action 21:29:40 INFO - ##### 21:29:40 INFO - ##### Finished clobber step (success) 21:29:40 INFO - ##### 21:29:40 INFO - ##### 21:29:40 INFO - ##### Running read-buildbot-config step. 21:29:40 INFO - ##### 21:29:40 INFO - Running pre-action listener: _resource_record_pre_action 21:29:40 INFO - Running main action method: read_buildbot_config 21:29:40 INFO - Using buildbot properties: 21:29:40 INFO - { 21:29:40 INFO - "project": "", 21:29:40 INFO - "product": "firefox", 21:29:40 INFO - "script_repo_revision": "production", 21:29:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 21:29:40 INFO - "repository": "", 21:29:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 21:29:40 INFO - "buildid": "20160606184929", 21:29:40 INFO - "pgo_build": "True", 21:29:40 INFO - "basedir": "/builds/slave/test", 21:29:40 INFO - "buildnumber": 556, 21:29:40 INFO - "slavename": "talos-linux64-ix-020", 21:29:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:29:40 INFO - "platform": "ubuntu64_hw", 21:29:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 21:29:40 INFO - "branch": "mozilla-aurora", 21:29:40 INFO - "repo_path": "releases/mozilla-aurora", 21:29:40 INFO - "revision": "691f37458b8cd5e51c894bfcf04afe423459aee1", 21:29:40 INFO - "stage_platform": "linux64-pgo", 21:29:40 INFO - "builduid": "e567472d74654f07a3598ac3ad9c8279", 21:29:40 INFO - "slavebuilddir": "test" 21:29:40 INFO - } 21:29:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 21:29:40 INFO - Running post-action listener: _resource_record_post_action 21:29:40 INFO - ##### 21:29:40 INFO - ##### Finished read-buildbot-config step (success) 21:29:40 INFO - ##### 21:29:40 INFO - ##### 21:29:40 INFO - ##### Running download-and-extract step. 21:29:40 INFO - ##### 21:29:40 INFO - Running pre-action listener: _resource_record_pre_action 21:29:40 INFO - Running main action method: download_and_extract 21:29:40 INFO - mkdir: /builds/slave/test/build/tests 21:29:40 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')]} 21:29:40 INFO - https://queue.taskcluster.net/v1/task/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:29:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 21:29:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 21:29:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPKLA7OCQcKKyFHh0q78oA/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 21:29:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPKLA7OCQcKKyFHh0q78oA/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 21:29:44 INFO - Downloaded 1361 bytes. 21:29:44 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 21:29:44 INFO - Using the following test package requirements: 21:29:44 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 21:29:44 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 21:29:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 21:29:44 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 21:29:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 21:29:44 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 21:29:44 INFO - u'jsshell-linux-x86_64.zip'], 21:29:44 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 21:29:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 21:29:44 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 21:29:44 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 21:29:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 21:29:44 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 21:29:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 21:29:44 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 21:29:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 21:29:44 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 21:29:44 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 21:29:44 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:29:44 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')]} 21:29:44 INFO - https://queue.taskcluster.net/v1/task/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:29:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 21:29:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 21:29:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPKLA7OCQcKKyFHh0q78oA/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 21:29:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPKLA7OCQcKKyFHh0q78oA/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 21:29:53 INFO - Downloaded 24472587 bytes. 21:29:53 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'] 21:29:53 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 21:29:54 INFO - Return code: 0 21:29:54 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 21:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:29:54 INFO - https://queue.taskcluster.net/v1/task/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:29:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 21:29:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 21:29:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPKLA7OCQcKKyFHh0q78oA/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 21:29:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPKLA7OCQcKKyFHh0q78oA/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 21:29:58 INFO - Downloaded 24472587 bytes. 21:29:58 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'] 21:29:58 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 21:30:00 INFO - Return code: 0 21:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:00 INFO - https://queue.taskcluster.net/v1/task/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:30:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 21:30:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 21:30:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPKLA7OCQcKKyFHh0q78oA/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 21:30:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPKLA7OCQcKKyFHh0q78oA/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 21:30:01 INFO - Downloaded 10833369 bytes. 21:30:01 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'] 21:30:01 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 21:30:01 INFO - Return code: 0 21:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:01 INFO - https://queue.taskcluster.net/v1/task/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:30:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 21:30:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 21:30:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPKLA7OCQcKKyFHh0q78oA/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 21:30:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZPKLA7OCQcKKyFHh0q78oA/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 21:30:04 INFO - Downloaded 63560566 bytes. 21:30:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 21:30:04 INFO - mkdir: /builds/slave/test/properties 21:30:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:30:04 INFO - Writing to file /builds/slave/test/properties/build_url 21:30:04 INFO - Contents: 21:30:04 INFO - build_url:https://queue.taskcluster.net/v1/task/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 21:30:05 INFO - Running post-action listener: _resource_record_post_action 21:30:05 INFO - Running post-action listener: set_extra_try_arguments 21:30:05 INFO - ##### 21:30:05 INFO - ##### Finished download-and-extract step (success) 21:30:05 INFO - ##### 21:30:05 INFO - ##### 21:30:05 INFO - ##### Running populate-webroot step. 21:30:05 INFO - ##### 21:30:05 INFO - Running pre-action listener: _resource_record_pre_action 21:30:05 INFO - Running main action method: populate_webroot 21:30:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:30:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:30:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:30:05 INFO - '--tppagecycles', 21:30:05 INFO - '7'], 21:30:05 INFO - 'tests': ['tsvgm']}}, 21:30:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:30:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:30:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:30:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:30:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:30:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:30:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:05 INFO - 'talos_options': ['--disable-e10s'], 21:30:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:30:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:30:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:05 INFO - 'talos_options': ['--disable-e10s'], 21:30:05 INFO - 'tests': ['damp', 'tps']}, 21:30:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:05 INFO - 'tests': ['damp', 'tps']}, 21:30:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:30:05 INFO - 'tests': ['dromaeo_dom']}, 21:30:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:30:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:30:05 INFO - 'tests': ['a11yr', 21:30:05 INFO - 'ts_paint', 21:30:05 INFO - 'tpaint', 21:30:05 INFO - 'sessionrestore', 21:30:05 INFO - 'sessionrestore_no_auto_restore', 21:30:05 INFO - 'tabpaint']}, 21:30:05 INFO - 'other-e10s': {'tests': ['a11yr', 21:30:05 INFO - 'ts_paint', 21:30:05 INFO - 'tpaint', 21:30:05 INFO - 'sessionrestore', 21:30:05 INFO - 'sessionrestore_no_auto_restore', 21:30:05 INFO - 'tabpaint']}, 21:30:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:30:05 INFO - 'ts_paint', 21:30:05 INFO - 'tpaint', 21:30:05 INFO - 'sessionrestore', 21:30:05 INFO - 'sessionrestore_no_auto_restore', 21:30:05 INFO - 'tabpaint']}, 21:30:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:30:05 INFO - 'ts_paint', 21:30:05 INFO - 'tpaint', 21:30:05 INFO - 'sessionrestore', 21:30:05 INFO - 'sessionrestore_no_auto_restore', 21:30:05 INFO - 'tabpaint']}, 21:30:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:30:05 INFO - 'tests': ['a11yr', 21:30:05 INFO - 'ts_paint', 21:30:05 INFO - 'tpaint', 21:30:05 INFO - 'sessionrestore', 21:30:05 INFO - 'sessionrestore_no_auto_restore', 21:30:05 INFO - 'tabpaint']}, 21:30:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:30:05 INFO - 'tests': ['a11yr', 21:30:05 INFO - 'ts_paint', 21:30:05 INFO - 'tpaint', 21:30:05 INFO - 'sessionrestore', 21:30:05 INFO - 'sessionrestore_no_auto_restore', 21:30:05 INFO - 'tabpaint']}, 21:30:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:30:05 INFO - 'tests': ['tsvgx', 21:30:05 INFO - 'tsvgr_opacity', 21:30:05 INFO - 'tart', 21:30:05 INFO - 'tscrollx', 21:30:05 INFO - 'cart']}, 21:30:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:30:05 INFO - 'tsvgr_opacity', 21:30:05 INFO - 'tart', 21:30:05 INFO - 'tscrollx', 21:30:05 INFO - 'cart']}, 21:30:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:05 INFO - 'talos_options': ['--disable-e10s'], 21:30:05 INFO - 'tests': ['tp5o']}, 21:30:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:05 INFO - 'tests': ['tp5o']}, 21:30:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:05 INFO - 'talos_options': ['--disable-e10s', 21:30:05 INFO - '--xperf_path', 21:30:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:30:05 INFO - 'tests': ['tp5n']}, 21:30:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:05 INFO - 'talos_options': ['--xperf_path', 21:30:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:30:05 INFO - 'tests': ['tp5n']}}, 21:30:05 INFO - 'talos.zip': {'path': '', 21:30:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:30:05 INFO - Running post-action listener: _resource_record_post_action 21:30:05 INFO - ##### 21:30:05 INFO - ##### Finished populate-webroot step (success) 21:30:05 INFO - ##### 21:30:05 INFO - ##### 21:30:05 INFO - ##### Running create-virtualenv step. 21:30:05 INFO - ##### 21:30:05 INFO - Running pre-action listener: _resource_record_pre_action 21:30:05 INFO - Running main action method: create_virtualenv 21:30:05 INFO - Creating virtualenv /builds/slave/test/build/venv 21:30:05 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 21:30:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:30:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:30:06 INFO - Using real prefix '/usr' 21:30:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:30:06 INFO - Installing distribute.............................................................................................................................................................................................done. 21:30:08 INFO - Installing pip.................done. 21:30:08 INFO - Return code: 0 21:30:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:30: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')]} 21:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30: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')]} 21:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:08 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 0x7fcf86699f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf562e0>, '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 0xec2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec25d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', '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 21:30:08 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 21:30:08 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 21:30:08 INFO - Using env: {'DISPLAY': ':0', 21:30:08 INFO - 'HOME': '/home/cltbld', 21:30:08 INFO - 'LANG': 'en_US.UTF-8', 21:30:08 INFO - 'LANGUAGE': 'en_US:en', 21:30:08 INFO - 'LOGNAME': 'cltbld', 21:30:08 INFO - 'MAIL': '/var/mail/cltbld', 21:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:08 INFO - 'MOZ_NO_REMOTE': '1', 21:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:08 INFO - 'NO_EM_RESTART': '1', 21:30:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:08 INFO - 'PWD': '/builds/slave/test', 21:30:08 INFO - 'SHELL': '/bin/bash', 21:30:08 INFO - 'SHLVL': '1', 21:30:08 INFO - 'TERM': 'linux', 21:30:08 INFO - 'TMOUT': '86400', 21:30:08 INFO - 'USER': 'cltbld', 21:30:08 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', 21:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:08 INFO - '_': '/tools/buildbot/bin/python'} 21:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:08 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 21:30:08 INFO - Cleaning up... 21:30:08 INFO - Return code: 0 21:30:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:30: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')]} 21:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30: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')]} 21:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:08 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 0x7fcf86699f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf562e0>, '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 0xec2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec25d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', '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 21:30:08 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 21:30:08 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 21:30:08 INFO - Using env: {'DISPLAY': ':0', 21:30:08 INFO - 'HOME': '/home/cltbld', 21:30:08 INFO - 'LANG': 'en_US.UTF-8', 21:30:08 INFO - 'LANGUAGE': 'en_US:en', 21:30:08 INFO - 'LOGNAME': 'cltbld', 21:30:08 INFO - 'MAIL': '/var/mail/cltbld', 21:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:08 INFO - 'MOZ_NO_REMOTE': '1', 21:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:08 INFO - 'NO_EM_RESTART': '1', 21:30:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:08 INFO - 'PWD': '/builds/slave/test', 21:30:08 INFO - 'SHELL': '/bin/bash', 21:30:08 INFO - 'SHLVL': '1', 21:30:08 INFO - 'TERM': 'linux', 21:30:08 INFO - 'TMOUT': '86400', 21:30:08 INFO - 'USER': 'cltbld', 21:30:08 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', 21:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:08 INFO - '_': '/tools/buildbot/bin/python'} 21:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:08 INFO - Downloading/unpacking psutil>=3.1.1 21:30:08 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 21:30:08 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 21:30:08 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 21:30:08 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 21:30:08 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 21:30:08 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 21:30:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:30:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:30:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:30:11 INFO - Installing collected packages: psutil 21:30:11 INFO - Running setup.py install for psutil 21:30:11 INFO - building 'psutil._psutil_linux' extension 21:30:11 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 21:30:11 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 21:30:11 INFO - building 'psutil._psutil_posix' extension 21:30:11 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 21:30:11 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 21:30:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:30:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:30:11 INFO - Successfully installed psutil 21:30:11 INFO - Cleaning up... 21:30:11 INFO - Return code: 0 21:30:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:30:11 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')]} 21:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:11 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')]} 21:30:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:11 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 0x7fcf86699f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf562e0>, '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 0xec2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec25d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', '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 21:30:11 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 21:30:11 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 21:30:11 INFO - Using env: {'DISPLAY': ':0', 21:30:11 INFO - 'HOME': '/home/cltbld', 21:30:11 INFO - 'LANG': 'en_US.UTF-8', 21:30:11 INFO - 'LANGUAGE': 'en_US:en', 21:30:11 INFO - 'LOGNAME': 'cltbld', 21:30:11 INFO - 'MAIL': '/var/mail/cltbld', 21:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:11 INFO - 'MOZ_NO_REMOTE': '1', 21:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:11 INFO - 'NO_EM_RESTART': '1', 21:30:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:11 INFO - 'PWD': '/builds/slave/test', 21:30:11 INFO - 'SHELL': '/bin/bash', 21:30:11 INFO - 'SHLVL': '1', 21:30:11 INFO - 'TERM': 'linux', 21:30:11 INFO - 'TMOUT': '86400', 21:30:11 INFO - 'USER': 'cltbld', 21:30:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', 21:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:11 INFO - '_': '/tools/buildbot/bin/python'} 21:30:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:30:11 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 21:30:11 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 21:30:11 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 21:30:11 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 21:30:11 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 21:30:11 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 21:30:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:30:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:30:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:30:13 INFO - Installing collected packages: mozsystemmonitor 21:30:13 INFO - Running setup.py install for mozsystemmonitor 21:30:13 INFO - Successfully installed mozsystemmonitor 21:30:13 INFO - Cleaning up... 21:30:14 INFO - Return code: 0 21:30:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:30:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcf86699f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf562e0>, '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 0xec2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec25d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', '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 21:30:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:30:14 INFO - Using env: {'DISPLAY': ':0', 21:30:14 INFO - 'HOME': '/home/cltbld', 21:30:14 INFO - 'LANG': 'en_US.UTF-8', 21:30:14 INFO - 'LANGUAGE': 'en_US:en', 21:30:14 INFO - 'LOGNAME': 'cltbld', 21:30:14 INFO - 'MAIL': '/var/mail/cltbld', 21:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:14 INFO - 'MOZ_NO_REMOTE': '1', 21:30:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:14 INFO - 'NO_EM_RESTART': '1', 21:30:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:14 INFO - 'PWD': '/builds/slave/test', 21:30:14 INFO - 'SHELL': '/bin/bash', 21:30:14 INFO - 'SHLVL': '1', 21:30:14 INFO - 'TERM': 'linux', 21:30:14 INFO - 'TMOUT': '86400', 21:30:14 INFO - 'USER': 'cltbld', 21:30:14 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', 21:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:14 INFO - '_': '/tools/buildbot/bin/python'} 21:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:14 INFO - Downloading/unpacking jsonschema==2.5.1 21:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:30:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:16 INFO - Downloading functools32-3.2.3-2.tar.gz 21:30:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:30:16 INFO - warning: no files found matching '*.txt' 21:30:16 INFO - no previously-included directories found matching 'build' 21:30:16 INFO - no previously-included directories found matching 'dist' 21:30:16 INFO - no previously-included directories found matching '.git*' 21:30:16 INFO - Installing collected packages: jsonschema, functools32 21:30:16 INFO - Running setup.py install for functools32 21:30:16 INFO - warning: no files found matching '*.txt' 21:30:16 INFO - no previously-included directories found matching 'build' 21:30:16 INFO - no previously-included directories found matching 'dist' 21:30:16 INFO - no previously-included directories found matching '.git*' 21:30:16 INFO - Successfully installed jsonschema functools32 21:30:16 INFO - Cleaning up... 21:30:16 INFO - Return code: 0 21:30:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcf86699f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf562e0>, '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 0xec2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec25d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', '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 21:30:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:30:16 INFO - Using env: {'DISPLAY': ':0', 21:30:16 INFO - 'HOME': '/home/cltbld', 21:30:16 INFO - 'LANG': 'en_US.UTF-8', 21:30:16 INFO - 'LANGUAGE': 'en_US:en', 21:30:16 INFO - 'LOGNAME': 'cltbld', 21:30:16 INFO - 'MAIL': '/var/mail/cltbld', 21:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:16 INFO - 'MOZ_NO_REMOTE': '1', 21:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:16 INFO - 'NO_EM_RESTART': '1', 21:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:16 INFO - 'PWD': '/builds/slave/test', 21:30:16 INFO - 'SHELL': '/bin/bash', 21:30:16 INFO - 'SHLVL': '1', 21:30:16 INFO - 'TERM': 'linux', 21:30:16 INFO - 'TMOUT': '86400', 21:30:16 INFO - 'USER': 'cltbld', 21:30:16 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', 21:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:16 INFO - '_': '/tools/buildbot/bin/python'} 21:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:16 INFO - Downloading/unpacking blobuploader==1.2.4 21:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:18 INFO - Downloading blobuploader-1.2.4.tar.gz 21:30:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:30:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:30: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 21:30: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 21:30: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 21:30: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 21:30: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 21:30: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 21:30:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:30:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:19 INFO - Downloading docopt-0.6.1.tar.gz 21:30:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:30:19 INFO - Installing collected packages: blobuploader, requests, docopt 21:30:19 INFO - Running setup.py install for blobuploader 21:30:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:30:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:30:19 INFO - Running setup.py install for requests 21:30:20 INFO - Running setup.py install for docopt 21:30:20 INFO - Successfully installed blobuploader requests docopt 21:30:20 INFO - Cleaning up... 21:30:20 INFO - Return code: 0 21:30:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:30: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')]} 21:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30: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')]} 21:30:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:20 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 0x7fcf86699f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf562e0>, '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 0xec2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec25d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', '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 21:30:20 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 21:30:20 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 21:30:20 INFO - Using env: {'DISPLAY': ':0', 21:30:20 INFO - 'HOME': '/home/cltbld', 21:30:20 INFO - 'LANG': 'en_US.UTF-8', 21:30:20 INFO - 'LANGUAGE': 'en_US:en', 21:30:20 INFO - 'LOGNAME': 'cltbld', 21:30:20 INFO - 'MAIL': '/var/mail/cltbld', 21:30:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:20 INFO - 'MOZ_NO_REMOTE': '1', 21:30:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:20 INFO - 'NO_EM_RESTART': '1', 21:30:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:20 INFO - 'PWD': '/builds/slave/test', 21:30:20 INFO - 'SHELL': '/bin/bash', 21:30:20 INFO - 'SHLVL': '1', 21:30:20 INFO - 'TERM': 'linux', 21:30:20 INFO - 'TMOUT': '86400', 21:30:20 INFO - 'USER': 'cltbld', 21:30:20 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', 21:30:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:20 INFO - '_': '/tools/buildbot/bin/python'} 21:30:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:30:20 INFO - Running setup.py (path:/tmp/pip-DZ7iSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:30:20 INFO - Running setup.py (path:/tmp/pip-brcJXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:30:20 INFO - Running setup.py (path:/tmp/pip-eQ5Ux2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:30:20 INFO - Running setup.py (path:/tmp/pip-aSKDdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:30:20 INFO - Running setup.py (path:/tmp/pip-7NyApy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:30:20 INFO - Running setup.py (path:/tmp/pip-4yTr17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:30:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:30:20 INFO - Running setup.py (path:/tmp/pip-9pov5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:30:21 INFO - Running setup.py (path:/tmp/pip-uI0t1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:30:21 INFO - Running setup.py (path:/tmp/pip-CfDnvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:30:21 INFO - Running setup.py (path:/tmp/pip-Y4BPn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:30:21 INFO - Running setup.py (path:/tmp/pip-qYdFHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:30:21 INFO - Running setup.py (path:/tmp/pip-8oegUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:30:21 INFO - Running setup.py (path:/tmp/pip-ys1kIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:30:21 INFO - Running setup.py (path:/tmp/pip-tN_sV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:21 INFO - Running setup.py (path:/tmp/pip-cOV8es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:30:21 INFO - Running setup.py (path:/tmp/pip-ZGlKbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:30:21 INFO - Running setup.py (path:/tmp/pip-NN3e54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:30:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:30:21 INFO - Running setup.py install for manifestparser 21:30:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:30:21 INFO - Running setup.py install for mozcrash 21:30:21 INFO - Running setup.py install for mozdebug 21:30:22 INFO - Running setup.py install for mozdevice 21:30:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:30:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:30:22 INFO - Running setup.py install for mozfile 21:30:22 INFO - Running setup.py install for mozhttpd 21:30:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:30:22 INFO - Running setup.py install for mozinfo 21:30:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:30:22 INFO - Running setup.py install for mozInstall 21:30:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:30:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:30:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:30:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:30:22 INFO - Running setup.py install for mozleak 21:30:22 INFO - Running setup.py install for mozlog 21:30:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:30:22 INFO - Running setup.py install for moznetwork 21:30:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:30:22 INFO - Running setup.py install for mozprocess 21:30:22 INFO - Running setup.py install for mozprofile 21:30:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:30:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:30:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:30:23 INFO - Running setup.py install for mozrunner 21:30:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:30:23 INFO - Running setup.py install for mozscreenshot 21:30:23 INFO - Running setup.py install for moztest 21:30:23 INFO - Running setup.py install for mozversion 21:30:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:30:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:30:23 INFO - Cleaning up... 21:30:23 INFO - Return code: 0 21:30:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:30:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:23 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 0x7fcf86699f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf562e0>, '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 0xec2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec25d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', '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 21:30:23 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 21:30:23 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 21:30:23 INFO - Using env: {'DISPLAY': ':0', 21:30:23 INFO - 'HOME': '/home/cltbld', 21:30:23 INFO - 'LANG': 'en_US.UTF-8', 21:30:23 INFO - 'LANGUAGE': 'en_US:en', 21:30:23 INFO - 'LOGNAME': 'cltbld', 21:30:23 INFO - 'MAIL': '/var/mail/cltbld', 21:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:23 INFO - 'MOZ_NO_REMOTE': '1', 21:30:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:23 INFO - 'NO_EM_RESTART': '1', 21:30:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:23 INFO - 'PWD': '/builds/slave/test', 21:30:23 INFO - 'SHELL': '/bin/bash', 21:30:23 INFO - 'SHLVL': '1', 21:30:23 INFO - 'TERM': 'linux', 21:30:23 INFO - 'TMOUT': '86400', 21:30:23 INFO - 'USER': 'cltbld', 21:30:23 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', 21:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:23 INFO - '_': '/tools/buildbot/bin/python'} 21:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:30:23 INFO - Running setup.py (path:/tmp/pip-y1p8hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:30:23 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)) 21:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:30:23 INFO - Running setup.py (path:/tmp/pip-WldTdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:30:23 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)) 21:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:30:23 INFO - Running setup.py (path:/tmp/pip-H0GaJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:30:23 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)) 21:30:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:30:23 INFO - Running setup.py (path:/tmp/pip-nDUqPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:30:24 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)) 21:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:30:24 INFO - Running setup.py (path:/tmp/pip-DczXJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:30:24 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)) 21:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:30:24 INFO - Running setup.py (path:/tmp/pip-xgK34g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:30:24 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)) 21:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:30:24 INFO - Running setup.py (path:/tmp/pip-u9O3mU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:30:24 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)) 21:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:30:24 INFO - Running setup.py (path:/tmp/pip-p80bg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:30:24 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)) 21:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:30:24 INFO - Running setup.py (path:/tmp/pip-mbG7No-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:30:24 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)) 21:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:30:24 INFO - Running setup.py (path:/tmp/pip-ruFMeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:30:24 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)) 21:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:30:24 INFO - Running setup.py (path:/tmp/pip-vFI6yV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:30:24 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)) 21:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:30:24 INFO - Running setup.py (path:/tmp/pip-sEYLLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:30:24 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)) 21:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:30:24 INFO - Running setup.py (path:/tmp/pip-kJnD9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:30:24 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)) 21:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:30:24 INFO - Running setup.py (path:/tmp/pip-fNGGdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:30:24 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)) 21:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:24 INFO - Running setup.py (path:/tmp/pip-y9irCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:24 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)) 21:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:30:24 INFO - Running setup.py (path:/tmp/pip-13bZqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:30:24 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)) 21:30:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:30:24 INFO - Running setup.py (path:/tmp/pip-Zzgcu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:30:24 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)) 21:30:24 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)) 21:30:24 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)) 21:30:24 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)) 21:30:24 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)) 21:30:24 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)) 21:30:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:26 INFO - Downloading blessings-1.6.tar.gz 21:30:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:30:26 INFO - Installing collected packages: blessings 21:30:26 INFO - Running setup.py install for blessings 21:30:27 INFO - Successfully installed blessings 21:30:27 INFO - Cleaning up... 21:30:27 INFO - Return code: 0 21:30:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:30:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:30:27 INFO - Reading from file tmpfile_stdout 21:30:27 INFO - Current package versions: 21:30:27 INFO - argparse == 1.2.1 21:30:27 INFO - blessings == 1.6 21:30:27 INFO - blobuploader == 1.2.4 21:30:27 INFO - docopt == 0.6.1 21:30:27 INFO - functools32 == 3.2.3-2 21:30:27 INFO - jsonschema == 2.5.1 21:30:27 INFO - manifestparser == 1.1 21:30:27 INFO - mozInstall == 1.12 21:30:27 INFO - mozcrash == 0.17 21:30:27 INFO - mozdebug == 0.1 21:30:27 INFO - mozdevice == 0.48 21:30:27 INFO - mozfile == 1.2 21:30:27 INFO - mozhttpd == 0.7 21:30:27 INFO - mozinfo == 0.9 21:30:27 INFO - mozleak == 0.1 21:30:27 INFO - mozlog == 3.2 21:30:27 INFO - moznetwork == 0.27 21:30:27 INFO - mozprocess == 0.22 21:30:27 INFO - mozprofile == 0.28 21:30:27 INFO - mozrunner == 6.11 21:30:27 INFO - mozscreenshot == 0.1 21:30:27 INFO - mozsystemmonitor == 0.3 21:30:27 INFO - moztest == 0.7 21:30:27 INFO - mozversion == 1.4 21:30:27 INFO - psutil == 3.1.1 21:30:27 INFO - requests == 1.2.3 21:30:27 INFO - wsgiref == 0.1.2 21:30:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:30: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')]} 21:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30: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')]} 21:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:27 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 0x7fcf86699f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf562e0>, '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 0xec2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec25d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', '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 21:30:27 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 21:30:27 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 21:30:27 INFO - Using env: {'DISPLAY': ':0', 21:30:27 INFO - 'HOME': '/home/cltbld', 21:30:27 INFO - 'LANG': 'en_US.UTF-8', 21:30:27 INFO - 'LANGUAGE': 'en_US:en', 21:30:27 INFO - 'LOGNAME': 'cltbld', 21:30:27 INFO - 'MAIL': '/var/mail/cltbld', 21:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:27 INFO - 'MOZ_NO_REMOTE': '1', 21:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:27 INFO - 'NO_EM_RESTART': '1', 21:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:27 INFO - 'PWD': '/builds/slave/test', 21:30:27 INFO - 'SHELL': '/bin/bash', 21:30:27 INFO - 'SHLVL': '1', 21:30:27 INFO - 'TERM': 'linux', 21:30:27 INFO - 'TMOUT': '86400', 21:30:27 INFO - 'USER': 'cltbld', 21:30:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', 21:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:27 INFO - '_': '/tools/buildbot/bin/python'} 21:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:27 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)) 21:30:27 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)) 21:30:27 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)) 21:30:27 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)) 21:30:27 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)) 21:30:27 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)) 21:30:27 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)) 21:30:27 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)) 21:30:27 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)) 21:30:27 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)) 21:30:27 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)) 21:30:27 INFO - Cleaning up... 21:30:27 INFO - Return code: 0 21:30:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:30: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')]} 21:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30: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')]} 21:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:27 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 0x7fcf86699f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf562e0>, '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 0xec2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec25d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', '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 21:30:27 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 21:30:27 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 21:30:27 INFO - Using env: {'DISPLAY': ':0', 21:30:27 INFO - 'HOME': '/home/cltbld', 21:30:27 INFO - 'LANG': 'en_US.UTF-8', 21:30:27 INFO - 'LANGUAGE': 'en_US:en', 21:30:27 INFO - 'LOGNAME': 'cltbld', 21:30:27 INFO - 'MAIL': '/var/mail/cltbld', 21:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:27 INFO - 'MOZ_NO_REMOTE': '1', 21:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:27 INFO - 'NO_EM_RESTART': '1', 21:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:27 INFO - 'PWD': '/builds/slave/test', 21:30:27 INFO - 'SHELL': '/bin/bash', 21:30:27 INFO - 'SHLVL': '1', 21:30:27 INFO - 'TERM': 'linux', 21:30:27 INFO - 'TMOUT': '86400', 21:30:27 INFO - 'USER': 'cltbld', 21:30:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', 21:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:27 INFO - '_': '/tools/buildbot/bin/python'} 21:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:30:27 INFO - Cleaning up... 21:30:27 INFO - Return code: 0 21:30:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:30: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')]} 21:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30: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')]} 21:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:27 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 0x7fcf86699f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xec4020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf562e0>, '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 0xec2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec25d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', '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 21:30:27 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 21:30:27 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 21:30:27 INFO - Using env: {'DISPLAY': ':0', 21:30:27 INFO - 'HOME': '/home/cltbld', 21:30:27 INFO - 'LANG': 'en_US.UTF-8', 21:30:27 INFO - 'LANGUAGE': 'en_US:en', 21:30:27 INFO - 'LOGNAME': 'cltbld', 21:30:27 INFO - 'MAIL': '/var/mail/cltbld', 21:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:27 INFO - 'MOZ_NO_REMOTE': '1', 21:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:27 INFO - 'NO_EM_RESTART': '1', 21:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:27 INFO - 'PWD': '/builds/slave/test', 21:30:27 INFO - 'SHELL': '/bin/bash', 21:30:27 INFO - 'SHLVL': '1', 21:30:27 INFO - 'TERM': 'linux', 21:30:27 INFO - 'TMOUT': '86400', 21:30:27 INFO - 'USER': 'cltbld', 21:30:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', 21:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:27 INFO - '_': '/tools/buildbot/bin/python'} 21:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:28 INFO - Downloading/unpacking flake8 21:30: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 21:30: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 21:30: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 21:30: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 21:30: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 21:30: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 21:30:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:30:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:30:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:30:30 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 21:30:30 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 21:30:30 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 21:30:30 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 21:30:30 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 21:30:30 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 21:30:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:30:30 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 21:30:30 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 21:30:30 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 21:30:30 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 21:30:30 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 21:30:30 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 21:30:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:30:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:30:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:30:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:30:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:30:30 INFO - no previously-included directories found matching 'docs/_build' 21:30:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:30:30 INFO - Running setup.py install for pep8 21:30:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:30:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:30:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:30:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:30:30 INFO - no previously-included directories found matching 'docs/_build' 21:30:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:30:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:30:30 INFO - Cleaning up... 21:30:30 INFO - Return code: 0 21:30:30 INFO - Running post-action listener: _resource_record_post_action 21:30:30 INFO - Running post-action listener: _start_resource_monitoring 21:30:30 INFO - Starting resource monitoring. 21:30:30 INFO - ##### 21:30:30 INFO - ##### Finished create-virtualenv step (success) 21:30:30 INFO - ##### 21:30:30 INFO - ##### 21:30:30 INFO - ##### Running install step. 21:30:30 INFO - ##### 21:30:30 INFO - Running pre-action listener: _resource_record_pre_action 21:30:30 INFO - Running main action method: install 21:30:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:30:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:30:31 INFO - Reading from file tmpfile_stdout 21:30:31 INFO - Detecting whether we're running mozinstall >=1.0... 21:30:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:30:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:30:31 INFO - Reading from file tmpfile_stdout 21:30:31 INFO - Output received: 21:30:31 INFO - Usage: mozinstall [options] installer 21:30:31 INFO - Options: 21:30:31 INFO - -h, --help show this help message and exit 21:30:31 INFO - -d DEST, --destination=DEST 21:30:31 INFO - Directory to install application into. [default: 21:30:31 INFO - "/builds/slave/test"] 21:30:31 INFO - --app=APP Application being installed. [default: firefox] 21:30:31 INFO - mkdir: /builds/slave/test/build/application 21:30:31 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'] 21:30:31 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 21:30:47 INFO - Reading from file tmpfile_stdout 21:30:47 INFO - Output received: 21:30:47 INFO - /builds/slave/test/build/application/firefox/firefox 21:30:47 INFO - Running post-action listener: _resource_record_post_action 21:30:47 INFO - ##### 21:30:47 INFO - ##### Finished install step (success) 21:30:47 INFO - ##### 21:30:47 INFO - ##### 21:30:47 INFO - ##### Running run-tests step. 21:30:47 INFO - ##### 21:30:47 INFO - Running pre-action listener: _resource_record_pre_action 21:30:47 INFO - Running main action method: run_tests 21:30:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:30:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:30:47 INFO - Python 2.7.3 21:30:47 INFO - Return code: 0 21:30:47 INFO - grabbing minidump binary from tooltool 21:30:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:30:47 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 0xf562e0>, '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 0xec2140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xec25d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:30:47 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 21:30:47 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 21:30:47 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 21:30:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:30:47 INFO - Return code: 0 21:30:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:30:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:30:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:30:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:30:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:30:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:30:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:30:48 INFO - Return code: 0 21:30:48 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/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 21:30:48 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/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 21:30:48 INFO - Using env: {'DISPLAY': ':0', 21:30:48 INFO - 'HOME': '/home/cltbld', 21:30:48 INFO - 'LANG': 'en_US.UTF-8', 21:30:48 INFO - 'LANGUAGE': 'en_US:en', 21:30:48 INFO - 'LOGNAME': 'cltbld', 21:30:48 INFO - 'MAIL': '/var/mail/cltbld', 21:30:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:30:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:48 INFO - 'MOZ_NO_REMOTE': '1', 21:30:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:48 INFO - 'NO_EM_RESTART': '1', 21:30:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:48 INFO - 'PWD': '/builds/slave/test', 21:30:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:30:48 INFO - 'SHELL': '/bin/bash', 21:30:48 INFO - 'SHLVL': '1', 21:30:48 INFO - 'TERM': 'linux', 21:30:48 INFO - 'TMOUT': '86400', 21:30:48 INFO - 'USER': 'cltbld', 21:30:48 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788', 21:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:48 INFO - '_': '/tools/buildbot/bin/python'} 21:30:48 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/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 21:30:48 INFO - mozversion application_buildid: 20160606184929 21:30:48 INFO - mozversion application_changeset: 691f37458b8cd5e51c894bfcf04afe423459aee1 21:30:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:30:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:30:48 INFO - mozversion application_name: Firefox 21:30:48 INFO - mozversion application_remotingname: firefox-dev 21:30:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:30:48 INFO - mozversion application_vendor: Mozilla 21:30:48 INFO - mozversion application_version: 49.0a2 21:30:48 INFO - mozversion platform_buildid: 20160606184929 21:30:48 INFO - mozversion platform_changeset: 691f37458b8cd5e51c894bfcf04afe423459aee1 21:30:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:30:48 INFO - mozversion platform_version: 49.0a2 21:30:48 INFO - using testdate: 1465273848 21:30:48 INFO - actual date: 1465273848 21:30:48 INFO - starting webserver on 'localhost:35991' 21:30:48 INFO - SUITE-START | Running 2 tests 21:30:48 INFO - TEST-START | dromaeo_css 21:30:48 INFO - operating with platform_type : linux_ 21:30:48 INFO - Initialising browser for dromaeo_css test... 21:30:48 INFO - TEST-INFO | started process 20574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_GNTmH/profile http://localhost:35991/getInfo.html) 21:30:52 INFO - PROCESS | 20574 | __metrics Screen width/height:1600/1200 21:30:52 INFO - PROCESS | 20574 | colorDepth:24 21:30:52 INFO - PROCESS | 20574 | Browser inner width/height: 1024/697 21:30:52 INFO - PROCESS | 20574 | __metrics 21:30:53 ERROR - PROCESS | 20574 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:30:54 INFO - PROCESS | 20574 | console.error: PushService: 21:30:54 INFO - PROCESS | 20574 | stateChangeProcessEnqueue: Error transitioning state 21:30:54 INFO - PROCESS | 20574 | UnknownError 21:30:54 INFO - TEST-INFO | 20574: exit 0 21:30:54 INFO - Browser initialized. 21:30:54 INFO - Running cycle 1/1 for dromaeo_css test... 21:30:54 INFO - TEST-INFO | started process 20668 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_GNTmH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:31:06 INFO - PROCESS | 20668 | RSS: Main: 145756160 21:31:06 INFO - PROCESS | 20668 | 21:31:58 INFO - PROCESS | 20668 | 1465273918117 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] 21:34:06 INFO - PROCESS | 20668 | Cycle 1(1): loaded http://localhost:35991/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35991/tests/dromaeo/cssquery-ext.html) 21:34:07 INFO - PROCESS | 20668 | RSS: Main: 257032192 21:34:07 INFO - PROCESS | 20668 | 21:37:09 INFO - PROCESS | 20668 | Cycle 1(1): loaded http://localhost:35991/tests/dromaeo/cssquery-ext.html (next: http://localhost:35991/tests/dromaeo/cssquery-jquery.html) 21:37:10 INFO - PROCESS | 20668 | RSS: Main: 229830656 21:37:10 INFO - PROCESS | 20668 | 21:40:12 INFO - PROCESS | 20668 | Cycle 1(1): loaded http://localhost:35991/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35991/tests/dromaeo/cssquery-mootools.html) 21:40:13 INFO - PROCESS | 20668 | RSS: Main: 229634048 21:40:13 INFO - PROCESS | 20668 | 21:43:15 INFO - PROCESS | 20668 | Cycle 1(1): loaded http://localhost:35991/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35991/tests/dromaeo/cssquery-prototype.html) 21:43:15 INFO - PROCESS | 20668 | RSS: Main: 225206272 21:43:15 INFO - PROCESS | 20668 | 21:46:18 INFO - PROCESS | 20668 | Cycle 1(1): loaded http://localhost:35991/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35991/tests/dromaeo/cssquery-yui.html) 21:46:19 INFO - PROCESS | 20668 | RSS: Main: 211902464 21:46:19 INFO - PROCESS | 20668 | 21:49:21 INFO - PROCESS | 20668 | Cycle 1(1): loaded http://localhost:35991/tests/dromaeo/cssquery-yui.html (next: http://localhost:35991/tests/dromaeo/cssquery-dojo.html) 21:49:21 INFO - PROCESS | 20668 | RSS: Main: 258334720 21:49:21 INFO - PROCESS | 20668 | 21:49:21 INFO - PROCESS | 20668 | __start_tp_report 21:49:21 INFO - PROCESS | 20668 | _x_x_mozilla_page_load 21:49:21 INFO - PROCESS | 20668 | _x_x_mozilla_page_load_details 21:49:21 INFO - PROCESS | 20668 | |i|pagename|runs| 21:49:21 INFO - PROCESS | 20668 | |0;dojo.html;3410.0110967819332;3433.416319225732;3436.261203841172;3464.8960531184043;3486.7036301914336;5690.743916523756;5761.279840019997;5772.740226689799;5810.273715785527;5816.33112192098;5708.800191993281;5716.514096301809;5724.4561766632205;5725.599208055427;5729.140628905666;5038.294638750578;5079.441261461246;5103.26002729604;5217.530422261995;5220.947790522084;5110.872228194306;5136.743162841843;5140.8971820563565;5207.505286997748;5210.583153347723;5122.231665250224;5149.30484384607;5160.716160611165;5191.714455704935;5203.2975548301065;5248.343957005374;5253.973730131325;5254.842354729383;5262.578993680497;5288.735563221823;5020.723860187688;5050.6212034097225;5076.263941728429;5145.819896303648;5162.922556161623;5503;5546.084895992157;5558.638688485276;5560.610757246995;5592.972035139798;6154.046122850965;6159.4456498915315;6161.537884658668;6162.506999440079;6166.568340216187;6088.512918966517;6162.568620196588;6173.228346456693;6187.3503282155625;6289.968550157266;5818.534517238569;5831.679257640828;5847.561432892465;5872.941270587282;5887.499562537189;6006.159137720722;6388.744450222032;6394.328595497405;6394.880895843209;6395.296517383084;5959.851003724855;6021.578489505692;6028.879422411527;6098.480874808306;6118.632882027093;6170.969145154335;6177.320494745574;6178.073289006685;6178.289496707936;6178.351273116348;5845.473907348359;5902.498287645598;6071.544634152457;6113.113598528189;6131.662758548323;5994.400559944058;6035.517158627299;6038.516918646497;6042.516598672184;6065.302490213594;4660.091282200006;4668.883277918079;4675.95324046762;4676.462206846256;4676.859694209179;4114.19773144234;4124.546299907008;4161.271777438936;4176.853810116692;4190.979045104755;5840.970795146082;5869.383714709894;5873.58884878063;5889.587728858939;5897.76408943646;6163.568550201532;6203.100550420164;6210.968945155336;6213.2233470816145;6233.844153896189;5657.12314591239;5741.913871291934;5769.1923130761725;5772.6536407815665;5825.4174582542255;5289.814856480005;5312.362516498045;5319.308489896366;5324.5740340772645;5346.1713434417725;6402.583832050902;6407.167068281094;6407.359264073555;6412.166418365583;6413.230412350548;5987.251593550806;6136.140940268277;6170.475509581735;6184.845378865564;6224;6377.298497165215;6414.775482858077;6427.485801135805;6434.549581529435;6435.163428754419;6115.694215289307;6116.785912493041;6123.785667501616;6126.23422072241;6128.8774224516155;5987.221661184019;6064.151018857276;6121.663308517896;6129.84675383119;6141.64046186889;5998.25021872266;6000.039993601003;6000.669963152069;6002.369751176238;6033.939660603338;5817.970910145422;5931.406859314034;5974.820755377345;5989.221401217814;5998.310194327708;5807.274090738658;5877.853053673693;5879.265091863517;5917.260342457193;5977.5217982560425;6037.879242415215;6097.542684298606;6102.328743838263;6103.267607887082;6106.480949119375;5802.129680547782;5924.111383292368;5939.673317967553;5939.851503712442;5942.10868369748 21:49:21 INFO - PROCESS | 20668 | |1;ext.html;595.9851003724906;648.070019521986;648.7729294746839;663.1147418196707;663.6217356107021;33585.66414335856;45479;45910.540894591126;46244;46388.536114638846;45367.092658146816;45991.310130347985;46040;46167.30749038759;46487.767561162145;8338.374621903351;8917.50953697548;9093.545322733837;9101.680256362823;10808;10540.736481587983;10934.234603577752;10996.890031099707;10998.175136864727;10999.725006874813;11027.338359698404;11106.6112686056;11108.500117494732;11109.388983605899;11111.333320000786;8452.366072544584;10901.890981090168;10919.290246133976;11185.440727963569;11186.664400068012;10626.203034772345;11074.833877491845;11077.390743509104;11083.113350931986;11083.833742493869;45901.31148032782;46352;46498.76750616225;46697.766511167225;46703.766481167375;3665.596784353719;3691.667749902522;3766.9434958475645;3959.4456776051375;4307.267764480046;35145.29709405823;35992.10019749501;36049;36226.63773362259;36428.27143457143;4707.246840505537;4713.882152946169;4772.9761351193365;4780.593649539794;4904.362432883702;387838;388940;389367;389805;391191;69548.6522567384;69947.65026174836;70219.64890175516;70244.64877675578;70330.29669703238;41015.589844101174;42099.158016839494;42159.36760948588;44068;44072.779636102256;19245.8075419244;19548.804511954982;19551.315703950295;19554.511137221398;19559.706604400944;13835.723285534234;13944.442222310994;14128.85871141296;14185.503507377192;14575.344109515097;22427.10291588318;22601.321960341214;22722.318330450114;22758.089676412757;22872;7932.246436588515;8066;8230.42387032914;8247.835043299101;8295.253427191581;1041.5209003858158;1054.488573042074;1148.55780524497;1148.787474317254;1183.4496958914146;33474;33716.15709607279;34618;34740.826295868355;34917.12817642014;1144.4621028116771;1195.5056179775281;1204.5482943896038;1219.4329636718792;1280.443007291831;18110.63778724418;18165.7275140873;18215.72676409855;18284.360047398277;18431.907840460713;572209;576506;577309;580119;583261;64079.35920640734;65639.67180164068;65654;65662.34337656658;65707.34292657013;1363.7545241856362;1453.774664926938;1487.3827361645012;1509.645233370157;1509.9169545675313;33477.33045339128;34723.82638086793;34752.47871281984;35167.12082197965;35820.28359432745;54720.72639636776;55174.44825551854;55280.95954722368;55308.17037744357;55308.72345638246;420164;422192;424544;425378;520160;27042.459150817267;27893.860530698028;27904;28912.566311505765;28926;51977.480225197265;53672.73163634157;54467.182992254355;55013.449865500836;55106;45114.323285150094;45901;46200;46340.536594633624;47506.28740568825;42195.3670694946;44629.55370446384;44984.77507612441;45094.77452612716;46079.308810368544;44207.77896110499;44890.551094488634;45270.77364613156;46209.306860397795;46355.304670429294;39141.2171756569;40167;40355.394669079404;40464.79767601143;40944.38583421191;29805.023643312736;29844.403111937205;29939.55090673598;30292.54561181628;30340 21:49:21 INFO - PROCESS | 20668 | |2;jquery.html;410.3229671042779;414.27501871724485;424.2850796408052;432.69927400456686;439.3980247061526;18609.162587683553;19223.981481944385;20144;20237.089330980103;20256.189752409904;13875.932266304584;18840;19038;19388.903055484738;20549.280775172872;5716.857078573027;5782.277215348082;6070.6661133637635;6081.6351018938785;6153.569250152491;6045.909311360311;6055.485283750886;6062.090686397054;6067.18093057436;6072.058830881198;3990.241854047736;5615.522680572156;6011.068284415901;6054.122152287916;6056.636601803906;5871.794487192949;5916.437938395846;5938.435848594377;5943.910841337383;5948.970255148696;5586;5754.884902301972;5756.280464941882;5767.942320576783;5776.422357764232;14655.780163297559;14831.851681483155;15074.773878391832;19794.40616781499;19851.602967940704;2424.4423782530116;2443.963340549893;2460.766227208412;2556.143691863228;2560.5903055511217;10470.581176752921;10897.400642964634;10897.486720050732;11015.449227538671;11153.553857845676;1924.8432570584253;1960.4118764370774;1978.0416492630952;1994.9826187139356;2054.281001649411;57628.71185644087;57971.71014144945;72733.2726672737;87374;87916;11616.419179041015;11791.29252244868;11813.291202527877;11840.585579504675;12504.687007864226;16300.836991630169;16358.509244722678;16415.589610259838;16459.506214813573;16471.34114635425;9042.909570904338;9067.81864362709;9093.81812363749;9106.590203440861;9188.173064424234;8839.116088391109;8893;8926.285897128215;8964.327675424369;9090.045545217788;5007.899842003212;5047.2429135629945;5063.11395505785;5076.74616269185;5144.639875208774;2071.8135367816967;2087.0503920716037;2101.558672678724;2121.469632591852;2145.1633862793524;983.4296108257194;993.8906720260766;1077.4612693653016;1099.3239157917983;1127.3912087472672;18919;19308.613827723366;19650.410487685105;19856.90071549662;19939.501512462306;1045.6183493025144;1060.8726952765717;1074.0655629602295;1085.7285678580356;1113.059464752283;10693.465326733633;11055.889441105646;11242.156838237164;11260.493277802518;11369.602063927723;433260;434570;439673;517284;584704;98349;105019.47490262499;105022;105441;107316;1097.5719469406938;1115.486876037016;1132.4507613807298;1135.239389608964;1138.021301680554;17609.20758565842;17930.372436964644;18115.909420452812;18175.727364089813;18325.908370458063;36761.448578270814;40104.39843402409;42706.572934271506;43320;44789.552104479844;60947.390526095944;62297;62406.37593624006;62676;62909.370906292184;8467;8505.74482765518;8904.421212621159;8934;9004.234640055669;9834.934663720698;13450.12574182675;13629.250391228577;13656.385462654005;13877.375518101508;11977.341246231541;12062.51749929993;12090.274583525017;12127.151099422956;12527.436265368262;12039.458224379749;12148.574799881962;12381.690457738268;12428.440720167433;12683.429245683781;12421.565245216736;12441.502339906665;12462.688432789253;12465;12582.24506529611;8746.256568191775;8771.605277762643;8842.425242359226;8951.820963580822;8981.865272021056;9029.729108126767;11746.882531174579;12389.504419823106;12476.563320283747;12625.558105466265 21:49:21 INFO - PROCESS | 20668 | |3;mootools.html;1405.156905856487;1580.6443550201207;1601.783759192509;1814.2652225848528;1924.5188702824294;8783.253423459006;9148.359614826957;9150.816983660323;9372.531373431335;9428.481433521154;9077.409968352053;9271.814563708722;9279.257659387249;9281.907180928189;9288.953555232214;2253.211376018389;2294.908203671851;2477;2519;2533.227365653475;2533.784628306596;2551.374913146282;2552.068494999321;2555.4889022195543;2558.987205063972;2468.728439871613;2526.216872769438;2526.3810366460243;2526.7725904668578;2538.200466852945;2163.9242626508076;2401.5076909233567;2442.059806974328;2446.963295550568;2462.4336402627405;2494.4761600064007;2496.962545561818;2519.1183085919965;2519.2694118705554;2577.510273048115;9544;9564.282678799118;9565.808683826284;9583.04169583043;9596.280278979104;5624.100143976944;5765;5777.45114214149;5778;5779.219805326269;3470.9826450867836;3578.177019285553;3593.1735700788704;3818.7517811342173;3848.9607805892533;1196.3958201108385;1210.5512242508833;1215.19796934024;1254.6926003129292;1295.3587973952954;13890;13893.79159312611;13895.374708138159;13907.374168162458;13916;5057.393112826484;5192.506711862367;5226.738663066832;5274.367075950834;5298.099323115002;10673.62642307531;10725.463726813628;10777.730556735987;10783.514741836636;10788.56845726178;5809.564282678816;5815.127730840408;5819.912701309484;5821.88356232873;5822.155787410802;4812.278158276286;5252.921206181911;5354.651947623392;5379.488948549882;5419.458054194549;4068.2880495913096;4071.0840060986043;4113.8971525712095;4116.403121547419;4117.053077792125;1151.6717735445525;1163.6567212672282;1166.9228772784456;1171.5372427891107;1173.9119566032582;932.3240650528313;1004.2618675273668;1090.8636420447444;1093.0872721277822;1098.3300186885992;6577.14497115372;6620.238672552622;6652.54491317125;6709.329067093252;6757.831054223586;1002.9197664186847;1003.3277703938379;1013.2299452416216;1085.495244711213;1089.0634054712941;4534.319852022157;4597.218472859622;4638.350630911675;4648.883777905579;4662.906741865211;11581.652550423501;11791.35147566875;11856.05151587871;11888.643340699793;11898.167128300936;11234;11622;11715.882841171479;11770.293782373084;11784.234024788362;8866.069062748447;8939.553022348857;9071.138241867013;9077.636894524145;9079.137481939206;6591.176102987127;6636.203655561363;6715.764948226789;6733.360330768569;6819.931800682129;10877.184211184034;11158.218924675195;11225.550977961117;11257.380844053328;11408.315501069963;11288.661340159808;11395.316281023164;11461;11565.768684626428;11578.478968446609;7841.451098423056;8471.745847624581;8482.872756908528;8502.277306429023;8827.426217295855;9452.43285402878;9461.716148515556;9499;9541.666041688508;9552.092551207625;8024.358051355995;8248.83502329962;8436.957815210884;8475.279601233964;8640.04959454472;8248.298894594027;8323.833523329378;8390.454620449651;8470.703525376583;8536.317094632539;7506.624668766649;7704.30661240491;7716.884246736191;7718.687823070204;7722.92277077222;5638.859028524155;5660.490555849993;5713.742881570256;5738.4134915677705;5821.679807610622;5765.509931655689;5767.336756273083;5827.6794776286015;5947.999702003988;5966.970165149147 21:49:21 INFO - PROCESS | 20668 | |4;prototype.html;353.9646533888376;354.83322838266014;356.1630169102609;360.877301717416;365.03994494479514;5516.255305533752;5579.13523403872;5588.189712491686;5591.580631452642;5612.607117501777;5544.140658197975;5551.2228288039605;5551.250581171541;5566.582506312033;5679.602427830043;4025.3156963316233;4251.574842515754;4271.380649805777;4284.785760711968;4291.699581029329;4225.556316586761;4266.573342665724;4268.850590229343;4281.314989601664;4341.348797680357;4058.8782336529953;4154.169166166764;4280.229558679436;4281.657467402601;4286.97856510717;4262.595053469947;4266.2320782259185;4267.829286828523;4277.123189746095;4280.871573852789;3760.9623903761158;3767.530663041416;3773.6037716039696;3779.5653499847595;3787.62123787619;5081.314022606938;5202.320804785539;5324.4675532446445;5333.679979201261;5344.706041167734;4997.225430058311;5004.148465067949;5005.924911126336;5011.749412529359;5030.918352554182;5754.769809207627;5789.247397838296;5796.420357964212;5808.709564521757;5818.825435236908;4120.320147175712;4234.407182994383;4247.5540068293;4259.382389553529;4269.807858646337;5910.290765108214;5978.475488750428;5991.621926956781;6015.75936962521;6026.367231440723;4335.523092459827;4346.565343465628;4352.303631418958;4352.933531284855;4357.477102747691;4295.570442955742;4428.68999170055;4430.582213691652;4442.73343599385;4459.152760975404;4941.950580494221;4948.109340318705;4952.801887924443;4968.478309777422;4994.225894986283;5677.858053548612;5737.88524229513;5791.333996590446;5795.333536643256;5801.274840644919;1504.751715966875;1534.4706076403622;1538.9692206155814;1540.9922950385176;1549.6905115177656;962.8363178259573;976.7411635916487;985.7087215747393;986.3391527676474;990.5245482168456;4939.678920870132;4983.931668357591;4991;5011.774470148852;5032.396112466454;5163.690178589297;5216.426193118754;5227.686338819683;5255.608698042382;5262.868428289246;4967.950320496821;5321.64298103981;5348.331458567679;5642.6614403135945;5652.7738890443925;3147.740903638563;3161.4783560712226;3175.1903264667826;3180.2685382361724;3182.9204269892975;5889.322727886348;6151.384861513902;6170.598911070766;6176.227971503562;6220.947087461127;6090.6041107328765;6146.508279337642;6149.477294429934;6168.259808822881;6178.227721534809;6169.507056983767;6203.16257305258;6209.789091127187;6253.312135665074;6266.530010249158;5908.231929849092;6059.242594675666;6067.271927368744;6069.878602428015;6070.878582428415;5916;5960.165576819162;5968.46283834457;5971.402859713994;5980.34216236205;6041;6078.817635470943;6189.566730328834;6192.752289908353;6194.690265486617;4274.6793990450215;4276.337167739005;4294.506131794758;4295.045754181902;4296.505901821206;5959.940400595939;6001.519878409804;6006.039033754753;6013.128096426081;6031.36670649593;5629.577781666473;5772.614572502654;5782.017057100387;5789.478946894799;5806.738696758572;5759.683217423082;5764.596478246483;5766.481016708516;5824.097264923944;5852;5457.263269458731;5685.118806584986;5730.627509211888;5756.625819321731;5763.221965034667;5841.649501029951;5871.1486834409625;5874.206982057368;5874.530037596896;5893.793717219876;5457.317835270591;5755.503569071988;5761.5102716269585;5763.423657634203;5785.39253378406 21:49:21 INFO - PROCESS | 20668 | |5;yui.html;805.1143741883928;814.9470284431513;842.5155535567048;852.3096292003478;886.9113088691136;14867.182304973223;14970.401183952656;15010.474633387834;15073.773893391608;15814.209289535534;12592.055595830327;15759.054456732576;15983.200839957984;16422.917885410585;16763.748543771824;857.871319302105;872.075599864146;878.9824203515958;889.9421537600068;890.8485557455216;861.4228466927174;862.0259107208846;864.6282098697558;866.6576702202626;868.5570359116864;772.4091070331201;785.1912530093983;906.0486489186361;908.0238743350891;921.7695576105973;902.1339514066505;909.940853844498;910.4992254260163;910.517425764346;911.4576826788051;671.0370618162951;671.5332843673649;672;672.357898207211;672.4418732452053;16935.745963810554;16937.491875243762;16948.40680576174;16964.830351696448;17005.574860628458;14057.156570605797;14165.433382664682;14378.993470456968;14546.199959002251;14678.779818302733;13193.934030329787;13262;13502.392392342368;14117.78823317651;14452;4623.144718227105;4683.180443422388;4740.668153229275;4752.310914917352;4829.396325459317;68486;70959.64520177418;71815;81560.59219703864;85778;12683.809742853864;12748.745025099632;12793.424295906707;12836.16564923277;13090.280034598189;22853.428664283194;22875.885620572124;23044.65433018506;23082.76917230806;23091.307260782203;9247.480526228992;9413.482258475713;9539.570719317648;9559.283053770994;9589.616415343307;5100.515451032146;5143.228515722672;5172.250023746536;5214.921776173361;5227.294315267391;3876.457295978565;4020.83916643331;4021.7788021658503;4022.2357752027606;4022.738521996061;650.681166228554;653.7973228299243;699.1121275979477;724.3010494872474;762.7444805990056;696.78747981865;698.3121625199175;713.5290708132608;766.4060353226295;817.6380443917172;10499.737506562396;10587.57649694019;10690.358578485315;10738.624148154933;11117.388543630017;726.531387255228;731.8133875861621;738.682366582364;771.8957940677936;774.4888373673349;4995.325631039836;5152.742362881841;5227.555657769056;5309.601779866525;5338.572914166857;122109;123702;127639;129492;130031.69968300196;108045;110700;111362;111533;111590;94624;95434;96152.51923740336;97656;101631.4918425418;9893.851592226267;9923.156531694887;9969.700908972742;10030.598776048877;10067.597296108073;56503;56739.148912765515;56866.715666421405;58354.83290334255;59573.404265956786;77188.61405692935;83468.16531834604;84811;84925.57537212274;87435;11945.641630751092;12525.498980040697;12644.683882903;12679.049071319872;12805.039622028198;14594.92702536523;14845.777313340093;14879.404823806926;14934.402623894923;14993.325300361728;11608.88391116078;11811.586594469152;13411;13964;14718.337674804874;13932.303384830515;14381.712365752835;14498.927505362406;14505.347259373142;14729.852701472848;13711.177329360271;13728.176309421468;13878.86121138816;13961.790573141614;14202.431902723776;11673;11827;11882.82175767347;12135.514579416724;12139.635810925687;11490.54037838477;11701.590444334408;11893.881061189624;11940.701482463008;11969.64091077269 21:49:21 INFO - PROCESS | 20668 | __end_tp_report 21:49:21 INFO - PROCESS | 20668 | __start_cc_report 21:49:21 INFO - PROCESS | 20668 | _x_x_mozilla_cycle_collect,874 21:49:21 INFO - PROCESS | 20668 | __end_cc_report 21:49:21 INFO - PROCESS | 20668 | __startTimestamp1465274961829__endTimestamp 21:49:21 INFO - PROCESS | 20668 | 21:49:21 INFO - PROCESS | 20668 | ------- Summary: start ------- 21:49:21 INFO - PROCESS | 20668 | Number of tests: 6 21:49:21 INFO - PROCESS | 20668 | 21:49:21 INFO - PROCESS | 20668 | [#0] dojo.html Cycles:165 Average:5699.23 Median:5917.26 stddev:650.21 (11.0%) stddev-sans-first:626.92 21:49:21 INFO - PROCESS | 20668 | Values: 3410.0 3433.4 3436.3 3464.9 3486.7 5690.7 5761.3 5772.7 5810.3 5816.3 5708.8 5716.5 5724.5 5725.6 5729.1 5038.3 5079.4 5103.3 5217.5 5220.9 5110.9 5136.7 5140.9 5207.5 5210.6 5122.2 5149.3 5160.7 5191.7 5203.3 5248.3 5254.0 5254.8 5262.6 5288.7 5020.7 5050.6 5076.3 5145.8 5162.9 5503.0 5546.1 5558.6 5560.6 5593.0 6154.0 6159.4 6161.5 6162.5 6166.6 6088.5 6162.6 6173.2 6187.4 6290.0 5818.5 5831.7 5847.6 5872.9 5887.5 6006.2 6388.7 6394.3 6394.9 6395.3 5959.9 6021.6 6028.9 6098.5 6118.6 6171.0 6177.3 6178.1 6178.3 6178.4 5845.5 5902.5 6071.5 6113.1 6131.7 5994.4 6035.5 6038.5 6042.5 6065.3 4660.1 4668.9 4676.0 4676.5 4676.9 4114.2 4124.5 4161.3 4176.9 4191.0 5841.0 5869.4 5873.6 5889.6 5897.8 6163.6 6203.1 6211.0 6213.2 6233.8 5657.1 5741.9 5769.2 5772.7 5825.4 5289.8 5312.4 5319.3 5324.6 5346.2 6402.6 6407.2 6407.4 6412.2 6413.2 5987.3 6136.1 6170.5 6184.8 6224.0 6377.3 6414.8 6427.5 6434.5 6435.2 6115.7 6116.8 6123.8 6126.2 6128.9 5987.2 6064.2 6121.7 6129.8 6141.6 5998.3 6000.0 6000.7 6002.4 6033.9 5818.0 5931.4 5974.8 5989.2 5998.3 5807.3 5877.9 5879.3 5917.3 5977.5 6037.9 6097.5 6102.3 6103.3 6106.5 5802.1 5924.1 5939.7 5939.9 5942.1 21:49:21 INFO - PROCESS | 20668 | 21:49:21 INFO - PROCESS | 20668 | [#1] ext.html Cycles:180 Average:64478.82 Median:22063.22 stddev:126368.37 (572.8%) stddev-sans-first:126631.85 21:49:21 INFO - PROCESS | 20668 | Values: 596.0 648.1 648.8 663.1 663.6 33585.7 45479.0 45910.5 46244.0 46388.5 45367.1 45991.3 46040.0 46167.3 46487.8 8338.4 8917.5 9093.5 9101.7 10808.0 10540.7 10934.2 10996.9 10998.2 10999.7 11027.3 11106.6 11108.5 11109.4 11111.3 8452.4 10901.9 10919.3 11185.4 11186.7 10626.2 11074.8 11077.4 11083.1 11083.8 45901.3 46352.0 46498.8 46697.8 46703.8 3665.6 3691.7 3766.9 3959.4 4307.3 35145.3 35992.1 36049.0 36226.6 36428.3 4707.2 4713.9 4773.0 4780.6 4904.4 387838.0 388940.0 389367.0 389805.0 391191.0 69548.7 69947.7 70219.6 70244.6 70330.3 41015.6 42099.2 42159.4 44068.0 44072.8 19245.8 19548.8 19551.3 19554.5 19559.7 13835.7 13944.4 14128.9 14185.5 14575.3 22427.1 22601.3 22722.3 22758.1 22872.0 7932.2 8066.0 8230.4 8247.8 8295.3 1041.5 1054.5 1148.6 1148.8 1183.4 33474.0 33716.2 34618.0 34740.8 34917.1 1144.5 1195.5 1204.5 1219.4 1280.4 18110.6 18165.7 18215.7 18284.4 18431.9 572209.0 576506.0 577309.0 580119.0 583261.0 64079.4 65639.7 65654.0 65662.3 65707.3 1363.8 1453.8 1487.4 1509.6 1509.9 33477.3 34723.8 34752.5 35167.1 35820.3 54720.7 55174.4 55281.0 55308.2 55308.7 420164.0 422192.0 424544.0 425378.0 520160.0 27042.5 27893.9 27904.0 28912.6 28926.0 51977.5 53672.7 54467.2 55013.4 55106.0 45114.3 45901.0 46200.0 46340.5 47506.3 42195.4 44629.6 44984.8 45094.8 46079.3 44207.8 44890.6 45270.8 46209.3 46355.3 39141.2 40167.0 40355.4 40464.8 40944.4 29805.0 29844.4 29939.6 30292.5 30340.0 21:49:21 INFO - PROCESS | 20668 | 21:49:21 INFO - PROCESS | 20668 | [#2] jquery.html Cycles:180 Average:29086.72 Median:2079.43 stddev:80333.54 (3863.2%) stddev-sans-first:80530.04 21:49:21 INFO - PROCESS | 20668 | Values: 410.3 414.3 424.3 432.7 439.4 18609.2 19224.0 20144.0 20237.1 20256.2 13875.9 18840.0 19038.0 19388.9 20549.3 5716.9 5782.3 6070.7 6081.6 6153.6 6045.9 6055.5 6062.1 6067.2 6072.1 3990.2 5615.5 6011.1 6054.1 6056.6 5871.8 5916.4 5938.4 5943.9 5949.0 5586.0 5754.9 5756.3 5767.9 5776.4 14655.8 14831.9 15074.8 19794.4 19851.6 2424.4 2444.0 2460.8 2556.1 2560.6 10470.6 10897.4 10897.5 11015.4 11153.6 1924.8 1960.4 1978.0 1995.0 2054.3 57628.7 57971.7 72733.3 87374.0 87916.0 11616.4 11791.3 11813.3 11840.6 12504.7 16300.8 16358.5 16415.6 16459.5 16471.3 9042.9 9067.8 9093.8 9106.6 9188.2 8839.1 8893.0 8926.3 8964.3 9090.0 5007.9 5047.2 5063.1 5076.7 5144.6 2071.8 2087.1 2101.6 2121.5 2145.2 983.4 993.9 1077.5 1099.3 1127.4 18919.0 19308.6 19650.4 19856.9 19939.5 1045.6 1060.9 1074.1 1085.7 1113.1 10693.5 11055.9 11242.2 11260.5 11369.6 433260.0 434570.0 439673.0 517284.0 584704.0 98349.0 105019.5 105022.0 105441.0 107316.0 1097.6 1115.5 1132.5 1135.2 1138.0 17609.2 17930.4 18115.9 18175.7 18325.9 36761.4 40104.4 42706.6 43320.0 44789.6 60947.4 62297.0 62406.4 62676.0 62909.4 8467.0 8505.7 8904.4 8934.0 9004.2 9834.9 13450.1 13629.3 13656.4 13877.4 11977.3 12062.5 12090.3 12127.2 12527.4 12039.5 12148.6 12381.7 12428.4 12683.4 12421.6 12441.5 12462.7 12465.0 12582.2 8746.3 8771.6 8842.4 8951.8 8981.9 9029.7 11746.9 12389.5 12476.6 12625.6 21:49:21 INFO - PROCESS | 20668 | 21:49:21 INFO - PROCESS | 20668 | [#3] mootools.html Cycles:180 Average:6331.53 Median:4617.78 stddev:3614.09 (78.3%) stddev-sans-first:3605.26 21:49:21 INFO - PROCESS | 20668 | Values: 1405.2 1580.6 1601.8 1814.3 1924.5 8783.3 9148.4 9150.8 9372.5 9428.5 9077.4 9271.8 9279.3 9281.9 9289.0 2253.2 2294.9 2477.0 2519.0 2533.2 2533.8 2551.4 2552.1 2555.5 2559.0 2468.7 2526.2 2526.4 2526.8 2538.2 2163.9 2401.5 2442.1 2447.0 2462.4 2494.5 2497.0 2519.1 2519.3 2577.5 9544.0 9564.3 9565.8 9583.0 9596.3 5624.1 5765.0 5777.5 5778.0 5779.2 3471.0 3578.2 3593.2 3818.8 3849.0 1196.4 1210.6 1215.2 1254.7 1295.4 13890.0 13893.8 13895.4 13907.4 13916.0 5057.4 5192.5 5226.7 5274.4 5298.1 10673.6 10725.5 10777.7 10783.5 10788.6 5809.6 5815.1 5819.9 5821.9 5822.2 4812.3 5252.9 5354.7 5379.5 5419.5 4068.3 4071.1 4113.9 4116.4 4117.1 1151.7 1163.7 1166.9 1171.5 1173.9 932.3 1004.3 1090.9 1093.1 1098.3 6577.1 6620.2 6652.5 6709.3 6757.8 1002.9 1003.3 1013.2 1085.5 1089.1 4534.3 4597.2 4638.4 4648.9 4662.9 11581.7 11791.4 11856.1 11888.6 11898.2 11234.0 11622.0 11715.9 11770.3 11784.2 8866.1 8939.6 9071.1 9077.6 9079.1 6591.2 6636.2 6715.8 6733.4 6819.9 10877.2 11158.2 11225.6 11257.4 11408.3 11288.7 11395.3 11461.0 11565.8 11578.5 7841.5 8471.7 8482.9 8502.3 8827.4 9452.4 9461.7 9499.0 9541.7 9552.1 8024.4 8248.8 8437.0 8475.3 8640.0 8248.3 8323.8 8390.5 8470.7 8536.3 7506.6 7704.3 7716.9 7718.7 7722.9 5638.9 5660.5 5713.7 5738.4 5821.7 5765.5 5767.3 5827.7 5948.0 5967.0 21:49:21 INFO - PROCESS | 20668 | 21:49:21 INFO - PROCESS | 20668 | [#4] prototype.html Cycles:180 Average:4861.96 Median:5530.20 stddev:1424.04 (25.8%) stddev-sans-first:1387.25 21:49:21 INFO - PROCESS | 20668 | Values: 354.0 354.8 356.2 360.9 365.0 5516.3 5579.1 5588.2 5591.6 5612.6 5544.1 5551.2 5551.3 5566.6 5679.6 4025.3 4251.6 4271.4 4284.8 4291.7 4225.6 4266.6 4268.9 4281.3 4341.3 4058.9 4154.2 4280.2 4281.7 4287.0 4262.6 4266.2 4267.8 4277.1 4280.9 3761.0 3767.5 3773.6 3779.6 3787.6 5081.3 5202.3 5324.5 5333.7 5344.7 4997.2 5004.1 5005.9 5011.7 5030.9 5754.8 5789.2 5796.4 5808.7 5818.8 4120.3 4234.4 4247.6 4259.4 4269.8 5910.3 5978.5 5991.6 6015.8 6026.4 4335.5 4346.6 4352.3 4352.9 4357.5 4295.6 4428.7 4430.6 4442.7 4459.2 4942.0 4948.1 4952.8 4968.5 4994.2 5677.9 5737.9 5791.3 5795.3 5801.3 1504.8 1534.5 1539.0 1541.0 1549.7 962.8 976.7 985.7 986.3 990.5 4939.7 4983.9 4991.0 5011.8 5032.4 5163.7 5216.4 5227.7 5255.6 5262.9 4968.0 5321.6 5348.3 5642.7 5652.8 3147.7 3161.5 3175.2 3180.3 3182.9 5889.3 6151.4 6170.6 6176.2 6220.9 6090.6 6146.5 6149.5 6168.3 6178.2 6169.5 6203.2 6209.8 6253.3 6266.5 5908.2 6059.2 6067.3 6069.9 6070.9 5916.0 5960.2 5968.5 5971.4 5980.3 6041.0 6078.8 6189.6 6192.8 6194.7 4274.7 4276.3 4294.5 4295.0 4296.5 5959.9 6001.5 6006.0 6013.1 6031.4 5629.6 5772.6 5782.0 5789.5 5806.7 5759.7 5764.6 5766.5 5824.1 5852.0 5457.3 5685.1 5730.6 5756.6 5763.2 5841.6 5871.1 5874.2 5874.5 5893.8 5457.3 5755.5 5761.5 5763.4 5785.4 21:49:21 INFO - PROCESS | 20668 | 21:49:21 INFO - PROCESS | 20668 | [#5] yui.html Cycles:180 Average:22547.77 Median:4022.01 stddev:33001.16 (820.5%) stddev-sans-first:33053.35 21:49:21 INFO - PROCESS | 20668 | Values: 805.1 814.9 842.5 852.3 886.9 14867.2 14970.4 15010.5 15073.8 15814.2 12592.1 15759.1 15983.2 16422.9 16763.7 857.9 872.1 879.0 889.9 890.8 861.4 862.0 864.6 866.7 868.6 772.4 785.2 906.0 908.0 921.8 902.1 909.9 910.5 910.5 911.5 671.0 671.5 672.0 672.4 672.4 16935.7 16937.5 16948.4 16964.8 17005.6 14057.2 14165.4 14379.0 14546.2 14678.8 13193.9 13262.0 13502.4 14117.8 14452.0 4623.1 4683.2 4740.7 4752.3 4829.4 68486.0 70959.6 71815.0 81560.6 85778.0 12683.8 12748.7 12793.4 12836.2 13090.3 22853.4 22875.9 23044.7 23082.8 23091.3 9247.5 9413.5 9539.6 9559.3 9589.6 5100.5 5143.2 5172.3 5214.9 5227.3 3876.5 4020.8 4021.8 4022.2 4022.7 650.7 653.8 699.1 724.3 762.7 696.8 698.3 713.5 766.4 817.6 10499.7 10587.6 10690.4 10738.6 11117.4 726.5 731.8 738.7 771.9 774.5 4995.3 5152.7 5227.6 5309.6 5338.6 122109.0 123702.0 127639.0 129492.0 130031.7 108045.0 110700.0 111362.0 111533.0 111590.0 94624.0 95434.0 96152.5 97656.0 101631.5 9893.9 9923.2 9969.7 10030.6 10067.6 56503.0 56739.1 56866.7 58354.8 59573.4 77188.6 83468.2 84811.0 84925.6 87435.0 11945.6 12525.5 12644.7 12679.0 12805.0 14594.9 14845.8 14879.4 14934.4 14993.3 11608.9 11811.6 13411.0 13964.0 14718.3 13932.3 14381.7 14498.9 14505.3 14729.9 13711.2 13728.2 13878.9 13961.8 14202.4 11673.0 11827.0 11882.8 12135.5 12139.6 11490.5 11701.6 11893.9 11940.7 11969.6 21:49:21 INFO - PROCESS | 20668 | -------- Summary: end -------- 21:49:21 INFO - PROCESS | 20668 | 21:49:22 INFO - TEST-INFO | 20668: exit 0 21:49:22 INFO - TEST-OK | dromaeo_css | took 1114268ms 21:49:22 INFO - TEST-START | kraken 21:49:22 INFO - operating with platform_type : linux_ 21:49:22 INFO - Initialising browser for kraken test... 21:49:22 INFO - TEST-INFO | started process 20857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTHqY2x/profile http://localhost:35991/getInfo.html) 21:49:26 INFO - PROCESS | 20857 | __metrics Screen width/height:1600/1200 21:49:26 INFO - PROCESS | 20857 | colorDepth:24 21:49:26 INFO - PROCESS | 20857 | Browser inner width/height: 1024/697 21:49:26 INFO - PROCESS | 20857 | __metrics 21:49:27 ERROR - PROCESS | 20857 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:49:27 INFO - PROCESS | 20857 | console.error: PushService: 21:49:27 INFO - PROCESS | 20857 | stateChangeProcessEnqueue: Error transitioning state 21:49:27 INFO - PROCESS | 20857 | UnknownError 21:49:28 INFO - TEST-INFO | 20857: exit 0 21:49:28 INFO - Browser initialized. 21:49:28 INFO - Running cycle 1/1 for kraken test... 21:49:28 INFO - TEST-INFO | started process 20946 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTHqY2x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:49:40 INFO - PROCESS | 20946 | RSS: Main: 145178624 21:49:40 INFO - PROCESS | 20946 | 21:49:43 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:35991/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35991/tests/kraken/driver.html?testName=audio-beat-detection) 21:49:43 INFO - PROCESS | 20946 | RSS: Main: 194064384 21:49:43 INFO - PROCESS | 20946 | 21:49:46 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:35991/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35991/tests/kraken/driver.html?testName=audio-dft) 21:49:47 INFO - PROCESS | 20946 | RSS: Main: 189464576 21:49:47 INFO - PROCESS | 20946 | 21:49:49 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:35991/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35991/tests/kraken/driver.html?testName=audio-fft) 21:49:50 INFO - PROCESS | 20946 | RSS: Main: 278667264 21:49:50 INFO - PROCESS | 20946 | 21:49:52 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:35991/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35991/tests/kraken/driver.html?testName=audio-oscillator) 21:49:53 INFO - PROCESS | 20946 | RSS: Main: 187170816 21:49:53 INFO - PROCESS | 20946 | 21:49:55 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:35991/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35991/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:49:55 INFO - PROCESS | 20946 | RSS: Main: 188780544 21:49:55 INFO - PROCESS | 20946 | 21:49:58 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:35991/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35991/tests/kraken/driver.html?testName=imaging-darkroom) 21:49:59 INFO - PROCESS | 20946 | RSS: Main: 222785536 21:49:59 INFO - PROCESS | 20946 | 21:50:02 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:35991/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35991/tests/kraken/driver.html?testName=imaging-desaturate) 21:50:03 INFO - PROCESS | 20946 | RSS: Main: 223772672 21:50:03 INFO - PROCESS | 20946 | 21:50:06 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:35991/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35991/tests/kraken/driver.html?testName=json-parse-financial) 21:50:06 INFO - PROCESS | 20946 | RSS: Main: 221794304 21:50:06 INFO - PROCESS | 20946 | 21:50:08 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:35991/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35991/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:50:08 INFO - PROCESS | 20946 | RSS: Main: 200482816 21:50:08 INFO - PROCESS | 20946 | 21:50:10 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:35991/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35991/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:50:11 INFO - PROCESS | 20946 | RSS: Main: 201793536 21:50:11 INFO - PROCESS | 20946 | 21:50:13 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:35991/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35991/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:50:13 INFO - PROCESS | 20946 | RSS: Main: 208707584 21:50:13 INFO - PROCESS | 20946 | 21:50:16 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:35991/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35991/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:50:17 INFO - PROCESS | 20946 | RSS: Main: 213434368 21:50:17 INFO - PROCESS | 20946 | 21:50:19 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:35991/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35991/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:50:20 INFO - PROCESS | 20946 | RSS: Main: 214036480 21:50:20 INFO - PROCESS | 20946 | 21:50:21 INFO - PROCESS | 20946 | Cycle 1(1): loaded http://localhost:35991/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35991/tests/kraken/driver.html?testName=ai-astar) 21:50:22 INFO - PROCESS | 20946 | RSS: Main: 257724416 21:50:22 INFO - PROCESS | 20946 | 21:50:22 INFO - PROCESS | 20946 | __start_tp_report 21:50:22 INFO - PROCESS | 20946 | _x_x_mozilla_page_load 21:50:22 INFO - PROCESS | 20946 | _x_x_mozilla_page_load_details 21:50:22 INFO - PROCESS | 20946 | |i|pagename|runs| 21:50:22 INFO - PROCESS | 20946 | |0;ai-astar;111;108;109;111;113;110;111;110;110;119 21:50:22 INFO - PROCESS | 20946 | |1;audio-beat-detection;156;125;126;169;123;158;158;125;189;135 21:50:22 INFO - PROCESS | 20946 | |2;audio-dft;160;160;160;160;162;160;163;161;161;159 21:50:22 INFO - PROCESS | 20946 | |3;audio-fft;75;74;75;113;75;76;75;75;98;75 21:50:22 INFO - PROCESS | 20946 | |4;audio-oscillator;84;84;108;83;84;85;111;84;85;134 21:50:22 INFO - PROCESS | 20946 | |5;imaging-gaussian-blur;117;116;117;117;117;117;116;117;116;117 21:50:22 INFO - PROCESS | 20946 | |6;imaging-darkroom;145;147;148;145;145;147;146;145;148;146 21:50:22 INFO - PROCESS | 20946 | |7;imaging-desaturate;96;95;96;95;95;95;95;95;96;96 21:50:22 INFO - PROCESS | 20946 | |8;json-parse-financial;50;49;50;50;52;50;50;51;49;50 21:50:22 INFO - PROCESS | 20946 | |9;json-stringify-tinderbox;59;60;60;60;61;60;59;60;61;60 21:50:22 INFO - PROCESS | 20946 | |10;stanford-crypto-aes;76;75;81;76;77;77;77;76;135;77 21:50:22 INFO - PROCESS | 20946 | |11;stanford-crypto-ccm;132;120;118;126;132;123;117;119;135;117 21:50:22 INFO - PROCESS | 20946 | |12;stanford-crypto-pbkdf2;155;154;158;151;155;152;154;153;154;154 21:50:22 INFO - PROCESS | 20946 | |13;stanford-crypto-sha256-iterative;62;64;62;61;61;62;66;61;61;61 21:50:22 INFO - PROCESS | 20946 | __end_tp_report 21:50:22 INFO - PROCESS | 20946 | __start_cc_report 21:50:22 INFO - PROCESS | 20946 | _x_x_mozilla_cycle_collect,1575 21:50:22 INFO - PROCESS | 20946 | __end_cc_report 21:50:22 INFO - PROCESS | 20946 | __startTimestamp1465275022168__endTimestamp 21:50:22 INFO - PROCESS | 20946 | 21:50:22 INFO - PROCESS | 20946 | ------- Summary: start ------- 21:50:22 INFO - PROCESS | 20946 | Number of tests: 14 21:50:22 INFO - PROCESS | 20946 | 21:50:22 INFO - PROCESS | 20946 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:3.05 (2.7%) stddev-sans-first:3.23 21:50:22 INFO - PROCESS | 20946 | Values: 111.0 108.0 109.0 111.0 113.0 110.0 111.0 110.0 110.0 119.0 21:50:22 INFO - PROCESS | 20946 | 21:50:22 INFO - PROCESS | 20946 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:157.00 stddev:22.84 (14.5%) stddev-sans-first:23.96 21:50:22 INFO - PROCESS | 20946 | Values: 156.0 125.0 126.0 169.0 123.0 158.0 158.0 125.0 189.0 135.0 21:50:22 INFO - PROCESS | 20946 | 21:50:22 INFO - PROCESS | 20946 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.17 (0.7%) stddev-sans-first:1.22 21:50:22 INFO - PROCESS | 20946 | Values: 160.0 160.0 160.0 160.0 162.0 160.0 163.0 161.0 161.0 159.0 21:50:22 INFO - PROCESS | 20946 | 21:50:22 INFO - PROCESS | 20946 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:13.35 (17.8%) stddev-sans-first:13.97 21:50:22 INFO - PROCESS | 20946 | Values: 75.0 74.0 75.0 113.0 75.0 76.0 75.0 75.0 98.0 75.0 21:50:22 INFO - PROCESS | 20946 | 21:50:22 INFO - PROCESS | 20946 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:84.00 stddev:17.54 (20.9%) stddev-sans-first:18.21 21:50:22 INFO - PROCESS | 20946 | Values: 84.0 84.0 108.0 83.0 84.0 85.0 111.0 84.0 85.0 134.0 21:50:22 INFO - PROCESS | 20946 | 21:50:22 INFO - PROCESS | 20946 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 21:50:22 INFO - PROCESS | 20946 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 21:50:22 INFO - PROCESS | 20946 | 21:50:22 INFO - PROCESS | 20946 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:1.23 (0.8%) stddev-sans-first:1.22 21:50:22 INFO - PROCESS | 20946 | Values: 145.0 147.0 148.0 145.0 145.0 147.0 146.0 145.0 148.0 146.0 21:50:22 INFO - PROCESS | 20946 | 21:50:22 INFO - PROCESS | 20946 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 21:50:22 INFO - PROCESS | 20946 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 21:50:22 INFO - PROCESS | 20946 | 21:50:22 INFO - PROCESS | 20946 | [#8] json-parse-financial Cycles:10 Average:50.10 Median:50.00 stddev:0.88 (1.8%) stddev-sans-first:0.93 21:50:22 INFO - PROCESS | 20946 | Values: 50.0 49.0 50.0 50.0 52.0 50.0 50.0 51.0 49.0 50.0 21:50:22 INFO - PROCESS | 20946 | 21:50:22 INFO - PROCESS | 20946 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 21:50:22 INFO - PROCESS | 20946 | Values: 59.0 60.0 60.0 60.0 61.0 60.0 59.0 60.0 61.0 60.0 21:50:22 INFO - PROCESS | 20946 | 21:50:22 INFO - PROCESS | 20946 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:77.00 stddev:18.45 (24.0%) stddev-sans-first:19.40 21:50:22 INFO - PROCESS | 20946 | Values: 76.0 75.0 81.0 76.0 77.0 77.0 77.0 76.0 135.0 77.0 21:50:22 INFO - PROCESS | 20946 | 21:50:22 INFO - PROCESS | 20946 | [#11] stanford-crypto-ccm Cycles:10 Average:123.90 Median:124.50 stddev:6.90 (5.5%) stddev-sans-first:6.67 21:50:22 INFO - PROCESS | 20946 | Values: 132.0 120.0 118.0 126.0 132.0 123.0 117.0 119.0 135.0 117.0 21:50:22 INFO - PROCESS | 20946 | 21:50:22 INFO - PROCESS | 20946 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.00 Median:154.00 stddev:1.89 (1.2%) stddev-sans-first:1.96 21:50:22 INFO - PROCESS | 20946 | Values: 155.0 154.0 158.0 151.0 155.0 152.0 154.0 153.0 154.0 154.0 21:50:22 INFO - PROCESS | 20946 | 21:50:22 INFO - PROCESS | 20946 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.66 (2.7%) stddev-sans-first:1.76 21:50:22 INFO - PROCESS | 20946 | Values: 62.0 64.0 62.0 61.0 61.0 62.0 66.0 61.0 61.0 61.0 21:50:22 INFO - PROCESS | 20946 | -------- Summary: end -------- 21:50:22 INFO - PROCESS | 20946 | 21:50:22 INFO - TEST-INFO | 20946: exit 0 21:50:23 INFO - TEST-OK | kraken | took 60476ms 21:50:23 INFO - SUITE-END | took 1174s 21:50:23 INFO - Completed test suite (00:19:35) 21:50:23 INFO - javascript benchmark 21:50:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3410.0110967819332, 3433.416319225732, 3436.261203841172, 3464.8960531184043, 3486.7036301914336, 5690.743916523756, 5761.279840019997, 5772.740226689799, 5810.273715785527, 5816.33112192098, 5708.800191993281, 5716.514096301809, 5724.4561766632205, 5725.599208055427, 5729.140628905666, 5038.294638750578, 5079.441261461246, 5103.26002729604, 5217.530422261995, 5220.947790522084, 5110.872228194306, 5136.743162841843, 5140.8971820563565, 5207.505286997748, 5210.583153347723, 5122.231665250224, 5149.30484384607, 5160.716160611165, 5191.714455704935, 5203.2975548301065, 5248.343957005374, 5253.973730131325, 5254.842354729383, 5262.578993680497, 5288.735563221823, 5020.723860187688, 5050.6212034097225, 5076.263941728429, 5145.819896303648, 5162.922556161623, 5503.0, 5546.084895992157, 5558.638688485276, 5560.610757246995, 5592.972035139798, 6154.046122850965, 6159.4456498915315, 6161.537884658668, 6162.506999440079, 6166.568340216187, 6088.512918966517, 6162.568620196588, 6173.228346456693, 6187.3503282155625, 6289.968550157266, 5818.534517238569, 5831.679257640828, 5847.561432892465, 5872.941270587282, 5887.499562537189, 6006.159137720722, 6388.744450222032, 6394.328595497405, 6394.880895843209, 6395.296517383084, 5959.851003724855, 6021.578489505692, 6028.879422411527, 6098.480874808306, 6118.632882027093, 6170.969145154335, 6177.320494745574, 6178.073289006685, 6178.289496707936, 6178.351273116348, 5845.473907348359, 5902.498287645598, 6071.544634152457, 6113.113598528189, 6131.662758548323, 5994.400559944058, 6035.517158627299, 6038.516918646497, 6042.516598672184, 6065.302490213594, 4660.091282200006, 4668.883277918079, 4675.95324046762, 4676.462206846256, 4676.859694209179, 4114.19773144234, 4124.546299907008, 4161.271777438936, 4176.853810116692, 4190.979045104755, 5840.970795146082, 5869.383714709894, 5873.58884878063, 5889.587728858939, 5897.76408943646, 6163.568550201532, 6203.100550420164, 6210.968945155336, 6213.2233470816145, 6233.844153896189, 5657.12314591239, 5741.913871291934, 5769.1923130761725, 5772.6536407815665, 5825.4174582542255, 5289.814856480005, 5312.362516498045, 5319.308489896366, 5324.5740340772645, 5346.1713434417725, 6402.583832050902, 6407.167068281094, 6407.359264073555, 6412.166418365583, 6413.230412350548, 5987.251593550806, 6136.140940268277, 6170.475509581735, 6184.845378865564, 6224.0, 6377.298497165215, 6414.775482858077, 6427.485801135805, 6434.549581529435, 6435.163428754419, 6115.694215289307, 6116.785912493041, 6123.785667501616, 6126.23422072241, 6128.8774224516155, 5987.221661184019, 6064.151018857276, 6121.663308517896, 6129.84675383119, 6141.64046186889, 5998.25021872266, 6000.039993601003, 6000.669963152069, 6002.369751176238, 6033.939660603338, 5817.970910145422, 5931.406859314034, 5974.820755377345, 5989.221401217814, 5998.310194327708, 5807.274090738658, 5877.853053673693, 5879.265091863517, 5917.260342457193, 5977.5217982560425, 6037.879242415215, 6097.542684298606, 6102.328743838263, 6103.267607887082, 6106.480949119375, 5802.129680547782, 5924.111383292368, 5939.673317967553, 5939.851503712442, 5942.10868369748], "value": 5656.0803106045705, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.9851003724906, 648.070019521986, 648.7729294746839, 663.1147418196707, 663.6217356107021, 33585.66414335856, 45479.0, 45910.540894591126, 46244.0, 46388.536114638846, 45367.092658146816, 45991.310130347985, 46040.0, 46167.30749038759, 46487.767561162145, 8338.374621903351, 8917.50953697548, 9093.545322733837, 9101.680256362823, 10808.0, 10540.736481587983, 10934.234603577752, 10996.890031099707, 10998.175136864727, 10999.725006874813, 11027.338359698404, 11106.6112686056, 11108.500117494732, 11109.388983605899, 11111.333320000786, 8452.366072544584, 10901.890981090168, 10919.290246133976, 11185.440727963569, 11186.664400068012, 10626.203034772345, 11074.833877491845, 11077.390743509104, 11083.113350931986, 11083.833742493869, 45901.31148032782, 46352.0, 46498.76750616225, 46697.766511167225, 46703.766481167375, 3665.596784353719, 3691.667749902522, 3766.9434958475645, 3959.4456776051375, 4307.267764480046, 35145.29709405823, 35992.10019749501, 36049.0, 36226.63773362259, 36428.27143457143, 4707.246840505537, 4713.882152946169, 4772.9761351193365, 4780.593649539794, 4904.362432883702, 387838.0, 388940.0, 389367.0, 389805.0, 391191.0, 69548.6522567384, 69947.65026174836, 70219.64890175516, 70244.64877675578, 70330.29669703238, 41015.589844101174, 42099.158016839494, 42159.36760948588, 44068.0, 44072.779636102256, 19245.8075419244, 19548.804511954982, 19551.315703950295, 19554.511137221398, 19559.706604400944, 13835.723285534234, 13944.442222310994, 14128.85871141296, 14185.503507377192, 14575.344109515097, 22427.10291588318, 22601.321960341214, 22722.318330450114, 22758.089676412757, 22872.0, 7932.246436588515, 8066.0, 8230.42387032914, 8247.835043299101, 8295.253427191581, 1041.5209003858158, 1054.488573042074, 1148.55780524497, 1148.787474317254, 1183.4496958914146, 33474.0, 33716.15709607279, 34618.0, 34740.826295868355, 34917.12817642014, 1144.4621028116771, 1195.5056179775281, 1204.5482943896038, 1219.4329636718792, 1280.443007291831, 18110.63778724418, 18165.7275140873, 18215.72676409855, 18284.360047398277, 18431.907840460713, 572209.0, 576506.0, 577309.0, 580119.0, 583261.0, 64079.35920640734, 65639.67180164068, 65654.0, 65662.34337656658, 65707.34292657013, 1363.7545241856362, 1453.774664926938, 1487.3827361645012, 1509.645233370157, 1509.9169545675313, 33477.33045339128, 34723.82638086793, 34752.47871281984, 35167.12082197965, 35820.28359432745, 54720.72639636776, 55174.44825551854, 55280.95954722368, 55308.17037744357, 55308.72345638246, 420164.0, 422192.0, 424544.0, 425378.0, 520160.0, 27042.459150817267, 27893.860530698028, 27904.0, 28912.566311505765, 28926.0, 51977.480225197265, 53672.73163634157, 54467.182992254355, 55013.449865500836, 55106.0, 45114.323285150094, 45901.0, 46200.0, 46340.536594633624, 47506.28740568825, 42195.3670694946, 44629.55370446384, 44984.77507612441, 45094.77452612716, 46079.308810368544, 44207.77896110499, 44890.551094488634, 45270.77364613156, 46209.306860397795, 46355.304670429294, 39141.2171756569, 40167.0, 40355.394669079404, 40464.79767601143, 40944.38583421191, 29805.023643312736, 29844.403111937205, 29939.55090673598, 30292.54561181628, 30340.0], "value": 21990.72685371425, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.3229671042779, 414.27501871724485, 424.2850796408052, 432.69927400456686, 439.3980247061526, 18609.162587683553, 19223.981481944385, 20144.0, 20237.089330980103, 20256.189752409904, 13875.932266304584, 18840.0, 19038.0, 19388.903055484738, 20549.280775172872, 5716.857078573027, 5782.277215348082, 6070.6661133637635, 6081.6351018938785, 6153.569250152491, 6045.909311360311, 6055.485283750886, 6062.090686397054, 6067.18093057436, 6072.058830881198, 3990.241854047736, 5615.522680572156, 6011.068284415901, 6054.122152287916, 6056.636601803906, 5871.794487192949, 5916.437938395846, 5938.435848594377, 5943.910841337383, 5948.970255148696, 5586.0, 5754.884902301972, 5756.280464941882, 5767.942320576783, 5776.422357764232, 14655.780163297559, 14831.851681483155, 15074.773878391832, 19794.40616781499, 19851.602967940704, 2424.4423782530116, 2443.963340549893, 2460.766227208412, 2556.143691863228, 2560.5903055511217, 10470.581176752921, 10897.400642964634, 10897.486720050732, 11015.449227538671, 11153.553857845676, 1924.8432570584253, 1960.4118764370774, 1978.0416492630952, 1994.9826187139356, 2054.281001649411, 57628.71185644087, 57971.71014144945, 72733.2726672737, 87374.0, 87916.0, 11616.419179041015, 11791.29252244868, 11813.291202527877, 11840.585579504675, 12504.687007864226, 16300.836991630169, 16358.509244722678, 16415.589610259838, 16459.506214813573, 16471.34114635425, 9042.909570904338, 9067.81864362709, 9093.81812363749, 9106.590203440861, 9188.173064424234, 8839.116088391109, 8893.0, 8926.285897128215, 8964.327675424369, 9090.045545217788, 5007.899842003212, 5047.2429135629945, 5063.11395505785, 5076.74616269185, 5144.639875208774, 2071.8135367816967, 2087.0503920716037, 2101.558672678724, 2121.469632591852, 2145.1633862793524, 983.4296108257194, 993.8906720260766, 1077.4612693653016, 1099.3239157917983, 1127.3912087472672, 18919.0, 19308.613827723366, 19650.410487685105, 19856.90071549662, 19939.501512462306, 1045.6183493025144, 1060.8726952765717, 1074.0655629602295, 1085.7285678580356, 1113.059464752283, 10693.465326733633, 11055.889441105646, 11242.156838237164, 11260.493277802518, 11369.602063927723, 433260.0, 434570.0, 439673.0, 517284.0, 584704.0, 98349.0, 105019.47490262499, 105022.0, 105441.0, 107316.0, 1097.5719469406938, 1115.486876037016, 1132.4507613807298, 1135.239389608964, 1138.021301680554, 17609.20758565842, 17930.372436964644, 18115.909420452812, 18175.727364089813, 18325.908370458063, 36761.448578270814, 40104.39843402409, 42706.572934271506, 43320.0, 44789.552104479844, 60947.390526095944, 62297.0, 62406.37593624006, 62676.0, 62909.370906292184, 8467.0, 8505.74482765518, 8904.421212621159, 8934.0, 9004.234640055669, 9834.934663720698, 13450.12574182675, 13629.250391228577, 13656.385462654005, 13877.375518101508, 11977.341246231541, 12062.51749929993, 12090.274583525017, 12127.151099422956, 12527.436265368262, 12039.458224379749, 12148.574799881962, 12381.690457738268, 12428.440720167433, 12683.429245683781, 12421.565245216736, 12441.502339906665, 12462.688432789253, 12465.0, 12582.24506529611, 8746.256568191775, 8771.605277762643, 8842.425242359226, 8951.820963580822, 8981.865272021056, 9029.729108126767, 11746.882531174579, 12389.504419823106, 12476.563320283747, 12625.558105466265], "value": 9512.968719333465, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.156905856487, 1580.6443550201207, 1601.783759192509, 1814.2652225848528, 1924.5188702824294, 8783.253423459006, 9148.359614826957, 9150.816983660323, 9372.531373431335, 9428.481433521154, 9077.409968352053, 9271.814563708722, 9279.257659387249, 9281.907180928189, 9288.953555232214, 2253.211376018389, 2294.908203671851, 2477.0, 2519.0, 2533.227365653475, 2533.784628306596, 2551.374913146282, 2552.068494999321, 2555.4889022195543, 2558.987205063972, 2468.728439871613, 2526.216872769438, 2526.3810366460243, 2526.7725904668578, 2538.200466852945, 2163.9242626508076, 2401.5076909233567, 2442.059806974328, 2446.963295550568, 2462.4336402627405, 2494.4761600064007, 2496.962545561818, 2519.1183085919965, 2519.2694118705554, 2577.510273048115, 9544.0, 9564.282678799118, 9565.808683826284, 9583.04169583043, 9596.280278979104, 5624.100143976944, 5765.0, 5777.45114214149, 5778.0, 5779.219805326269, 3470.9826450867836, 3578.177019285553, 3593.1735700788704, 3818.7517811342173, 3848.9607805892533, 1196.3958201108385, 1210.5512242508833, 1215.19796934024, 1254.6926003129292, 1295.3587973952954, 13890.0, 13893.79159312611, 13895.374708138159, 13907.374168162458, 13916.0, 5057.393112826484, 5192.506711862367, 5226.738663066832, 5274.367075950834, 5298.099323115002, 10673.62642307531, 10725.463726813628, 10777.730556735987, 10783.514741836636, 10788.56845726178, 5809.564282678816, 5815.127730840408, 5819.912701309484, 5821.88356232873, 5822.155787410802, 4812.278158276286, 5252.921206181911, 5354.651947623392, 5379.488948549882, 5419.458054194549, 4068.2880495913096, 4071.0840060986043, 4113.8971525712095, 4116.403121547419, 4117.053077792125, 1151.6717735445525, 1163.6567212672282, 1166.9228772784456, 1171.5372427891107, 1173.9119566032582, 932.3240650528313, 1004.2618675273668, 1090.8636420447444, 1093.0872721277822, 1098.3300186885992, 6577.14497115372, 6620.238672552622, 6652.54491317125, 6709.329067093252, 6757.831054223586, 1002.9197664186847, 1003.3277703938379, 1013.2299452416216, 1085.495244711213, 1089.0634054712941, 4534.319852022157, 4597.218472859622, 4638.350630911675, 4648.883777905579, 4662.906741865211, 11581.652550423501, 11791.35147566875, 11856.05151587871, 11888.643340699793, 11898.167128300936, 11234.0, 11622.0, 11715.882841171479, 11770.293782373084, 11784.234024788362, 8866.069062748447, 8939.553022348857, 9071.138241867013, 9077.636894524145, 9079.137481939206, 6591.176102987127, 6636.203655561363, 6715.764948226789, 6733.360330768569, 6819.931800682129, 10877.184211184034, 11158.218924675195, 11225.550977961117, 11257.380844053328, 11408.315501069963, 11288.661340159808, 11395.316281023164, 11461.0, 11565.768684626428, 11578.478968446609, 7841.451098423056, 8471.745847624581, 8482.872756908528, 8502.277306429023, 8827.426217295855, 9452.43285402878, 9461.716148515556, 9499.0, 9541.666041688508, 9552.092551207625, 8024.358051355995, 8248.83502329962, 8436.957815210884, 8475.279601233964, 8640.04959454472, 8248.298894594027, 8323.833523329378, 8390.454620449651, 8470.703525376583, 8536.317094632539, 7506.624668766649, 7704.30661240491, 7716.884246736191, 7718.687823070204, 7722.92277077222, 5638.859028524155, 5660.490555849993, 5713.742881570256, 5738.4134915677705, 5821.679807610622, 5765.509931655689, 5767.336756273083, 5827.6794776286015, 5947.999702003988, 5966.970165149147], "value": 5037.161702537459, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.9646533888376, 354.83322838266014, 356.1630169102609, 360.877301717416, 365.03994494479514, 5516.255305533752, 5579.13523403872, 5588.189712491686, 5591.580631452642, 5612.607117501777, 5544.140658197975, 5551.2228288039605, 5551.250581171541, 5566.582506312033, 5679.602427830043, 4025.3156963316233, 4251.574842515754, 4271.380649805777, 4284.785760711968, 4291.699581029329, 4225.556316586761, 4266.573342665724, 4268.850590229343, 4281.314989601664, 4341.348797680357, 4058.8782336529953, 4154.169166166764, 4280.229558679436, 4281.657467402601, 4286.97856510717, 4262.595053469947, 4266.2320782259185, 4267.829286828523, 4277.123189746095, 4280.871573852789, 3760.9623903761158, 3767.530663041416, 3773.6037716039696, 3779.5653499847595, 3787.62123787619, 5081.314022606938, 5202.320804785539, 5324.4675532446445, 5333.679979201261, 5344.706041167734, 4997.225430058311, 5004.148465067949, 5005.924911126336, 5011.749412529359, 5030.918352554182, 5754.769809207627, 5789.247397838296, 5796.420357964212, 5808.709564521757, 5818.825435236908, 4120.320147175712, 4234.407182994383, 4247.5540068293, 4259.382389553529, 4269.807858646337, 5910.290765108214, 5978.475488750428, 5991.621926956781, 6015.75936962521, 6026.367231440723, 4335.523092459827, 4346.565343465628, 4352.303631418958, 4352.933531284855, 4357.477102747691, 4295.570442955742, 4428.68999170055, 4430.582213691652, 4442.73343599385, 4459.152760975404, 4941.950580494221, 4948.109340318705, 4952.801887924443, 4968.478309777422, 4994.225894986283, 5677.858053548612, 5737.88524229513, 5791.333996590446, 5795.333536643256, 5801.274840644919, 1504.751715966875, 1534.4706076403622, 1538.9692206155814, 1540.9922950385176, 1549.6905115177656, 962.8363178259573, 976.7411635916487, 985.7087215747393, 986.3391527676474, 990.5245482168456, 4939.678920870132, 4983.931668357591, 4991.0, 5011.774470148852, 5032.396112466454, 5163.690178589297, 5216.426193118754, 5227.686338819683, 5255.608698042382, 5262.868428289246, 4967.950320496821, 5321.64298103981, 5348.331458567679, 5642.6614403135945, 5652.7738890443925, 3147.740903638563, 3161.4783560712226, 3175.1903264667826, 3180.2685382361724, 3182.9204269892975, 5889.322727886348, 6151.384861513902, 6170.598911070766, 6176.227971503562, 6220.947087461127, 6090.6041107328765, 6146.508279337642, 6149.477294429934, 6168.259808822881, 6178.227721534809, 6169.507056983767, 6203.16257305258, 6209.789091127187, 6253.312135665074, 6266.530010249158, 5908.231929849092, 6059.242594675666, 6067.271927368744, 6069.878602428015, 6070.878582428415, 5916.0, 5960.165576819162, 5968.46283834457, 5971.402859713994, 5980.34216236205, 6041.0, 6078.817635470943, 6189.566730328834, 6192.752289908353, 6194.690265486617, 4274.6793990450215, 4276.337167739005, 4294.506131794758, 4295.045754181902, 4296.505901821206, 5959.940400595939, 6001.519878409804, 6006.039033754753, 6013.128096426081, 6031.36670649593, 5629.577781666473, 5772.614572502654, 5782.017057100387, 5789.478946894799, 5806.738696758572, 5759.683217423082, 5764.596478246483, 5766.481016708516, 5824.097264923944, 5852.0, 5457.263269458731, 5685.118806584986, 5730.627509211888, 5756.625819321731, 5763.221965034667, 5841.649501029951, 5871.1486834409625, 5874.206982057368, 5874.530037596896, 5893.793717219876, 5457.317835270591, 5755.503569071988, 5761.5102716269585, 5763.423657634203, 5785.39253378406], "value": 4414.165122839119, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [805.1143741883928, 814.9470284431513, 842.5155535567048, 852.3096292003478, 886.9113088691136, 14867.182304973223, 14970.401183952656, 15010.474633387834, 15073.773893391608, 15814.209289535534, 12592.055595830327, 15759.054456732576, 15983.200839957984, 16422.917885410585, 16763.748543771824, 857.871319302105, 872.075599864146, 878.9824203515958, 889.9421537600068, 890.8485557455216, 861.4228466927174, 862.0259107208846, 864.6282098697558, 866.6576702202626, 868.5570359116864, 772.4091070331201, 785.1912530093983, 906.0486489186361, 908.0238743350891, 921.7695576105973, 902.1339514066505, 909.940853844498, 910.4992254260163, 910.517425764346, 911.4576826788051, 671.0370618162951, 671.5332843673649, 672.0, 672.357898207211, 672.4418732452053, 16935.745963810554, 16937.491875243762, 16948.40680576174, 16964.830351696448, 17005.574860628458, 14057.156570605797, 14165.433382664682, 14378.993470456968, 14546.199959002251, 14678.779818302733, 13193.934030329787, 13262.0, 13502.392392342368, 14117.78823317651, 14452.0, 4623.144718227105, 4683.180443422388, 4740.668153229275, 4752.310914917352, 4829.396325459317, 68486.0, 70959.64520177418, 71815.0, 81560.59219703864, 85778.0, 12683.809742853864, 12748.745025099632, 12793.424295906707, 12836.16564923277, 13090.280034598189, 22853.428664283194, 22875.885620572124, 23044.65433018506, 23082.76917230806, 23091.307260782203, 9247.480526228992, 9413.482258475713, 9539.570719317648, 9559.283053770994, 9589.616415343307, 5100.515451032146, 5143.228515722672, 5172.250023746536, 5214.921776173361, 5227.294315267391, 3876.457295978565, 4020.83916643331, 4021.7788021658503, 4022.2357752027606, 4022.738521996061, 650.681166228554, 653.7973228299243, 699.1121275979477, 724.3010494872474, 762.7444805990056, 696.78747981865, 698.3121625199175, 713.5290708132608, 766.4060353226295, 817.6380443917172, 10499.737506562396, 10587.57649694019, 10690.358578485315, 10738.624148154933, 11117.388543630017, 726.531387255228, 731.8133875861621, 738.682366582364, 771.8957940677936, 774.4888373673349, 4995.325631039836, 5152.742362881841, 5227.555657769056, 5309.601779866525, 5338.572914166857, 122109.0, 123702.0, 127639.0, 129492.0, 130031.69968300196, 108045.0, 110700.0, 111362.0, 111533.0, 111590.0, 94624.0, 95434.0, 96152.51923740336, 97656.0, 101631.4918425418, 9893.851592226267, 9923.156531694887, 9969.700908972742, 10030.598776048877, 10067.597296108073, 56503.0, 56739.148912765515, 56866.715666421405, 58354.83290334255, 59573.404265956786, 77188.61405692935, 83468.16531834604, 84811.0, 84925.57537212274, 87435.0, 11945.641630751092, 12525.498980040697, 12644.683882903, 12679.049071319872, 12805.039622028198, 14594.92702536523, 14845.777313340093, 14879.404823806926, 14934.402623894923, 14993.325300361728, 11608.88391116078, 11811.586594469152, 13411.0, 13964.0, 14718.337674804874, 13932.303384830515, 14381.712365752835, 14498.927505362406, 14505.347259373142, 14729.852701472848, 13711.177329360271, 13728.176309421468, 13878.86121138816, 13961.790573141614, 14202.431902723776, 11673.0, 11827.0, 11882.82175767347, 12135.514579416724, 12139.635810925687, 11490.54037838477, 11701.590444334408, 11893.881061189624, 11940.701482463008, 11969.64091077269], "value": 8108.990686647427, "unit": "score"}], "name": "dromaeo_css", "value": 7730.1150111991155, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 108.0, 109.0, 111.0, 113.0, 110.0, 111.0, 110.0, 110.0, 119.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 126.0, 169.0, 123.0, 158.0, 158.0, 125.0, 189.0, 135.0], "value": 146.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 160.0, 162.0, 160.0, 163.0, 161.0, 161.0, 159.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 113.0, 75.0, 76.0, 75.0, 75.0, 98.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 108.0, 83.0, 84.0, 85.0, 111.0, 84.0, 85.0, 134.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 148.0, 145.0, 145.0, 147.0, 146.0, 145.0, 148.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 50.0, 50.0, 52.0, 50.0, 50.0, 51.0, 49.0, 50.0], "value": 50.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 61.0, 60.0, 59.0, 60.0, 61.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 81.0, 76.0, 77.0, 77.0, 77.0, 76.0, 135.0, 77.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 120.0, 118.0, 126.0, 132.0, 123.0, 117.0, 119.0, 135.0, 117.0], "value": 123.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 154.0, 158.0, 151.0, 155.0, 152.0, 154.0, 153.0, 154.0, 154.0], "value": 154.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 62.0, 61.0, 61.0, 62.0, 66.0, 61.0, 61.0, 61.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1484.6000000000001, "alertThreshold": 2.0}]} 21:50:23 INFO - Return code: 0 21:50:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:50:23 ERROR - # TBPL SUCCESS # 21:50:23 INFO - Running post-action listener: _resource_record_post_action 21:50:23 INFO - ##### 21:50:23 INFO - ##### Finished run-tests step (success) 21:50:23 INFO - ##### 21:50:23 INFO - Running post-run listener: _resource_record_post_run 21:50:23 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 458596352; Read time: 12; Write time: 621008 21:50:23 INFO - TinderboxPrint: CPU usage
13.1% 21:50:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:50:23 INFO - TinderboxPrint: I/O write bytes / time
458,596,352 / 621,008 21:50:23 INFO - TinderboxPrint: CPU idle
8,265.5 (86.9%) 21:50:23 INFO - TinderboxPrint: CPU user
1,196.7 (12.6%) 21:50:23 INFO - TinderboxPrint: Swap in / out
0 / 0 21:50:23 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 207519744; Read time: 0; Write time: 390972 21:50:23 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 250351616; Read time: 12; Write time: 229980 21:50:24 INFO - Running post-run listener: _upload_blobber_files 21:50:24 INFO - Blob upload gear active. 21:50:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:50:24 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 21:50:24 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'] 21:50:24 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 21:50:24 INFO - (blobuploader) - INFO - Open directory for files ... 21:50:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:50:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:50:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:50:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:50:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:50:27 INFO - (blobuploader) - INFO - Done attempting. 21:50:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:50:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:50:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:50:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:50:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:50:28 INFO - (blobuploader) - INFO - Done attempting. 21:50:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:50:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:50:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:50:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:50:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:50:29 INFO - (blobuploader) - INFO - Done attempting. 21:50:29 INFO - (blobuploader) - INFO - Iteration through files over. 21:50:29 INFO - Return code: 0 21:50:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:50:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:50:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/611df1d8a7ddda494fe4bc4edfb4146ab080a919d3e0889c8791e53e36f63dbdd5285dd3019aa6a57c8705fb245648eb4d6f4f5bdb2702038f4bf3724abb38db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8067fdae94dd3703f6badd3e26a54365a863914a1b9ea53503b81080a056e550e766d993ee3a2cf01a53d931b72fc1793f8d8878e1308d2dd1c2454334533aa4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb480ed9a8f7abbebef804998866a81181915edd99c73bffdfc76a134d8a93489118d853f5f4db2cd0105185d16f756d3db804821f98f8603c16f491dddc3148"} 21:50:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:50:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:50:29 INFO - Contents: 21:50:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/611df1d8a7ddda494fe4bc4edfb4146ab080a919d3e0889c8791e53e36f63dbdd5285dd3019aa6a57c8705fb245648eb4d6f4f5bdb2702038f4bf3724abb38db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8067fdae94dd3703f6badd3e26a54365a863914a1b9ea53503b81080a056e550e766d993ee3a2cf01a53d931b72fc1793f8d8878e1308d2dd1c2454334533aa4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb480ed9a8f7abbebef804998866a81181915edd99c73bffdfc76a134d8a93489118d853f5f4db2cd0105185d16f756d3db804821f98f8603c16f491dddc3148"} 21:50:29 INFO - Running post-run listener: copy_logs_to_upload_dir 21:50:29 INFO - Copying logs to upload dir... 21:50:29 INFO - mkdir: /builds/slave/test/build/upload/logs 21:50:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.297997 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-06 21:50:29.514796) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 21:50:29.518138) ========= 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=af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788 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/611df1d8a7ddda494fe4bc4edfb4146ab080a919d3e0889c8791e53e36f63dbdd5285dd3019aa6a57c8705fb245648eb4d6f4f5bdb2702038f4bf3724abb38db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8067fdae94dd3703f6badd3e26a54365a863914a1b9ea53503b81080a056e550e766d993ee3a2cf01a53d931b72fc1793f8d8878e1308d2dd1c2454334533aa4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb480ed9a8f7abbebef804998866a81181915edd99c73bffdfc76a134d8a93489118d853f5f4db2cd0105185d16f756d3db804821f98f8603c16f491dddc3148"} build_url:https://queue.taskcluster.net/v1/task/ZPKLA7OCQcKKyFHh0q78oA/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/ZPKLA7OCQcKKyFHh0q78oA/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/611df1d8a7ddda494fe4bc4edfb4146ab080a919d3e0889c8791e53e36f63dbdd5285dd3019aa6a57c8705fb245648eb4d6f4f5bdb2702038f4bf3724abb38db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8067fdae94dd3703f6badd3e26a54365a863914a1b9ea53503b81080a056e550e766d993ee3a2cf01a53d931b72fc1793f8d8878e1308d2dd1c2454334533aa4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cb480ed9a8f7abbebef804998866a81181915edd99c73bffdfc76a134d8a93489118d853f5f4db2cd0105185d16f756d3db804821f98f8603c16f491dddc3148"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 21:50:29.547802) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 21:50:29.548522) ========= 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=af724c981e2a0f424dbabf99000001e7-1465272879.712349-643645788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 21:50:29.633119) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 21:50:29.633812) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 21:50:29.634415) ========= ========= Total master_lag: 0.19 =========