builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1470167660.07 results: success (0) buildid: 20160802101548 builduid: dd9079342e3c4a71b95c566afd6554e1 revision: 47b1f7ef94579405ba1f29c63c775250bc86289f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 12:54:20.069166) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-02 12:54:20.069552) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 12:54:20.069821) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-02 12:54:20.110744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 12:54:20.111095) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-02 12:54:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 102M=0s 2016-08-02 12:54:20 (102 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.373818 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 12:54:20.502297) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 12:54:20.502603) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016807 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 12:54:20.551677) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 12:54:20.555106) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 47b1f7ef94579405ba1f29c63c775250bc86289f --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-beta --rev 47b1f7ef94579405ba1f29c63c775250bc86289f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-02 12:54:20,622 truncating revision to first 12 chars 2016-08-02 12:54:20,622 Setting DEBUG logging. 2016-08-02 12:54:20,622 attempt 1/10 2016-08-02 12:54:20,622 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/47b1f7ef9457?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-02 12:54:20,935 unpacking tar archive at: mozilla-beta-47b1f7ef9457/testing/mozharness/ program finished with exit code 0 elapsedTime=0.677731 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 12:54:21.247411) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 12:54:21.247729) ========= script_repo_revision: 47b1f7ef94579405ba1f29c63c775250bc86289f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-02 12:54:21.248165) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 12:54:21.248424) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-02 12:54:21.259359) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-08-02 12:54:21.259619) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:54:21 INFO - MultiFileLogger online at 20160802 12:54:21 in /builds/slave/test 12:54:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:54:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:54:21 INFO - {'append_to_log': False, 12:54:21 INFO - 'base_work_dir': '/builds/slave/test', 12:54:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:54:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:54:21 INFO - 'branch': 'Mozilla-Beta', 12:54:21 INFO - 'buildbot_json_path': 'buildprops.json', 12:54:21 INFO - 'config_files': ('talos/linux_config.py',), 12:54:21 INFO - 'default_actions': ('clobber', 12:54:21 INFO - 'read-buildbot-config', 12:54:21 INFO - 'download-and-extract', 12:54:21 INFO - 'populate-webroot', 12:54:21 INFO - 'create-virtualenv', 12:54:21 INFO - 'install', 12:54:21 INFO - 'run-tests'), 12:54:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:54:21 INFO - 'download_minidump_stackwalk': True, 12:54:21 INFO - 'download_symbols': 'ondemand', 12:54:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:54:21 INFO - 'tooltool.py': '/tools/tooltool.py', 12:54:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:54:21 INFO - '/tools/misc-python/virtualenv.py')}, 12:54:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:54:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:54:21 INFO - 'installer_path': 'installer.exe', 12:54:21 INFO - 'log_level': 'info', 12:54:21 INFO - 'log_name': 'talos', 12:54:21 INFO - 'log_to_console': True, 12:54:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:54:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:54:21 INFO - 'opt_config_files': (), 12:54:21 INFO - 'pip_index': False, 12:54:21 INFO - 'sps_profile': False, 12:54:21 INFO - 'sps_profile_interval': 0, 12:54:21 INFO - 'suite': 'dromaeojs-e10s', 12:54:21 INFO - 'system_bits': '32', 12:54:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:54:21 INFO - 'title': 'talos-linux64-ix-060', 12:54:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:54:21 INFO - 'use_talos_json': True, 12:54:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:54:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:54:21 INFO - 'work_dir': 'build'} 12:54:21 INFO - ##### 12:54:21 INFO - ##### Running clobber step. 12:54:21 INFO - ##### 12:54:21 INFO - Running pre-action listener: _resource_record_pre_action 12:54:21 INFO - Running main action method: clobber 12:54:21 INFO - rmtree: /builds/slave/test/build 12:54:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:54:21 INFO - Running post-action listener: _resource_record_post_action 12:54:21 INFO - ##### 12:54:21 INFO - ##### Finished clobber step (success) 12:54:21 INFO - ##### 12:54:21 INFO - ##### 12:54:21 INFO - ##### Running read-buildbot-config step. 12:54:21 INFO - ##### 12:54:21 INFO - Running pre-action listener: _resource_record_pre_action 12:54:21 INFO - Running main action method: read_buildbot_config 12:54:21 INFO - Using buildbot properties: 12:54:21 INFO - { 12:54:21 INFO - "project": "", 12:54:21 INFO - "product": "firefox", 12:54:21 INFO - "script_repo_revision": "production", 12:54:21 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 12:54:21 INFO - "repository": "", 12:54:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 12:54:21 INFO - "buildid": "20160802101548", 12:54:21 INFO - "pgo_build": "True", 12:54:21 INFO - "basedir": "/builds/slave/test", 12:54:21 INFO - "buildnumber": 65, 12:54:21 INFO - "slavename": "talos-linux64-ix-060", 12:54:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:54:21 INFO - "platform": "ubuntu64_hw", 12:54:21 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:54:21 INFO - "branch": "mozilla-beta", 12:54:21 INFO - "repo_path": "releases/mozilla-beta", 12:54:21 INFO - "revision": "47b1f7ef94579405ba1f29c63c775250bc86289f", 12:54:21 INFO - "stage_platform": "linux64-pgo", 12:54:21 INFO - "builduid": "dd9079342e3c4a71b95c566afd6554e1", 12:54:21 INFO - "slavebuilddir": "test" 12:54:21 INFO - } 12:54:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2. 12:54:21 INFO - Running post-action listener: _resource_record_post_action 12:54:21 INFO - ##### 12:54:21 INFO - ##### Finished read-buildbot-config step (success) 12:54:21 INFO - ##### 12:54:21 INFO - ##### 12:54:21 INFO - ##### Running download-and-extract step. 12:54:21 INFO - ##### 12:54:21 INFO - Running pre-action listener: _resource_record_pre_action 12:54:21 INFO - Running main action method: download_and_extract 12:54:21 INFO - mkdir: /builds/slave/test/build/tests 12:54:21 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')]} 12:54:21 INFO - https://queue.taskcluster.net/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:54:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 12:54:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 12:54:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 12:54:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:54:22 INFO - Downloaded 1327 bytes. 12:54:22 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 12:54:22 INFO - Using the following test package requirements: 12:54:22 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 12:54:22 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 12:54:22 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:54:22 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 12:54:22 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 12:54:22 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 12:54:22 INFO - u'jsshell-linux-x86_64.zip'], 12:54:22 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 12:54:22 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:54:22 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 12:54:22 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 12:54:22 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 12:54:22 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 12:54:22 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 12:54:22 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 12:54:22 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:54:22 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 12:54:22 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:54:22 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:22 INFO - https://queue.taskcluster.net/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:54:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:54:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:54:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:54:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:54:23 INFO - Downloaded 21968354 bytes. 12:54:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:54:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:54:24 INFO - Return code: 0 12:54:24 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:54:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:24 INFO - https://queue.taskcluster.net/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:54:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:54:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:54:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 12:54:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:54:25 INFO - Downloaded 21968354 bytes. 12:54:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:54:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:54:26 INFO - Return code: 0 12:54:26 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')]} 12:54:26 INFO - https://queue.taskcluster.net/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:54:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 12:54:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 12:54:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 12:54:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:54:27 INFO - Downloaded 10833369 bytes. 12:54:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:54:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:54:27 INFO - Return code: 0 12:54: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')]} 12:54:27 INFO - https://queue.taskcluster.net/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:54:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 12:54:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 12:54:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 12:54:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:54:29 INFO - Downloaded 55282512 bytes. 12:54:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 12:54:29 INFO - mkdir: /builds/slave/test/properties 12:54:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:54:29 INFO - Writing to file /builds/slave/test/properties/build_url 12:54:29 INFO - Contents: 12:54:29 INFO - build_url:https://queue.taskcluster.net/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 12:54:29 INFO - Running post-action listener: _resource_record_post_action 12:54:29 INFO - Running post-action listener: set_extra_try_arguments 12:54:29 INFO - ##### 12:54:29 INFO - ##### Finished download-and-extract step (success) 12:54:29 INFO - ##### 12:54:29 INFO - ##### 12:54:29 INFO - ##### Running populate-webroot step. 12:54:29 INFO - ##### 12:54:29 INFO - Running pre-action listener: _resource_record_pre_action 12:54:29 INFO - Running main action method: populate_webroot 12:54:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:54:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:54:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:54:29 INFO - '--tppagecycles', 12:54:29 INFO - '7'], 12:54:29 INFO - 'tests': ['tsvgm']}}, 12:54:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:54:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:54:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:54:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:54:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:54:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:54:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:29 INFO - 'talos_options': ['--disable-e10s'], 12:54:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:29 INFO - 'talos_options': ['--disable-e10s'], 12:54:29 INFO - 'tests': ['damp', 'tps']}, 12:54:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:29 INFO - 'tests': ['damp', 'tps']}, 12:54:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:54:29 INFO - 'tests': ['dromaeo_dom']}, 12:54:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:54:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:54:29 INFO - 'tests': ['a11yr', 12:54:29 INFO - 'ts_paint', 12:54:29 INFO - 'tpaint', 12:54:29 INFO - 'sessionrestore', 12:54:29 INFO - 'sessionrestore_no_auto_restore', 12:54:29 INFO - 'tabpaint']}, 12:54:29 INFO - 'other-e10s': {'tests': ['a11yr', 12:54:29 INFO - 'ts_paint', 12:54:29 INFO - 'tpaint', 12:54:29 INFO - 'sessionrestore', 12:54:29 INFO - 'sessionrestore_no_auto_restore', 12:54:29 INFO - 'tabpaint']}, 12:54:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:54:29 INFO - 'ts_paint', 12:54:29 INFO - 'tpaint', 12:54:29 INFO - 'sessionrestore', 12:54:29 INFO - 'sessionrestore_no_auto_restore', 12:54:29 INFO - 'tabpaint']}, 12:54:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:54:29 INFO - 'ts_paint', 12:54:29 INFO - 'tpaint', 12:54:29 INFO - 'sessionrestore', 12:54:29 INFO - 'sessionrestore_no_auto_restore', 12:54:29 INFO - 'tabpaint']}, 12:54:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:54:29 INFO - 'tests': ['a11yr', 12:54:29 INFO - 'ts_paint', 12:54:29 INFO - 'tpaint', 12:54:29 INFO - 'sessionrestore', 12:54:29 INFO - 'sessionrestore_no_auto_restore', 12:54:29 INFO - 'tabpaint']}, 12:54:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:54:29 INFO - 'tests': ['a11yr', 12:54:29 INFO - 'ts_paint', 12:54:29 INFO - 'tpaint', 12:54:29 INFO - 'sessionrestore', 12:54:29 INFO - 'sessionrestore_no_auto_restore', 12:54:29 INFO - 'tabpaint']}, 12:54:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:54:29 INFO - 'tests': ['tsvgx', 12:54:29 INFO - 'tsvgr_opacity', 12:54:29 INFO - 'tart', 12:54:29 INFO - 'tscrollx', 12:54:29 INFO - 'cart']}, 12:54:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:54:29 INFO - 'tsvgr_opacity', 12:54:29 INFO - 'tart', 12:54:29 INFO - 'tscrollx', 12:54:29 INFO - 'cart']}, 12:54:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:29 INFO - 'talos_options': ['--disable-e10s'], 12:54:29 INFO - 'tests': ['tp5o']}, 12:54:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:29 INFO - 'tests': ['tp5o']}, 12:54:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:29 INFO - 'talos_options': ['--disable-e10s', 12:54:29 INFO - '--xperf_path', 12:54:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:29 INFO - 'tests': ['tp5n']}, 12:54:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:29 INFO - 'talos_options': ['--xperf_path', 12:54:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:29 INFO - 'tests': ['tp5n']}}, 12:54:29 INFO - 'talos.zip': {'path': '', 12:54:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:54:29 INFO - Running post-action listener: _resource_record_post_action 12:54:29 INFO - ##### 12:54:29 INFO - ##### Finished populate-webroot step (success) 12:54:29 INFO - ##### 12:54:29 INFO - ##### 12:54:29 INFO - ##### Running create-virtualenv step. 12:54:29 INFO - ##### 12:54:29 INFO - Running pre-action listener: _resource_record_pre_action 12:54:29 INFO - Running main action method: create_virtualenv 12:54:29 INFO - Creating virtualenv /builds/slave/test/build/venv 12:54:29 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 12:54:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:54:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:54:29 INFO - Using real prefix '/usr' 12:54:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:54:30 INFO - Installing distribute.............................................................................................................................................................................................done. 12:54:32 INFO - Installing pip.................done. 12:54:32 INFO - Return code: 0 12:54:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:54:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:32 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 0x7fc735993f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e23b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2374990>, '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 0x22e0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e0900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', '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 12:54:32 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 12:54:32 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 12:54:32 INFO - Using env: {'DISPLAY': ':0', 12:54:32 INFO - 'HOME': '/home/cltbld', 12:54:32 INFO - 'LANG': 'en_US.UTF-8', 12:54:32 INFO - 'LANGUAGE': 'en_US:en', 12:54:32 INFO - 'LOGNAME': 'cltbld', 12:54:32 INFO - 'MAIL': '/var/mail/cltbld', 12:54:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:32 INFO - 'MOZ_NO_REMOTE': '1', 12:54:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:32 INFO - 'NO_EM_RESTART': '1', 12:54:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:32 INFO - 'PWD': '/builds/slave/test', 12:54:32 INFO - 'SHELL': '/bin/bash', 12:54:32 INFO - 'SHLVL': '1', 12:54:32 INFO - 'TERM': 'linux', 12:54:32 INFO - 'TMOUT': '86400', 12:54:32 INFO - 'USER': 'cltbld', 12:54:32 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', 12:54:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:32 INFO - '_': '/tools/buildbot/bin/python'} 12:54:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:32 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 12:54:32 INFO - Cleaning up... 12:54:32 INFO - Return code: 0 12:54:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:54:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:32 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 0x7fc735993f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e23b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2374990>, '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 0x22e0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e0900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', '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 12:54:32 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 12:54:32 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 12:54:32 INFO - Using env: {'DISPLAY': ':0', 12:54:32 INFO - 'HOME': '/home/cltbld', 12:54:32 INFO - 'LANG': 'en_US.UTF-8', 12:54:32 INFO - 'LANGUAGE': 'en_US:en', 12:54:32 INFO - 'LOGNAME': 'cltbld', 12:54:32 INFO - 'MAIL': '/var/mail/cltbld', 12:54:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:32 INFO - 'MOZ_NO_REMOTE': '1', 12:54:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:32 INFO - 'NO_EM_RESTART': '1', 12:54:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:32 INFO - 'PWD': '/builds/slave/test', 12:54:32 INFO - 'SHELL': '/bin/bash', 12:54:32 INFO - 'SHLVL': '1', 12:54:32 INFO - 'TERM': 'linux', 12:54:32 INFO - 'TMOUT': '86400', 12:54:32 INFO - 'USER': 'cltbld', 12:54:32 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', 12:54:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:32 INFO - '_': '/tools/buildbot/bin/python'} 12:54:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:32 INFO - Downloading/unpacking psutil>=3.1.1 12:54:32 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 12:54:32 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 12:54:32 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 12:54:32 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 12:54:32 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 12:54:32 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 12:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:54:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:36 INFO - Installing collected packages: psutil 12:54:36 INFO - Running setup.py install for psutil 12:54:36 INFO - building 'psutil._psutil_linux' extension 12:54:36 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 12:54:36 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 12:54:36 INFO - building 'psutil._psutil_posix' extension 12:54:36 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 12:54:36 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 12:54:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:36 INFO - Successfully installed psutil 12:54:36 INFO - Cleaning up... 12:54:36 INFO - Return code: 0 12:54:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc735993f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e23b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2374990>, '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 0x22e0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e0900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', '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 12:54:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:54:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:54:36 INFO - Using env: {'DISPLAY': ':0', 12:54:36 INFO - 'HOME': '/home/cltbld', 12:54:36 INFO - 'LANG': 'en_US.UTF-8', 12:54:36 INFO - 'LANGUAGE': 'en_US:en', 12:54:36 INFO - 'LOGNAME': 'cltbld', 12:54:36 INFO - 'MAIL': '/var/mail/cltbld', 12:54:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:36 INFO - 'MOZ_NO_REMOTE': '1', 12:54:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:36 INFO - 'NO_EM_RESTART': '1', 12:54:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:36 INFO - 'PWD': '/builds/slave/test', 12:54:36 INFO - 'SHELL': '/bin/bash', 12:54:36 INFO - 'SHLVL': '1', 12:54:36 INFO - 'TERM': 'linux', 12:54:36 INFO - 'TMOUT': '86400', 12:54:36 INFO - 'USER': 'cltbld', 12:54:36 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', 12:54:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:36 INFO - '_': '/tools/buildbot/bin/python'} 12:54:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:54:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:54:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:54:38 INFO - Installing collected packages: mozsystemmonitor 12:54:38 INFO - Running setup.py install for mozsystemmonitor 12:54:38 INFO - Successfully installed mozsystemmonitor 12:54:38 INFO - Cleaning up... 12:54:38 INFO - Return code: 0 12:54:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:38 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 0x7fc735993f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e23b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2374990>, '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 0x22e0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e0900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', '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 12:54:38 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 12:54:38 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 12:54:38 INFO - Using env: {'DISPLAY': ':0', 12:54:38 INFO - 'HOME': '/home/cltbld', 12:54:38 INFO - 'LANG': 'en_US.UTF-8', 12:54:38 INFO - 'LANGUAGE': 'en_US:en', 12:54:38 INFO - 'LOGNAME': 'cltbld', 12:54:38 INFO - 'MAIL': '/var/mail/cltbld', 12:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:38 INFO - 'MOZ_NO_REMOTE': '1', 12:54:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:38 INFO - 'NO_EM_RESTART': '1', 12:54:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:38 INFO - 'PWD': '/builds/slave/test', 12:54:38 INFO - 'SHELL': '/bin/bash', 12:54:38 INFO - 'SHLVL': '1', 12:54:38 INFO - 'TERM': 'linux', 12:54:38 INFO - 'TMOUT': '86400', 12:54:38 INFO - 'USER': 'cltbld', 12:54:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', 12:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:38 INFO - '_': '/tools/buildbot/bin/python'} 12:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:39 INFO - Downloading/unpacking jsonschema==2.5.1 12:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:54:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:54:41 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 12:54:41 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 12:54:41 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 12:54:41 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 12:54:41 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 12:54:41 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 12:54:41 INFO - Downloading functools32-3.2.3-2.tar.gz 12:54:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:54:41 INFO - warning: no files found matching '*.txt' 12:54:41 INFO - no previously-included directories found matching 'build' 12:54:41 INFO - no previously-included directories found matching 'dist' 12:54:41 INFO - no previously-included directories found matching '.git*' 12:54:41 INFO - Installing collected packages: jsonschema, functools32 12:54:41 INFO - Running setup.py install for functools32 12:54:41 INFO - warning: no files found matching '*.txt' 12:54:41 INFO - no previously-included directories found matching 'build' 12:54:41 INFO - no previously-included directories found matching 'dist' 12:54:41 INFO - no previously-included directories found matching '.git*' 12:54:41 INFO - Successfully installed jsonschema functools32 12:54:41 INFO - Cleaning up... 12:54:41 INFO - Return code: 0 12:54:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:54:41 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')]} 12:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:41 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')]} 12:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:41 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 0x7fc735993f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e23b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2374990>, '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 0x22e0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e0900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', '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 12:54:41 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 12:54:41 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 12:54:41 INFO - Using env: {'DISPLAY': ':0', 12:54:41 INFO - 'HOME': '/home/cltbld', 12:54:41 INFO - 'LANG': 'en_US.UTF-8', 12:54:41 INFO - 'LANGUAGE': 'en_US:en', 12:54:41 INFO - 'LOGNAME': 'cltbld', 12:54:41 INFO - 'MAIL': '/var/mail/cltbld', 12:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:41 INFO - 'MOZ_NO_REMOTE': '1', 12:54:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:41 INFO - 'NO_EM_RESTART': '1', 12:54:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:41 INFO - 'PWD': '/builds/slave/test', 12:54:41 INFO - 'SHELL': '/bin/bash', 12:54:41 INFO - 'SHLVL': '1', 12:54:41 INFO - 'TERM': 'linux', 12:54:41 INFO - 'TMOUT': '86400', 12:54:41 INFO - 'USER': 'cltbld', 12:54:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', 12:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:41 INFO - '_': '/tools/buildbot/bin/python'} 12:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:41 INFO - Downloading/unpacking blobuploader==1.2.4 12:54:41 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 12:54:41 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 12:54:41 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 12:54:41 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 12:54:41 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 12:54:41 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 12:54:43 INFO - Downloading blobuploader-1.2.4.tar.gz 12:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:54:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:54:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:44 INFO - Downloading docopt-0.6.1.tar.gz 12:54:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:54:44 INFO - Installing collected packages: blobuploader, requests, docopt 12:54:44 INFO - Running setup.py install for blobuploader 12:54:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:54:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:54:44 INFO - Running setup.py install for requests 12:54:44 INFO - Running setup.py install for docopt 12:54:45 INFO - Successfully installed blobuploader requests docopt 12:54:45 INFO - Cleaning up... 12:54:45 INFO - Return code: 0 12:54:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:45 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 0x7fc735993f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e23b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2374990>, '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 0x22e0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e0900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', '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 12:54:45 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 12:54:45 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 12:54:45 INFO - Using env: {'DISPLAY': ':0', 12:54:45 INFO - 'HOME': '/home/cltbld', 12:54:45 INFO - 'LANG': 'en_US.UTF-8', 12:54:45 INFO - 'LANGUAGE': 'en_US:en', 12:54:45 INFO - 'LOGNAME': 'cltbld', 12:54:45 INFO - 'MAIL': '/var/mail/cltbld', 12:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:45 INFO - 'MOZ_NO_REMOTE': '1', 12:54:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:45 INFO - 'NO_EM_RESTART': '1', 12:54:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:45 INFO - 'PWD': '/builds/slave/test', 12:54:45 INFO - 'SHELL': '/bin/bash', 12:54:45 INFO - 'SHLVL': '1', 12:54:45 INFO - 'TERM': 'linux', 12:54:45 INFO - 'TMOUT': '86400', 12:54:45 INFO - 'USER': 'cltbld', 12:54:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', 12:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:45 INFO - '_': '/tools/buildbot/bin/python'} 12:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:45 INFO - Running setup.py (path:/tmp/pip-y4JbNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:45 INFO - Running setup.py (path:/tmp/pip-RQA_6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:45 INFO - Running setup.py (path:/tmp/pip-sHTTP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:45 INFO - Running setup.py (path:/tmp/pip-ibccMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:45 INFO - Running setup.py (path:/tmp/pip-ZMaftA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:45 INFO - Running setup.py (path:/tmp/pip-fmHsUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:45 INFO - Running setup.py (path:/tmp/pip-jipimH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:45 INFO - Running setup.py (path:/tmp/pip-IeMIZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:45 INFO - Running setup.py (path:/tmp/pip-ZtehXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:45 INFO - Running setup.py (path:/tmp/pip-6LtTKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:46 INFO - Running setup.py (path:/tmp/pip-Kuio17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:46 INFO - Running setup.py (path:/tmp/pip-T65IpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:46 INFO - Running setup.py (path:/tmp/pip-G3qAoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:46 INFO - Running setup.py (path:/tmp/pip-841l5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:46 INFO - Running setup.py (path:/tmp/pip-dKfivc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:46 INFO - Running setup.py (path:/tmp/pip-Fr3xUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:46 INFO - Running setup.py (path:/tmp/pip-7SJRq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:54:46 INFO - Running setup.py install for manifestparser 12:54:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:54:46 INFO - Running setup.py install for mozcrash 12:54:46 INFO - Running setup.py install for mozdebug 12:54:46 INFO - Running setup.py install for mozdevice 12:54:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:54:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:54:46 INFO - Running setup.py install for mozfile 12:54:47 INFO - Running setup.py install for mozhttpd 12:54:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:54:47 INFO - Running setup.py install for mozinfo 12:54:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:54:47 INFO - Running setup.py install for mozInstall 12:54:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:54:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:54:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:54:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:54:47 INFO - Running setup.py install for mozleak 12:54:47 INFO - Running setup.py install for mozlog 12:54:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:54:47 INFO - Running setup.py install for moznetwork 12:54:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:54:47 INFO - Running setup.py install for mozprocess 12:54:47 INFO - Running setup.py install for mozprofile 12:54:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:54:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:54:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:54:47 INFO - Running setup.py install for mozrunner 12:54:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Running setup.py install for mozscreenshot 12:54:48 INFO - Running setup.py install for moztest 12:54:48 INFO - Running setup.py install for mozversion 12:54:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:54:48 INFO - Cleaning up... 12:54:48 INFO - Return code: 0 12:54:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:48 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 0x7fc735993f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e23b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2374990>, '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 0x22e0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e0900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', '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 12:54:48 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 12:54:48 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 12:54:48 INFO - Using env: {'DISPLAY': ':0', 12:54:48 INFO - 'HOME': '/home/cltbld', 12:54:48 INFO - 'LANG': 'en_US.UTF-8', 12:54:48 INFO - 'LANGUAGE': 'en_US:en', 12:54:48 INFO - 'LOGNAME': 'cltbld', 12:54:48 INFO - 'MAIL': '/var/mail/cltbld', 12:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:48 INFO - 'MOZ_NO_REMOTE': '1', 12:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:48 INFO - 'NO_EM_RESTART': '1', 12:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:48 INFO - 'PWD': '/builds/slave/test', 12:54:48 INFO - 'SHELL': '/bin/bash', 12:54:48 INFO - 'SHLVL': '1', 12:54:48 INFO - 'TERM': 'linux', 12:54:48 INFO - 'TMOUT': '86400', 12:54:48 INFO - 'USER': 'cltbld', 12:54:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', 12:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:48 INFO - '_': '/tools/buildbot/bin/python'} 12:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:48 INFO - Running setup.py (path:/tmp/pip-ezd7uU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:48 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)) 12:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:48 INFO - Running setup.py (path:/tmp/pip-XY4p1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:48 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)) 12:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:48 INFO - Running setup.py (path:/tmp/pip-qyD6jT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:48 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)) 12:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:48 INFO - Running setup.py (path:/tmp/pip-mv5eLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:48 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)) 12:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:48 INFO - Running setup.py (path:/tmp/pip-a18mLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:48 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)) 12:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:48 INFO - Running setup.py (path:/tmp/pip-lVANQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:48 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)) 12:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:48 INFO - Running setup.py (path:/tmp/pip-6nxxPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:49 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)) 12:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:49 INFO - Running setup.py (path:/tmp/pip-fLhT6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:49 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)) 12:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:49 INFO - Running setup.py (path:/tmp/pip-nNT5O9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:49 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)) 12:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:49 INFO - Running setup.py (path:/tmp/pip-I2ue8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:49 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)) 12:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:49 INFO - Running setup.py (path:/tmp/pip-yebKeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:49 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)) 12:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:49 INFO - Running setup.py (path:/tmp/pip-y21cQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 12:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:49 INFO - Running setup.py (path:/tmp/pip-Z2c4RS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:49 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)) 12:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:49 INFO - Running setup.py (path:/tmp/pip-1lWCd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 12:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:49 INFO - Running setup.py (path:/tmp/pip-FtOk3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:49 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)) 12:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:49 INFO - Running setup.py (path:/tmp/pip-xc9dTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:49 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)) 12:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:49 INFO - Running setup.py (path:/tmp/pip-4Aa7y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:49 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)) 12:54:49 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)) 12:54:49 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)) 12:54:49 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)) 12:54:49 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)) 12:54:49 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)) 12:54:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:51 INFO - Downloading blessings-1.6.tar.gz 12:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:54:51 INFO - Installing collected packages: blessings 12:54:51 INFO - Running setup.py install for blessings 12:54:51 INFO - Successfully installed blessings 12:54:51 INFO - Cleaning up... 12:54:51 INFO - Return code: 0 12:54:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:54:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:52 INFO - Reading from file tmpfile_stdout 12:54:52 INFO - Current package versions: 12:54:52 INFO - argparse == 1.2.1 12:54:52 INFO - blessings == 1.6 12:54:52 INFO - blobuploader == 1.2.4 12:54:52 INFO - docopt == 0.6.1 12:54:52 INFO - functools32 == 3.2.3-2 12:54:52 INFO - jsonschema == 2.5.1 12:54:52 INFO - manifestparser == 1.1 12:54:52 INFO - mozInstall == 1.12 12:54:52 INFO - mozcrash == 0.17 12:54:52 INFO - mozdebug == 0.1 12:54:52 INFO - mozdevice == 0.48 12:54:52 INFO - mozfile == 1.2 12:54:52 INFO - mozhttpd == 0.7 12:54:52 INFO - mozinfo == 0.9 12:54:52 INFO - mozleak == 0.1 12:54:52 INFO - mozlog == 3.2 12:54:52 INFO - moznetwork == 0.27 12:54:52 INFO - mozprocess == 0.23 12:54:52 INFO - mozprofile == 0.28 12:54:52 INFO - mozrunner == 6.12 12:54:52 INFO - mozscreenshot == 0.1 12:54:52 INFO - mozsystemmonitor == 0.3 12:54:52 INFO - moztest == 0.7 12:54:52 INFO - mozversion == 1.4 12:54:52 INFO - psutil == 3.1.1 12:54:52 INFO - requests == 1.2.3 12:54:52 INFO - wsgiref == 0.1.2 12:54:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:52 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')]} 12:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:52 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')]} 12:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:52 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 0x7fc735993f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e23b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2374990>, '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 0x22e0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e0900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', '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 12:54:52 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 12:54:52 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 12:54:52 INFO - Using env: {'DISPLAY': ':0', 12:54:52 INFO - 'HOME': '/home/cltbld', 12:54:52 INFO - 'LANG': 'en_US.UTF-8', 12:54:52 INFO - 'LANGUAGE': 'en_US:en', 12:54:52 INFO - 'LOGNAME': 'cltbld', 12:54:52 INFO - 'MAIL': '/var/mail/cltbld', 12:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:52 INFO - 'MOZ_NO_REMOTE': '1', 12:54:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:52 INFO - 'NO_EM_RESTART': '1', 12:54:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:52 INFO - 'PWD': '/builds/slave/test', 12:54:52 INFO - 'SHELL': '/bin/bash', 12:54:52 INFO - 'SHLVL': '1', 12:54:52 INFO - 'TERM': 'linux', 12:54:52 INFO - 'TMOUT': '86400', 12:54:52 INFO - 'USER': 'cltbld', 12:54:52 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', 12:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:52 INFO - '_': '/tools/buildbot/bin/python'} 12:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:52 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)) 12:54:52 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)) 12:54:52 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)) 12:54:52 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)) 12:54:52 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)) 12:54:52 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)) 12:54:52 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)) 12:54:52 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)) 12:54:52 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)) 12:54:52 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)) 12:54:52 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)) 12:54:52 INFO - Cleaning up... 12:54:52 INFO - Return code: 0 12:54:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:54:52 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')]} 12:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:52 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')]} 12:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:52 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 0x7fc735993f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e23b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2374990>, '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 0x22e0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e0900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', '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 12:54:52 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 12:54:52 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 12:54:52 INFO - Using env: {'DISPLAY': ':0', 12:54:52 INFO - 'HOME': '/home/cltbld', 12:54:52 INFO - 'LANG': 'en_US.UTF-8', 12:54:52 INFO - 'LANGUAGE': 'en_US:en', 12:54:52 INFO - 'LOGNAME': 'cltbld', 12:54:52 INFO - 'MAIL': '/var/mail/cltbld', 12:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:52 INFO - 'MOZ_NO_REMOTE': '1', 12:54:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:52 INFO - 'NO_EM_RESTART': '1', 12:54:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:52 INFO - 'PWD': '/builds/slave/test', 12:54:52 INFO - 'SHELL': '/bin/bash', 12:54:52 INFO - 'SHLVL': '1', 12:54:52 INFO - 'TERM': 'linux', 12:54:52 INFO - 'TMOUT': '86400', 12:54:52 INFO - 'USER': 'cltbld', 12:54:52 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', 12:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:52 INFO - '_': '/tools/buildbot/bin/python'} 12:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:54:52 INFO - Cleaning up... 12:54:52 INFO - Return code: 0 12:54:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:54:52 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')]} 12:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:52 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')]} 12:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:52 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 0x7fc735993f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e23b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2374990>, '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 0x22e0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e0900>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', '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 12:54:52 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 12:54:52 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 12:54:52 INFO - Using env: {'DISPLAY': ':0', 12:54:52 INFO - 'HOME': '/home/cltbld', 12:54:52 INFO - 'LANG': 'en_US.UTF-8', 12:54:52 INFO - 'LANGUAGE': 'en_US:en', 12:54:52 INFO - 'LOGNAME': 'cltbld', 12:54:52 INFO - 'MAIL': '/var/mail/cltbld', 12:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:52 INFO - 'MOZ_NO_REMOTE': '1', 12:54:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:52 INFO - 'NO_EM_RESTART': '1', 12:54:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:52 INFO - 'PWD': '/builds/slave/test', 12:54:52 INFO - 'SHELL': '/bin/bash', 12:54:52 INFO - 'SHLVL': '1', 12:54:52 INFO - 'TERM': 'linux', 12:54:52 INFO - 'TMOUT': '86400', 12:54:52 INFO - 'USER': 'cltbld', 12:54:52 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', 12:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:52 INFO - '_': '/tools/buildbot/bin/python'} 12:54:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:52 INFO - Downloading/unpacking flake8 12:54:52 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 12:54:52 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 12:54:52 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 12:54:52 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 12:54:52 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 12:54:52 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 12:54:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:54:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:54:54 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 12:54:54 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 12:54:54 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 12:54:54 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 12:54:54 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 12:54:54 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 12:54:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:54:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:54:54 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 12:54:54 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 12:54:54 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 12:54:54 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 12:54:54 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 12:54:54 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 12:54:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:54:55 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 12:54:55 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 12:54:55 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 12:54:55 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 12:54:55 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 12:54:55 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 12:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:54:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:54:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:54:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:54:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:54:55 INFO - no previously-included directories found matching 'docs/_build' 12:54:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:54:55 INFO - Running setup.py install for pep8 12:54:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:54:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:54:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:54:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:54:55 INFO - no previously-included directories found matching 'docs/_build' 12:54:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:54:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:54:55 INFO - Cleaning up... 12:54:55 INFO - Return code: 0 12:54:55 INFO - Running post-action listener: _resource_record_post_action 12:54:55 INFO - Running post-action listener: _start_resource_monitoring 12:54:55 INFO - Starting resource monitoring. 12:54:55 INFO - ##### 12:54:55 INFO - ##### Finished create-virtualenv step (success) 12:54:55 INFO - ##### 12:54:55 INFO - ##### 12:54:55 INFO - ##### Running install step. 12:54:55 INFO - ##### 12:54:55 INFO - Running pre-action listener: _resource_record_pre_action 12:54:55 INFO - Running main action method: install 12:54:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:55 INFO - Reading from file tmpfile_stdout 12:54:55 INFO - Detecting whether we're running mozinstall >=1.0... 12:54:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:54:55 INFO - Reading from file tmpfile_stdout 12:54:55 INFO - Output received: 12:54:55 INFO - Usage: mozinstall [options] installer 12:54:55 INFO - Options: 12:54:55 INFO - -h, --help show this help message and exit 12:54:55 INFO - -d DEST, --destination=DEST 12:54:55 INFO - Directory to install application into. [default: 12:54:55 INFO - "/builds/slave/test"] 12:54:55 INFO - --app=APP Application being installed. [default: firefox] 12:54:55 INFO - mkdir: /builds/slave/test/build/application 12:54:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:55:09 INFO - Reading from file tmpfile_stdout 12:55:09 INFO - Output received: 12:55:09 INFO - /builds/slave/test/build/application/firefox/firefox 12:55:09 INFO - Running post-action listener: _resource_record_post_action 12:55:09 INFO - ##### 12:55:09 INFO - ##### Finished install step (success) 12:55:09 INFO - ##### 12:55:09 INFO - ##### 12:55:09 INFO - ##### Running run-tests step. 12:55:09 INFO - ##### 12:55:09 INFO - Running pre-action listener: _resource_record_pre_action 12:55:09 INFO - Running main action method: run_tests 12:55:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:55:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:55:09 INFO - Python 2.7.3 12:55:09 INFO - Return code: 0 12:55:09 INFO - grabbing minidump binary from tooltool 12:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:55:09 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 0x2374990>, '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 0x22e0470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e0900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:55:09 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 12:55:09 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 12:55:09 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 12:55:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:55:09 INFO - Return code: 0 12:55:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:55:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:55:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:55:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:55:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:55:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:55:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:55:10 INFO - Return code: 0 12:55:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:55:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:55:10 INFO - Using env: {'DISPLAY': ':0', 12:55:10 INFO - 'HOME': '/home/cltbld', 12:55:10 INFO - 'LANG': 'en_US.UTF-8', 12:55:10 INFO - 'LANGUAGE': 'en_US:en', 12:55:10 INFO - 'LOGNAME': 'cltbld', 12:55:10 INFO - 'MAIL': '/var/mail/cltbld', 12:55:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:55:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:10 INFO - 'MOZ_NO_REMOTE': '1', 12:55:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:55:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:10 INFO - 'NO_EM_RESTART': '1', 12:55:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:10 INFO - 'PWD': '/builds/slave/test', 12:55:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:55:10 INFO - 'SHELL': '/bin/bash', 12:55:10 INFO - 'SHLVL': '1', 12:55:10 INFO - 'TERM': 'linux', 12:55:10 INFO - 'TMOUT': '86400', 12:55:10 INFO - 'USER': 'cltbld', 12:55:10 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766', 12:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:10 INFO - '_': '/tools/buildbot/bin/python'} 12:55:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:55:10 INFO - mozversion application_buildid: 20160802101548 12:55:10 INFO - mozversion application_changeset: 47b1f7ef94579405ba1f29c63c775250bc86289f 12:55:10 INFO - mozversion application_display_name: Firefox 12:55:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:55:10 INFO - mozversion application_name: Firefox 12:55:10 INFO - mozversion application_remotingname: firefox 12:55:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:55:10 INFO - mozversion application_vendor: Mozilla 12:55:10 INFO - mozversion application_version: 49.0 12:55:10 INFO - mozversion platform_buildid: 20160802101548 12:55:10 INFO - mozversion platform_changeset: 47b1f7ef94579405ba1f29c63c775250bc86289f 12:55:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:55:10 INFO - mozversion platform_version: 49.0 12:55:10 INFO - using testdate: 1470167710 12:55:10 INFO - actual date: 1470167710 12:55:10 INFO - starting webserver on 'localhost:38291' 12:55:10 INFO - SUITE-START | Running 2 tests 12:55:10 INFO - TEST-START | dromaeo_css 12:55:10 INFO - operating with platform_type : linux_ 12:55:10 INFO - Initialising browser for dromaeo_css test... 12:55:10 INFO - TEST-INFO | started process 7015 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzwaErp/profile http://localhost:38291/getInfo.html) 12:55:14 INFO - PROCESS | 7015 | __metrics Screen width/height:1600/1200 12:55:14 INFO - PROCESS | 7015 | colorDepth:24 12:55:14 INFO - PROCESS | 7015 | Browser inner width/height: 1024/697 12:55:14 INFO - PROCESS | 7015 | __metrics 12:55:15 ERROR - PROCESS | 7015 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 12:55:16 INFO - TEST-INFO | 7015: exit 0 12:55:16 INFO - Browser initialized. 12:55:16 INFO - Running cycle 1/1 for dromaeo_css test... 12:55:16 INFO - TEST-INFO | started process 7141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzwaErp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:55:27 INFO - PROCESS | 7141 | RSS: Main: 153366528 12:55:27 INFO - PROCESS | 7141 | 12:56:17 INFO - PROCESS | 7141 | 1470167777578 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] 12:58:25 INFO - PROCESS | 7141 | Cycle 1(1): loaded http://localhost:38291/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38291/tests/dromaeo/cssquery-ext.html) 12:58:26 INFO - PROCESS | 7141 | RSS: Main: 158064640 12:58:26 INFO - PROCESS | 7141 | 13:01:28 INFO - PROCESS | 7141 | Cycle 1(1): loaded http://localhost:38291/tests/dromaeo/cssquery-ext.html (next: http://localhost:38291/tests/dromaeo/cssquery-jquery.html) 13:01:29 INFO - PROCESS | 7141 | RSS: Main: 154906624 13:01:29 INFO - PROCESS | 7141 | 13:04:31 INFO - PROCESS | 7141 | Cycle 1(1): loaded http://localhost:38291/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38291/tests/dromaeo/cssquery-mootools.html) 13:04:31 INFO - PROCESS | 7141 | RSS: Main: 155082752 13:04:31 INFO - PROCESS | 7141 | 13:07:33 INFO - PROCESS | 7141 | Cycle 1(1): loaded http://localhost:38291/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38291/tests/dromaeo/cssquery-prototype.html) 13:07:34 INFO - PROCESS | 7141 | RSS: Main: 156172288 13:07:34 INFO - PROCESS | 7141 | 13:10:36 INFO - PROCESS | 7141 | Cycle 1(1): loaded http://localhost:38291/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38291/tests/dromaeo/cssquery-yui.html) 13:10:37 INFO - PROCESS | 7141 | RSS: Main: 154800128 13:10:37 INFO - PROCESS | 7141 | 13:13:39 INFO - PROCESS | 7141 | Cycle 1(1): loaded http://localhost:38291/tests/dromaeo/cssquery-yui.html (next: http://localhost:38291/tests/dromaeo/cssquery-dojo.html) 13:13:39 INFO - PROCESS | 7141 | RSS: Main: 158720000 13:13:39 INFO - PROCESS | 7141 | 13:13:39 INFO - PROCESS | 7141 | __start_tp_report 13:13:39 INFO - PROCESS | 7141 | _x_x_mozilla_page_load 13:13:39 INFO - PROCESS | 7141 | _x_x_mozilla_page_load_details 13:13:39 INFO - PROCESS | 7141 | |i|pagename|runs| 13:13:39 INFO - PROCESS | 7141 | |0;dojo.html;3397.0658069031015;3449.068751437112;3467.8439470223843;3472.288180922911;3482.1294676330917;5670.659760414378;5688.601797874146;5728.770849166039;5751.942480575193;5751.971240143794;5651.1523271509195;5670.574706896979;5684.772609095641;5687.80556083222;5737.024705800013;5123.282740416354;5131.409887862887;5179.585633149339;5217.582593392539;5235.450277720842;5193.844184674447;5195.480451954793;5210.713410762407;5215.58275337972;5232.764525596357;5191.922121168185;5241.266222728802;5243.501867322599;5252.212168174785;5273.024490469256;5014.373203349582;5035.54680078791;5183.770978479252;5184.066867963765;5262.763175657085;5019.247112933052;5072.365954255718;5096.05722941257;5119.078565858144;5131.281620573122;5572.7770889164385;5573.721313934328;5576.079946808772;5594.692291923942;5595.244641973322;6019.157317975487;6027;6089.725962331706;6123.142760013601;6135.478484328837;6225.657588832612;6246.562740608159;6248.218972628421;6254.155688981975;6257.937420625781;5808.041673123929;5819.359870414251;5833.0375488044;5833.854153646151;5854.121881717734;5985;6145.262568491809;6226.221722284715;6239.500839932794;6368.076628888785;6098.176746139303;6113.266408031065;6113.806573611043;6123.958926982424;6127.647695152957;6176.197094377702;6189.35011823761;6189.84525386869;6190.535709821781;6190.535709821781;5965.105234214902;6064.423879731418;6117;6117.736059405574;6210.441060304594;6185.505159587222;6210.9068363974575;6220.911340515392;6234.251889773165;6239.594426362272;4576.908461830745;4711.340412342275;4719.1033703596895;4723.362346083303;4723.905521889612;4062.045419326456;4117.053077792065;4117.855875044359;4120.505539335299;4192.958070419257;5896.056630939029;5908.704564771744;5916.704164791743;5935.554833387513;5983.61106528083;5936.643801371932;6173.41352571505;6204.844878877974;6245.531585131133;6302.369763023753;5895.086261629454;5927.585069045212;5968.612040217372;5993.910091348634;6006.099085137177;5411.431799661058;5412.5940554458575;5419.078756611386;5426.864328391743;5427.810026649048;6243.125962365272;6380.585261957958;6568.770093046721;6577.934220657828;6602.2737498875085;6187.659678717714;6236;6311.779087731908;6315.684215789284;6319.241690996926;6497.545171837926;6515.446187073962;6558.8360290993105;6578.375054369827;6593.769218077345;5905.881882362414;5942.673152976455;5959.7020148991505;6092.543059270483;6103.969480152571;6083.452489275809;6160.10678451631;6178.443940045418;6187.195664563578;6187.566870319214;5969.701514924323;6024.728887199999;6033.895269883757;6037.275526936795;6063.181470501426;5738.885222295614;6016.308124565556;6037.698115094316;6117.143599896107;6140.105498721277;5989.041753319448;5993.730282137227;5999.5800293979;6002.45977861977;6032.668203248863;6013.609115407485;6061.15143879866;6075.696215189135;6083.878322433615;6092.329843717276;5807.186993820784;5815.738291776965;5848.298204215522;5873.706314684334;5957.582969192288 13:13:39 INFO - PROCESS | 7141 | |1;ext.html;570.9200711900332;620.5718054542368;628.0829988217203;646.4860435953417;652.7486917536747;41030.58969410305;45327.32009019867;45382.86542836435;45395.99999999992;45399.546004540025;47177.76411117948;47406.762966185124;47766.522334776644;47856;47955.52044479554;8921.732348029553;9082.409643373192;9082.86375704365;9092.727218183432;9097.681581144661;8968.058353872848;9077.546122693871;9083.273338132933;9084.182423581877;9094.909050909473;9104.954475227647;9160.816783664322;9163.633454661805;9168.54157292136;9169.174774270314;8956.507392093432;8983.775405614912;8988.865167022499;9071.319651026166;9101.499417532033;8826.602802873886;8935.41919775219;8960.05919378469;8968.372213944962;8998.775030624221;43065;43379.56620433787;43547.78226108849;43807.78096109499;43920.78039609813;3486.9128271793406;3755.0800053986677;3806.2387522495333;3902.6487616114687;4301.784910754481;35339;35352.11619709502;35725.46411803825;35866.82066589651;36171;4748.406449193851;4752.5247475252545;4755.239161734106;4807.519248075199;4818.807247710088;371246;374708;375255;376380;376492;37862;68345.65827170931;68777.31222687809;68783.31216687869;68839.65580172067;37954.620453795105;39800.40299395511;40153.59846401557;40220.59779402227;40276.194476110315;16512.504624861274;16838.326466941184;16844.74732879008;16850.57873553171;16874.662506750043;13921.095128816594;13950.232737199349;13996.300184990914;14006.229657368738;14049.859501404855;8130.186981301823;8162.061362943337;8865.423747456394;9328.580213890391;9412.294077944181;3540.805255710909;3544.291141771656;3545.964540354615;3562.8218589070443;3574.6425357464045;1051.6381286234346;1094;1100.873399559061;1101.0695961912172;1130.3218069158604;31299;31401;31522.52716209259;31578.368432631218;32171.034868953502;1135.73310272086;1153.1121036801617;1194.062660811259;1199.5381778015353;1252.9037092544024;16949.830501695073;18128.9093554534;18340.54148646268;18978.90510547466;19342.903285483484;594826;596634;599408;641260;661447;59088.40911590829;65102;65747.67126164434;65865.67067164634;65930.34069659338;1413.4204975959808;1421.2538417330984;1442.077070674769;1454.941802327895;1460.518029050432;33389;33766.831165844014;34051.269753243585;34512.82743586366;34677.47983780195;53014.46985530095;53543;53706.73146634242;53740.73129634327;53800.46199537955;535140;537609;538281;540311;540710;31698.366032679678;31783;31955.840220798746;32084;32118.35763284768;52010.479895200566;52055.47944520506;52162.21756673729;52465;52780.47219527756;43320.350194746476;43860.342094869244;43877.78061109674;44585.77707111444;45090.0981980352;43396.56603434052;43587;43863.56136438595;44631;45268.32097518474;44507.33239001353;44576.10847783091;44935;47000.7649961748;47970;39129.2174156521;39140.60157889432;39372;39823;40133.1973360537;29911.401771964873;30168.49157542158;30755;30974.53538196884;31087 13:13:39 INFO - PROCESS | 7141 | |2;jquery.html;429.22310617781807;430.43397931719807;436.212636191674;436.6769279188017;447.858924438802;19075.904620476897;20460.89769551152;21084;21698.566028679415;21699.3490195294;19756.604867902668;20142.69785953212;20871.79128208721;20887.060082296295;20898.477538061557;5778.884422311551;5967.224260846084;5981.192539007222;6003.6697981611;6038.849028774272;5613.971930140344;5852.619579727304;5951.494122999528;5954.285485741717;6025.9096113558335;5834.883302333951;5985.311689155737;5999.310079340867;6140.171076904606;6161.045038019091;6114.785982490614;6122.051082082285;6168.568200225986;6178.907316390258;6192.907106393408;5743.10981797822;5940.108983652487;5958.702064896738;5964.7315870785915;5980.700964951735;14622.707545849024;14910.62723431912;18593.7210941836;24089.51820963571;24385.512289754104;2286.16554957441;2347.0778880293974;2422.8139995905326;2469.32093674241;2606.7653911148086;9922.3054386193;10254;10654.946725266323;10913.618023369223;10915.563377464892;1918.414883460544;1996.2613832881927;2002.7997200280001;2020.3938818354582;2061.175529788082;68839.65580172067;79685;80566.5971670138;85964.14035859687;92994;11506.19456638044;11918.940405297919;11920.344381058952;11935.701607459883;11982.400879955967;17033.233504492327;17111.57221069483;17123.91438042827;17135.143242837807;17197.31210751581;8936.821263574691;9092.909070909338;9149.268058555299;9213.585388657526;9309.394889332307;8827.867581986275;8839.646414143363;8882.289416846637;8906.73279801607;9026.909730902738;5206.062908676475;5213.2701421800975;5237.266782650432;5265.52610265078;5307.071262529042;2001.5396458814555;2114.2177394364185;2138.946526336854;2186.584548935697;2186.5954798362354;963.3786207895868;992.6873034993954;1015.2284263959438;1022.5194158745378;1099.263493459384;17811.73282400765;19503.512412189808;20120.39638810838;20224.595508089755;20309.59380812405;1034.8602938603342;1037.4294138223947;1068.3750006246278;1068.5725709716176;1098.8846171152074;10788.730281742863;11385.601503947322;11515.25150865191;11520.94239528797;11577.421128943519;483953;488392;492286;499066;501858;84010.57994709988;88336.55831720801;96769.51615241879;98356.50821745845;99651.43955464032;1055.672741450153;1098.0995583621354;1107.7009207513927;1112.6105862947904;1125.1842414249768;18165.636687266444;18401.263949441873;18574.907125464288;18622.348217812312;18751.90624046871;42176.15647686968;43059.138817222854;43115;43121;43942.34086488641;60110;61847.690761545906;62081.379186209364;62105.37894620996;63112.15995280132;8503.787405314917;8811.206991370807;8961.50711710836;8987.236084932854;9166.037566055735;12776.425060872098;13472.124311919693;13665.385057672229;14174.14955102697;14194.574162775134;11989.40052997364;12046.277223366626;12268;12306;12492.56276030371;12000.699982500159;12131.332776697014;12434.37828108609;12489.93755031219;12554.623361299176;11463.484143213742;11773.941130294636;12028.338441385808;12202.08484363694;12270.018398528275;9070.682526111554;9152.95423522878;9214.308926830648;9216.07839216073;9234.95382523083;10835.783284334428;11534.94232528832;11788.646340609796;11993.040556755264;12013.519459221534 13:13:39 INFO - PROCESS | 7141 | |3;mootools.html;1539.7459419195834;1565.1157096240622;1752.93947161967;1865;1889.159324100774;8627.87058194126;9276.118768716979;9354.766130846723;10045.547950342234;10050.849237261447;9374.43753374798;9621.567029483673;9706.951465242682;9762.17021553167;9838.508074596277;2464.1375518568448;2498.850068995857;2517.1315896015844;2517.3203235126507;2522.7351128131468;2443.645671377658;2468.6420469031978;2474.5793215153376;2479.9008039678392;2485.5774518331837;2369;2377.346229786805;2381.84518006329;2383.642453631952;2391.3662879336903;2356.69362982812;2359.5752764502467;2365.4559451326204;2408.8193385495983;2435.1598698449006;2339.415146213447;2352.5530149271754;2367.4673198530363;2367.7513861044513;2372.715274167094;9785.119339259501;9816.361936474177;9822.410655360702;9828.950855245677;9879.456629885353;5786.971065144648;5946.464818166342;5947.732352044169;5954.642721436728;5963.850903727398;3545.308664810363;3548.1129717570607;3575.5173051637958;3709.5919448860604;3712.1647629283466;1212.381685340474;1230.2556953043459;1241.6026871401154;1245.3150767078162;1247.7130260040242;14122.576322710438;14128.364223609859;14163.433462661482;14177.078489898227;14180;5041.168207245837;5121.61587880903;5137.152369859006;5164.070467315919;5246.3704355477585;11634.76730465386;11671.416429178507;11691.356975366267;11705.297682139098;11730.296182229093;5838.795642152504;5843.123531470228;5843.678597677169;5844.064949608042;5864.912026319608;5246.554042906396;5359.08895487768;5413.539849112791;5420.810271640474;5518.172274158908;4152.937705934413;4173.833046678099;4212.410262563244;4220.113776107052;4221.704480686322;1207.1549915059493;1209.8366720492797;1219.737756382382;1226.3868065967017;1228.81567764836;931.9347645664874;1035.4201647077662;1036.461040259061;1058.4284486377423;1060.1095080132725;6291.937080629226;6350.4284614384005;6391.712372943136;6430.485561155097;6556.213254409406;470.96938698984457;479.47976445556264;483.15689122481496;489.66213312814045;490.23523303646425;4092.447519584818;4181.707280490397;4184.121334519724;4187.895302617398;4228.5982831630945;11818.822717659243;12212.389380531116;12317.507299707911;12348.938255308665;12422.875771242172;11989.460474278678;12037.699057523632;12071.456784444545;12086.15396922207;12187.634370968884;9066.09339066075;9073.682421115229;9074.546272686339;9137.314701397288;9214.861777073349;5959.523238141025;6040.124181993674;6066.1204125402455;6074.817755467343;6094.695265236632;11206.159538034517;11256.887431125584;11289.04043156341;11385.146114041645;11417.942910285396;11253.943730281297;11450.599229026944;11456.713582160513;11601.071914246671;11637.650870473899;7251.673674684757;7796.9220307796195;8034.397420193626;8215.301699355621;8299.95850020746;9320.906790932004;9415.340926135104;9447.24422046221;9525.809483810424;9535.570899309687;8384.53885036329;8512.574371281287;8529.95735021321;8605.311575073854;8647.654093836427;8401.117882622237;8442.15578442151;8480.279176270085;8517.276031537389;8524.232819046316;7320.194778574246;7335.596542190231;7369.115706115301;7392.852142957003;7410.6665200065045;5645.209670646195;5783.652980821164;5863.912041319469;5901.911471327848;5922.082077278029;5667.801626943202;5721.284839395075;5760.107183386582;5849.970750146222;5892.499137573354 13:13:39 INFO - PROCESS | 7141 | |4;prototype.html;353.2229095988825;354.28788135846946;359.17031656872626;365.7439792145499;366.60040555794177;5685.914711279334;5816.633091223564;5829.533637309016;5909.911351329728;5930.644161350317;5680.977424063667;5686.289213848269;5729.971350143243;5748.2527271454655;5748.252727145476;4443.622292105175;4454.53227411122;4456.309272062819;4499.595036446719;4501.279795232764;4274.850380236692;4471.607689885912;4483.30508771141;4509.323601459774;4534.478534968488;4405.801738921757;4413.426254586915;4425.114977004596;4436.755978421185;4441.422615060038;4469.82120715171;4491.9775401123115;4492.618127459154;4502.347159661864;4508.932366014513;3708.962910370889;3903.4144878268203;3958;3971.086650070471;3987.3620220764537;5568.554515638739;5571.303587051619;5589.524890384322;5598.720063996784;5600.4959553639965;5075.644704870623;5132.280685970204;5142.228665700138;5146.974265128688;5162.793488260465;5762.394948530427;6029.849253768647;6031.819045428644;6031.8793624127275;6094.360092190301;4254.7021708480415;4267.359896015591;4286.892827679302;4293.957060429387;4307.418498502693;6251.093591429263;6294.559380843343;6313.842153946142;6336.651484168369;6363.5863668861375;4239.7492739641875;4384.693071484965;4387.846425375096;4412.69111162222;4436.534163912743;4470.262406702923;4486.955130448719;4496.820127194941;4499.842505512292;4501.819927202875;5135.948640513622;5137.460566640449;5170.250313704491;5173.198154286091;5175.223716442489;5809.6223745457255;5925.822225333247;5984.3417224105315;6012.939870601238;6017.915552329906;1516.3631274864583;1538.4077130304913;1542.1595230599125;1544.4285614322773;1554.9144797036272;930.6091441594547;967.849983252597;973.8198433289864;976.1946394224793;977.1449981266392;5177;5250.868728281824;5271.4464981176425;5302.314891150613;5315;5476.945230547643;5489.039418101816;5538.667679939216;5558.471945165203;5568.9443105569235;4993.076280888047;5223.3209682741;5269.814291784318;5298.682079075268;5332.893342133136;2934.5451455024504;2957.349383135707;2963.6147300850753;2968.2282606522026;2977.970220297813;5730.828075157752;5773.507028247934;5780.786034932627;5821.243238379068;5826.388229235954;5220.712860792617;5506.972465137729;5530.972345138329;5559.916601250984;5567.582431317667;5579.46995035471;5672.8865422691315;5709.858028394337;5740.770369185269;5742.799002034909;5124.74376281177;5507.889842203213;5515.503604675599;5554.250176226158;5584;5441.347038355264;5452.945470545403;5460.307304735545;5500.58745594074;5509.724513774376;5651.802186923438;5660.46225608583;5682.982541197815;5729.541636668973;5751.7411716472025;3984.462097616901;4019.256437559061;4111.362738775495;4442.400275962833;4457.108578284421;6042.788502402394;6170.53720970938;6210.813675589739;6228.252609686867;6271.843203919939;6032.6983650818165;6049.455549000611;6059.606125601822;6088.4215999479975;6089.421504957199;6081.391860813883;6107.9389206109145;6112.358202388685;6143.416375444325;6177.84555386119;5756.366799652119;6018.759249630141;6077.969610151921;6092.421219984094;6092.75628974836;6119.571629985859;6128.356522565245;6133.815985520441;6136.723847426787;6140.4473597376455;5949.72764979251;5998.9100163496705;6005.147554911382;6027.728752206073;6046.12331211963 13:13:39 INFO - PROCESS | 7141 | |5;yui.html;804.1676864445296;808.2483290539795;851.7572491839825;890.7995700967283;924.1497822003756;15280.770788438169;16588.91705541472;16619.83380166198;16646.417375391862;16657.167141642916;14857.182854942974;15042.247887605603;15144.318505667245;15177.620559486018;15209;889.4174315823146;909.1363204955286;911.4485736129645;912.2473958983832;917.5412293853074;902.7246689759621;907.686848037426;908.8636704494346;909.522500687138;910.1671970147307;940.7601061729249;948.1419315519466;952.790386115057;954.0936110694832;959.1990687775716;941.7410212191668;942.0344147249056;944.9102335278137;947.0907928388755;952.204908901065;691.930806919309;694.6943344928216;694.9826254343632;695.0304325465997;697.2260790522516;14507;14688.632784180374;14784.704305913929;14786.704265914728;14798.334074966653;13415.262160581164;13577.932110339483;13672.111312764639;13714.725705485935;13919.860801391958;12167.452464639113;12173.878261217451;12324.630261092181;12832;13209.207447553177;4142.399352093929;4249.490061192646;4788.545088216614;4795.232762757942;4849.878753031167;53488.73255633697;67784.32215677829;70012.64993675;72376.63811680961;80142;12561.56034538805;12601.18092323996;12625.179363341353;12628;12818.487260509663;23124.88437557835;23279;23294;23401.41496462568;23698.289051328487;9411.247100231965;9422.481763503074;9543.188828949616;9615.56729947154;9798.51007449639;5206.219067139959;5212.8175513857595;5220.373555173328;5228.738563071831;5277.788888444419;3666.6699996999864;3776.6412190841825;3791.33651610967;3798.6771124454176;3804.0489877530617;652.6704014472756;659.6635715784985;663.4659099424913;675.787127054976;688.1054628982303;663.290279401046;706.1631966120163;725.2384995754437;757.772668199549;779.773865578987;10331.94834025825;10352.327098738559;10356.378617282988;10382.688519344432;10610.522526486327;671.2817285504561;746.6901235987114;746.943979201562;752.9397648188132;805.5931754463958;5129.5101517397015;5423.918641220384;5467.808626698046;5510.6969116698165;5580.107182850806;73502;74100;115567.42216288864;118958;122965.38517307356;63634.68182659057;74795.25204747992;89665.55167224252;103874.48062759789;104605.47697261465;76590.61704691552;92550.53724731333;93605.5319723397;95277;97947.51026244965;10712.303700259457;10766.204720635833;10787.244892857425;11117.83323250168;11512.827307590225;49196;51539;53270.20094698505;53548;53905.191422127915;49231;76688.23311767034;77315;77498.22501774911;77960.61019694865;13194.208347499181;13371.799423008468;13407.664808379479;14211.360488777824;14522.273886305431;15166.241687915339;15832.28754706018;15994.600134996717;16345.264463099427;16440.67118657596;15272.541823745305;15286.541403757905;15289.923550382176;15502.612434689223;15788.76316855271;14688.632784180481;14749.631259218606;15196.620084497976;15205.77191342153;15268.923655381652;13121;13209.075364724376;13249.072564920363;13416.865831341562;13546.390412431267;12060.216085954386;12069.758604827679;12636.30500322491;12654.367281636065;12669.493220271086;12765.8085128725;12797.936010320262;12991;13061.869381306065;13154.73690526165 13:13:39 INFO - PROCESS | 7141 | __end_tp_report 13:13:39 INFO - PROCESS | 7141 | __start_cc_report 13:13:39 INFO - PROCESS | 7141 | _x_x_mozilla_cycle_collect,319 13:13:39 INFO - PROCESS | 7141 | __end_cc_report 13:13:39 INFO - PROCESS | 7141 | __startTimestamp1470168819626__endTimestamp 13:13:39 INFO - PROCESS | 7141 | 13:13:39 INFO - PROCESS | 7141 | ------- Summary: start ------- 13:13:39 INFO - PROCESS | 7141 | Number of tests: 6 13:13:39 INFO - PROCESS | 7141 | 13:13:39 INFO - PROCESS | 7141 | [#0] dojo.html Cycles:165 Average:5726.37 Median:5968.61 stddev:663.70 (11.1%) stddev-sans-first:640.09 13:13:39 INFO - PROCESS | 7141 | Values: 3397.1 3449.1 3467.8 3472.3 3482.1 5670.7 5688.6 5728.8 5751.9 5752.0 5651.2 5670.6 5684.8 5687.8 5737.0 5123.3 5131.4 5179.6 5217.6 5235.5 5193.8 5195.5 5210.7 5215.6 5232.8 5191.9 5241.3 5243.5 5252.2 5273.0 5014.4 5035.5 5183.8 5184.1 5262.8 5019.2 5072.4 5096.1 5119.1 5131.3 5572.8 5573.7 5576.1 5594.7 5595.2 6019.2 6027.0 6089.7 6123.1 6135.5 6225.7 6246.6 6248.2 6254.2 6257.9 5808.0 5819.4 5833.0 5833.9 5854.1 5985.0 6145.3 6226.2 6239.5 6368.1 6098.2 6113.3 6113.8 6124.0 6127.6 6176.2 6189.4 6189.8 6190.5 6190.5 5965.1 6064.4 6117.0 6117.7 6210.4 6185.5 6210.9 6220.9 6234.3 6239.6 4576.9 4711.3 4719.1 4723.4 4723.9 4062.0 4117.1 4117.9 4120.5 4193.0 5896.1 5908.7 5916.7 5935.6 5983.6 5936.6 6173.4 6204.8 6245.5 6302.4 5895.1 5927.6 5968.6 5993.9 6006.1 5411.4 5412.6 5419.1 5426.9 5427.8 6243.1 6380.6 6568.8 6577.9 6602.3 6187.7 6236.0 6311.8 6315.7 6319.2 6497.5 6515.4 6558.8 6578.4 6593.8 5905.9 5942.7 5959.7 6092.5 6104.0 6083.5 6160.1 6178.4 6187.2 6187.6 5969.7 6024.7 6033.9 6037.3 6063.2 5738.9 6016.3 6037.7 6117.1 6140.1 5989.0 5993.7 5999.6 6002.5 6032.7 6013.6 6061.2 6075.7 6083.9 6092.3 5807.2 5815.7 5848.3 5873.7 5957.6 13:13:39 INFO - PROCESS | 7141 | 13:13:39 INFO - PROCESS | 7141 | [#1] ext.html Cycles:180 Average:66587.98 Median:43870.67 stddev:138846.14 (316.5%) stddev-sans-first:139147.17 13:13:39 INFO - PROCESS | 7141 | Values: 570.9 620.6 628.1 646.5 652.7 41030.6 45327.3 45382.9 45396.0 45399.5 47177.8 47406.8 47766.5 47856.0 47955.5 8921.7 9082.4 9082.9 9092.7 9097.7 8968.1 9077.5 9083.3 9084.2 9094.9 9105.0 9160.8 9163.6 9168.5 9169.2 8956.5 8983.8 8988.9 9071.3 9101.5 8826.6 8935.4 8960.1 8968.4 8998.8 43065.0 43379.6 43547.8 43807.8 43920.8 3486.9 3755.1 3806.2 3902.6 4301.8 35339.0 35352.1 35725.5 35866.8 36171.0 4748.4 4752.5 4755.2 4807.5 4818.8 371246.0 374708.0 375255.0 376380.0 376492.0 37862.0 68345.7 68777.3 68783.3 68839.7 37954.6 39800.4 40153.6 40220.6 40276.2 16512.5 16838.3 16844.7 16850.6 16874.7 13921.1 13950.2 13996.3 14006.2 14049.9 8130.2 8162.1 8865.4 9328.6 9412.3 3540.8 3544.3 3546.0 3562.8 3574.6 1051.6 1094.0 1100.9 1101.1 1130.3 31299.0 31401.0 31522.5 31578.4 32171.0 1135.7 1153.1 1194.1 1199.5 1252.9 16949.8 18128.9 18340.5 18978.9 19342.9 594826.0 596634.0 599408.0 641260.0 661447.0 59088.4 65102.0 65747.7 65865.7 65930.3 1413.4 1421.3 1442.1 1454.9 1460.5 33389.0 33766.8 34051.3 34512.8 34677.5 53014.5 53543.0 53706.7 53740.7 53800.5 535140.0 537609.0 538281.0 540311.0 540710.0 31698.4 31783.0 31955.8 32084.0 32118.4 52010.5 52055.5 52162.2 52465.0 52780.5 43320.4 43860.3 43877.8 44585.8 45090.1 43396.6 43587.0 43863.6 44631.0 45268.3 44507.3 44576.1 44935.0 47000.8 47970.0 39129.2 39140.6 39372.0 39823.0 40133.2 29911.4 30168.5 30755.0 30974.5 31087.0 13:13:39 INFO - PROCESS | 7141 | 13:13:39 INFO - PROCESS | 7141 | [#2] jquery.html Cycles:180 Average:29608.34 Median:2316.62 stddev:81326.17 (3510.6%) stddev-sans-first:81524.80 13:13:39 INFO - PROCESS | 7141 | Values: 429.2 430.4 436.2 436.7 447.9 19075.9 20460.9 21084.0 21698.6 21699.3 19756.6 20142.7 20871.8 20887.1 20898.5 5778.9 5967.2 5981.2 6003.7 6038.8 5614.0 5852.6 5951.5 5954.3 6025.9 5834.9 5985.3 5999.3 6140.2 6161.0 6114.8 6122.1 6168.6 6178.9 6192.9 5743.1 5940.1 5958.7 5964.7 5980.7 14622.7 14910.6 18593.7 24089.5 24385.5 2286.2 2347.1 2422.8 2469.3 2606.8 9922.3 10254.0 10654.9 10913.6 10915.6 1918.4 1996.3 2002.8 2020.4 2061.2 68839.7 79685.0 80566.6 85964.1 92994.0 11506.2 11918.9 11920.3 11935.7 11982.4 17033.2 17111.6 17123.9 17135.1 17197.3 8936.8 9092.9 9149.3 9213.6 9309.4 8827.9 8839.6 8882.3 8906.7 9026.9 5206.1 5213.3 5237.3 5265.5 5307.1 2001.5 2114.2 2138.9 2186.6 2186.6 963.4 992.7 1015.2 1022.5 1099.3 17811.7 19503.5 20120.4 20224.6 20309.6 1034.9 1037.4 1068.4 1068.6 1098.9 10788.7 11385.6 11515.3 11520.9 11577.4 483953.0 488392.0 492286.0 499066.0 501858.0 84010.6 88336.6 96769.5 98356.5 99651.4 1055.7 1098.1 1107.7 1112.6 1125.2 18165.6 18401.3 18574.9 18622.3 18751.9 42176.2 43059.1 43115.0 43121.0 43942.3 60110.0 61847.7 62081.4 62105.4 63112.2 8503.8 8811.2 8961.5 8987.2 9166.0 12776.4 13472.1 13665.4 14174.1 14194.6 11989.4 12046.3 12268.0 12306.0 12492.6 12000.7 12131.3 12434.4 12489.9 12554.6 11463.5 11773.9 12028.3 12202.1 12270.0 9070.7 9153.0 9214.3 9216.1 9235.0 10835.8 11534.9 11788.6 11993.0 12013.5 13:13:39 INFO - PROCESS | 7141 | 13:13:39 INFO - PROCESS | 7141 | [#3] mootools.html Cycles:180 Average:6357.55 Median:2349.78 stddev:3756.95 (159.9%) stddev-sans-first:3750.04 13:13:39 INFO - PROCESS | 7141 | Values: 1539.7 1565.1 1752.9 1865.0 1889.2 8627.9 9276.1 9354.8 10045.5 10050.8 9374.4 9621.6 9707.0 9762.2 9838.5 2464.1 2498.9 2517.1 2517.3 2522.7 2443.6 2468.6 2474.6 2479.9 2485.6 2369.0 2377.3 2381.8 2383.6 2391.4 2356.7 2359.6 2365.5 2408.8 2435.2 2339.4 2352.6 2367.5 2367.8 2372.7 9785.1 9816.4 9822.4 9829.0 9879.5 5787.0 5946.5 5947.7 5954.6 5963.9 3545.3 3548.1 3575.5 3709.6 3712.2 1212.4 1230.3 1241.6 1245.3 1247.7 14122.6 14128.4 14163.4 14177.1 14180.0 5041.2 5121.6 5137.2 5164.1 5246.4 11634.8 11671.4 11691.4 11705.3 11730.3 5838.8 5843.1 5843.7 5844.1 5864.9 5246.6 5359.1 5413.5 5420.8 5518.2 4152.9 4173.8 4212.4 4220.1 4221.7 1207.2 1209.8 1219.7 1226.4 1228.8 931.9 1035.4 1036.5 1058.4 1060.1 6291.9 6350.4 6391.7 6430.5 6556.2 471.0 479.5 483.2 489.7 490.2 4092.4 4181.7 4184.1 4187.9 4228.6 11818.8 12212.4 12317.5 12348.9 12422.9 11989.5 12037.7 12071.5 12086.2 12187.6 9066.1 9073.7 9074.5 9137.3 9214.9 5959.5 6040.1 6066.1 6074.8 6094.7 11206.2 11256.9 11289.0 11385.1 11417.9 11253.9 11450.6 11456.7 11601.1 11637.7 7251.7 7796.9 8034.4 8215.3 8300.0 9320.9 9415.3 9447.2 9525.8 9535.6 8384.5 8512.6 8530.0 8605.3 8647.7 8401.1 8442.2 8480.3 8517.3 8524.2 7320.2 7335.6 7369.1 7392.9 7410.7 5645.2 5783.7 5863.9 5901.9 5922.1 5667.8 5721.3 5760.1 5850.0 5892.5 13:13:39 INFO - PROCESS | 7141 | 13:13:39 INFO - PROCESS | 7141 | [#4] prototype.html Cycles:180 Average:4908.72 Median:5512.61 stddev:1427.53 (25.9%) stddev-sans-first:1389.98 13:13:39 INFO - PROCESS | 7141 | Values: 353.2 354.3 359.2 365.7 366.6 5685.9 5816.6 5829.5 5909.9 5930.6 5681.0 5686.3 5730.0 5748.3 5748.3 4443.6 4454.5 4456.3 4499.6 4501.3 4274.9 4471.6 4483.3 4509.3 4534.5 4405.8 4413.4 4425.1 4436.8 4441.4 4469.8 4492.0 4492.6 4502.3 4508.9 3709.0 3903.4 3958.0 3971.1 3987.4 5568.6 5571.3 5589.5 5598.7 5600.5 5075.6 5132.3 5142.2 5147.0 5162.8 5762.4 6029.8 6031.8 6031.9 6094.4 4254.7 4267.4 4286.9 4294.0 4307.4 6251.1 6294.6 6313.8 6336.7 6363.6 4239.7 4384.7 4387.8 4412.7 4436.5 4470.3 4487.0 4496.8 4499.8 4501.8 5135.9 5137.5 5170.3 5173.2 5175.2 5809.6 5925.8 5984.3 6012.9 6017.9 1516.4 1538.4 1542.2 1544.4 1554.9 930.6 967.8 973.8 976.2 977.1 5177.0 5250.9 5271.4 5302.3 5315.0 5476.9 5489.0 5538.7 5558.5 5568.9 4993.1 5223.3 5269.8 5298.7 5332.9 2934.5 2957.3 2963.6 2968.2 2978.0 5730.8 5773.5 5780.8 5821.2 5826.4 5220.7 5507.0 5531.0 5559.9 5567.6 5579.5 5672.9 5709.9 5740.8 5742.8 5124.7 5507.9 5515.5 5554.3 5584.0 5441.3 5452.9 5460.3 5500.6 5509.7 5651.8 5660.5 5683.0 5729.5 5751.7 3984.5 4019.3 4111.4 4442.4 4457.1 6042.8 6170.5 6210.8 6228.3 6271.8 6032.7 6049.5 6059.6 6088.4 6089.4 6081.4 6107.9 6112.4 6143.4 6177.8 5756.4 6018.8 6078.0 6092.4 6092.8 6119.6 6128.4 6133.8 6136.7 6140.4 5949.7 5998.9 6005.1 6027.7 6046.1 13:13:39 INFO - PROCESS | 7141 | 13:13:39 INFO - PROCESS | 7141 | [#5] yui.html Cycles:180 Average:20467.86 Median:4195.94 stddev:28106.08 (669.8%) stddev-sans-first:28146.14 13:13:39 INFO - PROCESS | 7141 | Values: 804.2 808.2 851.8 890.8 924.1 15280.8 16588.9 16619.8 16646.4 16657.2 14857.2 15042.2 15144.3 15177.6 15209.0 889.4 909.1 911.4 912.2 917.5 902.7 907.7 908.9 909.5 910.2 940.8 948.1 952.8 954.1 959.2 941.7 942.0 944.9 947.1 952.2 691.9 694.7 695.0 695.0 697.2 14507.0 14688.6 14784.7 14786.7 14798.3 13415.3 13577.9 13672.1 13714.7 13919.9 12167.5 12173.9 12324.6 12832.0 13209.2 4142.4 4249.5 4788.5 4795.2 4849.9 53488.7 67784.3 70012.6 72376.6 80142.0 12561.6 12601.2 12625.2 12628.0 12818.5 23124.9 23279.0 23294.0 23401.4 23698.3 9411.2 9422.5 9543.2 9615.6 9798.5 5206.2 5212.8 5220.4 5228.7 5277.8 3666.7 3776.6 3791.3 3798.7 3804.0 652.7 659.7 663.5 675.8 688.1 663.3 706.2 725.2 757.8 779.8 10331.9 10352.3 10356.4 10382.7 10610.5 671.3 746.7 746.9 752.9 805.6 5129.5 5423.9 5467.8 5510.7 5580.1 73502.0 74100.0 115567.4 118958.0 122965.4 63634.7 74795.3 89665.6 103874.5 104605.5 76590.6 92550.5 93605.5 95277.0 97947.5 10712.3 10766.2 10787.2 11117.8 11512.8 49196.0 51539.0 53270.2 53548.0 53905.2 49231.0 76688.2 77315.0 77498.2 77960.6 13194.2 13371.8 13407.7 14211.4 14522.3 15166.2 15832.3 15994.6 16345.3 16440.7 15272.5 15286.5 15289.9 15502.6 15788.8 14688.6 14749.6 15196.6 15205.8 15268.9 13121.0 13209.1 13249.1 13416.9 13546.4 12060.2 12069.8 12636.3 12654.4 12669.5 12765.8 12797.9 12991.0 13061.9 13154.7 13:13:39 INFO - PROCESS | 7141 | -------- Summary: end -------- 13:13:39 INFO - PROCESS | 7141 | 13:13:40 INFO - TEST-INFO | 7141: exit 0 13:13:40 INFO - TEST-OK | dromaeo_css | took 1110054ms 13:13:40 INFO - TEST-START | kraken 13:13:40 INFO - operating with platform_type : linux_ 13:13:40 INFO - Initialising browser for kraken test... 13:13:40 INFO - TEST-INFO | started process 7385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppy0ayk/profile http://localhost:38291/getInfo.html) 13:13:44 INFO - PROCESS | 7385 | __metrics Screen width/height:1600/1200 13:13:44 INFO - PROCESS | 7385 | colorDepth:24 13:13:44 INFO - PROCESS | 7385 | Browser inner width/height: 1024/697 13:13:44 INFO - PROCESS | 7385 | __metrics 13:13:45 ERROR - PROCESS | 7385 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 13:13:46 INFO - TEST-INFO | 7385: exit 0 13:13:46 INFO - Browser initialized. 13:13:46 INFO - Running cycle 1/1 for kraken test... 13:13:46 INFO - TEST-INFO | started process 7511 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppy0ayk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:13:58 INFO - PROCESS | 7511 | RSS: Main: 153063424 13:13:58 INFO - PROCESS | 7511 | 13:14:00 INFO - PROCESS | 7511 | Cycle 1(1): loaded http://localhost:38291/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38291/tests/kraken/driver.html?testName=audio-beat-detection) 13:14:01 INFO - PROCESS | 7511 | RSS: Main: 159125504 13:14:01 INFO - PROCESS | 7511 | 13:14:04 INFO - PROCESS | 7511 | Cycle 1(1): loaded http://localhost:38291/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38291/tests/kraken/driver.html?testName=audio-dft) 13:14:04 INFO - PROCESS | 7511 | RSS: Main: 157536256 13:14:04 INFO - PROCESS | 7511 | 13:14:07 INFO - PROCESS | 7511 | Cycle 1(1): loaded http://localhost:38291/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38291/tests/kraken/driver.html?testName=audio-fft) 13:14:08 INFO - PROCESS | 7511 | RSS: Main: 158310400 13:14:08 INFO - PROCESS | 7511 | 13:14:10 INFO - PROCESS | 7511 | Cycle 1(1): loaded http://localhost:38291/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38291/tests/kraken/driver.html?testName=audio-oscillator) 13:14:10 INFO - PROCESS | 7511 | RSS: Main: 158179328 13:14:10 INFO - PROCESS | 7511 | 13:14:13 INFO - PROCESS | 7511 | Cycle 1(1): loaded http://localhost:38291/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38291/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:14:13 INFO - PROCESS | 7511 | RSS: Main: 157831168 13:14:13 INFO - PROCESS | 7511 | 13:14:16 INFO - PROCESS | 7511 | Cycle 1(1): loaded http://localhost:38291/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38291/tests/kraken/driver.html?testName=imaging-darkroom) 13:14:17 INFO - PROCESS | 7511 | RSS: Main: 157442048 13:14:17 INFO - PROCESS | 7511 | 13:14:20 INFO - PROCESS | 7511 | Cycle 1(1): loaded http://localhost:38291/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38291/tests/kraken/driver.html?testName=imaging-desaturate) 13:14:21 INFO - PROCESS | 7511 | RSS: Main: 157872128 13:14:21 INFO - PROCESS | 7511 | 13:14:24 INFO - PROCESS | 7511 | Cycle 1(1): loaded http://localhost:38291/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38291/tests/kraken/driver.html?testName=json-parse-financial) 13:14:24 INFO - PROCESS | 7511 | RSS: Main: 157511680 13:14:24 INFO - PROCESS | 7511 | 13:14:26 INFO - PROCESS | 7511 | Cycle 1(1): loaded http://localhost:38291/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38291/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:14:26 INFO - PROCESS | 7511 | RSS: Main: 158007296 13:14:26 INFO - PROCESS | 7511 | 13:14:28 INFO - PROCESS | 7511 | Cycle 1(1): loaded http://localhost:38291/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38291/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:14:29 INFO - PROCESS | 7511 | RSS: Main: 158060544 13:14:29 INFO - PROCESS | 7511 | 13:14:31 INFO - PROCESS | 7511 | Cycle 1(1): loaded http://localhost:38291/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38291/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:14:31 INFO - PROCESS | 7511 | RSS: Main: 158371840 13:14:32 INFO - PROCESS | 7511 | 13:14:34 INFO - PROCESS | 7511 | Cycle 1(1): loaded http://localhost:38291/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:14:35 INFO - PROCESS | 7511 | RSS: Main: 158228480 13:14:35 INFO - PROCESS | 7511 | 13:14:37 INFO - PROCESS | 7511 | Cycle 1(1): loaded http://localhost:38291/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:14:38 INFO - PROCESS | 7511 | RSS: Main: 158146560 13:14:38 INFO - PROCESS | 7511 | 13:14:40 INFO - PROCESS | 7511 | Cycle 1(1): loaded http://localhost:38291/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38291/tests/kraken/driver.html?testName=ai-astar) 13:14:40 INFO - PROCESS | 7511 | RSS: Main: 158576640 13:14:40 INFO - PROCESS | 7511 | 13:14:40 INFO - PROCESS | 7511 | __start_tp_report 13:14:40 INFO - PROCESS | 7511 | _x_x_mozilla_page_load 13:14:40 INFO - PROCESS | 7511 | _x_x_mozilla_page_load_details 13:14:40 INFO - PROCESS | 7511 | |i|pagename|runs| 13:14:40 INFO - PROCESS | 7511 | |0;ai-astar;110;102;110;109;110;110;109;110;110;111 13:14:40 INFO - PROCESS | 7511 | |1;audio-beat-detection;153;127;167;173;129;153;151;125;187;126 13:14:40 INFO - PROCESS | 7511 | |2;audio-dft;162;162;161;163;161;163;162;162;161;160 13:14:40 INFO - PROCESS | 7511 | |3;audio-fft;74;75;77;176;77;74;75;86;161;77 13:14:40 INFO - PROCESS | 7511 | |4;audio-oscillator;85;85;147;86;85;85;135;85;85;159 13:14:40 INFO - PROCESS | 7511 | |5;imaging-gaussian-blur;118;118;117;117;118;118;118;117;117;117 13:14:40 INFO - PROCESS | 7511 | |6;imaging-darkroom;146;147;147;148;147;146;147;148;146;149 13:14:40 INFO - PROCESS | 7511 | |7;imaging-desaturate;96;95;96;98;96;95;96;100;101;95 13:14:40 INFO - PROCESS | 7511 | |8;json-parse-financial;55;52;54;55;54;57;54;55;57;56 13:14:40 INFO - PROCESS | 7511 | |9;json-stringify-tinderbox;61;60;60;59;61;59;60;60;59;59 13:14:40 INFO - PROCESS | 7511 | |10;stanford-crypto-aes;76;76;75;77;75;79;81;78;100;75 13:14:40 INFO - PROCESS | 7511 | |11;stanford-crypto-ccm;128;125;127;121;117;131;117;120;136;127 13:14:40 INFO - PROCESS | 7511 | |12;stanford-crypto-pbkdf2;159;158;159;153;158;155;155;152;149;152 13:14:40 INFO - PROCESS | 7511 | |13;stanford-crypto-sha256-iterative;64;63;65;62;61;61;61;62;62;60 13:14:40 INFO - PROCESS | 7511 | __end_tp_report 13:14:40 INFO - PROCESS | 7511 | __start_cc_report 13:14:40 INFO - PROCESS | 7511 | _x_x_mozilla_cycle_collect,867 13:14:40 INFO - PROCESS | 7511 | __end_cc_report 13:14:40 INFO - PROCESS | 7511 | __startTimestamp1470168880295__endTimestamp 13:14:40 INFO - PROCESS | 7511 | 13:14:40 INFO - PROCESS | 7511 | ------- Summary: start ------- 13:14:40 INFO - PROCESS | 7511 | Number of tests: 14 13:14:40 INFO - PROCESS | 7511 | 13:14:40 INFO - PROCESS | 7511 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:2.56 (2.3%) stddev-sans-first:2.69 13:14:40 INFO - PROCESS | 7511 | Values: 110.0 102.0 110.0 109.0 110.0 110.0 109.0 110.0 110.0 111.0 13:14:40 INFO - PROCESS | 7511 | 13:14:40 INFO - PROCESS | 7511 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:153.00 stddev:22.03 (14.4%) stddev-sans-first:23.32 13:14:40 INFO - PROCESS | 7511 | Values: 153.0 127.0 167.0 173.0 129.0 153.0 151.0 125.0 187.0 126.0 13:14:40 INFO - PROCESS | 7511 | 13:14:40 INFO - PROCESS | 7511 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 13:14:40 INFO - PROCESS | 7511 | Values: 162.0 162.0 161.0 163.0 161.0 163.0 162.0 162.0 161.0 160.0 13:14:40 INFO - PROCESS | 7511 | 13:14:40 INFO - PROCESS | 7511 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.00 stddev:38.95 (51.2%) stddev-sans-first:40.55 13:14:40 INFO - PROCESS | 7511 | Values: 74.0 75.0 77.0 176.0 77.0 74.0 75.0 86.0 161.0 77.0 13:14:40 INFO - PROCESS | 7511 | 13:14:40 INFO - PROCESS | 7511 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:85.00 stddev:30.41 (35.8%) stddev-sans-first:31.50 13:14:40 INFO - PROCESS | 7511 | Values: 85.0 85.0 147.0 86.0 85.0 85.0 135.0 85.0 85.0 159.0 13:14:40 INFO - PROCESS | 7511 | 13:14:40 INFO - PROCESS | 7511 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 13:14:40 INFO - PROCESS | 7511 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 118.0 117.0 117.0 117.0 13:14:40 INFO - PROCESS | 7511 | 13:14:40 INFO - PROCESS | 7511 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:0.97 13:14:40 INFO - PROCESS | 7511 | Values: 146.0 147.0 147.0 148.0 147.0 146.0 147.0 148.0 146.0 149.0 13:14:40 INFO - PROCESS | 7511 | 13:14:40 INFO - PROCESS | 7511 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:2.15 (2.2%) stddev-sans-first:2.26 13:14:40 INFO - PROCESS | 7511 | Values: 96.0 95.0 96.0 98.0 96.0 95.0 96.0 100.0 101.0 95.0 13:14:40 INFO - PROCESS | 7511 | 13:14:40 INFO - PROCESS | 7511 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.52 (2.8%) stddev-sans-first:1.62 13:14:40 INFO - PROCESS | 7511 | Values: 55.0 52.0 54.0 55.0 54.0 57.0 54.0 55.0 57.0 56.0 13:14:40 INFO - PROCESS | 7511 | 13:14:40 INFO - PROCESS | 7511 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.79 (1.3%) stddev-sans-first:0.71 13:14:40 INFO - PROCESS | 7511 | Values: 61.0 60.0 60.0 59.0 61.0 59.0 60.0 60.0 59.0 59.0 13:14:40 INFO - PROCESS | 7511 | 13:14:40 INFO - PROCESS | 7511 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:76.50 stddev:7.57 (9.9%) stddev-sans-first:7.94 13:14:40 INFO - PROCESS | 7511 | Values: 76.0 76.0 75.0 77.0 75.0 79.0 81.0 78.0 100.0 75.0 13:14:40 INFO - PROCESS | 7511 | 13:14:40 INFO - PROCESS | 7511 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:127.00 stddev:6.17 (4.9%) stddev-sans-first:6.44 13:14:40 INFO - PROCESS | 7511 | Values: 128.0 125.0 127.0 121.0 117.0 131.0 117.0 120.0 136.0 127.0 13:14:40 INFO - PROCESS | 7511 | 13:14:40 INFO - PROCESS | 7511 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.00 Median:156.50 stddev:3.46 (2.2%) stddev-sans-first:3.36 13:14:40 INFO - PROCESS | 7511 | Values: 159.0 158.0 159.0 153.0 158.0 155.0 155.0 152.0 149.0 152.0 13:14:40 INFO - PROCESS | 7511 | 13:14:40 INFO - PROCESS | 7511 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.52 (2.5%) stddev-sans-first:1.45 13:14:40 INFO - PROCESS | 7511 | Values: 64.0 63.0 65.0 62.0 61.0 61.0 61.0 62.0 62.0 60.0 13:14:40 INFO - PROCESS | 7511 | -------- Summary: end -------- 13:14:40 INFO - PROCESS | 7511 | 13:14:41 INFO - TEST-INFO | 7511: exit 0 13:14:41 INFO - TEST-OK | kraken | took 60859ms 13:14:41 INFO - SUITE-END | took 1170s 13:14:41 INFO - Completed test suite (00:19:31) 13:14:41 INFO - javascript benchmark 13:14:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7625.179230842069, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3397.0658069031015, 3449.068751437112, 3467.8439470223843, 3472.288180922911, 3482.1294676330917, 5670.659760414378, 5688.601797874146, 5728.770849166039, 5751.942480575193, 5751.971240143794, 5651.1523271509195, 5670.574706896979, 5684.772609095641, 5687.80556083222, 5737.024705800013, 5123.282740416354, 5131.409887862887, 5179.585633149339, 5217.582593392539, 5235.450277720842, 5193.844184674447, 5195.480451954793, 5210.713410762407, 5215.58275337972, 5232.764525596357, 5191.922121168185, 5241.266222728802, 5243.501867322599, 5252.212168174785, 5273.024490469256, 5014.373203349582, 5035.54680078791, 5183.770978479252, 5184.066867963765, 5262.763175657085, 5019.247112933052, 5072.365954255718, 5096.05722941257, 5119.078565858144, 5131.281620573122, 5572.7770889164385, 5573.721313934328, 5576.079946808772, 5594.692291923942, 5595.244641973322, 6019.157317975487, 6027.0, 6089.725962331706, 6123.142760013601, 6135.478484328837, 6225.657588832612, 6246.562740608159, 6248.218972628421, 6254.155688981975, 6257.937420625781, 5808.041673123929, 5819.359870414251, 5833.0375488044, 5833.854153646151, 5854.121881717734, 5985.0, 6145.262568491809, 6226.221722284715, 6239.500839932794, 6368.076628888785, 6098.176746139303, 6113.266408031065, 6113.806573611043, 6123.958926982424, 6127.647695152957, 6176.197094377702, 6189.35011823761, 6189.84525386869, 6190.535709821781, 6190.535709821781, 5965.105234214902, 6064.423879731418, 6117.0, 6117.736059405574, 6210.441060304594, 6185.505159587222, 6210.9068363974575, 6220.911340515392, 6234.251889773165, 6239.594426362272, 4576.908461830745, 4711.340412342275, 4719.1033703596895, 4723.362346083303, 4723.905521889612, 4062.045419326456, 4117.053077792065, 4117.855875044359, 4120.505539335299, 4192.958070419257, 5896.056630939029, 5908.704564771744, 5916.704164791743, 5935.554833387513, 5983.61106528083, 5936.643801371932, 6173.41352571505, 6204.844878877974, 6245.531585131133, 6302.369763023753, 5895.086261629454, 5927.585069045212, 5968.612040217372, 5993.910091348634, 6006.099085137177, 5411.431799661058, 5412.5940554458575, 5419.078756611386, 5426.864328391743, 5427.810026649048, 6243.125962365272, 6380.585261957958, 6568.770093046721, 6577.934220657828, 6602.2737498875085, 6187.659678717714, 6236.0, 6311.779087731908, 6315.684215789284, 6319.241690996926, 6497.545171837926, 6515.446187073962, 6558.8360290993105, 6578.375054369827, 6593.769218077345, 5905.881882362414, 5942.673152976455, 5959.7020148991505, 6092.543059270483, 6103.969480152571, 6083.452489275809, 6160.10678451631, 6178.443940045418, 6187.195664563578, 6187.566870319214, 5969.701514924323, 6024.728887199999, 6033.895269883757, 6037.275526936795, 6063.181470501426, 5738.885222295614, 6016.308124565556, 6037.698115094316, 6117.143599896107, 6140.105498721277, 5989.041753319448, 5993.730282137227, 5999.5800293979, 6002.45977861977, 6032.668203248863, 6013.609115407485, 6061.15143879866, 6075.696215189135, 6083.878322433615, 6092.329843717276, 5807.186993820784, 5815.738291776965, 5848.298204215522, 5873.706314684334, 5957.582969192288], "value": 5681.717142192399, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.9200711900332, 620.5718054542368, 628.0829988217203, 646.4860435953417, 652.7486917536747, 41030.58969410305, 45327.32009019867, 45382.86542836435, 45395.99999999992, 45399.546004540025, 47177.76411117948, 47406.762966185124, 47766.522334776644, 47856.0, 47955.52044479554, 8921.732348029553, 9082.409643373192, 9082.86375704365, 9092.727218183432, 9097.681581144661, 8968.058353872848, 9077.546122693871, 9083.273338132933, 9084.182423581877, 9094.909050909473, 9104.954475227647, 9160.816783664322, 9163.633454661805, 9168.54157292136, 9169.174774270314, 8956.507392093432, 8983.775405614912, 8988.865167022499, 9071.319651026166, 9101.499417532033, 8826.602802873886, 8935.41919775219, 8960.05919378469, 8968.372213944962, 8998.775030624221, 43065.0, 43379.56620433787, 43547.78226108849, 43807.78096109499, 43920.78039609813, 3486.9128271793406, 3755.0800053986677, 3806.2387522495333, 3902.6487616114687, 4301.784910754481, 35339.0, 35352.11619709502, 35725.46411803825, 35866.82066589651, 36171.0, 4748.406449193851, 4752.5247475252545, 4755.239161734106, 4807.519248075199, 4818.807247710088, 371246.0, 374708.0, 375255.0, 376380.0, 376492.0, 37862.0, 68345.65827170931, 68777.31222687809, 68783.31216687869, 68839.65580172067, 37954.620453795105, 39800.40299395511, 40153.59846401557, 40220.59779402227, 40276.194476110315, 16512.504624861274, 16838.326466941184, 16844.74732879008, 16850.57873553171, 16874.662506750043, 13921.095128816594, 13950.232737199349, 13996.300184990914, 14006.229657368738, 14049.859501404855, 8130.186981301823, 8162.061362943337, 8865.423747456394, 9328.580213890391, 9412.294077944181, 3540.805255710909, 3544.291141771656, 3545.964540354615, 3562.8218589070443, 3574.6425357464045, 1051.6381286234346, 1094.0, 1100.873399559061, 1101.0695961912172, 1130.3218069158604, 31299.0, 31401.0, 31522.52716209259, 31578.368432631218, 32171.034868953502, 1135.73310272086, 1153.1121036801617, 1194.062660811259, 1199.5381778015353, 1252.9037092544024, 16949.830501695073, 18128.9093554534, 18340.54148646268, 18978.90510547466, 19342.903285483484, 594826.0, 596634.0, 599408.0, 641260.0, 661447.0, 59088.40911590829, 65102.0, 65747.67126164434, 65865.67067164634, 65930.34069659338, 1413.4204975959808, 1421.2538417330984, 1442.077070674769, 1454.941802327895, 1460.518029050432, 33389.0, 33766.831165844014, 34051.269753243585, 34512.82743586366, 34677.47983780195, 53014.46985530095, 53543.0, 53706.73146634242, 53740.73129634327, 53800.46199537955, 535140.0, 537609.0, 538281.0, 540311.0, 540710.0, 31698.366032679678, 31783.0, 31955.840220798746, 32084.0, 32118.35763284768, 52010.479895200566, 52055.47944520506, 52162.21756673729, 52465.0, 52780.47219527756, 43320.350194746476, 43860.342094869244, 43877.78061109674, 44585.77707111444, 45090.0981980352, 43396.56603434052, 43587.0, 43863.56136438595, 44631.0, 45268.32097518474, 44507.33239001353, 44576.10847783091, 44935.0, 47000.7649961748, 47970.0, 39129.2174156521, 39140.60157889432, 39372.0, 39823.0, 40133.1973360537, 29911.401771964873, 30168.49157542158, 30755.0, 30974.53538196884, 31087.0], "value": 20310.404981214968, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.22310617781807, 430.43397931719807, 436.212636191674, 436.6769279188017, 447.858924438802, 19075.904620476897, 20460.89769551152, 21084.0, 21698.566028679415, 21699.3490195294, 19756.604867902668, 20142.69785953212, 20871.79128208721, 20887.060082296295, 20898.477538061557, 5778.884422311551, 5967.224260846084, 5981.192539007222, 6003.6697981611, 6038.849028774272, 5613.971930140344, 5852.619579727304, 5951.494122999528, 5954.285485741717, 6025.9096113558335, 5834.883302333951, 5985.311689155737, 5999.310079340867, 6140.171076904606, 6161.045038019091, 6114.785982490614, 6122.051082082285, 6168.568200225986, 6178.907316390258, 6192.907106393408, 5743.10981797822, 5940.108983652487, 5958.702064896738, 5964.7315870785915, 5980.700964951735, 14622.707545849024, 14910.62723431912, 18593.7210941836, 24089.51820963571, 24385.512289754104, 2286.16554957441, 2347.0778880293974, 2422.8139995905326, 2469.32093674241, 2606.7653911148086, 9922.3054386193, 10254.0, 10654.946725266323, 10913.618023369223, 10915.563377464892, 1918.414883460544, 1996.2613832881927, 2002.7997200280001, 2020.3938818354582, 2061.175529788082, 68839.65580172067, 79685.0, 80566.5971670138, 85964.14035859687, 92994.0, 11506.19456638044, 11918.940405297919, 11920.344381058952, 11935.701607459883, 11982.400879955967, 17033.233504492327, 17111.57221069483, 17123.91438042827, 17135.143242837807, 17197.31210751581, 8936.821263574691, 9092.909070909338, 9149.268058555299, 9213.585388657526, 9309.394889332307, 8827.867581986275, 8839.646414143363, 8882.289416846637, 8906.73279801607, 9026.909730902738, 5206.062908676475, 5213.2701421800975, 5237.266782650432, 5265.52610265078, 5307.071262529042, 2001.5396458814555, 2114.2177394364185, 2138.946526336854, 2186.584548935697, 2186.5954798362354, 963.3786207895868, 992.6873034993954, 1015.2284263959438, 1022.5194158745378, 1099.263493459384, 17811.73282400765, 19503.512412189808, 20120.39638810838, 20224.595508089755, 20309.59380812405, 1034.8602938603342, 1037.4294138223947, 1068.3750006246278, 1068.5725709716176, 1098.8846171152074, 10788.730281742863, 11385.601503947322, 11515.25150865191, 11520.94239528797, 11577.421128943519, 483953.0, 488392.0, 492286.0, 499066.0, 501858.0, 84010.57994709988, 88336.55831720801, 96769.51615241879, 98356.50821745845, 99651.43955464032, 1055.672741450153, 1098.0995583621354, 1107.7009207513927, 1112.6105862947904, 1125.1842414249768, 18165.636687266444, 18401.263949441873, 18574.907125464288, 18622.348217812312, 18751.90624046871, 42176.15647686968, 43059.138817222854, 43115.0, 43121.0, 43942.34086488641, 60110.0, 61847.690761545906, 62081.379186209364, 62105.37894620996, 63112.15995280132, 8503.787405314917, 8811.206991370807, 8961.50711710836, 8987.236084932854, 9166.037566055735, 12776.425060872098, 13472.124311919693, 13665.385057672229, 14174.14955102697, 14194.574162775134, 11989.40052997364, 12046.277223366626, 12268.0, 12306.0, 12492.56276030371, 12000.699982500159, 12131.332776697014, 12434.37828108609, 12489.93755031219, 12554.623361299176, 11463.484143213742, 11773.941130294636, 12028.338441385808, 12202.08484363694, 12270.018398528275, 9070.682526111554, 9152.95423522878, 9214.308926830648, 9216.07839216073, 9234.95382523083, 10835.783284334428, 11534.94232528832, 11788.646340609796, 11993.040556755264, 12013.519459221534], "value": 9669.821123163316, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1539.7459419195834, 1565.1157096240622, 1752.93947161967, 1865.0, 1889.159324100774, 8627.87058194126, 9276.118768716979, 9354.766130846723, 10045.547950342234, 10050.849237261447, 9374.43753374798, 9621.567029483673, 9706.951465242682, 9762.17021553167, 9838.508074596277, 2464.1375518568448, 2498.850068995857, 2517.1315896015844, 2517.3203235126507, 2522.7351128131468, 2443.645671377658, 2468.6420469031978, 2474.5793215153376, 2479.9008039678392, 2485.5774518331837, 2369.0, 2377.346229786805, 2381.84518006329, 2383.642453631952, 2391.3662879336903, 2356.69362982812, 2359.5752764502467, 2365.4559451326204, 2408.8193385495983, 2435.1598698449006, 2339.415146213447, 2352.5530149271754, 2367.4673198530363, 2367.7513861044513, 2372.715274167094, 9785.119339259501, 9816.361936474177, 9822.410655360702, 9828.950855245677, 9879.456629885353, 5786.971065144648, 5946.464818166342, 5947.732352044169, 5954.642721436728, 5963.850903727398, 3545.308664810363, 3548.1129717570607, 3575.5173051637958, 3709.5919448860604, 3712.1647629283466, 1212.381685340474, 1230.2556953043459, 1241.6026871401154, 1245.3150767078162, 1247.7130260040242, 14122.576322710438, 14128.364223609859, 14163.433462661482, 14177.078489898227, 14180.0, 5041.168207245837, 5121.61587880903, 5137.152369859006, 5164.070467315919, 5246.3704355477585, 11634.76730465386, 11671.416429178507, 11691.356975366267, 11705.297682139098, 11730.296182229093, 5838.795642152504, 5843.123531470228, 5843.678597677169, 5844.064949608042, 5864.912026319608, 5246.554042906396, 5359.08895487768, 5413.539849112791, 5420.810271640474, 5518.172274158908, 4152.937705934413, 4173.833046678099, 4212.410262563244, 4220.113776107052, 4221.704480686322, 1207.1549915059493, 1209.8366720492797, 1219.737756382382, 1226.3868065967017, 1228.81567764836, 931.9347645664874, 1035.4201647077662, 1036.461040259061, 1058.4284486377423, 1060.1095080132725, 6291.937080629226, 6350.4284614384005, 6391.712372943136, 6430.485561155097, 6556.213254409406, 470.96938698984457, 479.47976445556264, 483.15689122481496, 489.66213312814045, 490.23523303646425, 4092.447519584818, 4181.707280490397, 4184.121334519724, 4187.895302617398, 4228.5982831630945, 11818.822717659243, 12212.389380531116, 12317.507299707911, 12348.938255308665, 12422.875771242172, 11989.460474278678, 12037.699057523632, 12071.456784444545, 12086.15396922207, 12187.634370968884, 9066.09339066075, 9073.682421115229, 9074.546272686339, 9137.314701397288, 9214.861777073349, 5959.523238141025, 6040.124181993674, 6066.1204125402455, 6074.817755467343, 6094.695265236632, 11206.159538034517, 11256.887431125584, 11289.04043156341, 11385.146114041645, 11417.942910285396, 11253.943730281297, 11450.599229026944, 11456.713582160513, 11601.071914246671, 11637.650870473899, 7251.673674684757, 7796.9220307796195, 8034.397420193626, 8215.301699355621, 8299.95850020746, 9320.906790932004, 9415.340926135104, 9447.24422046221, 9525.809483810424, 9535.570899309687, 8384.53885036329, 8512.574371281287, 8529.95735021321, 8605.311575073854, 8647.654093836427, 8401.117882622237, 8442.15578442151, 8480.279176270085, 8517.276031537389, 8524.232819046316, 7320.194778574246, 7335.596542190231, 7369.115706115301, 7392.852142957003, 7410.6665200065045, 5645.209670646195, 5783.652980821164, 5863.912041319469, 5901.911471327848, 5922.082077278029, 5667.801626943202, 5721.284839395075, 5760.107183386582, 5849.970750146222, 5892.499137573354], "value": 4929.9452744194505, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.2229095988825, 354.28788135846946, 359.17031656872626, 365.7439792145499, 366.60040555794177, 5685.914711279334, 5816.633091223564, 5829.533637309016, 5909.911351329728, 5930.644161350317, 5680.977424063667, 5686.289213848269, 5729.971350143243, 5748.2527271454655, 5748.252727145476, 4443.622292105175, 4454.53227411122, 4456.309272062819, 4499.595036446719, 4501.279795232764, 4274.850380236692, 4471.607689885912, 4483.30508771141, 4509.323601459774, 4534.478534968488, 4405.801738921757, 4413.426254586915, 4425.114977004596, 4436.755978421185, 4441.422615060038, 4469.82120715171, 4491.9775401123115, 4492.618127459154, 4502.347159661864, 4508.932366014513, 3708.962910370889, 3903.4144878268203, 3958.0, 3971.086650070471, 3987.3620220764537, 5568.554515638739, 5571.303587051619, 5589.524890384322, 5598.720063996784, 5600.4959553639965, 5075.644704870623, 5132.280685970204, 5142.228665700138, 5146.974265128688, 5162.793488260465, 5762.394948530427, 6029.849253768647, 6031.819045428644, 6031.8793624127275, 6094.360092190301, 4254.7021708480415, 4267.359896015591, 4286.892827679302, 4293.957060429387, 4307.418498502693, 6251.093591429263, 6294.559380843343, 6313.842153946142, 6336.651484168369, 6363.5863668861375, 4239.7492739641875, 4384.693071484965, 4387.846425375096, 4412.69111162222, 4436.534163912743, 4470.262406702923, 4486.955130448719, 4496.820127194941, 4499.842505512292, 4501.819927202875, 5135.948640513622, 5137.460566640449, 5170.250313704491, 5173.198154286091, 5175.223716442489, 5809.6223745457255, 5925.822225333247, 5984.3417224105315, 6012.939870601238, 6017.915552329906, 1516.3631274864583, 1538.4077130304913, 1542.1595230599125, 1544.4285614322773, 1554.9144797036272, 930.6091441594547, 967.849983252597, 973.8198433289864, 976.1946394224793, 977.1449981266392, 5177.0, 5250.868728281824, 5271.4464981176425, 5302.314891150613, 5315.0, 5476.945230547643, 5489.039418101816, 5538.667679939216, 5558.471945165203, 5568.9443105569235, 4993.076280888047, 5223.3209682741, 5269.814291784318, 5298.682079075268, 5332.893342133136, 2934.5451455024504, 2957.349383135707, 2963.6147300850753, 2968.2282606522026, 2977.970220297813, 5730.828075157752, 5773.507028247934, 5780.786034932627, 5821.243238379068, 5826.388229235954, 5220.712860792617, 5506.972465137729, 5530.972345138329, 5559.916601250984, 5567.582431317667, 5579.46995035471, 5672.8865422691315, 5709.858028394337, 5740.770369185269, 5742.799002034909, 5124.74376281177, 5507.889842203213, 5515.503604675599, 5554.250176226158, 5584.0, 5441.347038355264, 5452.945470545403, 5460.307304735545, 5500.58745594074, 5509.724513774376, 5651.802186923438, 5660.46225608583, 5682.982541197815, 5729.541636668973, 5751.7411716472025, 3984.462097616901, 4019.256437559061, 4111.362738775495, 4442.400275962833, 4457.108578284421, 6042.788502402394, 6170.53720970938, 6210.813675589739, 6228.252609686867, 6271.843203919939, 6032.6983650818165, 6049.455549000611, 6059.606125601822, 6088.4215999479975, 6089.421504957199, 6081.391860813883, 6107.9389206109145, 6112.358202388685, 6143.416375444325, 6177.84555386119, 5756.366799652119, 6018.759249630141, 6077.969610151921, 6092.421219984094, 6092.75628974836, 6119.571629985859, 6128.356522565245, 6133.815985520441, 6136.723847426787, 6140.4473597376455, 5949.72764979251, 5998.9100163496705, 6005.147554911382, 6027.728752206073, 6046.12331211963], "value": 4454.8176109402475, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.1676864445296, 808.2483290539795, 851.7572491839825, 890.7995700967283, 924.1497822003756, 15280.770788438169, 16588.91705541472, 16619.83380166198, 16646.417375391862, 16657.167141642916, 14857.182854942974, 15042.247887605603, 15144.318505667245, 15177.620559486018, 15209.0, 889.4174315823146, 909.1363204955286, 911.4485736129645, 912.2473958983832, 917.5412293853074, 902.7246689759621, 907.686848037426, 908.8636704494346, 909.522500687138, 910.1671970147307, 940.7601061729249, 948.1419315519466, 952.790386115057, 954.0936110694832, 959.1990687775716, 941.7410212191668, 942.0344147249056, 944.9102335278137, 947.0907928388755, 952.204908901065, 691.930806919309, 694.6943344928216, 694.9826254343632, 695.0304325465997, 697.2260790522516, 14507.0, 14688.632784180374, 14784.704305913929, 14786.704265914728, 14798.334074966653, 13415.262160581164, 13577.932110339483, 13672.111312764639, 13714.725705485935, 13919.860801391958, 12167.452464639113, 12173.878261217451, 12324.630261092181, 12832.0, 13209.207447553177, 4142.399352093929, 4249.490061192646, 4788.545088216614, 4795.232762757942, 4849.878753031167, 53488.73255633697, 67784.32215677829, 70012.64993675, 72376.63811680961, 80142.0, 12561.56034538805, 12601.18092323996, 12625.179363341353, 12628.0, 12818.487260509663, 23124.88437557835, 23279.0, 23294.0, 23401.41496462568, 23698.289051328487, 9411.247100231965, 9422.481763503074, 9543.188828949616, 9615.56729947154, 9798.51007449639, 5206.219067139959, 5212.8175513857595, 5220.373555173328, 5228.738563071831, 5277.788888444419, 3666.6699996999864, 3776.6412190841825, 3791.33651610967, 3798.6771124454176, 3804.0489877530617, 652.6704014472756, 659.6635715784985, 663.4659099424913, 675.787127054976, 688.1054628982303, 663.290279401046, 706.1631966120163, 725.2384995754437, 757.772668199549, 779.773865578987, 10331.94834025825, 10352.327098738559, 10356.378617282988, 10382.688519344432, 10610.522526486327, 671.2817285504561, 746.6901235987114, 746.943979201562, 752.9397648188132, 805.5931754463958, 5129.5101517397015, 5423.918641220384, 5467.808626698046, 5510.6969116698165, 5580.107182850806, 73502.0, 74100.0, 115567.42216288864, 118958.0, 122965.38517307356, 63634.68182659057, 74795.25204747992, 89665.55167224252, 103874.48062759789, 104605.47697261465, 76590.61704691552, 92550.53724731333, 93605.5319723397, 95277.0, 97947.51026244965, 10712.303700259457, 10766.204720635833, 10787.244892857425, 11117.83323250168, 11512.827307590225, 49196.0, 51539.0, 53270.20094698505, 53548.0, 53905.191422127915, 49231.0, 76688.23311767034, 77315.0, 77498.22501774911, 77960.61019694865, 13194.208347499181, 13371.799423008468, 13407.664808379479, 14211.360488777824, 14522.273886305431, 15166.241687915339, 15832.28754706018, 15994.600134996717, 16345.264463099427, 16440.67118657596, 15272.541823745305, 15286.541403757905, 15289.923550382176, 15502.612434689223, 15788.76316855271, 14688.632784180481, 14749.631259218606, 15196.620084497976, 15205.77191342153, 15268.923655381652, 13121.0, 13209.075364724376, 13249.072564920363, 13416.865831341562, 13546.390412431267, 12060.216085954386, 12069.758604827679, 12636.30500322491, 12654.367281636065, 12669.493220271086, 12765.8085128725, 12797.936010320262, 12991.0, 13061.869381306065, 13154.73690526165], "value": 8019.936969420557, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1516.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 102.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 111.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 127.0, 167.0, 173.0, 129.0, 153.0, 151.0, 125.0, 187.0, 126.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 161.0, 163.0, 162.0, 162.0, 161.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 176.0, 77.0, 74.0, 75.0, 86.0, 161.0, 77.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 147.0, 86.0, 85.0, 85.0, 135.0, 85.0, 85.0, 159.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 148.0, 146.0, 149.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 98.0, 96.0, 95.0, 96.0, 100.0, 101.0, 95.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 54.0, 55.0, 54.0, 57.0, 54.0, 55.0, 57.0, 56.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 59.0, 61.0, 59.0, 60.0, 60.0, 59.0, 59.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 77.0, 75.0, 79.0, 81.0, 78.0, 100.0, 75.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 125.0, 127.0, 121.0, 117.0, 131.0, 117.0, 120.0, 136.0, 127.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 159.0, 153.0, 158.0, 155.0, 155.0, 152.0, 149.0, 152.0], "value": 155.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 62.0, 61.0, 61.0, 61.0, 62.0, 62.0, 60.0], "value": 62.1, "unit": "score"}]}]} 13:14:41 INFO - Return code: 0 13:14:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:14:41 ERROR - # TBPL SUCCESS # 13:14:41 INFO - Running post-action listener: _resource_record_post_action 13:14:41 INFO - ##### 13:14:41 INFO - ##### Finished run-tests step (success) 13:14:41 INFO - ##### 13:14:41 INFO - Running post-run listener: _resource_record_post_run 13:14:41 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 475136; Write bytes: 221265920; Read time: 272; Write time: 98120 13:14:41 INFO - TinderboxPrint: CPU usage
13.4% 13:14:41 INFO - TinderboxPrint: I/O read bytes / time
475,136 / 272 13:14:41 INFO - TinderboxPrint: I/O write bytes / time
221,265,920 / 98,120 13:14:41 INFO - TinderboxPrint: CPU idle
8,189.6 (86.6%) 13:14:41 INFO - TinderboxPrint: CPU user
1,214.1 (12.8%) 13:14:41 INFO - TinderboxPrint: Swap in / out
0 / 0 13:14:41 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 5292032; Read time: 0; Write time: 300 13:14:41 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 450560; Write bytes: 215973888; Read time: 256; Write time: 97820 13:14:42 INFO - Running post-run listener: _upload_blobber_files 13:14:42 INFO - Blob upload gear active. 13:14:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:14:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:14:42 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:14:42 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:14:42 INFO - (blobuploader) - INFO - Open directory for files ... 13:14:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:14:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:14:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:43 INFO - (blobuploader) - INFO - Done attempting. 13:14:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:14:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:14:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:46 INFO - (blobuploader) - INFO - Done attempting. 13:14:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:14:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:14:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:47 INFO - (blobuploader) - INFO - Done attempting. 13:14:47 INFO - (blobuploader) - INFO - Iteration through files over. 13:14:47 INFO - Return code: 0 13:14:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:14:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:14:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/91d19ba1338300e307305da7935c2cf95d167541f2b6a79eb2a1f374de431cd18c9d4b33270c95b892f8c77c037c11d9f6ca19b5b8fa876564323390b9185135", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e7651fbd3cb878f6d46d1aae27c31e8291763378d04ff93c5dbe3da3e05b95df83c968ab02aeb4e8c9968e9ef01b41746724fef289284b19c0ba8da98d78c695", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c78929c9ee05296d07160b78af356ab37ec619dbfe574e8acedf47404ab335780f298ab4134fec1a2a711cc1f67c01d5a641892b31885f0c6be11c92f5a439b4"} 13:14:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:14:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:14:47 INFO - Contents: 13:14:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/91d19ba1338300e307305da7935c2cf95d167541f2b6a79eb2a1f374de431cd18c9d4b33270c95b892f8c77c037c11d9f6ca19b5b8fa876564323390b9185135", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e7651fbd3cb878f6d46d1aae27c31e8291763378d04ff93c5dbe3da3e05b95df83c968ab02aeb4e8c9968e9ef01b41746724fef289284b19c0ba8da98d78c695", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c78929c9ee05296d07160b78af356ab37ec619dbfe574e8acedf47404ab335780f298ab4134fec1a2a711cc1f67c01d5a641892b31885f0c6be11c92f5a439b4"} 13:14:47 INFO - Running post-run listener: copy_logs_to_upload_dir 13:14:47 INFO - Copying logs to upload dir... 13:14:47 INFO - mkdir: /builds/slave/test/build/upload/logs 13:14:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1226.460387 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 26 secs) (at 2016-08-02 13:14:47.802156) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 13:14:47.805288) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/91d19ba1338300e307305da7935c2cf95d167541f2b6a79eb2a1f374de431cd18c9d4b33270c95b892f8c77c037c11d9f6ca19b5b8fa876564323390b9185135", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e7651fbd3cb878f6d46d1aae27c31e8291763378d04ff93c5dbe3da3e05b95df83c968ab02aeb4e8c9968e9ef01b41746724fef289284b19c0ba8da98d78c695", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c78929c9ee05296d07160b78af356ab37ec619dbfe574e8acedf47404ab335780f298ab4134fec1a2a711cc1f67c01d5a641892b31885f0c6be11c92f5a439b4"} build_url:https://queue.taskcluster.net/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011407 build_url: 'https://queue.taskcluster.net/v1/task/Hzhp7oYUSLCEBlpeA_hB6Q/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/91d19ba1338300e307305da7935c2cf95d167541f2b6a79eb2a1f374de431cd18c9d4b33270c95b892f8c77c037c11d9f6ca19b5b8fa876564323390b9185135", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e7651fbd3cb878f6d46d1aae27c31e8291763378d04ff93c5dbe3da3e05b95df83c968ab02aeb4e8c9968e9ef01b41746724fef289284b19c0ba8da98d78c695", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c78929c9ee05296d07160b78af356ab37ec619dbfe574e8acedf47404ab335780f298ab4134fec1a2a711cc1f67c01d5a641892b31885f0c6be11c92f5a439b4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-02 13:14:47.830518) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 13:14:47.830807) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1470167655.785435-50737766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-02 13:14:47.913358) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 13:14:47.913629) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-02 13:14:47.913882) ========= ========= Total master_lag: 0.24 =========