builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1465960345.79 results: success (0) buildid: 20160614173009 builduid: a23fa29c0da64919a916cf07973148a3 revision: 071e9554e3e76a7692fd1a24b845bc42064352b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 20:12:25.793877) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 20:12:25.794355) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 20:12:25.794717) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 20:12:25.828682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 20:12:25.828985) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 20:12:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-06-14 20:12:26 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114955 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 20:12:25.964155) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 20:12:25.964439) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019795 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 20:12:26.014170) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 20:12:26.014528) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 071e9554e3e76a7692fd1a24b845bc42064352b0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 071e9554e3e76a7692fd1a24b845bc42064352b0 --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=82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 20:12:26,779 truncating revision to first 12 chars 2016-06-14 20:12:26,780 Setting DEBUG logging. 2016-06-14 20:12:26,780 attempt 1/10 2016-06-14 20:12:26,780 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/071e9554e3e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 20:12:27,193 unpacking tar archive at: fx-team-071e9554e3e7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.786928 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 20:12:26.836063) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 20:12:26.836344) ========= script_repo_revision: 071e9554e3e76a7692fd1a24b845bc42064352b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 20:12:26.836726) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 20:12:26.836989) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 20:12:26.845986) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-06-14 20:12:26.846257) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:12:27 INFO - MultiFileLogger online at 20160614 20:12:27 in /builds/slave/test 20:12:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:12:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:12:27 INFO - {'append_to_log': False, 20:12:27 INFO - 'base_work_dir': '/builds/slave/test', 20:12:27 INFO - 'blob_upload_branch': 'Fx-Team', 20:12:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:12:27 INFO - 'branch': 'Fx-Team', 20:12:27 INFO - 'buildbot_json_path': 'buildprops.json', 20:12:27 INFO - 'config_files': ('talos/linux_config.py',), 20:12:27 INFO - 'default_actions': ('clobber', 20:12:27 INFO - 'read-buildbot-config', 20:12:27 INFO - 'download-and-extract', 20:12:27 INFO - 'populate-webroot', 20:12:27 INFO - 'create-virtualenv', 20:12:27 INFO - 'install', 20:12:27 INFO - 'run-tests'), 20:12:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:12:27 INFO - 'download_minidump_stackwalk': True, 20:12:27 INFO - 'download_symbols': 'ondemand', 20:12:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:12:27 INFO - 'tooltool.py': '/tools/tooltool.py', 20:12:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:12:27 INFO - '/tools/misc-python/virtualenv.py')}, 20:12:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:12:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:12:27 INFO - 'installer_path': 'installer.exe', 20:12:27 INFO - 'log_level': 'info', 20:12:27 INFO - 'log_name': 'talos', 20:12:27 INFO - 'log_to_console': True, 20:12:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:12:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:12:27 INFO - 'opt_config_files': (), 20:12:27 INFO - 'pip_index': False, 20:12:27 INFO - 'sps_profile': False, 20:12:27 INFO - 'sps_profile_interval': 0, 20:12:27 INFO - 'suite': 'dromaeojs', 20:12:27 INFO - 'system_bits': '32', 20:12:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:12:27 INFO - 'title': 'talos-linux64-ix-066', 20:12:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:12:27 INFO - 'use_talos_json': True, 20:12:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:12:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:12:27 INFO - 'work_dir': 'build'} 20:12:27 INFO - ##### 20:12:27 INFO - ##### Running clobber step. 20:12:27 INFO - ##### 20:12:27 INFO - Running pre-action listener: _resource_record_pre_action 20:12:27 INFO - Running main action method: clobber 20:12:27 INFO - rmtree: /builds/slave/test/build 20:12:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:12:28 INFO - Running post-action listener: _resource_record_post_action 20:12:28 INFO - ##### 20:12:28 INFO - ##### Finished clobber step (success) 20:12:28 INFO - ##### 20:12:28 INFO - ##### 20:12:28 INFO - ##### Running read-buildbot-config step. 20:12:28 INFO - ##### 20:12:28 INFO - Running pre-action listener: _resource_record_pre_action 20:12:28 INFO - Running main action method: read_buildbot_config 20:12:28 INFO - Using buildbot properties: 20:12:28 INFO - { 20:12:28 INFO - "project": "", 20:12:28 INFO - "product": "firefox", 20:12:28 INFO - "script_repo_revision": "production", 20:12:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:12:28 INFO - "repository": "", 20:12:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:12:28 INFO - "buildid": "20160614173009", 20:12:28 INFO - "pgo_build": "True", 20:12:28 INFO - "basedir": "/builds/slave/test", 20:12:28 INFO - "buildnumber": 186, 20:12:28 INFO - "slavename": "talos-linux64-ix-066", 20:12:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:12:28 INFO - "platform": "ubuntu64_hw", 20:12:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:12:28 INFO - "branch": "fx-team", 20:12:28 INFO - "repo_path": "integration/fx-team", 20:12:28 INFO - "revision": "071e9554e3e76a7692fd1a24b845bc42064352b0", 20:12:28 INFO - "stage_platform": "linux64-pgo", 20:12:28 INFO - "builduid": "a23fa29c0da64919a916cf07973148a3", 20:12:28 INFO - "slavebuilddir": "test" 20:12:28 INFO - } 20:12:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:12:28 INFO - Running post-action listener: _resource_record_post_action 20:12:28 INFO - ##### 20:12:28 INFO - ##### Finished read-buildbot-config step (success) 20:12:28 INFO - ##### 20:12:28 INFO - ##### 20:12:28 INFO - ##### Running download-and-extract step. 20:12:28 INFO - ##### 20:12:28 INFO - Running pre-action listener: _resource_record_pre_action 20:12:28 INFO - Running main action method: download_and_extract 20:12:28 INFO - mkdir: /builds/slave/test/build/tests 20:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:28 INFO - https://queue.taskcluster.net/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:12:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:12:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:12:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:12:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:12:28 WARNING - URL Error: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:12:28 INFO - Running command: ['nslookup', 'queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com'] 20:12:28 INFO - Copy/paste: nslookup queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com 20:12:28 INFO - Server: 10.26.75.40 20:12:28 INFO - Address: 10.26.75.40#53 20:12:28 INFO - queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com canonical name = proxxy1.srv.releng.scl3.mozilla.com. 20:12:28 INFO - Name: proxxy1.srv.releng.scl3.mozilla.com 20:12:28 INFO - Address: 10.26.48.46 20:12:28 INFO - Return code: 0 20:12:28 INFO - retry: attempt #1 caught exception: 20:12:28 INFO - retry: Failed, sleeping 30 seconds before retrying 20:12:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #2 20:12:59 INFO - Downloaded 1361 bytes. 20:12:59 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:12:59 INFO - Using the following test package requirements: 20:12:59 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:12:59 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:12:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:12:59 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:12:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:12:59 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:12:59 INFO - u'jsshell-linux-x86_64.zip'], 20:12:59 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:12:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:12:59 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:12:59 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:12:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:12:59 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:12:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:12:59 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:12:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:12:59 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:12:59 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:12:59 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:12:59 INFO - https://queue.taskcluster.net/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:12:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:12:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:12:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:12:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:13:01 INFO - Downloaded 24220471 bytes. 20:13:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:13:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:13:02 INFO - Return code: 0 20:13:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:13:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:02 INFO - https://queue.taskcluster.net/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:13:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:13:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:13:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:13:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:13:06 INFO - Downloaded 24220471 bytes. 20:13:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:13:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:13:08 INFO - Return code: 0 20:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:08 INFO - https://queue.taskcluster.net/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:13:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:13:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:13:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:13:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:13:09 INFO - Downloaded 14405384 bytes. 20:13:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:13:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:13:10 INFO - Return code: 0 20:13:10 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')]} 20:13:10 INFO - https://queue.taskcluster.net/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:13:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:13:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:13:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:13:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:13:11 INFO - Downloaded 59340302 bytes. 20:13:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:13:11 INFO - mkdir: /builds/slave/test/properties 20:13:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:13:11 INFO - Writing to file /builds/slave/test/properties/build_url 20:13:11 INFO - Contents: 20:13:11 INFO - build_url:https://queue.taskcluster.net/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:13:12 INFO - Running post-action listener: _resource_record_post_action 20:13:12 INFO - Running post-action listener: set_extra_try_arguments 20:13:12 INFO - ##### 20:13:12 INFO - ##### Finished download-and-extract step (success) 20:13:12 INFO - ##### 20:13:12 INFO - ##### 20:13:12 INFO - ##### Running populate-webroot step. 20:13:12 INFO - ##### 20:13:12 INFO - Running pre-action listener: _resource_record_pre_action 20:13:12 INFO - Running main action method: populate_webroot 20:13:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:13:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:13:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:13:12 INFO - '--tppagecycles', 20:13:12 INFO - '7'], 20:13:12 INFO - 'tests': ['tsvgm']}}, 20:13:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:13:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:13:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:13:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:13:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:13:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:13:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:12 INFO - 'talos_options': ['--disable-e10s'], 20:13:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:13:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:13:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:12 INFO - 'talos_options': ['--disable-e10s'], 20:13:12 INFO - 'tests': ['damp', 'tps']}, 20:13:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:12 INFO - 'tests': ['damp', 'tps']}, 20:13:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:13:12 INFO - 'tests': ['dromaeo_dom']}, 20:13:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:13:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:13:12 INFO - 'tests': ['basic_compositor_video']}, 20:13:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:13:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:13:12 INFO - 'tests': ['a11yr', 20:13:12 INFO - 'ts_paint', 20:13:12 INFO - 'tpaint', 20:13:12 INFO - 'sessionrestore', 20:13:12 INFO - 'sessionrestore_no_auto_restore', 20:13:12 INFO - 'tabpaint']}, 20:13:12 INFO - 'other-e10s': {'tests': ['a11yr', 20:13:12 INFO - 'ts_paint', 20:13:12 INFO - 'tpaint', 20:13:12 INFO - 'sessionrestore', 20:13:12 INFO - 'sessionrestore_no_auto_restore', 20:13:12 INFO - 'tabpaint']}, 20:13:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:13:12 INFO - 'ts_paint', 20:13:12 INFO - 'tpaint', 20:13:12 INFO - 'sessionrestore', 20:13:12 INFO - 'sessionrestore_no_auto_restore', 20:13:12 INFO - 'tabpaint']}, 20:13:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:13:12 INFO - 'ts_paint', 20:13:12 INFO - 'tpaint', 20:13:12 INFO - 'sessionrestore', 20:13:12 INFO - 'sessionrestore_no_auto_restore', 20:13:12 INFO - 'tabpaint']}, 20:13:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:13:12 INFO - 'tests': ['a11yr', 20:13:12 INFO - 'ts_paint', 20:13:12 INFO - 'tpaint', 20:13:12 INFO - 'sessionrestore', 20:13:12 INFO - 'sessionrestore_no_auto_restore', 20:13:12 INFO - 'tabpaint']}, 20:13:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:13:12 INFO - 'tests': ['a11yr', 20:13:12 INFO - 'ts_paint', 20:13:12 INFO - 'tpaint', 20:13:12 INFO - 'sessionrestore', 20:13:12 INFO - 'sessionrestore_no_auto_restore', 20:13:12 INFO - 'tabpaint']}, 20:13:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:13:12 INFO - 'tests': ['tsvgx', 20:13:12 INFO - 'tsvgr_opacity', 20:13:12 INFO - 'tart', 20:13:12 INFO - 'tscrollx', 20:13:12 INFO - 'cart']}, 20:13:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:13:12 INFO - 'tsvgr_opacity', 20:13:12 INFO - 'tart', 20:13:12 INFO - 'tscrollx', 20:13:12 INFO - 'cart']}, 20:13:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:12 INFO - 'talos_options': ['--disable-e10s'], 20:13:12 INFO - 'tests': ['tp5o']}, 20:13:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:12 INFO - 'tests': ['tp5o']}, 20:13:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:12 INFO - 'talos_options': ['--disable-e10s', 20:13:12 INFO - '--xperf_path', 20:13:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:13:12 INFO - 'tests': ['tp5n']}, 20:13:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:13:12 INFO - 'talos_options': ['--xperf_path', 20:13:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:13:12 INFO - 'tests': ['tp5n']}}, 20:13:12 INFO - 'talos.zip': {'path': '', 20:13:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:13:12 INFO - Running post-action listener: _resource_record_post_action 20:13:12 INFO - ##### 20:13:12 INFO - ##### Finished populate-webroot step (success) 20:13:12 INFO - ##### 20:13:12 INFO - ##### 20:13:12 INFO - ##### Running create-virtualenv step. 20:13:12 INFO - ##### 20:13:12 INFO - Running pre-action listener: _resource_record_pre_action 20:13:12 INFO - Running main action method: create_virtualenv 20:13:12 INFO - Creating virtualenv /builds/slave/test/build/venv 20:13:12 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 20:13:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:13:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:13:12 INFO - Using real prefix '/usr' 20:13:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:13:12 INFO - Installing distribute.............................................................................................................................................................................................done. 20:13:14 INFO - Installing pip.................done. 20:13:14 INFO - Return code: 0 20:13:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8429e57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x281c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ae110>, '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 0x281a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281a6c0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', '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 20:13:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:13:14 INFO - Using env: {'DISPLAY': ':0', 20:13:14 INFO - 'HOME': '/home/cltbld', 20:13:14 INFO - 'LANG': 'en_US.UTF-8', 20:13:14 INFO - 'LANGUAGE': 'en_US:en', 20:13:14 INFO - 'LOGNAME': 'cltbld', 20:13:14 INFO - 'MAIL': '/var/mail/cltbld', 20:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:14 INFO - 'MOZ_NO_REMOTE': '1', 20:13:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:14 INFO - 'NO_EM_RESTART': '1', 20:13:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:14 INFO - 'PWD': '/builds/slave/test', 20:13:14 INFO - 'SHELL': '/bin/bash', 20:13:14 INFO - 'SHLVL': '1', 20:13:14 INFO - 'TERM': 'linux', 20:13:14 INFO - 'TMOUT': '86400', 20:13:14 INFO - 'USER': 'cltbld', 20:13:14 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', 20:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:14 INFO - '_': '/tools/buildbot/bin/python'} 20:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:15 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 20:13:15 INFO - Cleaning up... 20:13:15 INFO - Return code: 0 20:13:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8429e57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x281c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ae110>, '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 0x281a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281a6c0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', '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 20:13:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:13:15 INFO - Using env: {'DISPLAY': ':0', 20:13:15 INFO - 'HOME': '/home/cltbld', 20:13:15 INFO - 'LANG': 'en_US.UTF-8', 20:13:15 INFO - 'LANGUAGE': 'en_US:en', 20:13:15 INFO - 'LOGNAME': 'cltbld', 20:13:15 INFO - 'MAIL': '/var/mail/cltbld', 20:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:15 INFO - 'MOZ_NO_REMOTE': '1', 20:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:15 INFO - 'NO_EM_RESTART': '1', 20:13:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:15 INFO - 'PWD': '/builds/slave/test', 20:13:15 INFO - 'SHELL': '/bin/bash', 20:13:15 INFO - 'SHLVL': '1', 20:13:15 INFO - 'TERM': 'linux', 20:13:15 INFO - 'TMOUT': '86400', 20:13:15 INFO - 'USER': 'cltbld', 20:13:15 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', 20:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:15 INFO - '_': '/tools/buildbot/bin/python'} 20:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:15 INFO - Downloading/unpacking psutil>=3.1.1 20:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:13:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:13:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:13:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:13:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:13:17 INFO - Installing collected packages: psutil 20:13:17 INFO - Running setup.py install for psutil 20:13:17 INFO - building 'psutil._psutil_linux' extension 20:13:17 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 20:13:17 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 20:13:17 INFO - building 'psutil._psutil_posix' extension 20:13:17 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 20:13:17 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 20:13:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:13:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:13:17 INFO - Successfully installed psutil 20:13:17 INFO - Cleaning up... 20:13:17 INFO - Return code: 0 20:13:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:13:17 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')]} 20:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:17 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')]} 20:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:17 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 0x7f8429e57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x281c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ae110>, '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 0x281a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281a6c0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', '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 20:13:17 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 20:13:17 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 20:13:17 INFO - Using env: {'DISPLAY': ':0', 20:13:17 INFO - 'HOME': '/home/cltbld', 20:13:17 INFO - 'LANG': 'en_US.UTF-8', 20:13:17 INFO - 'LANGUAGE': 'en_US:en', 20:13:17 INFO - 'LOGNAME': 'cltbld', 20:13:17 INFO - 'MAIL': '/var/mail/cltbld', 20:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:17 INFO - 'MOZ_NO_REMOTE': '1', 20:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:17 INFO - 'NO_EM_RESTART': '1', 20:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:17 INFO - 'PWD': '/builds/slave/test', 20:13:17 INFO - 'SHELL': '/bin/bash', 20:13:17 INFO - 'SHLVL': '1', 20:13:17 INFO - 'TERM': 'linux', 20:13:17 INFO - 'TMOUT': '86400', 20:13:17 INFO - 'USER': 'cltbld', 20:13:17 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', 20:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:17 INFO - '_': '/tools/buildbot/bin/python'} 20:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:13:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:13:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:13:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:13:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:13:20 INFO - Installing collected packages: mozsystemmonitor 20:13:20 INFO - Running setup.py install for mozsystemmonitor 20:13:20 INFO - Successfully installed mozsystemmonitor 20:13:20 INFO - Cleaning up... 20:13:20 INFO - Return code: 0 20:13:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8429e57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x281c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ae110>, '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 0x281a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281a6c0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', '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 20:13:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:13:20 INFO - Using env: {'DISPLAY': ':0', 20:13:20 INFO - 'HOME': '/home/cltbld', 20:13:20 INFO - 'LANG': 'en_US.UTF-8', 20:13:20 INFO - 'LANGUAGE': 'en_US:en', 20:13:20 INFO - 'LOGNAME': 'cltbld', 20:13:20 INFO - 'MAIL': '/var/mail/cltbld', 20:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:20 INFO - 'MOZ_NO_REMOTE': '1', 20:13:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:20 INFO - 'NO_EM_RESTART': '1', 20:13:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:20 INFO - 'PWD': '/builds/slave/test', 20:13:20 INFO - 'SHELL': '/bin/bash', 20:13:20 INFO - 'SHLVL': '1', 20:13:20 INFO - 'TERM': 'linux', 20:13:20 INFO - 'TMOUT': '86400', 20:13:20 INFO - 'USER': 'cltbld', 20:13:20 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', 20:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:20 INFO - '_': '/tools/buildbot/bin/python'} 20:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:20 INFO - Downloading/unpacking jsonschema==2.5.1 20:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:13:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:13:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:13:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:13:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:13:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:13:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:13:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:13:22 INFO - Downloading functools32-3.2.3-2.tar.gz 20:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:13:22 INFO - warning: no files found matching '*.txt' 20:13:22 INFO - no previously-included directories found matching 'build' 20:13:22 INFO - no previously-included directories found matching 'dist' 20:13:22 INFO - no previously-included directories found matching '.git*' 20:13:22 INFO - Installing collected packages: jsonschema, functools32 20:13:22 INFO - Running setup.py install for functools32 20:13:22 INFO - warning: no files found matching '*.txt' 20:13:22 INFO - no previously-included directories found matching 'build' 20:13:22 INFO - no previously-included directories found matching 'dist' 20:13:22 INFO - no previously-included directories found matching '.git*' 20:13:22 INFO - Successfully installed jsonschema functools32 20:13:22 INFO - Cleaning up... 20:13:22 INFO - Return code: 0 20:13:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:13: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')]} 20:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13: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')]} 20:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:22 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 0x7f8429e57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x281c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ae110>, '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 0x281a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281a6c0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', '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 20:13:22 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 20:13:22 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 20:13:22 INFO - Using env: {'DISPLAY': ':0', 20:13:22 INFO - 'HOME': '/home/cltbld', 20:13:22 INFO - 'LANG': 'en_US.UTF-8', 20:13:22 INFO - 'LANGUAGE': 'en_US:en', 20:13:22 INFO - 'LOGNAME': 'cltbld', 20:13:22 INFO - 'MAIL': '/var/mail/cltbld', 20:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:22 INFO - 'MOZ_NO_REMOTE': '1', 20:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:22 INFO - 'NO_EM_RESTART': '1', 20:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:22 INFO - 'PWD': '/builds/slave/test', 20:13:22 INFO - 'SHELL': '/bin/bash', 20:13:22 INFO - 'SHLVL': '1', 20:13:22 INFO - 'TERM': 'linux', 20:13:22 INFO - 'TMOUT': '86400', 20:13:22 INFO - 'USER': 'cltbld', 20:13:22 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', 20:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:22 INFO - '_': '/tools/buildbot/bin/python'} 20:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:23 INFO - Downloading/unpacking blobuploader==1.2.4 20:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:13:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:13:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:13:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:13:24 INFO - Downloading blobuploader-1.2.4.tar.gz 20:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:13:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:13:25 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 20:13:25 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 20:13:25 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 20:13:25 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 20:13:25 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 20:13:25 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 20:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:13:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:13:25 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 20:13:25 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 20:13:25 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 20:13:25 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 20:13:25 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 20:13:25 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 20:13:25 INFO - Downloading docopt-0.6.1.tar.gz 20:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:13:25 INFO - Installing collected packages: blobuploader, requests, docopt 20:13:25 INFO - Running setup.py install for blobuploader 20:13:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:13:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:13:25 INFO - Running setup.py install for requests 20:13:26 INFO - Running setup.py install for docopt 20:13:26 INFO - Successfully installed blobuploader requests docopt 20:13:26 INFO - Cleaning up... 20:13:26 INFO - Return code: 0 20:13:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:13: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')]} 20:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13: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')]} 20:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:26 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 0x7f8429e57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x281c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ae110>, '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 0x281a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281a6c0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', '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 20:13:26 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 20:13:26 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 20:13:26 INFO - Using env: {'DISPLAY': ':0', 20:13:26 INFO - 'HOME': '/home/cltbld', 20:13:26 INFO - 'LANG': 'en_US.UTF-8', 20:13:26 INFO - 'LANGUAGE': 'en_US:en', 20:13:26 INFO - 'LOGNAME': 'cltbld', 20:13:26 INFO - 'MAIL': '/var/mail/cltbld', 20:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:26 INFO - 'MOZ_NO_REMOTE': '1', 20:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:26 INFO - 'NO_EM_RESTART': '1', 20:13:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:26 INFO - 'PWD': '/builds/slave/test', 20:13:26 INFO - 'SHELL': '/bin/bash', 20:13:26 INFO - 'SHLVL': '1', 20:13:26 INFO - 'TERM': 'linux', 20:13:26 INFO - 'TMOUT': '86400', 20:13:26 INFO - 'USER': 'cltbld', 20:13:26 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', 20:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:26 INFO - '_': '/tools/buildbot/bin/python'} 20:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:13:26 INFO - Running setup.py (path:/tmp/pip-LESOfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:13:26 INFO - Running setup.py (path:/tmp/pip-dhhfr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:13:26 INFO - Running setup.py (path:/tmp/pip-yG_q3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:13:26 INFO - Running setup.py (path:/tmp/pip-QbLudQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:13:26 INFO - Running setup.py (path:/tmp/pip-uY8eLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:13:26 INFO - Running setup.py (path:/tmp/pip-pxr2cx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:13:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:13:27 INFO - Running setup.py (path:/tmp/pip-qWv5jE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:13:27 INFO - Running setup.py (path:/tmp/pip-fzDUET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:13:27 INFO - Running setup.py (path:/tmp/pip-xpvJmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:13:27 INFO - Running setup.py (path:/tmp/pip-wb4KJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:13:27 INFO - Running setup.py (path:/tmp/pip-ARJ0lj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:13:27 INFO - Running setup.py (path:/tmp/pip-zuA_tR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:13:27 INFO - Running setup.py (path:/tmp/pip-4zax7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:13:27 INFO - Running setup.py (path:/tmp/pip-UuhSx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:13:27 INFO - Running setup.py (path:/tmp/pip-Q5CMr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:13:27 INFO - Running setup.py (path:/tmp/pip-qKMM0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:13:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:13:27 INFO - Running setup.py (path:/tmp/pip-ZWsO_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:13:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:13:27 INFO - Running setup.py install for manifestparser 20:13:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:13:27 INFO - Running setup.py install for mozcrash 20:13:27 INFO - Running setup.py install for mozdebug 20:13:28 INFO - Running setup.py install for mozdevice 20:13:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:13:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:13:28 INFO - Running setup.py install for mozfile 20:13:28 INFO - Running setup.py install for mozhttpd 20:13:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:13:28 INFO - Running setup.py install for mozinfo 20:13:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:13:28 INFO - Running setup.py install for mozInstall 20:13:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:13:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:13:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:13:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:13:28 INFO - Running setup.py install for mozleak 20:13:28 INFO - Running setup.py install for mozlog 20:13:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:13:28 INFO - Running setup.py install for moznetwork 20:13:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:13:28 INFO - Running setup.py install for mozprocess 20:13:29 INFO - Running setup.py install for mozprofile 20:13:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:13:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:13:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:13:29 INFO - Running setup.py install for mozrunner 20:13:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:13:29 INFO - Running setup.py install for mozscreenshot 20:13:29 INFO - Running setup.py install for moztest 20:13:29 INFO - Running setup.py install for mozversion 20:13:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:13:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:13:29 INFO - Cleaning up... 20:13:29 INFO - Return code: 0 20:13:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:13:29 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')]} 20:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:29 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')]} 20:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:29 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 0x7f8429e57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x281c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ae110>, '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 0x281a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281a6c0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', '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 20:13:29 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 20:13:29 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 20:13:29 INFO - Using env: {'DISPLAY': ':0', 20:13:29 INFO - 'HOME': '/home/cltbld', 20:13:29 INFO - 'LANG': 'en_US.UTF-8', 20:13:29 INFO - 'LANGUAGE': 'en_US:en', 20:13:29 INFO - 'LOGNAME': 'cltbld', 20:13:29 INFO - 'MAIL': '/var/mail/cltbld', 20:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:29 INFO - 'MOZ_NO_REMOTE': '1', 20:13:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:29 INFO - 'NO_EM_RESTART': '1', 20:13:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:29 INFO - 'PWD': '/builds/slave/test', 20:13:29 INFO - 'SHELL': '/bin/bash', 20:13:29 INFO - 'SHLVL': '1', 20:13:29 INFO - 'TERM': 'linux', 20:13:29 INFO - 'TMOUT': '86400', 20:13:29 INFO - 'USER': 'cltbld', 20:13:29 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', 20:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:29 INFO - '_': '/tools/buildbot/bin/python'} 20:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:13:29 INFO - Running setup.py (path:/tmp/pip-64bGIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:13:29 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)) 20:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:13:29 INFO - Running setup.py (path:/tmp/pip-wKvVsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:13:29 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)) 20:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:13:29 INFO - Running setup.py (path:/tmp/pip-U7siJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:13:30 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)) 20:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:13:30 INFO - Running setup.py (path:/tmp/pip-uy_vxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:13:30 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)) 20:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:13:30 INFO - Running setup.py (path:/tmp/pip-rkujsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:13:30 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)) 20:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:13:30 INFO - Running setup.py (path:/tmp/pip-JiJ7xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:13:30 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)) 20:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:13:30 INFO - Running setup.py (path:/tmp/pip-3Tz9ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:13:30 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)) 20:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:13:30 INFO - Running setup.py (path:/tmp/pip-nbhayP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:13:30 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)) 20:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:13:30 INFO - Running setup.py (path:/tmp/pip-qtnOJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:13:30 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)) 20:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:13:30 INFO - Running setup.py (path:/tmp/pip-cAWTpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:13:30 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)) 20:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:13:30 INFO - Running setup.py (path:/tmp/pip-p3IMIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:13:30 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)) 20:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:13:30 INFO - Running setup.py (path:/tmp/pip-byIpE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:13:30 INFO - Running setup.py (path:/tmp/pip-yJWNTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:13:30 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)) 20:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:13:30 INFO - Running setup.py (path:/tmp/pip-WMQAJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:13:30 INFO - Running setup.py (path:/tmp/pip-8tN_PK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:13:30 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)) 20:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:13:30 INFO - Running setup.py (path:/tmp/pip-KmU0Fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:13:30 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)) 20:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:13:30 INFO - Running setup.py (path:/tmp/pip-cbwHne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:13:31 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)) 20:13:31 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)) 20:13:31 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)) 20:13:31 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)) 20:13:31 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)) 20:13:31 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)) 20:13:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:13:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:13:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:13:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:13:32 INFO - Downloading blessings-1.6.tar.gz 20:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:13:33 INFO - Installing collected packages: blessings 20:13:33 INFO - Running setup.py install for blessings 20:13:33 INFO - Successfully installed blessings 20:13:33 INFO - Cleaning up... 20:13:33 INFO - Return code: 0 20:13:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:13:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:13:33 INFO - Reading from file tmpfile_stdout 20:13:33 INFO - Current package versions: 20:13:33 INFO - argparse == 1.2.1 20:13:33 INFO - blessings == 1.6 20:13:33 INFO - blobuploader == 1.2.4 20:13:33 INFO - docopt == 0.6.1 20:13:33 INFO - functools32 == 3.2.3-2 20:13:33 INFO - jsonschema == 2.5.1 20:13:33 INFO - manifestparser == 1.1 20:13:33 INFO - mozInstall == 1.12 20:13:33 INFO - mozcrash == 0.17 20:13:33 INFO - mozdebug == 0.1 20:13:33 INFO - mozdevice == 0.48 20:13:33 INFO - mozfile == 1.2 20:13:33 INFO - mozhttpd == 0.7 20:13:33 INFO - mozinfo == 0.9 20:13:33 INFO - mozleak == 0.1 20:13:33 INFO - mozlog == 3.2 20:13:33 INFO - moznetwork == 0.27 20:13:33 INFO - mozprocess == 0.22 20:13:33 INFO - mozprofile == 0.28 20:13:33 INFO - mozrunner == 6.11 20:13:33 INFO - mozscreenshot == 0.1 20:13:33 INFO - mozsystemmonitor == 0.3 20:13:33 INFO - moztest == 0.7 20:13:33 INFO - mozversion == 1.4 20:13:33 INFO - psutil == 3.1.1 20:13:33 INFO - requests == 1.2.3 20:13:33 INFO - wsgiref == 0.1.2 20:13:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:33 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 0x7f8429e57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x281c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ae110>, '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 0x281a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281a6c0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', '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 20:13:33 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 20:13:33 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 20:13:33 INFO - Using env: {'DISPLAY': ':0', 20:13:33 INFO - 'HOME': '/home/cltbld', 20:13:33 INFO - 'LANG': 'en_US.UTF-8', 20:13:33 INFO - 'LANGUAGE': 'en_US:en', 20:13:33 INFO - 'LOGNAME': 'cltbld', 20:13:33 INFO - 'MAIL': '/var/mail/cltbld', 20:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:33 INFO - 'MOZ_NO_REMOTE': '1', 20:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:33 INFO - 'NO_EM_RESTART': '1', 20:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:33 INFO - 'PWD': '/builds/slave/test', 20:13:33 INFO - 'SHELL': '/bin/bash', 20:13:33 INFO - 'SHLVL': '1', 20:13:33 INFO - 'TERM': 'linux', 20:13:33 INFO - 'TMOUT': '86400', 20:13:33 INFO - 'USER': 'cltbld', 20:13:33 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', 20:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:33 INFO - '_': '/tools/buildbot/bin/python'} 20:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:33 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)) 20:13:33 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)) 20:13:33 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)) 20:13:33 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)) 20:13:33 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)) 20:13:33 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)) 20:13:33 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)) 20:13:33 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)) 20:13:33 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)) 20:13:33 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)) 20:13:33 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)) 20:13:33 INFO - Cleaning up... 20:13:33 INFO - Return code: 0 20:13:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8429e57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x281c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ae110>, '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 0x281a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281a6c0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', '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 20:13:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:13:33 INFO - Using env: {'DISPLAY': ':0', 20:13:33 INFO - 'HOME': '/home/cltbld', 20:13:33 INFO - 'LANG': 'en_US.UTF-8', 20:13:33 INFO - 'LANGUAGE': 'en_US:en', 20:13:33 INFO - 'LOGNAME': 'cltbld', 20:13:33 INFO - 'MAIL': '/var/mail/cltbld', 20:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:33 INFO - 'MOZ_NO_REMOTE': '1', 20:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:33 INFO - 'NO_EM_RESTART': '1', 20:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:33 INFO - 'PWD': '/builds/slave/test', 20:13:33 INFO - 'SHELL': '/bin/bash', 20:13:33 INFO - 'SHLVL': '1', 20:13:33 INFO - 'TERM': 'linux', 20:13:33 INFO - 'TMOUT': '86400', 20:13:33 INFO - 'USER': 'cltbld', 20:13:33 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', 20:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:33 INFO - '_': '/tools/buildbot/bin/python'} 20:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:13:33 INFO - Cleaning up... 20:13:33 INFO - Return code: 0 20:13:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:13:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8429e57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x274f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x281c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28ae110>, '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 0x281a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281a6c0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', '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 20:13:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:13:33 INFO - Using env: {'DISPLAY': ':0', 20:13:33 INFO - 'HOME': '/home/cltbld', 20:13:33 INFO - 'LANG': 'en_US.UTF-8', 20:13:33 INFO - 'LANGUAGE': 'en_US:en', 20:13:33 INFO - 'LOGNAME': 'cltbld', 20:13:33 INFO - 'MAIL': '/var/mail/cltbld', 20:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:33 INFO - 'MOZ_NO_REMOTE': '1', 20:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:33 INFO - 'NO_EM_RESTART': '1', 20:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:33 INFO - 'PWD': '/builds/slave/test', 20:13:33 INFO - 'SHELL': '/bin/bash', 20:13:33 INFO - 'SHLVL': '1', 20:13:33 INFO - 'TERM': 'linux', 20:13:33 INFO - 'TMOUT': '86400', 20:13:33 INFO - 'USER': 'cltbld', 20:13:33 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', 20:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:33 INFO - '_': '/tools/buildbot/bin/python'} 20:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:13:34 INFO - Downloading/unpacking flake8 20:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:13:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:13:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:13:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:13:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:13:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:13:35 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 20:13:35 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 20:13:35 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 20:13:35 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 20:13:35 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 20:13:35 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 20:13:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:13:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:13: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 20:13: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 20:13: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 20:13: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 20:13: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 20:13: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 20:13:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:13: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 20:13: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 20:13: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 20:13: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 20:13: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 20:13: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 20:13:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:13:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:13:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:13:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:13:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:13:36 INFO - no previously-included directories found matching 'docs/_build' 20:13:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:13:36 INFO - Running setup.py install for pep8 20:13:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:13:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:13:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:13:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:13:36 INFO - no previously-included directories found matching 'docs/_build' 20:13:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:13:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:13:36 INFO - Cleaning up... 20:13:36 INFO - Return code: 0 20:13:36 INFO - Running post-action listener: _resource_record_post_action 20:13:36 INFO - Running post-action listener: _start_resource_monitoring 20:13:36 INFO - Starting resource monitoring. 20:13:36 INFO - ##### 20:13:36 INFO - ##### Finished create-virtualenv step (success) 20:13:36 INFO - ##### 20:13:36 INFO - ##### 20:13:36 INFO - ##### Running install step. 20:13:36 INFO - ##### 20:13:36 INFO - Running pre-action listener: _resource_record_pre_action 20:13:36 INFO - Running main action method: install 20:13:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:13:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:13:37 INFO - Reading from file tmpfile_stdout 20:13:37 INFO - Detecting whether we're running mozinstall >=1.0... 20:13:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:13:37 INFO - Reading from file tmpfile_stdout 20:13:37 INFO - Output received: 20:13:37 INFO - Usage: mozinstall [options] installer 20:13:37 INFO - Options: 20:13:37 INFO - -h, --help show this help message and exit 20:13:37 INFO - -d DEST, --destination=DEST 20:13:37 INFO - Directory to install application into. [default: 20:13:37 INFO - "/builds/slave/test"] 20:13:37 INFO - --app=APP Application being installed. [default: firefox] 20:13:37 INFO - mkdir: /builds/slave/test/build/application 20:13:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:13:54 INFO - Reading from file tmpfile_stdout 20:13:54 INFO - Output received: 20:13:54 INFO - /builds/slave/test/build/application/firefox/firefox 20:13:54 INFO - Running post-action listener: _resource_record_post_action 20:13:54 INFO - ##### 20:13:54 INFO - ##### Finished install step (success) 20:13:54 INFO - ##### 20:13:54 INFO - ##### 20:13:54 INFO - ##### Running run-tests step. 20:13:54 INFO - ##### 20:13:54 INFO - Running pre-action listener: _resource_record_pre_action 20:13:54 INFO - Running main action method: run_tests 20:13:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:13:54 INFO - Python 2.7.3 20:13:54 INFO - Return code: 0 20:13:54 INFO - grabbing minidump binary from tooltool 20:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:13:54 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 0x28ae110>, '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 0x281a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x281a6c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:13:54 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 20:13:54 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 20:13:54 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 20:13:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:13:54 INFO - Return code: 0 20:13:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:13:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:13:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:13:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:13:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:13:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:13:55 INFO - Return code: 0 20:13:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:13:55 INFO - Using env: {'DISPLAY': ':0', 20:13:55 INFO - 'HOME': '/home/cltbld', 20:13:55 INFO - 'LANG': 'en_US.UTF-8', 20:13:55 INFO - 'LANGUAGE': 'en_US:en', 20:13:55 INFO - 'LOGNAME': 'cltbld', 20:13:55 INFO - 'MAIL': '/var/mail/cltbld', 20:13:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:13:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:13:55 INFO - 'MOZ_NO_REMOTE': '1', 20:13:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:13:55 INFO - 'NO_EM_RESTART': '1', 20:13:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:13:55 INFO - 'PWD': '/builds/slave/test', 20:13:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:13:55 INFO - 'SHELL': '/bin/bash', 20:13:55 INFO - 'SHLVL': '1', 20:13:55 INFO - 'TERM': 'linux', 20:13:55 INFO - 'TMOUT': '86400', 20:13:55 INFO - 'USER': 'cltbld', 20:13:55 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243', 20:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:13:55 INFO - '_': '/tools/buildbot/bin/python'} 20:13:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:13:55 INFO - mozversion application_buildid: 20160614173009 20:13:55 INFO - mozversion application_changeset: 071e9554e3e76a7692fd1a24b845bc42064352b0 20:13:55 INFO - mozversion application_display_name: Nightly 20:13:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:13:55 INFO - mozversion application_name: Firefox 20:13:55 INFO - mozversion application_remotingname: firefox 20:13:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:13:55 INFO - mozversion application_vendor: Mozilla 20:13:55 INFO - mozversion application_version: 50.0a1 20:13:55 INFO - mozversion platform_buildid: 20160614173009 20:13:55 INFO - mozversion platform_changeset: 071e9554e3e76a7692fd1a24b845bc42064352b0 20:13:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:13:55 INFO - mozversion platform_version: 50.0a1 20:13:55 INFO - using testdate: 1465960435 20:13:55 INFO - actual date: 1465960435 20:13:55 INFO - starting webserver on 'localhost:59573' 20:13:55 INFO - SUITE-START | Running 2 tests 20:13:55 INFO - TEST-START | dromaeo_css 20:13:55 INFO - operating with platform_type : linux_ 20:13:55 INFO - Initialising browser for dromaeo_css test... 20:13:55 INFO - TEST-INFO | started process 18415 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzIP9uc/profile http://localhost:59573/getInfo.html) 20:13:59 INFO - PROCESS | 18415 | __metrics Screen width/height:1600/1200 20:13:59 INFO - PROCESS | 18415 | colorDepth:24 20:13:59 INFO - PROCESS | 18415 | Browser inner width/height: 1024/697 20:13:59 INFO - PROCESS | 18415 | __metrics 20:14:00 INFO - PROCESS | 18415 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:14:01 INFO - PROCESS | 18415 | console.error: PushService: 20:14:01 INFO - PROCESS | 18415 | stateChangeProcessEnqueue: Error transitioning state 20:14:01 INFO - PROCESS | 18415 | UnknownError 20:14:02 INFO - TEST-INFO | 18415: exit 0 20:14:02 INFO - Browser initialized. 20:14:02 INFO - Running cycle 1/1 for dromaeo_css test... 20:14:02 INFO - TEST-INFO | started process 18500 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzIP9uc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:14:13 INFO - PROCESS | 18500 | RSS: Main: 173449216 20:14:13 INFO - PROCESS | 18500 | 20:15:05 INFO - PROCESS | 18500 | 1465960505495 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] 20:17:13 INFO - PROCESS | 18500 | Cycle 1(1): loaded http://localhost:59573/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59573/tests/dromaeo/cssquery-ext.html) 20:17:14 INFO - PROCESS | 18500 | RSS: Main: 258097152 20:17:14 INFO - PROCESS | 18500 | 20:20:16 INFO - PROCESS | 18500 | Cycle 1(1): loaded http://localhost:59573/tests/dromaeo/cssquery-ext.html (next: http://localhost:59573/tests/dromaeo/cssquery-jquery.html) 20:20:17 INFO - PROCESS | 18500 | RSS: Main: 258777088 20:20:17 INFO - PROCESS | 18500 | 20:23:19 INFO - PROCESS | 18500 | Cycle 1(1): loaded http://localhost:59573/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59573/tests/dromaeo/cssquery-mootools.html) 20:23:20 INFO - PROCESS | 18500 | RSS: Main: 260218880 20:23:20 INFO - PROCESS | 18500 | 20:26:22 INFO - PROCESS | 18500 | Cycle 1(1): loaded http://localhost:59573/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59573/tests/dromaeo/cssquery-prototype.html) 20:26:22 INFO - PROCESS | 18500 | RSS: Main: 250933248 20:26:22 INFO - PROCESS | 18500 | 20:29:25 INFO - PROCESS | 18500 | Cycle 1(1): loaded http://localhost:59573/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59573/tests/dromaeo/cssquery-yui.html) 20:29:25 INFO - PROCESS | 18500 | RSS: Main: 220950528 20:29:25 INFO - PROCESS | 18500 | 20:32:28 INFO - PROCESS | 18500 | Cycle 1(1): loaded http://localhost:59573/tests/dromaeo/cssquery-yui.html (next: http://localhost:59573/tests/dromaeo/cssquery-dojo.html) 20:32:28 INFO - PROCESS | 18500 | RSS: Main: 286081024 20:32:28 INFO - PROCESS | 18500 | 20:32:28 INFO - PROCESS | 18500 | __start_tp_report 20:32:28 INFO - PROCESS | 18500 | _x_x_mozilla_page_load 20:32:28 INFO - PROCESS | 18500 | _x_x_mozilla_page_load_details 20:32:28 INFO - PROCESS | 18500 | |i|pagename|runs| 20:32:28 INFO - PROCESS | 18500 | |0;dojo.html;3005.459017376871;3011.036468330134;3034.2717747740535;3040.726334629883;3059.602251707278;5130.692158470494;5153.896922061566;5208.24480450335;5283.577313814891;5344.759485823138;5127.7948882044675;5184;5227.634065615409;5229.86925326867;5282.445343238962;4785.066911952171;4785.258284965836;4795.880102997418;4801.927971080445;4963.305137280766;4856.805727770885;4881.633877459187;4891.046245982035;4906.190478571049;4920.876978075559;4667.603253723438;4714.363560919301;4727.574518293353;4755.405574303212;4839.395075615548;4762.238041913277;4771.737554434505;4775.331453596499;4789.616830653539;4856.975715121437;4799.784009719536;4822.903541929142;4823.2282834746275;4831.734254615994;4860.80556777732;5131.794728210904;5193.324867767204;5209.791608335662;5269.104252277122;5359;5610.915836262459;5619.971900140514;5699.886002279931;5704.8859022819315;5710.000749868798;5693.060644993571;5706.229658996065;5706.572007099484;5708.029634962067;5711.286089238845;5150.97424512875;5184.688918664854;5220.451852555503;5223.085959956992;5302.3637163540625;5727.911696777599;5730.656160630376;5732.598718089777;5749.223854779635;5758.913616295759;5315.73421328932;5517.282753242052;5532.723363831792;5534.972325138348;5536.972315138399;5410.08028635133;5487.368952570506;5490.835274941758;5494.478024587658;5495.53287970519;5413.891722165614;5472.671639701551;5475.863103422366;5477.20580515823;5489.149181876815;5467.125259958388;5497.835064948058;5513.724313784295;5517.751701173457;5520.779168833282;4322.265214913472;4358.171947329997;4360.934585981213;4399.406080179199;4402.3176407656865;3863.150106976461;3867.1105645701646;3870.748401353903;3900.3564411871725;3904.941425878614;5129.051125541787;5167.0957582422925;5330.253764472977;5332.653377530526;5381.4349493303425;5640.153976903497;5669.943300566942;5685.772569097273;5687.175359572839;5696.259486266758;5361.303030606075;5364.409914909357;5367.141257398797;5372.140457526777;5377.8117765878005;4748.620110391161;4875.268709693574;4882.6826256293225;4932.556069953722;4972.428170760409;5792.218050563204;5798.275215598051;5805.129230615357;5855.092460668603;5902.3507414184405;5711.257536520392;5720.971395142998;5729.197912292199;5737.540996720169;5743.540516758566;5620.74706638194;5739.512141468022;5750.367459579359;5797;5814.5348372130975;5506.779728810803;5514.972425137848;5517.36550296721;5523.917141242804;5555.611107222618;5604.551635869202;5627.971860140673;5632.718364081861;5677.77288908439;5681.204631351531;5383.973080134574;5446.972765136149;5507.9449205507435;5511.448855114457;5572.359178694502;5516.972415137899;5519.530839878495;5520.53075488588;5520.834374968757;5524.861878453071;5417.891642167214;5430.429804870431;5436.184572314184;5441.0478166319945;5491.121420572689;5375.139977603565;5400.4059553448305;5458.044842152687;5458.645188062763;5530.170474428868;5332.413434522277;5335.653182543122;5338.3060202173465;5339.279197308314;5343.9465605345 20:32:28 INFO - PROCESS | 18500 | |1;ext.html;588.5615216663587;612.0788213738326;615.6398506873479;618.131525207084;629.9370062993701;29156.708432915664;41846;43000.784996075054;43060.56939430605;43076.353854692126;45429.77285113578;45669;45751.77124114383;45870.770646146804;45946;8988.011318754949;9028.729138125867;9106.726798196032;9114.908850911506;9158.404703694272;8988.68539601114;8993.550322483883;9043.638254469846;9093.18161365477;9099.317551183654;9134.680286189985;9174.17432431081;9177;9179.908200917973;9179.908200917973;9103.271738260957;9103.499307538083;9159.587818548182;9202.723918282429;9206.125418085305;8936.285097192209;9022.86465703015;9029.69069484921;9030.50332231727;9033.322500812399;42963.35554966678;43226;43283.350749738776;43301.13397732028;43371.56628433707;3759.6992240620684;3838.5393752749846;4220.092680073768;4277;4358.259095953696;32764.344713105605;33169;33246.335073298644;33487.6651233487;34874.47688284678;4448.977755111237;4535.818567257305;4542.977285113553;4632.073585282957;4644.744539050351;255070;255739;256050;256080;256972.99999999814;49272.75363623159;54406.455935440135;55723;55802.72098639562;57689;61780.38219617836;62152.37847621466;62426.37573624297;62446;62450.68774656188;14114.2942852859;14154.71690566183;14264;14267.78598321026;14271.429142834171;10702.946485267525;10719.678409647722;10751.0324070834;10760.946195268974;10762.300450470695;15202.087874727551;17249.91375043117;17296;17423.73864392035;17752.733708994376;5837.562182836219;5887.882242355129;5892.911606325909;5899.7020655455735;6091.329953705177;962.7352478068588;1009.8182327181178;1038.8649475568127;1093.9781204376027;1124.6738445850776;32148.19629509281;32437.18907027296;32545.67454325474;32806.83596582002;33068.83465582657;1085.1752667972398;1095.3427943234155;1106.7952428800697;1128.1820680006929;1167.3171194851107;15989.28048237832;16457.341706331852;16675.91662041682;16720.247588858532;16955.660886782443;533165;536202;539884;541465;542857;55827.162592561144;56986.43013569894;57402.13896791552;57497.42502574921;57573.71213143991;1260.8991280697521;1350.9121907076008;1363.1071648070529;1373.6703191234033;1386.1682990205998;31249.218769530944;33083.33833323272;33206.16984575405;33376.83311583426;33940.321193576485;48022.75988620034;48362.274565882246;48514.514854851;48537.5146248533;48555.27167092426;388164;397714;398134;398300.07649656414;398511;25249.621255681548;27361.179164625093;27826.443471130868;28136;30510.389792204474;43161.35257971196;47194.52805472039;47247.29129063136;47913.52086479091;48613;39592;39614.801925990185;40483.3927491082;40676.38985415162;40950.795246023576;38604;40109.79945100256;40597;40681.79659101686;41234.587654123075;40021.39967900542;40622.59377406306;41526.584734152275;41640.79179604082;41663;35386.29227415489;35879;36049.66106175747;36449.635503644626;36456.81771591125;27382.726172738017;27778;27904.30239244035;27963.58054629223;28024.719752803026 20:32:28 INFO - PROCESS | 18500 | |2;jquery.html;385.7936004237732;393.55331698522167;399;401.1575691048797;411.284365204544;14298.213598252118;17879.10604469776;17907.73138402922;19422.223111075557;19464.70802937955;14931.85068149321;17278.654426911453;17986.280548778064;18057.548561285974;18809.62380752384;5684.886302273962;5870.647761134345;5898.0268255737965;5901.970490147543;5909.93152396662;4203.936940945873;5823.2138661280605;5878.676672782995;6210.4100110489435;6515.7719479818215;6556.246031706343;6572.145621069254;6576.112224849656;6580.967095164518;6591.242007169189;6263.31103578606;6418.229812422539;6528.934710652904;6584.901226481583;6591.7363305467725;5477.67133971963;5595.356533998602;5597.272354593917;5600.775968961237;5775.306963164448;22223.44441388962;22907.54184916309;22939.655905161435;22975.655365169536;23319.300420987398;2225.321277010511;2275.601769690314;2427.5919966419433;2620.2270330252622;2875;13643.11319764222;14172.858271417257;14270;14271.571852844327;14273.214973176471;1911.0635788463553;1953.9804601954083;1964.2830366916116;1982.345825877457;2008.02610733794;72695.63652181758;77671.61164194143;77783.6110819448;79508;80498.59750701267;10378.37729736203;10798.352098874093;11110;11356.148288878367;11480.598179063692;15772.05367677943;15851.524454266391;15941.362345506283;15948.76076858848;15950.441734539236;7371.8157046074275;7473.252674732592;7659.846803063908;7734.651940662684;7737.458377913492;6940.514164008572;6993.160820701447;7018.5788852669;7141.143062832493;7163.67763450646;4465.866024019285;4569.9314510282375;4707.435107787088;4906.975465122651;4920.901581968341;2002.4693456233817;2016.7026911000619;2024.7469066366705;2026.1085122546033;2048.15001774262;967.5984466446487;1001.5392919257223;1024.6925922223304;1032.6901929421144;1045.6340280901622;18930.62138757217;19197;19228.327008554632;19405.902970485058;19544.511387215432;936.7283487788465;960.6061514779046;961.2598299309493;989.2481713897346;998.1765043838863;10440.321379110334;10685.626003089854;10791.78416431667;10805.567777288978;10840.349579025284;306851;313192;422212;423499;425055;59975.70012149911;60520.39479605236;61217.38782612206;61478.69260653668;96079;1008.3596915958419;1028.92797504174;1047.0471870597871;1047.9528421221064;1048.743057950807;16836.915815420845;17118.48644540666;17216.483505494856;17359.132043398033;17459.3889213882;30344.241393965327;31509;40750.1849963005;41297.587024129374;41748.79125604353;53992.46007540031;55625;63399.36600633935;63985;64330.678346607965;8576.099509551657;8670.91329086701;8749.16882896124;8789;8791.868121978303;9697.951510242403;12019.098567607289;12765.425555850195;12830.615081547568;13418.597442076752;11403.828942565702;11404.48679809394;11561.768764624492;11672.533098675958;11940;11335;11423.485943132746;11467.541298348306;11607.36159511235;11714.941425292818;11896.762064758483;11930.642080737593;11968.76062478763;12026.879731202926;12037.217580857216;8564.229219370287;8756.737297881074;8780.165884240987;8830.779230519289;9046.547672616474;10762.40806755636;10817.080548153495;10899.509522071685;11036.779264414827;11066 20:32:28 INFO - PROCESS | 18500 | |3;mootools.html;1339.3771896068326;1480.467031868527;1525.069707478438;1621.1488968291646;1799.532121648372;8340.082590915003;8765.991910930254;8766.868496972551;9029.142231488015;9040.095990400956;8763.868541971875;8948.597313120908;8956.641734330618;8958.283337333014;8959.596818143184;2069.793020697933;2332.125452955142;2421.6004359280787;2425.551273014489;2451.669024681672;2428.5992811186134;2434.6713193718797;2436.6954130733657;2437.0860927152316;2437.9512409751883;2378.8453750506246;2381.607034839258;2407.5786737320987;2408.1089996701244;2411.3007227903886;2016.8689035212665;2286.9199578014773;2318.2233951626226;2388.904443822245;2394.3535245483795;2314.409825494488;2326.5346930613946;2339.157903154863;2352.235523454884;2352.929412117639;9150.542472876396;9271.907280927171;9293.303002274788;9295.07049295072;9302.023287554777;5066.290719299301;5187.377514698261;5194;5196.870078248036;5199.402068762065;3349.9832500837583;3512.1921957949558;3542.415501442259;3555.1289933966086;3637.8181090945345;1211.836402085716;1244.2410129820892;1250.5685538489206;1257.0823298991788;1292.625138709773;12972.221666700028;13021.739565208738;13034.869651303556;13045.673858153623;13054.804177937338;4723.149833030087;4747.359106520645;4839.346688197119;4839.540243676845;4885.193942999365;10673.679789606324;10758.031777140095;10831.945840270748;10833.079188269085;10834.349939003685;5239.895202095937;5242.318498595158;5243.764030618555;5243.790248390022;5252.711100889488;4134.627883490501;4641.234196357631;4765.475797662254;4766.142094422968;4856.344393506832;4055.6755459563756;4109.746527309139;4126.91746165081;4148.688848336386;4160.667146628262;1331.973360532784;1334.1794796200268;1339.3614579278806;1342.5905098944916;1343.2612063365111;917.9036201198911;990.5988074829705;1004.0612027753928;1004.3020101029714;1006.6376104602338;5945.970270148621;5948.910766338422;6094.756209751649;6113.32753397126;6153.384661533811;462.6830621024609;473.1483330005976;480.74760750606214;488.65061481041226;490.4213028626255;4012.8194231259663;4117.444145040381;4127.938080928789;4155.127423241092;4209.158168366339;10803.621873234557;11248.212625116163;11259.943700281447;11624.186306958432;11631.88368116308;11427.48576314068;11472.598459053894;11480.770384592428;11488.712782180346;11492.482838272297;8273.958630206811;8505.61724722389;8512.616932238065;8514.106018868053;8531.317494600416;6177.4749146323065;6177.752889884534;6237.282712488122;6353.555251132377;6398.808035758934;10571.418571978615;10574;10618.628348007782;10702.09032232269;10729.141668666332;10177.287589868638;10537.315074520131;10947.616833411112;10955;10957.232993690364;7052.9647351762915;7186.065811444479;7187.425005999612;7859.528428294092;8241.25828675422;8514.744557663033;8746.30029597618;8782.560871956504;9099.909000909905;9113.908860911306;7730.845383092419;7942.722004729807;7957.244061814118;7973.8405231896195;8203.42576019673;7826.373890088893;7852.764417067498;7876.369890408868;7883.802904927423;8042.9597852010365;7021.929780702128;7028.964855175692;7102.538335008415;7106.218315985134;7117.110361204849;5233.555147812479;5275.129603615514;5291.206319052019;5332.5467335276935;5365.785368585213;5132;5173.7671804769625;5215.478452154754;5287.7620507078045;5303.178007408857 20:32:28 INFO - PROCESS | 18500 | |4;prototype.html;318.214011391862;328.0486588892212;333.6886037871167;335.27245876448103;335.7548989237858;5169.767360468779;5238;5274.129768588183;5331.173668081448;5373.382061062979;5288.312519372485;5292.041944480538;5309;5320.680759154454;5357.651752636076;4119.279126152919;4152.4394206782;4170;4183.326669332261;4185.0583618685705;3969.7221194516396;3970.841166353357;4163.292240319153;4174.478190226222;4188.455500784894;4074.899777060192;4104.794760261975;4118.919945427555;4123.463949686537;4126.112885729567;4107.322291821846;4112.691548133887;4139.337705967061;4154.273002224599;4197.685173611992;3492.336456073338;3727.9375378017407;3749.606291339425;3755.3052685253315;3764.7176461765202;5153.175491921312;5181.549166233461;5188.169892817131;5202.323697919284;5219.642892847849;4702.294655801623;4730.810767569327;4732.716037037754;4739.549742774431;4756.453007904101;5363.19552067193;5519.889602207933;5521.751521181516;5547.72261386929;5552.555795536347;3949.1904159647493;3958.4062390641634;3961.069148750041;3964.8017599120217;3971.4042893565907;5729.914051289234;5748.5975981681295;5754.913676294859;5776.162456443834;5805.82582522525;3872.283627528916;4040.252553277653;4045.2516284487465;4062.857799976987;4080.734752241154;4026.4564283821896;4051.777152256654;4072.572379900068;4077.388391741203;4097.7746223957965;4670.9766451167525;4674.509176536482;4681.157391669464;4693.718376897397;4696.154692155376;5558.694271815089;5560.638558493685;5575.637583557056;5605.80379686709;5613.887722245614;1359.2456186816412;1400.6568390744333;1409.8227979636913;1418.1987177244823;1420.6306360346384;884.9734507964771;902.9142231487998;917.8806755121791;923.7967647117623;932.664240873285;4713.31656909753;4728;4734.763261836894;4743.573078422958;4777.641676874248;5043;5045.394552653705;5048.368953880765;5060.013297407044;5065.670731402447;4702.929456058162;4740.265258884879;4760.785764640599;4842.709437433765;4964.230544265644;2998.670146283907;3010.3377257003426;3026.273694313349;3026.3190782073857;3062.31098002952;5869.354371019184;5907.675077870758;5915.674637894957;5945.732442040118;5968.403159684084;5551.944480555224;5786.479216870502;5812;5851.970740146272;5860.853478663067;5856.59003869725;5905.675187864623;5911.231539899785;5922.318933322723;5922.785828905064;5404.567634589302;5635.971820140873;5702.657840529581;5755.510781583613;5769.53843692512;5654.519365853948;5659.830205093854;5673.631213971079;5680.517156041783;5681;5814.895169917702;5857.970710146593;5946.910796338145;5953.613015154001;5977.581569290108;3767.96529873876;3879.6896248299504;4046.635802777764;4069.5320038195987;4093.7339072961354;5630.268065151504;5678.886422271614;5687.74869528703;5698.772049117989;5703.173039909273;5484.506394424521;5520.861978450571;5565.582581306499;5576.581756368208;5577;5354.902245039835;5583.74873130702;5631.493165615114;5637.661740295595;5650.63270887391;5381.811636592701;5399.326208875261;5428.972855135699;5432.429594892479;5471.835844924659;5327.22755200486;5603.887922241451;5635.577331700057;5647.20939068539;5670.716464176857;5398.892022159456;5463.945360546344;5464.754086066057;5474.753636086465;5485.780568777204 20:32:28 INFO - PROCESS | 18500 | |5;yui.html;742.5359150530918;756.73136036707;776.2819392062345;780.2977320411629;797.4378063465256;13979.720405591883;14950.626234344147;15234.695306093872;15354.692906141885;15411.614709632266;14706.63233419165;14724.411023559045;14873.479428220015;14892.553223403314;14895.404183832661;630.0549176235646;766.5553978692373;786.0802860653021;792.4848848248656;793.5556088590379;763.541874875076;763.900692909921;765.7319938021703;766.5937053361728;766.632016632017;806.6329819931917;811.8498077855586;812.9390295727815;818.3862103422433;818.8526065308242;661.7485355564903;790.2334735306744;811.2617518058538;816.9468984515987;829.7966998085448;598.7545106506356;601.7262145723686;601.8826328865873;602.1750202222938;602.1780269931512;14582.125072495579;14609.78085328721;14627.78058329126;14638.41446342145;14665.120092794466;13282.86717132826;13421.597352079356;13631.863681363258;14094.859051409458;14215.289235538285;12327.321997290235;12450.190737602026;12538.623841284776;12696.87303126966;12869.485220591165;4433.889152771174;4480.215962206634;4482.574155455259;4551.567601077925;4553.954460455386;71892;72195;73346;73398;73521.26478735251;11186.608468703718;11319.547218111184;11375.772484550263;11604;11765.52937882475;20910.163593456396;20980.370588882357;20982.79017209839;20993.37019889406;20996.47508812292;7935.682572697143;8034.879476807852;8103.351731861437;8308.12764659714;8357.122502137188;4550.453945526558;4653;4654.906901861944;4739.644526660514;4750.477447480775;3337.349216902729;3462.376772181032;3463.8441270142903;3468.9826550867588;3472.6527347265073;603.6287683074966;624.0763669768677;624.6720471752367;648.8832010238108;683.2518392360357;637.9521535884735;706.9575825450387;713.3187805645699;728.1262485017894;764.3009025888095;9261.583228754722;9993.050660187271;10036.297459177787;10044.497775111362;10075.899241007495;659.973601055962;709.1879797631683;723.2442098007594;739.4195556488131;746.7722344684814;4623.144718227139;4646.86059418218;4910;4913.557779799835;4960.627952903546;103394.48302758439;104866;105529.47235263775;105682;108492.4575377118;86863;92427.53786231026;92846;93335.53332233295;93593.5320323394;62903.6854815723;81888.59055704802;83523.5823820877;83772.16227837765;84280;8988.86516702237;9072.682456114268;9204.355695101278;9209.401388909699;9469.952650236704;47020.7648961753;47596.52403475921;48217;48677.75661121672;49189.754051229516;63148.36851631425;69068;69384.3061569398;70942.29057709563;71197;11004.39475828805;11207.495662695035;11312;12053.939730301292;12663.93668031654;11160.553577856796;13172.275524846225;13439.596812095653;14058.578242652737;14111.364988575744;12942;13712.794308085187;14168.574942751733;14237.430502779773;14357.712845743235;12828.166169198972;12978.610641680387;13038;13118.934405327913;13345.66635834112;12576.622701318975;12645.810312845499;12688.492460301484;13034.934825325812;13147.211167329608;10620.20348473852;10895;10916.235863489479;11053.668389948314;11470.713232169262;10947.9332372551;11152.330860148417;11229.045531129945;11458.598949036743;11764.294142351486 20:32:28 INFO - PROCESS | 18500 | __end_tp_report 20:32:28 INFO - PROCESS | 18500 | __start_cc_report 20:32:28 INFO - PROCESS | 18500 | _x_x_mozilla_cycle_collect,944 20:32:28 INFO - PROCESS | 18500 | __end_cc_report 20:32:28 INFO - PROCESS | 18500 | __startTimestamp1465961548711__endTimestamp 20:32:28 INFO - PROCESS | 18500 | 20:32:28 INFO - PROCESS | 18500 | ------- Summary: start ------- 20:32:28 INFO - PROCESS | 18500 | Number of tests: 6 20:32:28 INFO - PROCESS | 18500 | 20:32:28 INFO - PROCESS | 18500 | [#0] dojo.html Cycles:165 Average:5217.73 Median:5383.97 stddev:579.11 (10.8%) stddev-sans-first:554.27 20:32:28 INFO - PROCESS | 18500 | Values: 3005.5 3011.0 3034.3 3040.7 3059.6 5130.7 5153.9 5208.2 5283.6 5344.8 5127.8 5184.0 5227.6 5229.9 5282.4 4785.1 4785.3 4795.9 4801.9 4963.3 4856.8 4881.6 4891.0 4906.2 4920.9 4667.6 4714.4 4727.6 4755.4 4839.4 4762.2 4771.7 4775.3 4789.6 4857.0 4799.8 4822.9 4823.2 4831.7 4860.8 5131.8 5193.3 5209.8 5269.1 5359.0 5610.9 5620.0 5699.9 5704.9 5710.0 5693.1 5706.2 5706.6 5708.0 5711.3 5151.0 5184.7 5220.5 5223.1 5302.4 5727.9 5730.7 5732.6 5749.2 5758.9 5315.7 5517.3 5532.7 5535.0 5537.0 5410.1 5487.4 5490.8 5494.5 5495.5 5413.9 5472.7 5475.9 5477.2 5489.1 5467.1 5497.8 5513.7 5517.8 5520.8 4322.3 4358.2 4360.9 4399.4 4402.3 3863.2 3867.1 3870.7 3900.4 3904.9 5129.1 5167.1 5330.3 5332.7 5381.4 5640.2 5669.9 5685.8 5687.2 5696.3 5361.3 5364.4 5367.1 5372.1 5377.8 4748.6 4875.3 4882.7 4932.6 4972.4 5792.2 5798.3 5805.1 5855.1 5902.4 5711.3 5721.0 5729.2 5737.5 5743.5 5620.7 5739.5 5750.4 5797.0 5814.5 5506.8 5515.0 5517.4 5523.9 5555.6 5604.6 5628.0 5632.7 5677.8 5681.2 5384.0 5447.0 5507.9 5511.4 5572.4 5517.0 5519.5 5520.5 5520.8 5524.9 5417.9 5430.4 5436.2 5441.0 5491.1 5375.1 5400.4 5458.0 5458.6 5530.2 5332.4 5335.7 5338.3 5339.3 5343.9 20:32:28 INFO - PROCESS | 18500 | 20:32:28 INFO - PROCESS | 18500 | [#1] ext.html Cycles:180 Average:56221.46 Median:41651.90 stddev:109799.33 (263.6%) stddev-sans-first:110027.89 20:32:28 INFO - PROCESS | 18500 | Values: 588.6 612.1 615.6 618.1 629.9 29156.7 41846.0 43000.8 43060.6 43076.4 45429.8 45669.0 45751.8 45870.8 45946.0 8988.0 9028.7 9106.7 9114.9 9158.4 8988.7 8993.6 9043.6 9093.2 9099.3 9134.7 9174.2 9177.0 9179.9 9179.9 9103.3 9103.5 9159.6 9202.7 9206.1 8936.3 9022.9 9029.7 9030.5 9033.3 42963.4 43226.0 43283.4 43301.1 43371.6 3759.7 3838.5 4220.1 4277.0 4358.3 32764.3 33169.0 33246.3 33487.7 34874.5 4449.0 4535.8 4543.0 4632.1 4644.7 255070.0 255739.0 256050.0 256080.0 256973.0 49272.8 54406.5 55723.0 55802.7 57689.0 61780.4 62152.4 62426.4 62446.0 62450.7 14114.3 14154.7 14264.0 14267.8 14271.4 10702.9 10719.7 10751.0 10760.9 10762.3 15202.1 17249.9 17296.0 17423.7 17752.7 5837.6 5887.9 5892.9 5899.7 6091.3 962.7 1009.8 1038.9 1094.0 1124.7 32148.2 32437.2 32545.7 32806.8 33068.8 1085.2 1095.3 1106.8 1128.2 1167.3 15989.3 16457.3 16675.9 16720.2 16955.7 533165.0 536202.0 539884.0 541465.0 542857.0 55827.2 56986.4 57402.1 57497.4 57573.7 1260.9 1350.9 1363.1 1373.7 1386.2 31249.2 33083.3 33206.2 33376.8 33940.3 48022.8 48362.3 48514.5 48537.5 48555.3 388164.0 397714.0 398134.0 398300.1 398511.0 25249.6 27361.2 27826.4 28136.0 30510.4 43161.4 47194.5 47247.3 47913.5 48613.0 39592.0 39614.8 40483.4 40676.4 40950.8 38604.0 40109.8 40597.0 40681.8 41234.6 40021.4 40622.6 41526.6 41640.8 41663.0 35386.3 35879.0 36049.7 36449.6 36456.8 27382.7 27778.0 27904.3 27963.6 28024.7 20:32:28 INFO - PROCESS | 18500 | 20:32:28 INFO - PROCESS | 18500 | [#2] jquery.html Cycles:180 Average:25069.03 Median:2523.91 stddev:63211.10 (2504.5%) stddev-sans-first:63361.26 20:32:28 INFO - PROCESS | 18500 | Values: 385.8 393.6 399.0 401.2 411.3 14298.2 17879.1 17907.7 19422.2 19464.7 14931.9 17278.7 17986.3 18057.5 18809.6 5684.9 5870.6 5898.0 5902.0 5909.9 4203.9 5823.2 5878.7 6210.4 6515.8 6556.2 6572.1 6576.1 6581.0 6591.2 6263.3 6418.2 6528.9 6584.9 6591.7 5477.7 5595.4 5597.3 5600.8 5775.3 22223.4 22907.5 22939.7 22975.7 23319.3 2225.3 2275.6 2427.6 2620.2 2875.0 13643.1 14172.9 14270.0 14271.6 14273.2 1911.1 1954.0 1964.3 1982.3 2008.0 72695.6 77671.6 77783.6 79508.0 80498.6 10378.4 10798.4 11110.0 11356.1 11480.6 15772.1 15851.5 15941.4 15948.8 15950.4 7371.8 7473.3 7659.8 7734.7 7737.5 6940.5 6993.2 7018.6 7141.1 7163.7 4465.9 4569.9 4707.4 4907.0 4920.9 2002.5 2016.7 2024.7 2026.1 2048.2 967.6 1001.5 1024.7 1032.7 1045.6 18930.6 19197.0 19228.3 19405.9 19544.5 936.7 960.6 961.3 989.2 998.2 10440.3 10685.6 10791.8 10805.6 10840.3 306851.0 313192.0 422212.0 423499.0 425055.0 59975.7 60520.4 61217.4 61478.7 96079.0 1008.4 1028.9 1047.0 1048.0 1048.7 16836.9 17118.5 17216.5 17359.1 17459.4 30344.2 31509.0 40750.2 41297.6 41748.8 53992.5 55625.0 63399.4 63985.0 64330.7 8576.1 8670.9 8749.2 8789.0 8791.9 9698.0 12019.1 12765.4 12830.6 13418.6 11403.8 11404.5 11561.8 11672.5 11940.0 11335.0 11423.5 11467.5 11607.4 11714.9 11896.8 11930.6 11968.8 12026.9 12037.2 8564.2 8756.7 8780.2 8830.8 9046.5 10762.4 10817.1 10899.5 11036.8 11066.0 20:32:28 INFO - PROCESS | 18500 | 20:32:28 INFO - PROCESS | 18500 | [#3] mootools.html Cycles:180 Average:5959.31 Median:4682.19 stddev:3473.22 (74.2%) stddev-sans-first:3465.61 20:32:28 INFO - PROCESS | 18500 | Values: 1339.4 1480.5 1525.1 1621.1 1799.5 8340.1 8766.0 8766.9 9029.1 9040.1 8763.9 8948.6 8956.6 8958.3 8959.6 2069.8 2332.1 2421.6 2425.6 2451.7 2428.6 2434.7 2436.7 2437.1 2438.0 2378.8 2381.6 2407.6 2408.1 2411.3 2016.9 2286.9 2318.2 2388.9 2394.4 2314.4 2326.5 2339.2 2352.2 2352.9 9150.5 9271.9 9293.3 9295.1 9302.0 5066.3 5187.4 5194.0 5196.9 5199.4 3350.0 3512.2 3542.4 3555.1 3637.8 1211.8 1244.2 1250.6 1257.1 1292.6 12972.2 13021.7 13034.9 13045.7 13054.8 4723.1 4747.4 4839.3 4839.5 4885.2 10673.7 10758.0 10831.9 10833.1 10834.3 5239.9 5242.3 5243.8 5243.8 5252.7 4134.6 4641.2 4765.5 4766.1 4856.3 4055.7 4109.7 4126.9 4148.7 4160.7 1332.0 1334.2 1339.4 1342.6 1343.3 917.9 990.6 1004.1 1004.3 1006.6 5946.0 5948.9 6094.8 6113.3 6153.4 462.7 473.1 480.7 488.7 490.4 4012.8 4117.4 4127.9 4155.1 4209.2 10803.6 11248.2 11259.9 11624.2 11631.9 11427.5 11472.6 11480.8 11488.7 11492.5 8274.0 8505.6 8512.6 8514.1 8531.3 6177.5 6177.8 6237.3 6353.6 6398.8 10571.4 10574.0 10618.6 10702.1 10729.1 10177.3 10537.3 10947.6 10955.0 10957.2 7053.0 7186.1 7187.4 7859.5 8241.3 8514.7 8746.3 8782.6 9099.9 9113.9 7730.8 7942.7 7957.2 7973.8 8203.4 7826.4 7852.8 7876.4 7883.8 8043.0 7021.9 7029.0 7102.5 7106.2 7117.1 5233.6 5275.1 5291.2 5332.5 5365.8 5132.0 5173.8 5215.5 5287.8 5303.2 20:32:28 INFO - PROCESS | 18500 | 20:32:28 INFO - PROCESS | 18500 | [#4] prototype.html Cycles:180 Average:4628.17 Median:5228.82 stddev:1364.79 (26.1%) stddev-sans-first:1329.73 20:32:28 INFO - PROCESS | 18500 | Values: 318.2 328.0 333.7 335.3 335.8 5169.8 5238.0 5274.1 5331.2 5373.4 5288.3 5292.0 5309.0 5320.7 5357.7 4119.3 4152.4 4170.0 4183.3 4185.1 3969.7 3970.8 4163.3 4174.5 4188.5 4074.9 4104.8 4118.9 4123.5 4126.1 4107.3 4112.7 4139.3 4154.3 4197.7 3492.3 3727.9 3749.6 3755.3 3764.7 5153.2 5181.5 5188.2 5202.3 5219.6 4702.3 4730.8 4732.7 4739.5 4756.5 5363.2 5519.9 5521.8 5547.7 5552.6 3949.2 3958.4 3961.1 3964.8 3971.4 5729.9 5748.6 5754.9 5776.2 5805.8 3872.3 4040.3 4045.3 4062.9 4080.7 4026.5 4051.8 4072.6 4077.4 4097.8 4671.0 4674.5 4681.2 4693.7 4696.2 5558.7 5560.6 5575.6 5605.8 5613.9 1359.2 1400.7 1409.8 1418.2 1420.6 885.0 902.9 917.9 923.8 932.7 4713.3 4728.0 4734.8 4743.6 4777.6 5043.0 5045.4 5048.4 5060.0 5065.7 4702.9 4740.3 4760.8 4842.7 4964.2 2998.7 3010.3 3026.3 3026.3 3062.3 5869.4 5907.7 5915.7 5945.7 5968.4 5551.9 5786.5 5812.0 5852.0 5860.9 5856.6 5905.7 5911.2 5922.3 5922.8 5404.6 5636.0 5702.7 5755.5 5769.5 5654.5 5659.8 5673.6 5680.5 5681.0 5814.9 5858.0 5946.9 5953.6 5977.6 3768.0 3879.7 4046.6 4069.5 4093.7 5630.3 5678.9 5687.7 5698.8 5703.2 5484.5 5520.9 5565.6 5576.6 5577.0 5354.9 5583.7 5631.5 5637.7 5650.6 5381.8 5399.3 5429.0 5432.4 5471.8 5327.2 5603.9 5635.6 5647.2 5670.7 5398.9 5463.9 5464.8 5474.8 5485.8 20:32:28 INFO - PROCESS | 18500 | 20:32:28 INFO - PROCESS | 18500 | [#5] yui.html Cycles:180 Average:19658.05 Median:4649.93 stddev:27658.61 (594.8%) stddev-sans-first:27699.73 20:32:28 INFO - PROCESS | 18500 | Values: 742.5 756.7 776.3 780.3 797.4 13979.7 14950.6 15234.7 15354.7 15411.6 14706.6 14724.4 14873.5 14892.6 14895.4 630.1 766.6 786.1 792.5 793.6 763.5 763.9 765.7 766.6 766.6 806.6 811.8 812.9 818.4 818.9 661.7 790.2 811.3 816.9 829.8 598.8 601.7 601.9 602.2 602.2 14582.1 14609.8 14627.8 14638.4 14665.1 13282.9 13421.6 13631.9 14094.9 14215.3 12327.3 12450.2 12538.6 12696.9 12869.5 4433.9 4480.2 4482.6 4551.6 4554.0 71892.0 72195.0 73346.0 73398.0 73521.3 11186.6 11319.5 11375.8 11604.0 11765.5 20910.2 20980.4 20982.8 20993.4 20996.5 7935.7 8034.9 8103.4 8308.1 8357.1 4550.5 4653.0 4654.9 4739.6 4750.5 3337.3 3462.4 3463.8 3469.0 3472.7 603.6 624.1 624.7 648.9 683.3 638.0 707.0 713.3 728.1 764.3 9261.6 9993.1 10036.3 10044.5 10075.9 660.0 709.2 723.2 739.4 746.8 4623.1 4646.9 4910.0 4913.6 4960.6 103394.5 104866.0 105529.5 105682.0 108492.5 86863.0 92427.5 92846.0 93335.5 93593.5 62903.7 81888.6 83523.6 83772.2 84280.0 8988.9 9072.7 9204.4 9209.4 9470.0 47020.8 47596.5 48217.0 48677.8 49189.8 63148.4 69068.0 69384.3 70942.3 71197.0 11004.4 11207.5 11312.0 12053.9 12663.9 11160.6 13172.3 13439.6 14058.6 14111.4 12942.0 13712.8 14168.6 14237.4 14357.7 12828.2 12978.6 13038.0 13118.9 13345.7 12576.6 12645.8 12688.5 13034.9 13147.2 10620.2 10895.0 10916.2 11053.7 11470.7 10947.9 11152.3 11229.0 11458.6 11764.3 20:32:28 INFO - PROCESS | 18500 | -------- Summary: end -------- 20:32:28 INFO - PROCESS | 18500 | 20:32:29 INFO - TEST-INFO | 18500: exit 0 20:32:29 INFO - TEST-OK | dromaeo_css | took 1114228ms 20:32:29 INFO - TEST-START | kraken 20:32:29 INFO - operating with platform_type : linux_ 20:32:29 INFO - Initialising browser for kraken test... 20:32:29 INFO - TEST-INFO | started process 18690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCFvIgM/profile http://localhost:59573/getInfo.html) 20:32:33 INFO - PROCESS | 18690 | __metrics Screen width/height:1600/1200 20:32:33 INFO - PROCESS | 18690 | colorDepth:24 20:32:33 INFO - PROCESS | 18690 | Browser inner width/height: 1024/697 20:32:33 INFO - PROCESS | 18690 | __metrics 20:32:34 INFO - PROCESS | 18690 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:32:35 INFO - PROCESS | 18690 | console.error: PushService: 20:32:35 INFO - PROCESS | 18690 | stateChangeProcessEnqueue: Error transitioning state 20:32:35 INFO - PROCESS | 18690 | UnknownError 20:32:35 INFO - TEST-INFO | 18690: exit 0 20:32:35 INFO - Browser initialized. 20:32:35 INFO - Running cycle 1/1 for kraken test... 20:32:35 INFO - TEST-INFO | started process 18773 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCFvIgM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:32:47 INFO - PROCESS | 18773 | RSS: Main: 173776896 20:32:47 INFO - PROCESS | 18773 | 20:32:50 INFO - PROCESS | 18773 | Cycle 1(1): loaded http://localhost:59573/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59573/tests/kraken/driver.html?testName=audio-beat-detection) 20:32:51 INFO - PROCESS | 18773 | RSS: Main: 232026112 20:32:51 INFO - PROCESS | 18773 | 20:32:53 INFO - PROCESS | 18773 | Cycle 1(1): loaded http://localhost:59573/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59573/tests/kraken/driver.html?testName=audio-dft) 20:32:54 INFO - PROCESS | 18773 | RSS: Main: 221388800 20:32:54 INFO - PROCESS | 18773 | 20:32:57 INFO - PROCESS | 18773 | Cycle 1(1): loaded http://localhost:59573/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59573/tests/kraken/driver.html?testName=audio-fft) 20:32:58 INFO - PROCESS | 18773 | RSS: Main: 286801920 20:32:58 INFO - PROCESS | 18773 | 20:33:00 INFO - PROCESS | 18773 | Cycle 1(1): loaded http://localhost:59573/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59573/tests/kraken/driver.html?testName=audio-oscillator) 20:33:00 INFO - PROCESS | 18773 | RSS: Main: 197767168 20:33:00 INFO - PROCESS | 18773 | 20:33:03 INFO - PROCESS | 18773 | Cycle 1(1): loaded http://localhost:59573/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59573/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:33:03 INFO - PROCESS | 18773 | RSS: Main: 201310208 20:33:03 INFO - PROCESS | 18773 | 20:33:06 INFO - PROCESS | 18773 | Cycle 1(1): loaded http://localhost:59573/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59573/tests/kraken/driver.html?testName=imaging-darkroom) 20:33:07 INFO - PROCESS | 18773 | RSS: Main: 237441024 20:33:07 INFO - PROCESS | 18773 | 20:33:10 INFO - PROCESS | 18773 | Cycle 1(1): loaded http://localhost:59573/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59573/tests/kraken/driver.html?testName=imaging-desaturate) 20:33:11 INFO - PROCESS | 18773 | RSS: Main: 238522368 20:33:11 INFO - PROCESS | 18773 | 20:33:14 INFO - PROCESS | 18773 | Cycle 1(1): loaded http://localhost:59573/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59573/tests/kraken/driver.html?testName=json-parse-financial) 20:33:14 INFO - PROCESS | 18773 | RSS: Main: 238526464 20:33:14 INFO - PROCESS | 18773 | 20:33:16 INFO - PROCESS | 18773 | Cycle 1(1): loaded http://localhost:59573/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59573/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:33:16 INFO - PROCESS | 18773 | RSS: Main: 227082240 20:33:16 INFO - PROCESS | 18773 | 20:33:18 INFO - PROCESS | 18773 | Cycle 1(1): loaded http://localhost:59573/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59573/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:33:19 INFO - PROCESS | 18773 | RSS: Main: 231510016 20:33:19 INFO - PROCESS | 18773 | 20:33:21 INFO - PROCESS | 18773 | Cycle 1(1): loaded http://localhost:59573/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59573/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:33:22 INFO - PROCESS | 18773 | RSS: Main: 236703744 20:33:22 INFO - PROCESS | 18773 | 20:33:24 INFO - PROCESS | 18773 | Cycle 1(1): loaded http://localhost:59573/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59573/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:33:25 INFO - PROCESS | 18773 | RSS: Main: 240779264 20:33:25 INFO - PROCESS | 18773 | 20:33:27 INFO - PROCESS | 18773 | Cycle 1(1): loaded http://localhost:59573/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59573/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:33:28 INFO - PROCESS | 18773 | RSS: Main: 239640576 20:33:28 INFO - PROCESS | 18773 | 20:33:30 INFO - PROCESS | 18773 | Cycle 1(1): loaded http://localhost:59573/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59573/tests/kraken/driver.html?testName=ai-astar) 20:33:30 INFO - PROCESS | 18773 | RSS: Main: 282337280 20:33:30 INFO - PROCESS | 18773 | 20:33:30 INFO - PROCESS | 18773 | __start_tp_report 20:33:30 INFO - PROCESS | 18773 | _x_x_mozilla_page_load 20:33:30 INFO - PROCESS | 18773 | _x_x_mozilla_page_load_details 20:33:30 INFO - PROCESS | 18773 | |i|pagename|runs| 20:33:30 INFO - PROCESS | 18773 | |0;ai-astar;112;108;112;110;112;111;110;111;112;111 20:33:30 INFO - PROCESS | 18773 | |1;audio-beat-detection;151;124;127;181;127;127;149;125;165;125 20:33:30 INFO - PROCESS | 18773 | |2;audio-dft;161;161;161;161;160;163;159;160;160;162 20:33:30 INFO - PROCESS | 18773 | |3;audio-fft;75;74;75;123;75;75;73;76;98;75 20:33:30 INFO - PROCESS | 18773 | |4;audio-oscillator;85;85;107;86;85;84;111;85;86;129 20:33:30 INFO - PROCESS | 18773 | |5;imaging-gaussian-blur;117;117;116;116;117;116;117;117;117;116 20:33:30 INFO - PROCESS | 18773 | |6;imaging-darkroom;146;147;147;147;147;146;147;147;147;147 20:33:30 INFO - PROCESS | 18773 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;95 20:33:30 INFO - PROCESS | 18773 | |8;json-parse-financial;52;53;52;52;54;53;54;53;52;54 20:33:30 INFO - PROCESS | 18773 | |9;json-stringify-tinderbox;60;60;61;59;61;60;60;60;61;60 20:33:30 INFO - PROCESS | 18773 | |10;stanford-crypto-aes;80;85;79;80;78;81;80;81;117;80 20:33:30 INFO - PROCESS | 18773 | |11;stanford-crypto-ccm;123;124;135;132;123;133;124;131;127;127 20:33:30 INFO - PROCESS | 18773 | |12;stanford-crypto-pbkdf2;162;162;162;161;159;162;159;164;158;159 20:33:30 INFO - PROCESS | 18773 | |13;stanford-crypto-sha256-iterative;66;65;65;62;63;64;63;66;66;63 20:33:30 INFO - PROCESS | 18773 | __end_tp_report 20:33:30 INFO - PROCESS | 18773 | __start_cc_report 20:33:30 INFO - PROCESS | 18773 | _x_x_mozilla_cycle_collect,1617 20:33:30 INFO - PROCESS | 18773 | __end_cc_report 20:33:30 INFO - PROCESS | 18773 | __startTimestamp1465961610480__endTimestamp 20:33:30 INFO - PROCESS | 18773 | 20:33:30 INFO - PROCESS | 18773 | ------- Summary: start ------- 20:33:30 INFO - PROCESS | 18773 | Number of tests: 14 20:33:30 INFO - PROCESS | 18773 | 20:33:30 INFO - PROCESS | 18773 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.50 stddev:1.29 (1.2%) stddev-sans-first:1.30 20:33:30 INFO - PROCESS | 18773 | Values: 112.0 108.0 112.0 110.0 112.0 111.0 110.0 111.0 112.0 111.0 20:33:30 INFO - PROCESS | 18773 | 20:33:30 INFO - PROCESS | 18773 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:138.00 stddev:20.33 (14.7%) stddev-sans-first:21.18 20:33:30 INFO - PROCESS | 18773 | Values: 151.0 124.0 127.0 181.0 127.0 127.0 149.0 125.0 165.0 125.0 20:33:30 INFO - PROCESS | 18773 | 20:33:30 INFO - PROCESS | 18773 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 20:33:30 INFO - PROCESS | 18773 | Values: 161.0 161.0 161.0 161.0 160.0 163.0 159.0 160.0 160.0 162.0 20:33:30 INFO - PROCESS | 18773 | 20:33:30 INFO - PROCESS | 18773 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:16.20 (21.6%) stddev-sans-first:16.99 20:33:30 INFO - PROCESS | 18773 | Values: 75.0 74.0 75.0 123.0 75.0 75.0 73.0 76.0 98.0 75.0 20:33:30 INFO - PROCESS | 18773 | 20:33:30 INFO - PROCESS | 18773 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:85.00 stddev:15.76 (18.5%) stddev-sans-first:16.35 20:33:30 INFO - PROCESS | 18773 | Values: 85.0 85.0 107.0 86.0 85.0 84.0 111.0 85.0 86.0 129.0 20:33:30 INFO - PROCESS | 18773 | 20:33:30 INFO - PROCESS | 18773 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:33:30 INFO - PROCESS | 18773 | Values: 117.0 117.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 20:33:30 INFO - PROCESS | 18773 | 20:33:30 INFO - PROCESS | 18773 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 20:33:30 INFO - PROCESS | 18773 | Values: 146.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 20:33:30 INFO - PROCESS | 18773 | 20:33:30 INFO - PROCESS | 18773 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:33:30 INFO - PROCESS | 18773 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 20:33:30 INFO - PROCESS | 18773 | 20:33:30 INFO - PROCESS | 18773 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.88 (1.7%) stddev-sans-first:0.87 20:33:30 INFO - PROCESS | 18773 | Values: 52.0 53.0 52.0 52.0 54.0 53.0 54.0 53.0 52.0 54.0 20:33:30 INFO - PROCESS | 18773 | 20:33:30 INFO - PROCESS | 18773 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 20:33:30 INFO - PROCESS | 18773 | Values: 60.0 60.0 61.0 59.0 61.0 60.0 60.0 60.0 61.0 60.0 20:33:30 INFO - PROCESS | 18773 | 20:33:30 INFO - PROCESS | 18773 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:80.00 stddev:11.70 (14.6%) stddev-sans-first:12.32 20:33:30 INFO - PROCESS | 18773 | Values: 80.0 85.0 79.0 80.0 78.0 81.0 80.0 81.0 117.0 80.0 20:33:30 INFO - PROCESS | 18773 | 20:33:30 INFO - PROCESS | 18773 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:129.00 stddev:4.51 (3.5%) stddev-sans-first:4.42 20:33:30 INFO - PROCESS | 18773 | Values: 123.0 124.0 135.0 132.0 123.0 133.0 124.0 131.0 127.0 127.0 20:33:30 INFO - PROCESS | 18773 | 20:33:30 INFO - PROCESS | 18773 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:162.00 stddev:1.93 (1.2%) stddev-sans-first:2.00 20:33:30 INFO - PROCESS | 18773 | Values: 162.0 162.0 162.0 161.0 159.0 162.0 159.0 164.0 158.0 159.0 20:33:30 INFO - PROCESS | 18773 | 20:33:30 INFO - PROCESS | 18773 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:65.00 stddev:1.49 (2.3%) stddev-sans-first:1.45 20:33:30 INFO - PROCESS | 18773 | Values: 66.0 65.0 65.0 62.0 63.0 64.0 63.0 66.0 66.0 63.0 20:33:30 INFO - PROCESS | 18773 | -------- Summary: end -------- 20:33:30 INFO - PROCESS | 18773 | 20:33:31 INFO - TEST-INFO | 18773: exit 0 20:33:31 INFO - TEST-OK | kraken | took 62013ms 20:33:31 INFO - SUITE-END | took 1176s 20:33:31 INFO - Completed test suite (00:19:36) 20:33:31 INFO - javascript benchmark 20:33:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3005.459017376871, 3011.036468330134, 3034.2717747740535, 3040.726334629883, 3059.602251707278, 5130.692158470494, 5153.896922061566, 5208.24480450335, 5283.577313814891, 5344.759485823138, 5127.7948882044675, 5184.0, 5227.634065615409, 5229.86925326867, 5282.445343238962, 4785.066911952171, 4785.258284965836, 4795.880102997418, 4801.927971080445, 4963.305137280766, 4856.805727770885, 4881.633877459187, 4891.046245982035, 4906.190478571049, 4920.876978075559, 4667.603253723438, 4714.363560919301, 4727.574518293353, 4755.405574303212, 4839.395075615548, 4762.238041913277, 4771.737554434505, 4775.331453596499, 4789.616830653539, 4856.975715121437, 4799.784009719536, 4822.903541929142, 4823.2282834746275, 4831.734254615994, 4860.80556777732, 5131.794728210904, 5193.324867767204, 5209.791608335662, 5269.104252277122, 5359.0, 5610.915836262459, 5619.971900140514, 5699.886002279931, 5704.8859022819315, 5710.000749868798, 5693.060644993571, 5706.229658996065, 5706.572007099484, 5708.029634962067, 5711.286089238845, 5150.97424512875, 5184.688918664854, 5220.451852555503, 5223.085959956992, 5302.3637163540625, 5727.911696777599, 5730.656160630376, 5732.598718089777, 5749.223854779635, 5758.913616295759, 5315.73421328932, 5517.282753242052, 5532.723363831792, 5534.972325138348, 5536.972315138399, 5410.08028635133, 5487.368952570506, 5490.835274941758, 5494.478024587658, 5495.53287970519, 5413.891722165614, 5472.671639701551, 5475.863103422366, 5477.20580515823, 5489.149181876815, 5467.125259958388, 5497.835064948058, 5513.724313784295, 5517.751701173457, 5520.779168833282, 4322.265214913472, 4358.171947329997, 4360.934585981213, 4399.406080179199, 4402.3176407656865, 3863.150106976461, 3867.1105645701646, 3870.748401353903, 3900.3564411871725, 3904.941425878614, 5129.051125541787, 5167.0957582422925, 5330.253764472977, 5332.653377530526, 5381.4349493303425, 5640.153976903497, 5669.943300566942, 5685.772569097273, 5687.175359572839, 5696.259486266758, 5361.303030606075, 5364.409914909357, 5367.141257398797, 5372.140457526777, 5377.8117765878005, 4748.620110391161, 4875.268709693574, 4882.6826256293225, 4932.556069953722, 4972.428170760409, 5792.218050563204, 5798.275215598051, 5805.129230615357, 5855.092460668603, 5902.3507414184405, 5711.257536520392, 5720.971395142998, 5729.197912292199, 5737.540996720169, 5743.540516758566, 5620.74706638194, 5739.512141468022, 5750.367459579359, 5797.0, 5814.5348372130975, 5506.779728810803, 5514.972425137848, 5517.36550296721, 5523.917141242804, 5555.611107222618, 5604.551635869202, 5627.971860140673, 5632.718364081861, 5677.77288908439, 5681.204631351531, 5383.973080134574, 5446.972765136149, 5507.9449205507435, 5511.448855114457, 5572.359178694502, 5516.972415137899, 5519.530839878495, 5520.53075488588, 5520.834374968757, 5524.861878453071, 5417.891642167214, 5430.429804870431, 5436.184572314184, 5441.0478166319945, 5491.121420572689, 5375.139977603565, 5400.4059553448305, 5458.044842152687, 5458.645188062763, 5530.170474428868, 5332.413434522277, 5335.653182543122, 5338.3060202173465, 5339.279197308314, 5343.9465605345], "value": 5179.324185329262, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.5615216663587, 612.0788213738326, 615.6398506873479, 618.131525207084, 629.9370062993701, 29156.708432915664, 41846.0, 43000.784996075054, 43060.56939430605, 43076.353854692126, 45429.77285113578, 45669.0, 45751.77124114383, 45870.770646146804, 45946.0, 8988.011318754949, 9028.729138125867, 9106.726798196032, 9114.908850911506, 9158.404703694272, 8988.68539601114, 8993.550322483883, 9043.638254469846, 9093.18161365477, 9099.317551183654, 9134.680286189985, 9174.17432431081, 9177.0, 9179.908200917973, 9179.908200917973, 9103.271738260957, 9103.499307538083, 9159.587818548182, 9202.723918282429, 9206.125418085305, 8936.285097192209, 9022.86465703015, 9029.69069484921, 9030.50332231727, 9033.322500812399, 42963.35554966678, 43226.0, 43283.350749738776, 43301.13397732028, 43371.56628433707, 3759.6992240620684, 3838.5393752749846, 4220.092680073768, 4277.0, 4358.259095953696, 32764.344713105605, 33169.0, 33246.335073298644, 33487.6651233487, 34874.47688284678, 4448.977755111237, 4535.818567257305, 4542.977285113553, 4632.073585282957, 4644.744539050351, 255070.0, 255739.0, 256050.0, 256080.0, 256972.99999999814, 49272.75363623159, 54406.455935440135, 55723.0, 55802.72098639562, 57689.0, 61780.38219617836, 62152.37847621466, 62426.37573624297, 62446.0, 62450.68774656188, 14114.2942852859, 14154.71690566183, 14264.0, 14267.78598321026, 14271.429142834171, 10702.946485267525, 10719.678409647722, 10751.0324070834, 10760.946195268974, 10762.300450470695, 15202.087874727551, 17249.91375043117, 17296.0, 17423.73864392035, 17752.733708994376, 5837.562182836219, 5887.882242355129, 5892.911606325909, 5899.7020655455735, 6091.329953705177, 962.7352478068588, 1009.8182327181178, 1038.8649475568127, 1093.9781204376027, 1124.6738445850776, 32148.19629509281, 32437.18907027296, 32545.67454325474, 32806.83596582002, 33068.83465582657, 1085.1752667972398, 1095.3427943234155, 1106.7952428800697, 1128.1820680006929, 1167.3171194851107, 15989.28048237832, 16457.341706331852, 16675.91662041682, 16720.247588858532, 16955.660886782443, 533165.0, 536202.0, 539884.0, 541465.0, 542857.0, 55827.162592561144, 56986.43013569894, 57402.13896791552, 57497.42502574921, 57573.71213143991, 1260.8991280697521, 1350.9121907076008, 1363.1071648070529, 1373.6703191234033, 1386.1682990205998, 31249.218769530944, 33083.33833323272, 33206.16984575405, 33376.83311583426, 33940.321193576485, 48022.75988620034, 48362.274565882246, 48514.514854851, 48537.5146248533, 48555.27167092426, 388164.0, 397714.0, 398134.0, 398300.07649656414, 398511.0, 25249.621255681548, 27361.179164625093, 27826.443471130868, 28136.0, 30510.389792204474, 43161.35257971196, 47194.52805472039, 47247.29129063136, 47913.52086479091, 48613.0, 39592.0, 39614.801925990185, 40483.3927491082, 40676.38985415162, 40950.795246023576, 38604.0, 40109.79945100256, 40597.0, 40681.79659101686, 41234.587654123075, 40021.39967900542, 40622.59377406306, 41526.584734152275, 41640.79179604082, 41663.0, 35386.29227415489, 35879.0, 36049.66106175747, 36449.635503644626, 36456.81771591125, 27382.726172738017, 27778.0, 27904.30239244035, 27963.58054629223, 28024.719752803026], "value": 19647.66357458189, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.7936004237732, 393.55331698522167, 399.0, 401.1575691048797, 411.284365204544, 14298.213598252118, 17879.10604469776, 17907.73138402922, 19422.223111075557, 19464.70802937955, 14931.85068149321, 17278.654426911453, 17986.280548778064, 18057.548561285974, 18809.62380752384, 5684.886302273962, 5870.647761134345, 5898.0268255737965, 5901.970490147543, 5909.93152396662, 4203.936940945873, 5823.2138661280605, 5878.676672782995, 6210.4100110489435, 6515.7719479818215, 6556.246031706343, 6572.145621069254, 6576.112224849656, 6580.967095164518, 6591.242007169189, 6263.31103578606, 6418.229812422539, 6528.934710652904, 6584.901226481583, 6591.7363305467725, 5477.67133971963, 5595.356533998602, 5597.272354593917, 5600.775968961237, 5775.306963164448, 22223.44441388962, 22907.54184916309, 22939.655905161435, 22975.655365169536, 23319.300420987398, 2225.321277010511, 2275.601769690314, 2427.5919966419433, 2620.2270330252622, 2875.0, 13643.11319764222, 14172.858271417257, 14270.0, 14271.571852844327, 14273.214973176471, 1911.0635788463553, 1953.9804601954083, 1964.2830366916116, 1982.345825877457, 2008.02610733794, 72695.63652181758, 77671.61164194143, 77783.6110819448, 79508.0, 80498.59750701267, 10378.37729736203, 10798.352098874093, 11110.0, 11356.148288878367, 11480.598179063692, 15772.05367677943, 15851.524454266391, 15941.362345506283, 15948.76076858848, 15950.441734539236, 7371.8157046074275, 7473.252674732592, 7659.846803063908, 7734.651940662684, 7737.458377913492, 6940.514164008572, 6993.160820701447, 7018.5788852669, 7141.143062832493, 7163.67763450646, 4465.866024019285, 4569.9314510282375, 4707.435107787088, 4906.975465122651, 4920.901581968341, 2002.4693456233817, 2016.7026911000619, 2024.7469066366705, 2026.1085122546033, 2048.15001774262, 967.5984466446487, 1001.5392919257223, 1024.6925922223304, 1032.6901929421144, 1045.6340280901622, 18930.62138757217, 19197.0, 19228.327008554632, 19405.902970485058, 19544.511387215432, 936.7283487788465, 960.6061514779046, 961.2598299309493, 989.2481713897346, 998.1765043838863, 10440.321379110334, 10685.626003089854, 10791.78416431667, 10805.567777288978, 10840.349579025284, 306851.0, 313192.0, 422212.0, 423499.0, 425055.0, 59975.70012149911, 60520.39479605236, 61217.38782612206, 61478.69260653668, 96079.0, 1008.3596915958419, 1028.92797504174, 1047.0471870597871, 1047.9528421221064, 1048.743057950807, 16836.915815420845, 17118.48644540666, 17216.483505494856, 17359.132043398033, 17459.3889213882, 30344.241393965327, 31509.0, 40750.1849963005, 41297.587024129374, 41748.79125604353, 53992.46007540031, 55625.0, 63399.36600633935, 63985.0, 64330.678346607965, 8576.099509551657, 8670.91329086701, 8749.16882896124, 8789.0, 8791.868121978303, 9697.951510242403, 12019.098567607289, 12765.425555850195, 12830.615081547568, 13418.597442076752, 11403.828942565702, 11404.48679809394, 11561.768764624492, 11672.533098675958, 11940.0, 11335.0, 11423.485943132746, 11467.541298348306, 11607.36159511235, 11714.941425292818, 11896.762064758483, 11930.642080737593, 11968.76062478763, 12026.879731202926, 12037.217580857216, 8564.229219370287, 8756.737297881074, 8780.165884240987, 8830.779230519289, 9046.547672616474, 10762.40806755636, 10817.080548153495, 10899.509522071685, 11036.779264414827, 11066.0], "value": 9122.853455671957, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.3771896068326, 1480.467031868527, 1525.069707478438, 1621.1488968291646, 1799.532121648372, 8340.082590915003, 8765.991910930254, 8766.868496972551, 9029.142231488015, 9040.095990400956, 8763.868541971875, 8948.597313120908, 8956.641734330618, 8958.283337333014, 8959.596818143184, 2069.793020697933, 2332.125452955142, 2421.6004359280787, 2425.551273014489, 2451.669024681672, 2428.5992811186134, 2434.6713193718797, 2436.6954130733657, 2437.0860927152316, 2437.9512409751883, 2378.8453750506246, 2381.607034839258, 2407.5786737320987, 2408.1089996701244, 2411.3007227903886, 2016.8689035212665, 2286.9199578014773, 2318.2233951626226, 2388.904443822245, 2394.3535245483795, 2314.409825494488, 2326.5346930613946, 2339.157903154863, 2352.235523454884, 2352.929412117639, 9150.542472876396, 9271.907280927171, 9293.303002274788, 9295.07049295072, 9302.023287554777, 5066.290719299301, 5187.377514698261, 5194.0, 5196.870078248036, 5199.402068762065, 3349.9832500837583, 3512.1921957949558, 3542.415501442259, 3555.1289933966086, 3637.8181090945345, 1211.836402085716, 1244.2410129820892, 1250.5685538489206, 1257.0823298991788, 1292.625138709773, 12972.221666700028, 13021.739565208738, 13034.869651303556, 13045.673858153623, 13054.804177937338, 4723.149833030087, 4747.359106520645, 4839.346688197119, 4839.540243676845, 4885.193942999365, 10673.679789606324, 10758.031777140095, 10831.945840270748, 10833.079188269085, 10834.349939003685, 5239.895202095937, 5242.318498595158, 5243.764030618555, 5243.790248390022, 5252.711100889488, 4134.627883490501, 4641.234196357631, 4765.475797662254, 4766.142094422968, 4856.344393506832, 4055.6755459563756, 4109.746527309139, 4126.91746165081, 4148.688848336386, 4160.667146628262, 1331.973360532784, 1334.1794796200268, 1339.3614579278806, 1342.5905098944916, 1343.2612063365111, 917.9036201198911, 990.5988074829705, 1004.0612027753928, 1004.3020101029714, 1006.6376104602338, 5945.970270148621, 5948.910766338422, 6094.756209751649, 6113.32753397126, 6153.384661533811, 462.6830621024609, 473.1483330005976, 480.74760750606214, 488.65061481041226, 490.4213028626255, 4012.8194231259663, 4117.444145040381, 4127.938080928789, 4155.127423241092, 4209.158168366339, 10803.621873234557, 11248.212625116163, 11259.943700281447, 11624.186306958432, 11631.88368116308, 11427.48576314068, 11472.598459053894, 11480.770384592428, 11488.712782180346, 11492.482838272297, 8273.958630206811, 8505.61724722389, 8512.616932238065, 8514.106018868053, 8531.317494600416, 6177.4749146323065, 6177.752889884534, 6237.282712488122, 6353.555251132377, 6398.808035758934, 10571.418571978615, 10574.0, 10618.628348007782, 10702.09032232269, 10729.141668666332, 10177.287589868638, 10537.315074520131, 10947.616833411112, 10955.0, 10957.232993690364, 7052.9647351762915, 7186.065811444479, 7187.425005999612, 7859.528428294092, 8241.25828675422, 8514.744557663033, 8746.30029597618, 8782.560871956504, 9099.909000909905, 9113.908860911306, 7730.845383092419, 7942.722004729807, 7957.244061814118, 7973.8405231896195, 8203.42576019673, 7826.373890088893, 7852.764417067498, 7876.369890408868, 7883.802904927423, 8042.9597852010365, 7021.929780702128, 7028.964855175692, 7102.538335008415, 7106.218315985134, 7117.110361204849, 5233.555147812479, 5275.129603615514, 5291.206319052019, 5332.5467335276935, 5365.785368585213, 5132.0, 5173.7671804769625, 5215.478452154754, 5287.7620507078045, 5303.178007408857], "value": 4673.915986616661, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.214011391862, 328.0486588892212, 333.6886037871167, 335.27245876448103, 335.7548989237858, 5169.767360468779, 5238.0, 5274.129768588183, 5331.173668081448, 5373.382061062979, 5288.312519372485, 5292.041944480538, 5309.0, 5320.680759154454, 5357.651752636076, 4119.279126152919, 4152.4394206782, 4170.0, 4183.326669332261, 4185.0583618685705, 3969.7221194516396, 3970.841166353357, 4163.292240319153, 4174.478190226222, 4188.455500784894, 4074.899777060192, 4104.794760261975, 4118.919945427555, 4123.463949686537, 4126.112885729567, 4107.322291821846, 4112.691548133887, 4139.337705967061, 4154.273002224599, 4197.685173611992, 3492.336456073338, 3727.9375378017407, 3749.606291339425, 3755.3052685253315, 3764.7176461765202, 5153.175491921312, 5181.549166233461, 5188.169892817131, 5202.323697919284, 5219.642892847849, 4702.294655801623, 4730.810767569327, 4732.716037037754, 4739.549742774431, 4756.453007904101, 5363.19552067193, 5519.889602207933, 5521.751521181516, 5547.72261386929, 5552.555795536347, 3949.1904159647493, 3958.4062390641634, 3961.069148750041, 3964.8017599120217, 3971.4042893565907, 5729.914051289234, 5748.5975981681295, 5754.913676294859, 5776.162456443834, 5805.82582522525, 3872.283627528916, 4040.252553277653, 4045.2516284487465, 4062.857799976987, 4080.734752241154, 4026.4564283821896, 4051.777152256654, 4072.572379900068, 4077.388391741203, 4097.7746223957965, 4670.9766451167525, 4674.509176536482, 4681.157391669464, 4693.718376897397, 4696.154692155376, 5558.694271815089, 5560.638558493685, 5575.637583557056, 5605.80379686709, 5613.887722245614, 1359.2456186816412, 1400.6568390744333, 1409.8227979636913, 1418.1987177244823, 1420.6306360346384, 884.9734507964771, 902.9142231487998, 917.8806755121791, 923.7967647117623, 932.664240873285, 4713.31656909753, 4728.0, 4734.763261836894, 4743.573078422958, 4777.641676874248, 5043.0, 5045.394552653705, 5048.368953880765, 5060.013297407044, 5065.670731402447, 4702.929456058162, 4740.265258884879, 4760.785764640599, 4842.709437433765, 4964.230544265644, 2998.670146283907, 3010.3377257003426, 3026.273694313349, 3026.3190782073857, 3062.31098002952, 5869.354371019184, 5907.675077870758, 5915.674637894957, 5945.732442040118, 5968.403159684084, 5551.944480555224, 5786.479216870502, 5812.0, 5851.970740146272, 5860.853478663067, 5856.59003869725, 5905.675187864623, 5911.231539899785, 5922.318933322723, 5922.785828905064, 5404.567634589302, 5635.971820140873, 5702.657840529581, 5755.510781583613, 5769.53843692512, 5654.519365853948, 5659.830205093854, 5673.631213971079, 5680.517156041783, 5681.0, 5814.895169917702, 5857.970710146593, 5946.910796338145, 5953.613015154001, 5977.581569290108, 3767.96529873876, 3879.6896248299504, 4046.635802777764, 4069.5320038195987, 4093.7339072961354, 5630.268065151504, 5678.886422271614, 5687.74869528703, 5698.772049117989, 5703.173039909273, 5484.506394424521, 5520.861978450571, 5565.582581306499, 5576.581756368208, 5577.0, 5354.902245039835, 5583.74873130702, 5631.493165615114, 5637.661740295595, 5650.63270887391, 5381.811636592701, 5399.326208875261, 5428.972855135699, 5432.429594892479, 5471.835844924659, 5327.22755200486, 5603.887922241451, 5635.577331700057, 5647.20939068539, 5670.716464176857, 5398.892022159456, 5463.945360546344, 5464.754086066057, 5474.753636086465, 5485.780568777204], "value": 4192.64254429507, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.5359150530918, 756.73136036707, 776.2819392062345, 780.2977320411629, 797.4378063465256, 13979.720405591883, 14950.626234344147, 15234.695306093872, 15354.692906141885, 15411.614709632266, 14706.63233419165, 14724.411023559045, 14873.479428220015, 14892.553223403314, 14895.404183832661, 630.0549176235646, 766.5553978692373, 786.0802860653021, 792.4848848248656, 793.5556088590379, 763.541874875076, 763.900692909921, 765.7319938021703, 766.5937053361728, 766.632016632017, 806.6329819931917, 811.8498077855586, 812.9390295727815, 818.3862103422433, 818.8526065308242, 661.7485355564903, 790.2334735306744, 811.2617518058538, 816.9468984515987, 829.7966998085448, 598.7545106506356, 601.7262145723686, 601.8826328865873, 602.1750202222938, 602.1780269931512, 14582.125072495579, 14609.78085328721, 14627.78058329126, 14638.41446342145, 14665.120092794466, 13282.86717132826, 13421.597352079356, 13631.863681363258, 14094.859051409458, 14215.289235538285, 12327.321997290235, 12450.190737602026, 12538.623841284776, 12696.87303126966, 12869.485220591165, 4433.889152771174, 4480.215962206634, 4482.574155455259, 4551.567601077925, 4553.954460455386, 71892.0, 72195.0, 73346.0, 73398.0, 73521.26478735251, 11186.608468703718, 11319.547218111184, 11375.772484550263, 11604.0, 11765.52937882475, 20910.163593456396, 20980.370588882357, 20982.79017209839, 20993.37019889406, 20996.47508812292, 7935.682572697143, 8034.879476807852, 8103.351731861437, 8308.12764659714, 8357.122502137188, 4550.453945526558, 4653.0, 4654.906901861944, 4739.644526660514, 4750.477447480775, 3337.349216902729, 3462.376772181032, 3463.8441270142903, 3468.9826550867588, 3472.6527347265073, 603.6287683074966, 624.0763669768677, 624.6720471752367, 648.8832010238108, 683.2518392360357, 637.9521535884735, 706.9575825450387, 713.3187805645699, 728.1262485017894, 764.3009025888095, 9261.583228754722, 9993.050660187271, 10036.297459177787, 10044.497775111362, 10075.899241007495, 659.973601055962, 709.1879797631683, 723.2442098007594, 739.4195556488131, 746.7722344684814, 4623.144718227139, 4646.86059418218, 4910.0, 4913.557779799835, 4960.627952903546, 103394.48302758439, 104866.0, 105529.47235263775, 105682.0, 108492.4575377118, 86863.0, 92427.53786231026, 92846.0, 93335.53332233295, 93593.5320323394, 62903.6854815723, 81888.59055704802, 83523.5823820877, 83772.16227837765, 84280.0, 8988.86516702237, 9072.682456114268, 9204.355695101278, 9209.401388909699, 9469.952650236704, 47020.7648961753, 47596.52403475921, 48217.0, 48677.75661121672, 49189.754051229516, 63148.36851631425, 69068.0, 69384.3061569398, 70942.29057709563, 71197.0, 11004.39475828805, 11207.495662695035, 11312.0, 12053.939730301292, 12663.93668031654, 11160.553577856796, 13172.275524846225, 13439.596812095653, 14058.578242652737, 14111.364988575744, 12942.0, 13712.794308085187, 14168.574942751733, 14237.430502779773, 14357.712845743235, 12828.166169198972, 12978.610641680387, 13038.0, 13118.934405327913, 13345.66635834112, 12576.622701318975, 12645.810312845499, 12688.492460301484, 13034.934825325812, 13147.211167329608, 10620.20348473852, 10895.0, 10916.235863489479, 11053.668389948314, 11470.713232169262, 10947.9332372551, 11152.330860148417, 11229.045531129945, 11458.598949036743, 11764.294142351486], "value": 7356.616690195705, "unit": "score"}], "name": "dromaeo_css", "value": 7152.113331159509, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 112.0, 110.0, 112.0, 111.0, 110.0, 111.0, 112.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 127.0, 181.0, 127.0, 127.0, 149.0, 125.0, 165.0, 125.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 160.0, 163.0, 159.0, 160.0, 160.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 123.0, 75.0, 75.0, 73.0, 76.0, 98.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 107.0, 86.0, 85.0, 84.0, 111.0, 85.0, 86.0, 129.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 52.0, 52.0, 54.0, 53.0, 54.0, 53.0, 52.0, 54.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 59.0, 61.0, 60.0, 60.0, 60.0, 61.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 79.0, 80.0, 78.0, 81.0, 80.0, 81.0, 117.0, 80.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 124.0, 135.0, 132.0, 123.0, 133.0, 124.0, 131.0, 127.0, 127.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 159.0, 162.0, 159.0, 164.0, 158.0, 159.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 65.0, 62.0, 63.0, 64.0, 63.0, 66.0, 66.0, 63.0], "value": 64.3, "unit": "score"}], "name": "kraken", "value": 1496.5, "alertThreshold": 2.0}]} 20:33:31 INFO - Return code: 0 20:33:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:33:31 INFO - # TBPL SUCCESS # 20:33:31 INFO - Running post-action listener: _resource_record_post_action 20:33:31 INFO - ##### 20:33:31 INFO - ##### Finished run-tests step (success) 20:33:31 INFO - ##### 20:33:31 INFO - Running post-run listener: _resource_record_post_run 20:33:31 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 557404160; Read time: 12; Write time: 696220 20:33:31 INFO - TinderboxPrint: CPU usage
13.2% 20:33:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:33:31 INFO - TinderboxPrint: I/O write bytes / time
557,404,160 / 696,220 20:33:31 INFO - TinderboxPrint: CPU idle
8,270.8 (86.8%) 20:33:31 INFO - TinderboxPrint: CPU user
1,203.7 (12.6%) 20:33:31 INFO - TinderboxPrint: Swap in / out
0 / 0 20:33:31 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 264966144; Read time: 0; Write time: 403080 20:33:31 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 291852288; Read time: 12; Write time: 293124 20:33:32 INFO - Running post-run listener: _upload_blobber_files 20:33:32 INFO - Blob upload gear active. 20:33:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:33:32 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 20:33:32 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:33:32 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:33:32 INFO - (blobuploader) - INFO - Open directory for files ... 20:33:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:33:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:33:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:33:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:33:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:33:36 INFO - (blobuploader) - INFO - Done attempting. 20:33:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:33:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:33:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:33:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:33:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:33:37 INFO - (blobuploader) - INFO - Done attempting. 20:33:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:33:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:33:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:33:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:33:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:33:38 INFO - (blobuploader) - INFO - Done attempting. 20:33:38 INFO - (blobuploader) - INFO - Iteration through files over. 20:33:38 INFO - Return code: 0 20:33:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:33:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:33:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4450c27405cb8982f0d4c8580c443c892dfe5c104701e621c2608506e0d29b8eddef48c8f6f45ec5287e18941cd15bb4e5b379bc3386ffa60ac30d204c10699", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16a8d4036d9181f3d25a9ff08f5868d4d282572051a4257e1675b8c8f9545b31cb6a368c55e922bb9dcc69901ed1999c4906df5be9d1ef75fe8f5d7ba9cdb121", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41641e155f1a09b721ad04683e7184182dec6db5cd6722fadd86df47e78e0935d5ed12edc86f8ca3781fe5e8a37299c976dc432219453ff3cd8a2c2929f8ccc6"} 20:33:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:33:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:33:38 INFO - Contents: 20:33:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4450c27405cb8982f0d4c8580c443c892dfe5c104701e621c2608506e0d29b8eddef48c8f6f45ec5287e18941cd15bb4e5b379bc3386ffa60ac30d204c10699", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16a8d4036d9181f3d25a9ff08f5868d4d282572051a4257e1675b8c8f9545b31cb6a368c55e922bb9dcc69901ed1999c4906df5be9d1ef75fe8f5d7ba9cdb121", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41641e155f1a09b721ad04683e7184182dec6db5cd6722fadd86df47e78e0935d5ed12edc86f8ca3781fe5e8a37299c976dc432219453ff3cd8a2c2929f8ccc6"} 20:33:38 INFO - Running post-run listener: copy_logs_to_upload_dir 20:33:38 INFO - Copying logs to upload dir... 20:33:38 INFO - mkdir: /builds/slave/test/build/upload/logs 20:33:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.957358 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-06-14 20:33:37.810790) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 20:33:37.813997) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4450c27405cb8982f0d4c8580c443c892dfe5c104701e621c2608506e0d29b8eddef48c8f6f45ec5287e18941cd15bb4e5b379bc3386ffa60ac30d204c10699", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16a8d4036d9181f3d25a9ff08f5868d4d282572051a4257e1675b8c8f9545b31cb6a368c55e922bb9dcc69901ed1999c4906df5be9d1ef75fe8f5d7ba9cdb121", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41641e155f1a09b721ad04683e7184182dec6db5cd6722fadd86df47e78e0935d5ed12edc86f8ca3781fe5e8a37299c976dc432219453ff3cd8a2c2929f8ccc6"} build_url:https://queue.taskcluster.net/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011465 build_url: 'https://queue.taskcluster.net/v1/task/POkFHShRSS2OeyLifsZfVw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a4450c27405cb8982f0d4c8580c443c892dfe5c104701e621c2608506e0d29b8eddef48c8f6f45ec5287e18941cd15bb4e5b379bc3386ffa60ac30d204c10699", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/16a8d4036d9181f3d25a9ff08f5868d4d282572051a4257e1675b8c8f9545b31cb6a368c55e922bb9dcc69901ed1999c4906df5be9d1ef75fe8f5d7ba9cdb121", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41641e155f1a09b721ad04683e7184182dec6db5cd6722fadd86df47e78e0935d5ed12edc86f8ca3781fe5e8a37299c976dc432219453ff3cd8a2c2929f8ccc6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-14 20:33:37.839599) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 20:33:37.839944) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1465958672.949186-1508331243 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.005189 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 20:33:37.929297) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 20:33:37.930132) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-14 20:33:37.930796) ========= ========= Total master_lag: 0.19 =========