builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1468491378.08 results: success (0) buildid: 20160714004054 builduid: 6a8ca11f4a37440eb3d20ce92e3d6eb6 revision: 709652b674013b136627e45fd90b4e9063906a19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:18.084540) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:18.085014) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:18.085360) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:18.107651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:18.107974) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-14 03:16:19-- 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% 42.7M=0s 2016-07-14 03:16:19 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103557 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:18.235789) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:18.236119) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015032 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:18.286186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:18.286568) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 709652b674013b136627e45fd90b4e9063906a19 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 709652b674013b136627e45fd90b4e9063906a19 --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=516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-14 03:16:19,441 truncating revision to first 12 chars 2016-07-14 03:16:19,441 Setting DEBUG logging. 2016-07-14 03:16:19,441 attempt 1/10 2016-07-14 03:16:19,441 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/709652b67401?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 03:16:19,739 unpacking tar archive at: mozilla-aurora-709652b67401/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637314 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:18.938276) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:18.938607) ========= script_repo_revision: 709652b674013b136627e45fd90b4e9063906a19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:18.939083) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:18.939427) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 03:16:18.950874) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 30 secs) (at 2016-07-14 03:16:18.951334) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:16:20 INFO - MultiFileLogger online at 20160714 03:16:20 in /builds/slave/test 03:16:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:16:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:16:20 INFO - {'append_to_log': False, 03:16:20 INFO - 'base_work_dir': '/builds/slave/test', 03:16:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:16:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:16:20 INFO - 'branch': 'Mozilla-Aurora', 03:16:20 INFO - 'buildbot_json_path': 'buildprops.json', 03:16:20 INFO - 'config_files': ('talos/linux_config.py',), 03:16:20 INFO - 'default_actions': ('clobber', 03:16:20 INFO - 'read-buildbot-config', 03:16:20 INFO - 'download-and-extract', 03:16:20 INFO - 'populate-webroot', 03:16:20 INFO - 'create-virtualenv', 03:16:20 INFO - 'install', 03:16:20 INFO - 'run-tests'), 03:16:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:16:20 INFO - 'download_minidump_stackwalk': True, 03:16:20 INFO - 'download_symbols': 'ondemand', 03:16:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:16:20 INFO - 'tooltool.py': '/tools/tooltool.py', 03:16:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:16:20 INFO - '/tools/misc-python/virtualenv.py')}, 03:16:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:16:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:16:20 INFO - 'installer_path': 'installer.exe', 03:16:20 INFO - 'log_level': 'info', 03:16:20 INFO - 'log_name': 'talos', 03:16:20 INFO - 'log_to_console': True, 03:16:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:16:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:16:20 INFO - 'opt_config_files': (), 03:16:20 INFO - 'pip_index': False, 03:16:20 INFO - 'sps_profile': False, 03:16:20 INFO - 'sps_profile_interval': 0, 03:16:20 INFO - 'suite': 'dromaeojs', 03:16:20 INFO - 'system_bits': '32', 03:16:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:16:20 INFO - 'title': 'talos-linux64-ix-061', 03:16:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:16:20 INFO - 'use_talos_json': True, 03:16:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:16:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:16:20 INFO - 'work_dir': 'build'} 03:16:20 INFO - ##### 03:16:20 INFO - ##### Running clobber step. 03:16:20 INFO - ##### 03:16:20 INFO - Running pre-action listener: _resource_record_pre_action 03:16:20 INFO - Running main action method: clobber 03:16:20 INFO - rmtree: /builds/slave/test/build 03:16:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:16:20 INFO - Running post-action listener: _resource_record_post_action 03:16:20 INFO - ##### 03:16:20 INFO - ##### Finished clobber step (success) 03:16:20 INFO - ##### 03:16:20 INFO - ##### 03:16:20 INFO - ##### Running read-buildbot-config step. 03:16:20 INFO - ##### 03:16:20 INFO - Running pre-action listener: _resource_record_pre_action 03:16:20 INFO - Running main action method: read_buildbot_config 03:16:20 INFO - Using buildbot properties: 03:16:20 INFO - { 03:16:20 INFO - "project": "", 03:16:20 INFO - "product": "firefox", 03:16:20 INFO - "script_repo_revision": "production", 03:16:20 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:16:20 INFO - "repository": "", 03:16:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:16:20 INFO - "buildid": "20160714004054", 03:16:20 INFO - "stage_platform": "linux64-pgo", 03:16:20 INFO - "basedir": "/builds/slave/test", 03:16:20 INFO - "nightly_build": "True", 03:16:20 INFO - "buildnumber": 413, 03:16:20 INFO - "slavename": "talos-linux64-ix-061", 03:16:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:16:20 INFO - "platform": "ubuntu64_hw", 03:16:20 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:16:20 INFO - "branch": "mozilla-aurora", 03:16:20 INFO - "repo_path": "releases/mozilla-aurora", 03:16:20 INFO - "revision": "709652b674013b136627e45fd90b4e9063906a19", 03:16:20 INFO - "pgo_build": "True", 03:16:20 INFO - "builduid": "6a8ca11f4a37440eb3d20ce92e3d6eb6", 03:16:20 INFO - "slavebuilddir": "test" 03:16:20 INFO - } 03:16:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 03:16:20 INFO - Running post-action listener: _resource_record_post_action 03:16:20 INFO - ##### 03:16:20 INFO - ##### Finished read-buildbot-config step (success) 03:16:20 INFO - ##### 03:16:20 INFO - ##### 03:16:20 INFO - ##### Running download-and-extract step. 03:16:20 INFO - ##### 03:16:20 INFO - Running pre-action listener: _resource_record_pre_action 03:16:20 INFO - Running main action method: download_and_extract 03:16:20 INFO - mkdir: /builds/slave/test/build/tests 03:16: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')]} 03:16:20 INFO - https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:16:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:16:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:16:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:16:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:16:21 INFO - Downloaded 1361 bytes. 03:16:21 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 03:16:21 INFO - Using the following test package requirements: 03:16:21 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:16:21 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:16:21 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:16:21 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:21 INFO - u'jsshell-linux-x86_64.zip'], 03:16:21 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:16:21 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 03:16:21 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:16:21 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:16:21 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:16:21 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 03:16:21 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:16:21 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:21 INFO - https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:16:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:16:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:16:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:16:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:16:23 INFO - Downloaded 24490960 bytes. 03:16:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:16:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:16:25 INFO - Return code: 0 03:16:25 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:16:25 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')]} 03:16:25 INFO - https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:16:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:16:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:16:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 03:16:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:16:26 INFO - Downloaded 24490960 bytes. 03:16:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:16:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:16:27 INFO - Return code: 0 03:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:27 INFO - https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:16:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:16:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:16:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 03:16:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:16:28 INFO - Downloaded 10833369 bytes. 03:16:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:16:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:16:28 INFO - Return code: 0 03:16: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')]} 03:16:28 INFO - https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:16:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:16:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:16:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:16:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:16:30 INFO - Downloaded 63594329 bytes. 03:16:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:16:30 INFO - mkdir: /builds/slave/test/properties 03:16:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:16:30 INFO - Writing to file /builds/slave/test/properties/build_url 03:16:30 INFO - Contents: 03:16:30 INFO - build_url:https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 03:16:30 INFO - Running post-action listener: _resource_record_post_action 03:16:30 INFO - Running post-action listener: set_extra_try_arguments 03:16:30 INFO - ##### 03:16:30 INFO - ##### Finished download-and-extract step (success) 03:16:30 INFO - ##### 03:16:30 INFO - ##### 03:16:30 INFO - ##### Running populate-webroot step. 03:16:30 INFO - ##### 03:16:30 INFO - Running pre-action listener: _resource_record_pre_action 03:16:30 INFO - Running main action method: populate_webroot 03:16:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:16:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:16:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:16:30 INFO - '--tppagecycles', 03:16:30 INFO - '7'], 03:16:30 INFO - 'tests': ['tsvgm']}}, 03:16:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:16:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:16:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:16:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:16:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:16:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:16:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:30 INFO - 'talos_options': ['--disable-e10s'], 03:16:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:16:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:16:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:30 INFO - 'talos_options': ['--disable-e10s'], 03:16:30 INFO - 'tests': ['damp', 'tps']}, 03:16:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:30 INFO - 'tests': ['damp', 'tps']}, 03:16:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:16:30 INFO - 'tests': ['dromaeo_dom']}, 03:16:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:16:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:16:30 INFO - 'tests': ['a11yr', 03:16:30 INFO - 'ts_paint', 03:16:30 INFO - 'tpaint', 03:16:30 INFO - 'sessionrestore', 03:16:30 INFO - 'sessionrestore_no_auto_restore', 03:16:30 INFO - 'tabpaint']}, 03:16:30 INFO - 'other-e10s': {'tests': ['a11yr', 03:16:30 INFO - 'ts_paint', 03:16:30 INFO - 'tpaint', 03:16:30 INFO - 'sessionrestore', 03:16:30 INFO - 'sessionrestore_no_auto_restore', 03:16:30 INFO - 'tabpaint']}, 03:16:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:16:30 INFO - 'ts_paint', 03:16:30 INFO - 'tpaint', 03:16:30 INFO - 'sessionrestore', 03:16:30 INFO - 'sessionrestore_no_auto_restore', 03:16:30 INFO - 'tabpaint']}, 03:16:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:16:30 INFO - 'ts_paint', 03:16:30 INFO - 'tpaint', 03:16:30 INFO - 'sessionrestore', 03:16:30 INFO - 'sessionrestore_no_auto_restore', 03:16:30 INFO - 'tabpaint']}, 03:16:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:16:30 INFO - 'tests': ['a11yr', 03:16:30 INFO - 'ts_paint', 03:16:30 INFO - 'tpaint', 03:16:30 INFO - 'sessionrestore', 03:16:30 INFO - 'sessionrestore_no_auto_restore', 03:16:30 INFO - 'tabpaint']}, 03:16:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:16:30 INFO - 'tests': ['a11yr', 03:16:30 INFO - 'ts_paint', 03:16:30 INFO - 'tpaint', 03:16:30 INFO - 'sessionrestore', 03:16:30 INFO - 'sessionrestore_no_auto_restore', 03:16:30 INFO - 'tabpaint']}, 03:16:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:16:30 INFO - 'tests': ['tsvgx', 03:16:30 INFO - 'tsvgr_opacity', 03:16:30 INFO - 'tart', 03:16:30 INFO - 'tscrollx', 03:16:30 INFO - 'cart']}, 03:16:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:16:30 INFO - 'tsvgr_opacity', 03:16:30 INFO - 'tart', 03:16:30 INFO - 'tscrollx', 03:16:30 INFO - 'cart']}, 03:16:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:30 INFO - 'talos_options': ['--disable-e10s'], 03:16:30 INFO - 'tests': ['tp5o']}, 03:16:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:30 INFO - 'tests': ['tp5o']}, 03:16:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:30 INFO - 'talos_options': ['--disable-e10s', 03:16:30 INFO - '--xperf_path', 03:16:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:16:30 INFO - 'tests': ['tp5n']}, 03:16:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:16:30 INFO - 'talos_options': ['--xperf_path', 03:16:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:16:30 INFO - 'tests': ['tp5n']}}, 03:16:30 INFO - 'talos.zip': {'path': '', 03:16:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:16:30 INFO - Running post-action listener: _resource_record_post_action 03:16:30 INFO - ##### 03:16:30 INFO - ##### Finished populate-webroot step (success) 03:16:30 INFO - ##### 03:16:30 INFO - ##### 03:16:30 INFO - ##### Running create-virtualenv step. 03:16:30 INFO - ##### 03:16:30 INFO - Running pre-action listener: _resource_record_pre_action 03:16:30 INFO - Running main action method: create_virtualenv 03:16:30 INFO - Creating virtualenv /builds/slave/test/build/venv 03:16:30 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 03:16:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:16:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:16:31 INFO - Using real prefix '/usr' 03:16:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:16:31 INFO - Installing distribute.............................................................................................................................................................................................done. 03:16:33 INFO - Installing pip.................done. 03:16:33 INFO - Return code: 0 03:16:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:16: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')]} 03:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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')]} 03:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f205d15cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d392e0>, '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 0x1ca5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca55d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', '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 03:16: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', 'pip>=1.5'] in /builds/slave/test/build 03:16: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 pip>=1.5 03:16:33 INFO - Using env: {'DISPLAY': ':0', 03:16:33 INFO - 'HOME': '/home/cltbld', 03:16:33 INFO - 'LANG': 'en_US.UTF-8', 03:16:33 INFO - 'LANGUAGE': 'en_US:en', 03:16:33 INFO - 'LOGNAME': 'cltbld', 03:16:33 INFO - 'MAIL': '/var/mail/cltbld', 03:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:33 INFO - 'MOZ_NO_REMOTE': '1', 03:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:33 INFO - 'NO_EM_RESTART': '1', 03:16:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:33 INFO - 'PWD': '/builds/slave/test', 03:16:33 INFO - 'SHELL': '/bin/bash', 03:16:33 INFO - 'SHLVL': '1', 03:16:33 INFO - 'TERM': 'linux', 03:16:33 INFO - 'TMOUT': '86400', 03:16:33 INFO - 'USER': 'cltbld', 03:16:33 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', 03:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:33 INFO - '_': '/tools/buildbot/bin/python'} 03:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:33 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 03:16:33 INFO - Cleaning up... 03:16:33 INFO - Return code: 0 03:16:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:16: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')]} 03:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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')]} 03:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16: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', '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 0x7f205d15cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d392e0>, '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 0x1ca5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca55d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', '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 03:16: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:16: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 psutil>=3.1.1 03:16:33 INFO - Using env: {'DISPLAY': ':0', 03:16:33 INFO - 'HOME': '/home/cltbld', 03:16:33 INFO - 'LANG': 'en_US.UTF-8', 03:16:33 INFO - 'LANGUAGE': 'en_US:en', 03:16:33 INFO - 'LOGNAME': 'cltbld', 03:16:33 INFO - 'MAIL': '/var/mail/cltbld', 03:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:33 INFO - 'MOZ_NO_REMOTE': '1', 03:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:33 INFO - 'NO_EM_RESTART': '1', 03:16:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:33 INFO - 'PWD': '/builds/slave/test', 03:16:33 INFO - 'SHELL': '/bin/bash', 03:16:33 INFO - 'SHLVL': '1', 03:16:33 INFO - 'TERM': 'linux', 03:16:33 INFO - 'TMOUT': '86400', 03:16:33 INFO - 'USER': 'cltbld', 03:16:33 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', 03:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:33 INFO - '_': '/tools/buildbot/bin/python'} 03:16:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:33 INFO - Downloading/unpacking psutil>=3.1.1 03:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:16:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:16:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:16:35 INFO - Installing collected packages: psutil 03:16:35 INFO - Running setup.py install for psutil 03:16:35 INFO - building 'psutil._psutil_linux' extension 03:16:35 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 03:16:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:16:36 INFO - building 'psutil._psutil_posix' extension 03:16:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:16:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:16:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:16:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:16:36 INFO - Successfully installed psutil 03:16:36 INFO - Cleaning up... 03:16:36 INFO - Return code: 0 03:16:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f205d15cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d392e0>, '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 0x1ca5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca55d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', '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 03:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:16:36 INFO - Using env: {'DISPLAY': ':0', 03:16:36 INFO - 'HOME': '/home/cltbld', 03:16:36 INFO - 'LANG': 'en_US.UTF-8', 03:16:36 INFO - 'LANGUAGE': 'en_US:en', 03:16:36 INFO - 'LOGNAME': 'cltbld', 03:16:36 INFO - 'MAIL': '/var/mail/cltbld', 03:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:36 INFO - 'MOZ_NO_REMOTE': '1', 03:16:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:36 INFO - 'NO_EM_RESTART': '1', 03:16:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:36 INFO - 'PWD': '/builds/slave/test', 03:16:36 INFO - 'SHELL': '/bin/bash', 03:16:36 INFO - 'SHLVL': '1', 03:16:36 INFO - 'TERM': 'linux', 03:16:36 INFO - 'TMOUT': '86400', 03:16:36 INFO - 'USER': 'cltbld', 03:16:36 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', 03:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:36 INFO - '_': '/tools/buildbot/bin/python'} 03:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16: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 03:16:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:16:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:16:38 INFO - Installing collected packages: mozsystemmonitor 03:16:38 INFO - Running setup.py install for mozsystemmonitor 03:16:38 INFO - Successfully installed mozsystemmonitor 03:16:38 INFO - Cleaning up... 03:16:38 INFO - Return code: 0 03:16:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f205d15cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d392e0>, '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 0x1ca5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca55d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', '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 03:16:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:16:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:16:38 INFO - Using env: {'DISPLAY': ':0', 03:16:38 INFO - 'HOME': '/home/cltbld', 03:16:38 INFO - 'LANG': 'en_US.UTF-8', 03:16:38 INFO - 'LANGUAGE': 'en_US:en', 03:16:38 INFO - 'LOGNAME': 'cltbld', 03:16:38 INFO - 'MAIL': '/var/mail/cltbld', 03:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:38 INFO - 'MOZ_NO_REMOTE': '1', 03:16:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:38 INFO - 'NO_EM_RESTART': '1', 03:16:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:38 INFO - 'PWD': '/builds/slave/test', 03:16:38 INFO - 'SHELL': '/bin/bash', 03:16:38 INFO - 'SHLVL': '1', 03:16:38 INFO - 'TERM': 'linux', 03:16:38 INFO - 'TMOUT': '86400', 03:16:38 INFO - 'USER': 'cltbld', 03:16:38 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', 03:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:38 INFO - '_': '/tools/buildbot/bin/python'} 03:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:38 INFO - Downloading/unpacking jsonschema==2.5.1 03:16:38 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 03:16:38 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 03:16:38 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 03:16:38 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 03:16:38 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 03:16:38 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 03:16:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:16:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:16:40 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 03:16:40 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 03:16:40 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 03:16:40 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 03:16:40 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 03:16:40 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 03:16:41 INFO - Downloading functools32-3.2.3-2.tar.gz 03:16:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:16:41 INFO - warning: no files found matching '*.txt' 03:16:41 INFO - no previously-included directories found matching 'build' 03:16:41 INFO - no previously-included directories found matching 'dist' 03:16:41 INFO - no previously-included directories found matching '.git*' 03:16:41 INFO - Installing collected packages: jsonschema, functools32 03:16:41 INFO - Running setup.py install for functools32 03:16:41 INFO - warning: no files found matching '*.txt' 03:16:41 INFO - no previously-included directories found matching 'build' 03:16:41 INFO - no previously-included directories found matching 'dist' 03:16:41 INFO - no previously-included directories found matching '.git*' 03:16:41 INFO - Successfully installed jsonschema functools32 03:16:41 INFO - Cleaning up... 03:16:41 INFO - Return code: 0 03:16:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f205d15cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d392e0>, '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 0x1ca5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca55d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', '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 03:16:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:16:41 INFO - Using env: {'DISPLAY': ':0', 03:16:41 INFO - 'HOME': '/home/cltbld', 03:16:41 INFO - 'LANG': 'en_US.UTF-8', 03:16:41 INFO - 'LANGUAGE': 'en_US:en', 03:16:41 INFO - 'LOGNAME': 'cltbld', 03:16:41 INFO - 'MAIL': '/var/mail/cltbld', 03:16:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:41 INFO - 'MOZ_NO_REMOTE': '1', 03:16:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:41 INFO - 'NO_EM_RESTART': '1', 03:16:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:41 INFO - 'PWD': '/builds/slave/test', 03:16:41 INFO - 'SHELL': '/bin/bash', 03:16:41 INFO - 'SHLVL': '1', 03:16:41 INFO - 'TERM': 'linux', 03:16:41 INFO - 'TMOUT': '86400', 03:16:41 INFO - 'USER': 'cltbld', 03:16:41 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', 03:16:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:41 INFO - '_': '/tools/buildbot/bin/python'} 03:16:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:41 INFO - Downloading/unpacking blobuploader==1.2.4 03:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:43 INFO - Downloading blobuploader-1.2.4.tar.gz 03:16:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:16:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:16:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:44 INFO - Downloading docopt-0.6.1.tar.gz 03:16:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:16:44 INFO - Installing collected packages: blobuploader, requests, docopt 03:16:44 INFO - Running setup.py install for blobuploader 03:16:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:16:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:16:44 INFO - Running setup.py install for requests 03:16:44 INFO - Running setup.py install for docopt 03:16:44 INFO - Successfully installed blobuploader requests docopt 03:16:44 INFO - Cleaning up... 03:16:44 INFO - Return code: 0 03:16:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:44 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 0x7f205d15cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d392e0>, '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 0x1ca5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca55d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', '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 03:16:44 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 03:16:44 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 03:16:44 INFO - Using env: {'DISPLAY': ':0', 03:16:44 INFO - 'HOME': '/home/cltbld', 03:16:44 INFO - 'LANG': 'en_US.UTF-8', 03:16:44 INFO - 'LANGUAGE': 'en_US:en', 03:16:44 INFO - 'LOGNAME': 'cltbld', 03:16:44 INFO - 'MAIL': '/var/mail/cltbld', 03:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:44 INFO - 'MOZ_NO_REMOTE': '1', 03:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:44 INFO - 'NO_EM_RESTART': '1', 03:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:44 INFO - 'PWD': '/builds/slave/test', 03:16:44 INFO - 'SHELL': '/bin/bash', 03:16:44 INFO - 'SHLVL': '1', 03:16:44 INFO - 'TERM': 'linux', 03:16:44 INFO - 'TMOUT': '86400', 03:16:44 INFO - 'USER': 'cltbld', 03:16:44 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', 03:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:44 INFO - '_': '/tools/buildbot/bin/python'} 03:16:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:45 INFO - Running setup.py (path:/tmp/pip-qrpXua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:45 INFO - Running setup.py (path:/tmp/pip-6fLl9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:45 INFO - Running setup.py (path:/tmp/pip-KAy3BF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:45 INFO - Running setup.py (path:/tmp/pip-rTx6cJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:45 INFO - Running setup.py (path:/tmp/pip-PE4M9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:45 INFO - Running setup.py (path:/tmp/pip-qfTifV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:45 INFO - Running setup.py (path:/tmp/pip-_xmjrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:45 INFO - Running setup.py (path:/tmp/pip-dh04SS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:45 INFO - Running setup.py (path:/tmp/pip-sj3TU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:45 INFO - Running setup.py (path:/tmp/pip-5ktLpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:45 INFO - Running setup.py (path:/tmp/pip-pTL_Ne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:45 INFO - Running setup.py (path:/tmp/pip-TIjV4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:45 INFO - Running setup.py (path:/tmp/pip-QCJ78s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:46 INFO - Running setup.py (path:/tmp/pip-Oyz9Wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:46 INFO - Running setup.py (path:/tmp/pip-cShymE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:46 INFO - Running setup.py (path:/tmp/pip-agfDti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:46 INFO - Running setup.py (path:/tmp/pip-gEEVZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:16:46 INFO - Running setup.py install for manifestparser 03:16:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:16:46 INFO - Running setup.py install for mozcrash 03:16:46 INFO - Running setup.py install for mozdebug 03:16:46 INFO - Running setup.py install for mozdevice 03:16:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:16:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:16:46 INFO - Running setup.py install for mozfile 03:16:46 INFO - Running setup.py install for mozhttpd 03:16:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:16:46 INFO - Running setup.py install for mozinfo 03:16:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:16:47 INFO - Running setup.py install for mozInstall 03:16:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:16:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:16:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:16:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:16:47 INFO - Running setup.py install for mozleak 03:16:47 INFO - Running setup.py install for mozlog 03:16:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:16:47 INFO - Running setup.py install for moznetwork 03:16:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:16:47 INFO - Running setup.py install for mozprocess 03:16:47 INFO - Running setup.py install for mozprofile 03:16:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:16:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:16:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:16:47 INFO - Running setup.py install for mozrunner 03:16:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:16:47 INFO - Running setup.py install for mozscreenshot 03:16:47 INFO - Running setup.py install for moztest 03:16:48 INFO - Running setup.py install for mozversion 03:16:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:16:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:16:48 INFO - Cleaning up... 03:16:48 INFO - Return code: 0 03:16:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f205d15cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d392e0>, '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 0x1ca5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca55d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', '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 03:16:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:16:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:16:48 INFO - Using env: {'DISPLAY': ':0', 03:16:48 INFO - 'HOME': '/home/cltbld', 03:16:48 INFO - 'LANG': 'en_US.UTF-8', 03:16:48 INFO - 'LANGUAGE': 'en_US:en', 03:16:48 INFO - 'LOGNAME': 'cltbld', 03:16:48 INFO - 'MAIL': '/var/mail/cltbld', 03:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:48 INFO - 'MOZ_NO_REMOTE': '1', 03:16:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:48 INFO - 'NO_EM_RESTART': '1', 03:16:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:48 INFO - 'PWD': '/builds/slave/test', 03:16:48 INFO - 'SHELL': '/bin/bash', 03:16:48 INFO - 'SHLVL': '1', 03:16:48 INFO - 'TERM': 'linux', 03:16:48 INFO - 'TMOUT': '86400', 03:16:48 INFO - 'USER': 'cltbld', 03:16:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', 03:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:48 INFO - '_': '/tools/buildbot/bin/python'} 03:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:16:48 INFO - Running setup.py (path:/tmp/pip-CAg5ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:16:48 INFO - Running setup.py (path:/tmp/pip-7z_NEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:16:48 INFO - Running setup.py (path:/tmp/pip-xebusY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:16:48 INFO - Running setup.py (path:/tmp/pip-iztazj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:16:48 INFO - Running setup.py (path:/tmp/pip-YVy_PQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:16:48 INFO - Running setup.py (path:/tmp/pip-nC6EV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:16:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:16:48 INFO - Running setup.py (path:/tmp/pip-k6V20b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:16:48 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)) 03:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:16:48 INFO - Running setup.py (path:/tmp/pip-2lQUF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:16:48 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)) 03:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:16:48 INFO - Running setup.py (path:/tmp/pip-RZ9AFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:16:49 INFO - Running setup.py (path:/tmp/pip-2rNF2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:16:49 INFO - Running setup.py (path:/tmp/pip-VgXD1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:16:49 INFO - Running setup.py (path:/tmp/pip-fZwRvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:16:49 INFO - Running setup.py (path:/tmp/pip-BHB1mE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:16:49 INFO - Running setup.py (path:/tmp/pip-v43Mrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:49 INFO - Running setup.py (path:/tmp/pip-l620uK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:16:49 INFO - Running setup.py (path:/tmp/pip-7UznJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:16:49 INFO - Running setup.py (path:/tmp/pip-EeebNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:16:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:51 INFO - Downloading blessings-1.6.tar.gz 03:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:16:51 INFO - Installing collected packages: blessings 03:16:51 INFO - Running setup.py install for blessings 03:16:51 INFO - Successfully installed blessings 03:16:51 INFO - Cleaning up... 03:16:51 INFO - Return code: 0 03:16:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:16:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:51 INFO - Reading from file tmpfile_stdout 03:16:51 INFO - Current package versions: 03:16:51 INFO - argparse == 1.2.1 03:16:51 INFO - blessings == 1.6 03:16:51 INFO - blobuploader == 1.2.4 03:16:51 INFO - docopt == 0.6.1 03:16:51 INFO - functools32 == 3.2.3-2 03:16:51 INFO - jsonschema == 2.5.1 03:16:51 INFO - manifestparser == 1.1 03:16:51 INFO - mozInstall == 1.12 03:16:51 INFO - mozcrash == 0.17 03:16:51 INFO - mozdebug == 0.1 03:16:51 INFO - mozdevice == 0.48 03:16:51 INFO - mozfile == 1.2 03:16:51 INFO - mozhttpd == 0.7 03:16:51 INFO - mozinfo == 0.9 03:16:51 INFO - mozleak == 0.1 03:16:51 INFO - mozlog == 3.2 03:16:51 INFO - moznetwork == 0.27 03:16:51 INFO - mozprocess == 0.23 03:16:51 INFO - mozprofile == 0.28 03:16:51 INFO - mozrunner == 6.12 03:16:51 INFO - mozscreenshot == 0.1 03:16:51 INFO - mozsystemmonitor == 0.3 03:16:51 INFO - moztest == 0.7 03:16:51 INFO - mozversion == 1.4 03:16:51 INFO - psutil == 3.1.1 03:16:51 INFO - requests == 1.2.3 03:16:51 INFO - wsgiref == 0.1.2 03:16:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:16:51 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')]} 03:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:51 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')]} 03:16:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:51 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 0x7f205d15cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d392e0>, '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 0x1ca5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca55d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', '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 03:16:51 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 03:16:51 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 03:16:51 INFO - Using env: {'DISPLAY': ':0', 03:16:51 INFO - 'HOME': '/home/cltbld', 03:16:51 INFO - 'LANG': 'en_US.UTF-8', 03:16:51 INFO - 'LANGUAGE': 'en_US:en', 03:16:51 INFO - 'LOGNAME': 'cltbld', 03:16:51 INFO - 'MAIL': '/var/mail/cltbld', 03:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:51 INFO - 'MOZ_NO_REMOTE': '1', 03:16:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:51 INFO - 'NO_EM_RESTART': '1', 03:16:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:51 INFO - 'PWD': '/builds/slave/test', 03:16:51 INFO - 'SHELL': '/bin/bash', 03:16:51 INFO - 'SHLVL': '1', 03:16:51 INFO - 'TERM': 'linux', 03:16:51 INFO - 'TMOUT': '86400', 03:16:51 INFO - 'USER': 'cltbld', 03:16:51 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', 03:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:51 INFO - '_': '/tools/buildbot/bin/python'} 03:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:16:52 INFO - Cleaning up... 03:16:52 INFO - Return code: 0 03:16:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f205d15cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d392e0>, '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 0x1ca5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca55d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', '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 03:16:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:16:52 INFO - Using env: {'DISPLAY': ':0', 03:16:52 INFO - 'HOME': '/home/cltbld', 03:16:52 INFO - 'LANG': 'en_US.UTF-8', 03:16:52 INFO - 'LANGUAGE': 'en_US:en', 03:16:52 INFO - 'LOGNAME': 'cltbld', 03:16:52 INFO - 'MAIL': '/var/mail/cltbld', 03:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:52 INFO - 'MOZ_NO_REMOTE': '1', 03:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:52 INFO - 'NO_EM_RESTART': '1', 03:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:52 INFO - 'PWD': '/builds/slave/test', 03:16:52 INFO - 'SHELL': '/bin/bash', 03:16:52 INFO - 'SHLVL': '1', 03:16:52 INFO - 'TERM': 'linux', 03:16:52 INFO - 'TMOUT': '86400', 03:16:52 INFO - 'USER': 'cltbld', 03:16:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', 03:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:52 INFO - '_': '/tools/buildbot/bin/python'} 03:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:16:52 INFO - Cleaning up... 03:16:52 INFO - Return code: 0 03:16:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:16:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f205d15cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bda8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ca7020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d392e0>, '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 0x1ca5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca55d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', '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 03:16:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:16:52 INFO - Using env: {'DISPLAY': ':0', 03:16:52 INFO - 'HOME': '/home/cltbld', 03:16:52 INFO - 'LANG': 'en_US.UTF-8', 03:16:52 INFO - 'LANGUAGE': 'en_US:en', 03:16:52 INFO - 'LOGNAME': 'cltbld', 03:16:52 INFO - 'MAIL': '/var/mail/cltbld', 03:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:52 INFO - 'MOZ_NO_REMOTE': '1', 03:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:52 INFO - 'NO_EM_RESTART': '1', 03:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:52 INFO - 'PWD': '/builds/slave/test', 03:16:52 INFO - 'SHELL': '/bin/bash', 03:16:52 INFO - 'SHLVL': '1', 03:16:52 INFO - 'TERM': 'linux', 03:16:52 INFO - 'TMOUT': '86400', 03:16:52 INFO - 'USER': 'cltbld', 03:16:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', 03:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:52 INFO - '_': '/tools/buildbot/bin/python'} 03:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:16:52 INFO - Downloading/unpacking flake8 03:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:16:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:16:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:16:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:16:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:16:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:16:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:16:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:16:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:16:55 INFO - no previously-included directories found matching 'docs/_build' 03:16:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:16:55 INFO - Running setup.py install for pep8 03:16:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:16:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:16:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:16:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:16:55 INFO - no previously-included directories found matching 'docs/_build' 03:16:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:16:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:16:55 INFO - Cleaning up... 03:16:55 INFO - Return code: 0 03:16:55 INFO - Running post-action listener: _resource_record_post_action 03:16:55 INFO - Running post-action listener: _start_resource_monitoring 03:16:55 INFO - Starting resource monitoring. 03:16:55 INFO - ##### 03:16:55 INFO - ##### Finished create-virtualenv step (success) 03:16:55 INFO - ##### 03:16:55 INFO - ##### 03:16:55 INFO - ##### Running install step. 03:16:55 INFO - ##### 03:16:55 INFO - Running pre-action listener: _resource_record_pre_action 03:16:55 INFO - Running main action method: install 03:16:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:16:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:16:55 INFO - Reading from file tmpfile_stdout 03:16:55 INFO - Detecting whether we're running mozinstall >=1.0... 03:16:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:16:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:16:55 INFO - Reading from file tmpfile_stdout 03:16:55 INFO - Output received: 03:16:55 INFO - Usage: mozinstall [options] installer 03:16:55 INFO - Options: 03:16:55 INFO - -h, --help show this help message and exit 03:16:55 INFO - -d DEST, --destination=DEST 03:16:55 INFO - Directory to install application into. [default: 03:16:55 INFO - "/builds/slave/test"] 03:16:55 INFO - --app=APP Application being installed. [default: firefox] 03:16:55 INFO - mkdir: /builds/slave/test/build/application 03:16:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:16:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:17:11 INFO - Reading from file tmpfile_stdout 03:17:11 INFO - Output received: 03:17:11 INFO - /builds/slave/test/build/application/firefox/firefox 03:17:11 INFO - Running post-action listener: _resource_record_post_action 03:17:11 INFO - ##### 03:17:11 INFO - ##### Finished install step (success) 03:17:11 INFO - ##### 03:17:11 INFO - ##### 03:17:11 INFO - ##### Running run-tests step. 03:17:11 INFO - ##### 03:17:11 INFO - Running pre-action listener: _resource_record_pre_action 03:17:11 INFO - Running main action method: run_tests 03:17:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:17:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:17:11 INFO - Python 2.7.3 03:17:11 INFO - Return code: 0 03:17:11 INFO - grabbing minidump binary from tooltool 03:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:17:11 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 0x1d392e0>, '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 0x1ca5140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ca55d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:17:11 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 03:17:11 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 03:17:11 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 03:17:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:17:11 INFO - Return code: 0 03:17:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:17:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:17:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:17:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:17:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:17:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:17:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:17:12 INFO - Return code: 0 03:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 03:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 03:17:12 INFO - Using env: {'DISPLAY': ':0', 03:17:12 INFO - 'HOME': '/home/cltbld', 03:17:12 INFO - 'LANG': 'en_US.UTF-8', 03:17:12 INFO - 'LANGUAGE': 'en_US:en', 03:17:12 INFO - 'LOGNAME': 'cltbld', 03:17:12 INFO - 'MAIL': '/var/mail/cltbld', 03:17:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:17:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:12 INFO - 'MOZ_NO_REMOTE': '1', 03:17:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:17:12 INFO - 'NO_EM_RESTART': '1', 03:17:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:12 INFO - 'PWD': '/builds/slave/test', 03:17:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:17:12 INFO - 'SHELL': '/bin/bash', 03:17:12 INFO - 'SHLVL': '1', 03:17:12 INFO - 'TERM': 'linux', 03:17:12 INFO - 'TMOUT': '86400', 03:17:12 INFO - 'USER': 'cltbld', 03:17:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087', 03:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:12 INFO - '_': '/tools/buildbot/bin/python'} 03:17:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 03:17:12 INFO - mozversion application_buildid: 20160714004054 03:17:12 INFO - mozversion application_changeset: 709652b674013b136627e45fd90b4e9063906a19 03:17:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:17:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:17:12 INFO - mozversion application_name: Firefox 03:17:12 INFO - mozversion application_remotingname: firefox-dev 03:17:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:17:12 INFO - mozversion application_vendor: Mozilla 03:17:12 INFO - mozversion application_version: 49.0a2 03:17:12 INFO - mozversion platform_buildid: 20160714004054 03:17:12 INFO - mozversion platform_changeset: 709652b674013b136627e45fd90b4e9063906a19 03:17:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:17:12 INFO - mozversion platform_version: 49.0a2 03:17:12 INFO - using testdate: 1468491432 03:17:12 INFO - actual date: 1468491432 03:17:12 INFO - starting webserver on 'localhost:45913' 03:17:12 INFO - SUITE-START | Running 2 tests 03:17:12 INFO - TEST-START | dromaeo_css 03:17:12 INFO - operating with platform_type : linux_ 03:17:12 INFO - Initialising browser for dromaeo_css test... 03:17:12 INFO - TEST-INFO | started process 32423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO5oOmK/profile http://localhost:45913/getInfo.html) 03:17:17 INFO - PROCESS | 32423 | __metrics Screen width/height:1600/1200 03:17:17 INFO - PROCESS | 32423 | colorDepth:24 03:17:17 INFO - PROCESS | 32423 | Browser inner width/height: 1024/697 03:17:17 INFO - PROCESS | 32423 | __metrics 03:17:18 ERROR - PROCESS | 32423 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:17:19 INFO - TEST-INFO | 32423: exit 0 03:17:19 INFO - Browser initialized. 03:17:19 INFO - Running cycle 1/1 for dromaeo_css test... 03:17:19 INFO - TEST-INFO | started process 32515 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO5oOmK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:17:30 INFO - PROCESS | 32515 | RSS: Main: 145072128 03:17:30 INFO - PROCESS | 32515 | 03:18:22 INFO - PROCESS | 32515 | 1468491502124 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] 03:20:30 INFO - PROCESS | 32515 | Cycle 1(1): loaded http://localhost:45913/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45913/tests/dromaeo/cssquery-ext.html) 03:20:31 INFO - PROCESS | 32515 | RSS: Main: 257585152 03:20:31 INFO - PROCESS | 32515 | 03:23:33 INFO - PROCESS | 32515 | Cycle 1(1): loaded http://localhost:45913/tests/dromaeo/cssquery-ext.html (next: http://localhost:45913/tests/dromaeo/cssquery-jquery.html) 03:23:34 INFO - PROCESS | 32515 | RSS: Main: 228532224 03:23:34 INFO - PROCESS | 32515 | 03:26:36 INFO - PROCESS | 32515 | Cycle 1(1): loaded http://localhost:45913/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45913/tests/dromaeo/cssquery-mootools.html) 03:26:36 INFO - PROCESS | 32515 | RSS: Main: 228192256 03:26:36 INFO - PROCESS | 32515 | 03:29:38 INFO - PROCESS | 32515 | Cycle 1(1): loaded http://localhost:45913/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45913/tests/dromaeo/cssquery-prototype.html) 03:29:39 INFO - PROCESS | 32515 | RSS: Main: 221618176 03:29:39 INFO - PROCESS | 32515 | 03:32:41 INFO - PROCESS | 32515 | Cycle 1(1): loaded http://localhost:45913/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45913/tests/dromaeo/cssquery-yui.html) 03:32:42 INFO - PROCESS | 32515 | RSS: Main: 217997312 03:32:42 INFO - PROCESS | 32515 | 03:35:44 INFO - PROCESS | 32515 | Cycle 1(1): loaded http://localhost:45913/tests/dromaeo/cssquery-yui.html (next: http://localhost:45913/tests/dromaeo/cssquery-dojo.html) 03:35:45 INFO - PROCESS | 32515 | RSS: Main: 246185984 03:35:45 INFO - PROCESS | 32515 | 03:35:45 INFO - PROCESS | 32515 | __start_tp_report 03:35:45 INFO - PROCESS | 32515 | _x_x_mozilla_page_load 03:35:45 INFO - PROCESS | 32515 | _x_x_mozilla_page_load_details 03:35:45 INFO - PROCESS | 32515 | |i|pagename|runs| 03:35:45 INFO - PROCESS | 32515 | |0;dojo.html;3235.870565177393;3268.0849362178596;3269.9509507357393;3305.8677652893884;3322.202671358873;5494.725263736812;5571.637843540167;5575.832725018251;5606.103023516238;5623.803166889154;5502.58730595205;5558.805441809537;5560.499555040045;5565.41563135871;5595.272614560102;4959.8016079356785;4965.255211718253;5010.273510341008;5024.572911302544;5070.898582028357;5022.924656130161;5088;5100.897982040357;5101.948980510203;5104.5405913467785;5003.14946459101;5021.623378246646;5039.899202015958;5050.924236136461;5064.3922729272535;5107.106256405114;5128.461511541272;5131.974340128313;5137.17805151174;5151.278820965068;4852.878678033042;4888.73111978841;4952.380952380952;5044.596432285445;5076.390833100052;5386.1920711893135;5414.296141501619;5433.891322173574;5461.1808228766;5487.012337779198;5966.105084237399;5998.460138587505;6006.249218847644;6012.5791194616395;6012.939870601325;5885.382034886361;5929.703514824241;5935.080062590262;5950.315713692894;6051.606645568068;5581.748821303051;5599.300087489105;5624.128260119647;5630.887382252332;5634.295713035871;5903.291605007341;6094.146819445281;6094.8171554853425;6099.047086321597;6119.571629985859;5791.82624521265;5835.912461313083;5849.707514624251;5947.791827286111;5951;5955.37468565803;5977.760889564455;5978.8206353809455;6017.2779266488305;6024.457798798042;5715.199872017921;5816.360200377955;5957.940420595825;5970.940290597038;5983.222181116427;5876.294844618673;5932.703364831741;5939.4951429129005;5960.165576819249;5989.041753319448;4542.341360502709;4547.454305483297;4548.181327361107;4571.428571428572;4575.336576196433;4028.697847661437;4031.2945234584417;4066.430699702044;4083.2650122977557;4123.484564429446;5574.58190635704;5593.972030139823;5596.804111856066;5597.524210442158;5628.802991895264;5903.704814759245;5949.0481522956115;5956.880862382728;5959.344472108065;5990.341062483123;5394.433584473652;5480.780768769284;5515.448455154533;5526.50261476469;5535.612507124543;5102.923456148161;5112.9744351278005;5116.079105760924;5116.718580478109;5125.743712814345;5963.940360596425;5966.671833049137;5975.193348897843;5980.222571065734;6017.969910150508;5778.075507918713;5857.4435428634215;5902.704864756831;5912.054071348563;5968.104784282393;5997.31030931431;6000.429959153874;6010.068439391901;6016.2479690038745;6018.849528761816;5643.125315576092;5852.209951656472;5852.7658893643775;5861.794837180849;5862.765489380377;5801.5938884279385;5862.824115276378;5895.9115613266695;5902.144189092472;5937;5779.393163717749;5782.739776710142;5788.53691704671;5791.044477661138;5800.50695690871;5580.302462192226;5730.627509212055;5775.27809023872;5780.682062486603;5783.508401785727;5656.208130861765;5728.656280623176;5745.454181852718;5756.94243057564;5776.682282474336;5793.449622285876;5841.4450627190345;5894.528437725057;5898.144769008555;5906.940930590811;5577.916331254954;5578.3584887738425;5634.802781902614;5755.453231942959;5782.710864456844 03:35:45 INFO - PROCESS | 32515 | |1;ext.html;599.6671847124846;647.6308504152632;648.7048392981193;650.7494614573391;665.640554100785;32591;45857.77071114644;46773.76613116938;46806;46883.765581172134;48740.75629621847;49383.50616493834;49404.752976235155;49424;49474.75262623682;8196.385271104662;9091.954540227307;9231.353805233637;9238.538073096319;10853;10874.075703565206;10970.945145274263;10990.615328463506;10996;10999.395033273167;10824.079953203987;10942.288751231144;10947.945260273687;10951.726206844813;10959.287646303004;8289.461185022954;10795.78408431831;10853.620123295646;11174.832377514344;11194.216404851664;10632.78734425307;11003.33979961197;11027.944860275727;11030.448477576168;11039.668809935714;45108.77445612784;45417.31874021892;45518.31722524165;45565;45631.54368456306;3597.3524765542193;3765.6987441004653;3770.000949748319;3993.101552150772;4043.17114991429;34478;34927.825360873285;35058.64941350605;35192;35481.46777798335;4705.341252224691;4779.880502987418;4795;4795.58340793795;4840.346553215341;364486;366160;366677;367116;368778;39500.60499395027;70394.29605703878;71050;71153.64423177954;71241;40060.79969600133;41967.79016104961;42373.788131059766;42484.575154248065;42488.78755606202;13881.236531990837;13919.304034798219;13944.954128440408;13951.232682202577;13960.2321872298;11043.116550675926;12723.872761272454;12951.935240323737;13022.348882555834;13076.411561479756;9482.099200575934;9498.620055197853;9510.809783804285;9529.237660987104;9541;3584.874529391459;3586.7668601540818;3635.709143268532;3685.9078523037138;3695.5380577427823;1042.3276986343765;1046.6336782126195;1110.6001839337832;1127.577158565538;1223.6879595703217;32782.50826237608;34069.99716348746;34087.65912340894;34257.82871085629;34644.826775866466;1127.3912087472836;1150.1603829204728;1206.21595962625;1208.3474923541364;1224.094170313979;17262.65474690499;17871.910640446713;18185.272589096287;18190;18338.449846504627;165029;166207;166681;166880;167270;64054;65141.67429162824;65207;65311.67344163249;65458;1350.6690860739182;1424.964375890611;1428.8071110399962;1434.684369438722;1466.552701426054;34118.82940585281;35102.47346289859;35451;35607.465888012215;35804;54736.726316368164;55358.169627456424;55391.72304138453;55412.445875540725;55467.445325547844;413177;420276;420743;420860;422209;27936.720632794226;28604.713952860206;30325.848370758005;31445.528317074804;31593.36813263768;52506.212406814695;53157.20264196117;53694.46305537051;53763.73118134541;54108.45891541192;44004.77997609991;44273.55726442694;44413.77793111014;45247.547524524336;45972.770136149105;43467.13065738731;43593.56406436022;43609.56390436182;44051;44699.10601788011;43314.78342608393;43712.78143609261;44217.11565768602;44253.55746442494;44545;36946;39111;39333.21333573255;40191;40267.3959890596;28947.65785132247;29240.853795730884;29326;29626.55560166556;29887.850560747058 03:35:45 INFO - PROCESS | 32515 | |2;jquery.html;412.81835992163445;417.23853966511126;421.81440166326814;426.24341793316876;437.302502508499;18053;19252.903735481337;19405.32081377152;19447.31934382297;19997.100130494127;18774.249030038784;18841.340553080645;19359.70960435591;19619.705704414446;19647.60704785907;5591.720413979305;5787.3923238059815;5788.71056447178;5789.942100578983;5801.883962320751;4149.771762553059;5422.186671999192;5659.547236221092;5744.16709577111;6420.101185833987;6488.221413430395;6517.641529715864;6521.739130434777;6523.4455071319;6531.346865313478;6309.684515774239;6396.2964073951825;6455.870882582322;6460.063290822804;6492.415682588566;3767.6420740029653;5444.945550544483;5752.5110365618975;5757.884842303172;5779.104238842986;22447;22932.19737309186;23080.88459557708;23376.64935025976;23464;2064.566441047382;2398.2805158452393;2538.23852844146;2600.6099085137193;3112.439760843047;10571.154307655446;10762;10954.452277386179;11054.336739795637;11156.665300041012;2035.531827679642;2112.1445814445174;2131.936041918729;2133.370655656585;2161.2867753641262;82027.58986205091;86191.56904215501;87866.5606671969;88015.11984880133;88164.55917720434;11633.76732465346;11651.650450486499;11653.359065251492;11712.121590880719;11954.760904781855;16055.197240137946;16354.754678679828;16807.41174058902;16815.2433140509;16817.579560511083;7890.842183156305;7894.802629934297;8070.959645201737;8198.918010819816;8215.383846211558;7121.501494895411;7232.602206878567;7251.456140789462;7393.223711510322;7486.251374862579;5069.873253168626;5070.706969722771;5088.211327244283;5094.541491265803;5114.897702045938;1992.4620352504742;2051.9589608208053;2055.3320170944503;2078.4803799050237;2092.225876425732;976.7802244494932;999.8700168978132;1013.9746506337253;1036.3004971644261;1046.1787496815116;18712.53218669517;19316.130774115198;19322.71015934762;19655.50861228452;19659.705104423447;985.8866230383597;1000.4397537379091;1027.9331843430152;1047.5233768635253;1060.4220699718671;10579.84130238047;10819.567217311376;10866.891331086588;10977.615783447542;11100.278481898813;515340;518312;524001;532455;533058;72112.63943680248;92737;93412;94855.52572237095;95995.52002239945;1061.6443491430302;1072.855164552791;1077.1329080090445;1085.2240647936762;1098.2861140258897;17166.39917602878;17311.48065558035;17359.826401736325;17615.735763963294;17693.11534423248;40856;41272.79363603283;42162;42728;42897.142057159304;54091.72954135361;57662.7116864413;58696.06519674085;58747.70626147013;59208;8427.115152909102;8596.312295016258;8622.655093796178;8689.217970382695;8871.379003469696;9575.952120239353;9882.407055576401;10130.240231982483;13261;13552.864471355555;12199.451024704087;12254.448549815457;12305.56930507428;12368.381580921097;12471.563495277622;11974.22167559106;12079.456424460745;12162.391880406121;12229.87770122323;12363.814542781685;11939.820902686293;12523.686907827378;12628.810567841307;12671.493140274655;12734.687405542898;8530.488170709777;8580.399372043898;8699.869501957603;8722.956385218033;9327.766805829908;11063.778724425627;11996.340201289013;12000.15998880105;12536.74926501483;12674.936625316814 03:35:45 INFO - PROCESS | 32515 | |3;mootools.html;1391.749485092683;1561.9531414057576;1595.768613551035;1793.1930631215955;1904.4667493101936;9211.078892110785;9620.567074481647;9687.467189304585;9830.410175389481;9945.751356216098;9634.855477167848;9779.364341317827;9804.803903921935;9811.215102791777;9816.55825487853;2176.749673787511;2239.55208958209;2243.0354947372625;2514.8742562871876;2548.745125487446;2498.650188973545;2590.44305474323;2593.1313010141625;2600.4409052053807;2605.101240072172;2414.541237164942;2444.425559993409;2469.839460435075;2507.1726330310953;2510.79913606911;2127.2129312154448;2205.514786746913;2484.7515248475097;2486.950260994779;2518.320053585531;2186.7703891091364;2419.8911049002836;2493.9127130550523;2494.675692160026;2507.949841003188;9577.856332155023;9604.951975240148;9629.903700963041;9633.325667203299;9640.132388085107;5545.833624991256;5626.212330273765;5627.380988091307;5681.23303354046;5682.573806964453;3702.333579955607;3758.1919887224103;3840.9423858642144;3896.493455850721;3901.7073719471155;1294.9093563450563;1299.6036208956264;1307.3136603283258;1313.487739781486;1349.305107869448;14197.858021419757;14198.57404277863;14203.57389278313;14204.431822727078;14219.36012879423;4928.802847886116;4973.303737476756;5085.1355269604255;5106.872328191825;5139.922901156486;11741.88258117425;11754.29474231549;11760.35318057515;11846.466908989116;11858.407079645984;5734.77060917567;5742.942570574324;5745.3105627324985;5746.138079288056;5747.48272655463;4451.621612162938;5023.773930173151;5211.166213405837;5339.973300133474;5350.571954243651;4261.913212130887;4266.488021437447;4319.5464476229545;4350;4351.151525452569;1362.3664995777012;1380.882624976888;1385.2727318158047;1389.7081612861411;1391.2070120031485;898.4384759525296;996.5764550066338;1005.8440941654055;1010.5351538292321;1021.836506159011;5977.611455255482;6193.504519638418;6344.651044192614;6360.268569114611;6434.64609446485;959.5346257065318;991.3358050106445;1049.41757324684;1060.9045185933303;1124.2860783402434;4126.938095928564;4145.854895078658;4148.253314403436;4161.583841615814;4203.138356636882;12160.331181785086;12435.253884766942;12455.252684838757;12460.688482788002;12472.750544989049;12287.385630718429;12304.507819687291;12314.261144331369;12377.319247441297;12406.565770198;8762;9144.63421463134;9162.81674366509;9372.20336271411;9372.718818435458;6399.840003999937;6621.602703837592;6717.462602991846;6724.058631791455;6749.257581666111;10930.070943969851;11339.829902551633;11410.201285909907;11456.82814757796;11666.824997624874;11476.13928955315;11592.420378980849;11680.649580512598;11701.76596468083;11720.648380548597;8301.792455188668;8640.56797160152;8761.780955476164;8857.955710221408;9320.860187097334;8964.282857371525;9171.312151588523;9207.723768286962;9254.12085851843;9264.629414823332;7935.841283174189;8053.395995300493;8084.595770211348;8125.431219814556;8281.17188281167;7937.563434011185;7942.761717148494;7966.243206895336;8112.310453611509;8243.793905152419;7545.434092443198;7609.961950190213;7907.288344049063;7991.200879912195;8029.959850200712;5043.142665746906;5435.592330575144;5450.073487507213;5453.672779633234;5473.808416705396;5485.424030476743;5529.668219906818;5549.334079910436;5658.462446067617;5659.717014149193 03:35:45 INFO - PROCESS | 32515 | |4;prototype.html;345.60083104014853;356.30164876841394;360.67899569383246;362.2718336144349;366.44849501500255;5238.554722848553;5357.169638705997;5399.7030163341;5471.59249930031;5471.863203419912;5363.168708850135;5380;5394.406615272317;5397.109476936311;5416;4284.164587905359;4289.957100428987;4298.9785051074705;4312.913741725163;4325.178216138939;3991.7604943703473;4167.666586673059;4267.893302667442;4285.764282964436;4321.58944900234;4231.386448964899;4282;4303.364721405861;4318.676099292566;4331.956680433187;4255.702100852942;4259.51015633203;4264.083222107246;4299.871003869889;4312.4906282801085;3717.6616418089466;3832.329342365075;3858.8070596470343;3868.2070175614213;3878.553966293884;5149.201873709543;5176.145935920568;5192.350956130484;5196.792128314863;5205.843824685227;4901.289313049588;4945.477806318768;4955.454899961038;4980.327655766461;4998.700077995296;5369.543588794957;5651.632643878134;5688.544916406678;5703.914441283384;5724.341700704431;4166.66666666666;4172.3532852407925;4173.582641735832;4177.289860723684;4180.686448516343;5883.352831188566;5900.1739756434135;5914.822555323347;5952.851178720567;5956.434138756811;4186.853460128881;4207.915841683149;4237.470316210473;4288.635465985426;4289.721168124062;4294.871153865389;4296;4308.892277693083;4331.436913201263;4351.564843515623;4841.903161936812;4867.58625516835;4917.87705307363;4939.580135688435;4951.183054795991;5551.250581171571;5686.744096515667;5703.828885133453;5719.456651618089;5719.685417302005;1392.436063394327;1417.4046900301898;1417.922014289224;1430.3920833645866;1458.3000159923297;948.2082461144884;949.9977523712549;952.1668540027476;966.9613215471302;975.7658162041059;4852.393450818648;4861.562459378673;4877.975610121926;4886.975565122223;4890.290907818347;5132;5136.383633963948;5137.434882162959;5169.663971841818;5195.948040519622;4847.830325938575;4893.510648935078;4896.192128298862;4910;5134.151705386058;3120.8751649933747;3124.9219019438256;3132.060381885425;3136.8274744888795;3147.921301967469;5946.405359464019;5948.286205655262;5956.255468066492;5956.493698035629;5957.344692083867;5669.546436285087;5930;6007.828473447723;6037.939620603738;6046;5942.257217847769;5953.404659534012;5953.732082056405;5964.731587078505;5989.2812862456785;5716.228309178374;5850.678212698343;5863.384344643921;5954;5958.344582096052;5729.71351432435;5775.162601422686;5839.854003649943;5881.617694849821;5901.409859014064;5903.793367232126;5937.6249500200265;5947.910781338197;5952.791652292149;5957.761689532544;4152.5432202457105;4179.289520781414;4257.445532680367;4273.9358909617;4276.310857211446;5689.971550142222;5841.94158058431;5912.231409916683;5922.7334769936315;5930.495907847709;5659.236003139688;5714.285714285715;5717.885642287214;5726.312842458931;5773.769049237983;5677.9211949729415;5679.290088738908;5688.573356998324;5695.174199741097;5703.258576385043;5368.731563421891;5586.0673146598365;5602.887942241214;5677.545796336366;5696.743646535999;5776.42235776419;5804.100364443518;5805.635675616142;5821.534277257724;5829;5544.889102217852;5708.315002199763;5710.428957104256;5713.485786279255;5735.4551317624755 03:35:45 INFO - PROCESS | 32515 | |5;yui.html;799.9240072193144;803.2931020701783;835.5321020228672;849.9150084991502;869.5695630662823;14938.477153299636;15088.245587720598;15758.133302668377;15962.840371596281;16016.199190040496;14469.421223151088;14565.198914059722;14617.196054217015;14620.268986550656;14637.634059148526;730.5872182217057;855.9186877246651;865.969691060813;885.7741275974618;885.9158379953894;875.0636818604096;890.6170346750895;892.9687460938868;896.5651658945407;896.932730045246;932.2914584915479;936.148105224246;937.6718148647986;937.8218138553653;937.9390339627937;767.9232076792332;881.9823603527958;913.0139449394638;927.5269612497641;927.8051609162084;669.4477056428417;670.1656437735003;670.299536983853;670.3932940688685;670.4301343857682;14307.499237526637;14378.35297411619;14407.639809004859;14409.13545187292;14422.35099420518;14090.647733806634;14476.927615361856;14579.562613121623;14793.778093328609;14851.70296594062;11441.313521188755;11514.481848316846;11742.765144697058;11819.881801181964;12259.816102758467;4710.3405523226775;4746.169420351424;4799.928001079987;4844.297576851337;4910.288008238786;74152.62923685402;75538.62230688866;75826;76499.6175019127;77519.6124019382;12044.33756143403;12077.154599177973;12132.757344853053;12151.696207594881;12249.265044097383;21036.684449733268;21046;21058;21078.89460552718;21104.577908441745;8701.390902636755;8774;8798.252148567444;8939.687110951085;9033.593488293043;4910.729909854992;4919.803207871645;4951.356323677899;5042.546170844568;5088.414832294259;3708.517892673935;3804.5434547854434;3807.1814559869763;3813.1801662642665;3816.809159542012;622.4429135923414;628.6542401679059;628.7704987679556;635.4566845347254;639.7568923808923;668.3951024322995;679.5786612300307;765.8927750114989;769.1308821032197;781.8631739445574;9317.580708868118;9498.430094194371;9546.904530954602;9573.18627916621;9599.10724516388;702.2731472925498;704.3766266853871;718.3570704219799;728.3190217146879;733.2740586819117;4264.978675106605;4398.670099742468;4462.129884672458;4473.4408198975125;4498.910021799546;108629;110364;111106;112522;113740.43129784298;63536.36463635304;77971;90884.5455772717;98201.50899245602;100735;87905.56047219723;89200.5539972296;89701.99999999869;89934;90494.09505904857;8968.865467018131;8980.146886045815;9021.233195178484;9100.453972761656;9207.907920920705;46438.30342544932;51205.7439712799;51333.48666513287;52115;53689.46310537001;75005.62497187479;76927;77260.61369693115;77754.6112269435;79481.60259198667;13504.797428038784;13558.322083895568;13628.182309061489;13729.519466818614;13932.93033534826;14477.05899116554;14930.328135234158;15092.849071509583;15315.15766632846;16457.91771041137;14257.144571325754;14525;14587.19770412595;14726.484573039892;14769.778453322993;12853;12985.091043626855;13576.93211533936;13922.51271205503;14467.565973020826;13953.651158721113;14110.435582576582;14119.503252278922;14191.787123192953;14208.644783880072;10328.225383096447;10444.791104178026;10534.447783808595;10623.468826558486;10849.891501084889;11523.107783360594;11527.8270825936;11579.8263026053;11613.477393517482;11768.352740599006 03:35:45 INFO - PROCESS | 32515 | __end_tp_report 03:35:45 INFO - PROCESS | 32515 | __start_cc_report 03:35:45 INFO - PROCESS | 32515 | _x_x_mozilla_cycle_collect,906 03:35:45 INFO - PROCESS | 32515 | __end_cc_report 03:35:45 INFO - PROCESS | 32515 | __startTimestamp1468492545229__endTimestamp 03:35:45 INFO - PROCESS | 32515 | 03:35:45 INFO - PROCESS | 32515 | ------- Summary: start ------- 03:35:45 INFO - PROCESS | 32515 | Number of tests: 6 03:35:45 INFO - PROCESS | 32515 | 03:35:45 INFO - PROCESS | 32515 | [#0] dojo.html Cycles:165 Average:5500.57 Median:5728.66 stddev:607.92 (10.6%) stddev-sans-first:583.25 03:35:45 INFO - PROCESS | 32515 | Values: 3235.9 3268.1 3270.0 3305.9 3322.2 5494.7 5571.6 5575.8 5606.1 5623.8 5502.6 5558.8 5560.5 5565.4 5595.3 4959.8 4965.3 5010.3 5024.6 5070.9 5022.9 5088.0 5100.9 5101.9 5104.5 5003.1 5021.6 5039.9 5050.9 5064.4 5107.1 5128.5 5132.0 5137.2 5151.3 4852.9 4888.7 4952.4 5044.6 5076.4 5386.2 5414.3 5433.9 5461.2 5487.0 5966.1 5998.5 6006.2 6012.6 6012.9 5885.4 5929.7 5935.1 5950.3 6051.6 5581.7 5599.3 5624.1 5630.9 5634.3 5903.3 6094.1 6094.8 6099.0 6119.6 5791.8 5835.9 5849.7 5947.8 5951.0 5955.4 5977.8 5978.8 6017.3 6024.5 5715.2 5816.4 5957.9 5970.9 5983.2 5876.3 5932.7 5939.5 5960.2 5989.0 4542.3 4547.5 4548.2 4571.4 4575.3 4028.7 4031.3 4066.4 4083.3 4123.5 5574.6 5594.0 5596.8 5597.5 5628.8 5903.7 5949.0 5956.9 5959.3 5990.3 5394.4 5480.8 5515.4 5526.5 5535.6 5102.9 5113.0 5116.1 5116.7 5125.7 5963.9 5966.7 5975.2 5980.2 6018.0 5778.1 5857.4 5902.7 5912.1 5968.1 5997.3 6000.4 6010.1 6016.2 6018.8 5643.1 5852.2 5852.8 5861.8 5862.8 5801.6 5862.8 5895.9 5902.1 5937.0 5779.4 5782.7 5788.5 5791.0 5800.5 5580.3 5730.6 5775.3 5780.7 5783.5 5656.2 5728.7 5745.5 5756.9 5776.7 5793.4 5841.4 5894.5 5898.1 5906.9 5577.9 5578.4 5634.8 5755.5 5782.7 03:35:45 INFO - PROCESS | 32515 | 03:35:45 INFO - PROCESS | 32515 | [#1] ext.html Cycles:180 Average:50832.73 Median:202862.00 stddev:88737.79 (43.7%) stddev-sans-first:88906.57 03:35:45 INFO - PROCESS | 32515 | Values: 599.7 647.6 648.7 650.7 665.6 32591.0 45857.8 46773.8 46806.0 46883.8 48740.8 49383.5 49404.8 49424.0 49474.8 8196.4 9092.0 9231.4 9238.5 10853.0 10874.1 10970.9 10990.6 10996.0 10999.4 10824.1 10942.3 10947.9 10951.7 10959.3 8289.5 10795.8 10853.6 11174.8 11194.2 10632.8 11003.3 11027.9 11030.4 11039.7 45108.8 45417.3 45518.3 45565.0 45631.5 3597.4 3765.7 3770.0 3993.1 4043.2 34478.0 34927.8 35058.6 35192.0 35481.5 4705.3 4779.9 4795.0 4795.6 4840.3 364486.0 366160.0 366677.0 367116.0 368778.0 39500.6 70394.3 71050.0 71153.6 71241.0 40060.8 41967.8 42373.8 42484.6 42488.8 13881.2 13919.3 13945.0 13951.2 13960.2 11043.1 12723.9 12951.9 13022.3 13076.4 9482.1 9498.6 9510.8 9529.2 9541.0 3584.9 3586.8 3635.7 3685.9 3695.5 1042.3 1046.6 1110.6 1127.6 1223.7 32782.5 34070.0 34087.7 34257.8 34644.8 1127.4 1150.2 1206.2 1208.3 1224.1 17262.7 17871.9 18185.3 18190.0 18338.4 165029.0 166207.0 166681.0 166880.0 167270.0 64054.0 65141.7 65207.0 65311.7 65458.0 1350.7 1425.0 1428.8 1434.7 1466.6 34118.8 35102.5 35451.0 35607.5 35804.0 54736.7 55358.2 55391.7 55412.4 55467.4 413177.0 420276.0 420743.0 420860.0 422209.0 27936.7 28604.7 30325.8 31445.5 31593.4 52506.2 53157.2 53694.5 53763.7 54108.5 44004.8 44273.6 44413.8 45247.5 45972.8 43467.1 43593.6 43609.6 44051.0 44699.1 43314.8 43712.8 44217.1 44253.6 44545.0 36946.0 39111.0 39333.2 40191.0 40267.4 28947.7 29240.9 29326.0 29626.6 29887.9 03:35:45 INFO - PROCESS | 32515 | 03:35:45 INFO - PROCESS | 32515 | [#2] jquery.html Cycles:180 Average:30189.67 Median:12931.14 stddev:86364.18 (667.9%) stddev-sans-first:86577.52 03:35:45 INFO - PROCESS | 32515 | Values: 412.8 417.2 421.8 426.2 437.3 18053.0 19252.9 19405.3 19447.3 19997.1 18774.2 18841.3 19359.7 19619.7 19647.6 5591.7 5787.4 5788.7 5789.9 5801.9 4149.8 5422.2 5659.5 5744.2 6420.1 6488.2 6517.6 6521.7 6523.4 6531.3 6309.7 6396.3 6455.9 6460.1 6492.4 3767.6 5444.9 5752.5 5757.9 5779.1 22447.0 22932.2 23080.9 23376.6 23464.0 2064.6 2398.3 2538.2 2600.6 3112.4 10571.2 10762.0 10954.5 11054.3 11156.7 2035.5 2112.1 2131.9 2133.4 2161.3 82027.6 86191.6 87866.6 88015.1 88164.6 11633.8 11651.7 11653.4 11712.1 11954.8 16055.2 16354.8 16807.4 16815.2 16817.6 7890.8 7894.8 8071.0 8198.9 8215.4 7121.5 7232.6 7251.5 7393.2 7486.3 5069.9 5070.7 5088.2 5094.5 5114.9 1992.5 2052.0 2055.3 2078.5 2092.2 976.8 999.9 1014.0 1036.3 1046.2 18712.5 19316.1 19322.7 19655.5 19659.7 985.9 1000.4 1027.9 1047.5 1060.4 10579.8 10819.6 10866.9 10977.6 11100.3 515340.0 518312.0 524001.0 532455.0 533058.0 72112.6 92737.0 93412.0 94855.5 95995.5 1061.6 1072.9 1077.1 1085.2 1098.3 17166.4 17311.5 17359.8 17615.7 17693.1 40856.0 41272.8 42162.0 42728.0 42897.1 54091.7 57662.7 58696.1 58747.7 59208.0 8427.1 8596.3 8622.7 8689.2 8871.4 9576.0 9882.4 10130.2 13261.0 13552.9 12199.5 12254.4 12305.6 12368.4 12471.6 11974.2 12079.5 12162.4 12229.9 12363.8 11939.8 12523.7 12628.8 12671.5 12734.7 8530.5 8580.4 8699.9 8723.0 9327.8 11063.8 11996.3 12000.2 12536.7 12674.9 03:35:45 INFO - PROCESS | 32515 | 03:35:45 INFO - PROCESS | 32515 | [#3] mootools.html Cycles:180 Average:6389.45 Median:4401.39 stddev:3765.41 (85.6%) stddev-sans-first:3757.24 03:35:45 INFO - PROCESS | 32515 | Values: 1391.7 1562.0 1595.8 1793.2 1904.5 9211.1 9620.6 9687.5 9830.4 9945.8 9634.9 9779.4 9804.8 9811.2 9816.6 2176.7 2239.6 2243.0 2514.9 2548.7 2498.7 2590.4 2593.1 2600.4 2605.1 2414.5 2444.4 2469.8 2507.2 2510.8 2127.2 2205.5 2484.8 2487.0 2518.3 2186.8 2419.9 2493.9 2494.7 2507.9 9577.9 9605.0 9629.9 9633.3 9640.1 5545.8 5626.2 5627.4 5681.2 5682.6 3702.3 3758.2 3840.9 3896.5 3901.7 1294.9 1299.6 1307.3 1313.5 1349.3 14197.9 14198.6 14203.6 14204.4 14219.4 4928.8 4973.3 5085.1 5106.9 5139.9 11741.9 11754.3 11760.4 11846.5 11858.4 5734.8 5742.9 5745.3 5746.1 5747.5 4451.6 5023.8 5211.2 5340.0 5350.6 4261.9 4266.5 4319.5 4350.0 4351.2 1362.4 1380.9 1385.3 1389.7 1391.2 898.4 996.6 1005.8 1010.5 1021.8 5977.6 6193.5 6344.7 6360.3 6434.6 959.5 991.3 1049.4 1060.9 1124.3 4126.9 4145.9 4148.3 4161.6 4203.1 12160.3 12435.3 12455.3 12460.7 12472.8 12287.4 12304.5 12314.3 12377.3 12406.6 8762.0 9144.6 9162.8 9372.2 9372.7 6399.8 6621.6 6717.5 6724.1 6749.3 10930.1 11339.8 11410.2 11456.8 11666.8 11476.1 11592.4 11680.6 11701.8 11720.6 8301.8 8640.6 8761.8 8858.0 9320.9 8964.3 9171.3 9207.7 9254.1 9264.6 7935.8 8053.4 8084.6 8125.4 8281.2 7937.6 7942.8 7966.2 8112.3 8243.8 7545.4 7610.0 7907.3 7991.2 8030.0 5043.1 5435.6 5450.1 5453.7 5473.8 5485.4 5529.7 5549.3 5658.5 5659.7 03:35:45 INFO - PROCESS | 32515 | 03:35:45 INFO - PROCESS | 32515 | [#4] prototype.html Cycles:180 Average:4766.28 Median:5297.86 stddev:1382.83 (26.1%) stddev-sans-first:1346.31 03:35:45 INFO - PROCESS | 32515 | Values: 345.6 356.3 360.7 362.3 366.4 5238.6 5357.2 5399.7 5471.6 5471.9 5363.2 5380.0 5394.4 5397.1 5416.0 4284.2 4290.0 4299.0 4312.9 4325.2 3991.8 4167.7 4267.9 4285.8 4321.6 4231.4 4282.0 4303.4 4318.7 4332.0 4255.7 4259.5 4264.1 4299.9 4312.5 3717.7 3832.3 3858.8 3868.2 3878.6 5149.2 5176.1 5192.4 5196.8 5205.8 4901.3 4945.5 4955.5 4980.3 4998.7 5369.5 5651.6 5688.5 5703.9 5724.3 4166.7 4172.4 4173.6 4177.3 4180.7 5883.4 5900.2 5914.8 5952.9 5956.4 4186.9 4207.9 4237.5 4288.6 4289.7 4294.9 4296.0 4308.9 4331.4 4351.6 4841.9 4867.6 4917.9 4939.6 4951.2 5551.3 5686.7 5703.8 5719.5 5719.7 1392.4 1417.4 1417.9 1430.4 1458.3 948.2 950.0 952.2 967.0 975.8 4852.4 4861.6 4878.0 4887.0 4890.3 5132.0 5136.4 5137.4 5169.7 5195.9 4847.8 4893.5 4896.2 4910.0 5134.2 3120.9 3124.9 3132.1 3136.8 3147.9 5946.4 5948.3 5956.3 5956.5 5957.3 5669.5 5930.0 6007.8 6037.9 6046.0 5942.3 5953.4 5953.7 5964.7 5989.3 5716.2 5850.7 5863.4 5954.0 5958.3 5729.7 5775.2 5839.9 5881.6 5901.4 5903.8 5937.6 5947.9 5952.8 5957.8 4152.5 4179.3 4257.4 4273.9 4276.3 5690.0 5841.9 5912.2 5922.7 5930.5 5659.2 5714.3 5717.9 5726.3 5773.8 5677.9 5679.3 5688.6 5695.2 5703.3 5368.7 5586.1 5602.9 5677.5 5696.7 5776.4 5804.1 5805.6 5821.5 5829.0 5544.9 5708.3 5710.4 5713.5 5735.5 03:35:45 INFO - PROCESS | 32515 | 03:35:45 INFO - PROCESS | 32515 | [#5] yui.html Cycles:180 Average:20584.57 Median:4877.29 stddev:29097.04 (596.6%) stddev-sans-first:29140.74 03:35:45 INFO - PROCESS | 32515 | Values: 799.9 803.3 835.5 849.9 869.6 14938.5 15088.2 15758.1 15962.8 16016.2 14469.4 14565.2 14617.2 14620.3 14637.6 730.6 855.9 866.0 885.8 885.9 875.1 890.6 893.0 896.6 896.9 932.3 936.1 937.7 937.8 937.9 767.9 882.0 913.0 927.5 927.8 669.4 670.2 670.3 670.4 670.4 14307.5 14378.4 14407.6 14409.1 14422.4 14090.6 14476.9 14579.6 14793.8 14851.7 11441.3 11514.5 11742.8 11819.9 12259.8 4710.3 4746.2 4799.9 4844.3 4910.3 74152.6 75538.6 75826.0 76499.6 77519.6 12044.3 12077.2 12132.8 12151.7 12249.3 21036.7 21046.0 21058.0 21078.9 21104.6 8701.4 8774.0 8798.3 8939.7 9033.6 4910.7 4919.8 4951.4 5042.5 5088.4 3708.5 3804.5 3807.2 3813.2 3816.8 622.4 628.7 628.8 635.5 639.8 668.4 679.6 765.9 769.1 781.9 9317.6 9498.4 9546.9 9573.2 9599.1 702.3 704.4 718.4 728.3 733.3 4265.0 4398.7 4462.1 4473.4 4498.9 108629.0 110364.0 111106.0 112522.0 113740.4 63536.4 77971.0 90884.5 98201.5 100735.0 87905.6 89200.6 89702.0 89934.0 90494.1 8968.9 8980.1 9021.2 9100.5 9207.9 46438.3 51205.7 51333.5 52115.0 53689.5 75005.6 76927.0 77260.6 77754.6 79481.6 13504.8 13558.3 13628.2 13729.5 13932.9 14477.1 14930.3 15092.8 15315.2 16457.9 14257.1 14525.0 14587.2 14726.5 14769.8 12853.0 12985.1 13576.9 13922.5 14467.6 13953.7 14110.4 14119.5 14191.8 14208.6 10328.2 10444.8 10534.4 10623.5 10849.9 11523.1 11527.8 11579.8 11613.5 11768.4 03:35:45 INFO - PROCESS | 32515 | -------- Summary: end -------- 03:35:45 INFO - PROCESS | 32515 | 03:35:45 INFO - TEST-INFO | 32515: exit 0 03:35:45 INFO - TEST-OK | dromaeo_css | took 1113005ms 03:35:45 INFO - TEST-START | kraken 03:35:45 INFO - operating with platform_type : linux_ 03:35:45 INFO - Initialising browser for kraken test... 03:35:45 INFO - TEST-INFO | started process 32704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTtl7be/profile http://localhost:45913/getInfo.html) 03:35:50 INFO - PROCESS | 32704 | __metrics Screen width/height:1600/1200 03:35:50 INFO - PROCESS | 32704 | colorDepth:24 03:35:50 INFO - PROCESS | 32704 | Browser inner width/height: 1024/697 03:35:50 INFO - PROCESS | 32704 | __metrics 03:35:51 ERROR - PROCESS | 32704 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:35:52 INFO - TEST-INFO | 32704: exit 0 03:35:52 INFO - Browser initialized. 03:35:52 INFO - Running cycle 1/1 for kraken test... 03:35:52 INFO - TEST-INFO | started process 331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTtl7be/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:36:03 INFO - PROCESS | 331 | RSS: Main: 144752640 03:36:03 INFO - PROCESS | 331 | 03:36:06 INFO - PROCESS | 331 | Cycle 1(1): loaded http://localhost:45913/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45913/tests/kraken/driver.html?testName=audio-beat-detection) 03:36:07 INFO - PROCESS | 331 | RSS: Main: 194170880 03:36:07 INFO - PROCESS | 331 | 03:36:09 INFO - PROCESS | 331 | Cycle 1(1): loaded http://localhost:45913/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45913/tests/kraken/driver.html?testName=audio-dft) 03:36:10 INFO - PROCESS | 331 | RSS: Main: 193896448 03:36:10 INFO - PROCESS | 331 | 03:36:13 INFO - PROCESS | 331 | Cycle 1(1): loaded http://localhost:45913/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45913/tests/kraken/driver.html?testName=audio-fft) 03:36:13 INFO - PROCESS | 331 | RSS: Main: 279146496 03:36:13 INFO - PROCESS | 331 | 03:36:15 INFO - PROCESS | 331 | Cycle 1(1): loaded http://localhost:45913/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45913/tests/kraken/driver.html?testName=audio-oscillator) 03:36:16 INFO - PROCESS | 331 | RSS: Main: 188616704 03:36:16 INFO - PROCESS | 331 | 03:36:18 INFO - PROCESS | 331 | Cycle 1(1): loaded http://localhost:45913/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45913/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:36:19 INFO - PROCESS | 331 | RSS: Main: 189243392 03:36:19 INFO - PROCESS | 331 | 03:36:22 INFO - PROCESS | 331 | Cycle 1(1): loaded http://localhost:45913/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45913/tests/kraken/driver.html?testName=imaging-darkroom) 03:36:22 INFO - PROCESS | 331 | RSS: Main: 224051200 03:36:22 INFO - PROCESS | 331 | 03:36:26 INFO - PROCESS | 331 | Cycle 1(1): loaded http://localhost:45913/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45913/tests/kraken/driver.html?testName=imaging-desaturate) 03:36:26 INFO - PROCESS | 331 | RSS: Main: 224804864 03:36:26 INFO - PROCESS | 331 | 03:36:29 INFO - PROCESS | 331 | Cycle 1(1): loaded http://localhost:45913/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45913/tests/kraken/driver.html?testName=json-parse-financial) 03:36:30 INFO - PROCESS | 331 | RSS: Main: 223113216 03:36:30 INFO - PROCESS | 331 | 03:36:31 INFO - PROCESS | 331 | Cycle 1(1): loaded http://localhost:45913/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45913/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:36:32 INFO - PROCESS | 331 | RSS: Main: 200970240 03:36:32 INFO - PROCESS | 331 | 03:36:33 INFO - PROCESS | 331 | Cycle 1(1): loaded http://localhost:45913/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45913/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:36:34 INFO - PROCESS | 331 | RSS: Main: 201887744 03:36:34 INFO - PROCESS | 331 | 03:36:36 INFO - PROCESS | 331 | Cycle 1(1): loaded http://localhost:45913/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45913/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:36:37 INFO - PROCESS | 331 | RSS: Main: 208670720 03:36:37 INFO - PROCESS | 331 | 03:36:39 INFO - PROCESS | 331 | Cycle 1(1): loaded http://localhost:45913/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:36:40 INFO - PROCESS | 331 | RSS: Main: 216137728 03:36:40 INFO - PROCESS | 331 | 03:36:42 INFO - PROCESS | 331 | Cycle 1(1): loaded http://localhost:45913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:36:43 INFO - PROCESS | 331 | RSS: Main: 217088000 03:36:43 INFO - PROCESS | 331 | 03:36:45 INFO - PROCESS | 331 | Cycle 1(1): loaded http://localhost:45913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45913/tests/kraken/driver.html?testName=ai-astar) 03:36:45 INFO - PROCESS | 331 | RSS: Main: 260005888 03:36:45 INFO - PROCESS | 331 | 03:36:45 INFO - PROCESS | 331 | __start_tp_report 03:36:45 INFO - PROCESS | 331 | _x_x_mozilla_page_load 03:36:45 INFO - PROCESS | 331 | _x_x_mozilla_page_load_details 03:36:45 INFO - PROCESS | 331 | |i|pagename|runs| 03:36:45 INFO - PROCESS | 331 | |0;ai-astar;113;105;110;111;109;110;110;110;109;110 03:36:45 INFO - PROCESS | 331 | |1;audio-beat-detection;148;123;130;179;124;124;155;125;156;130 03:36:45 INFO - PROCESS | 331 | |2;audio-dft;161;160;160;159;160;161;160;160;160;166 03:36:45 INFO - PROCESS | 331 | |3;audio-fft;75;75;76;133;75;77;75;76;97;75 03:36:45 INFO - PROCESS | 331 | |4;audio-oscillator;83;84;107;85;85;85;112;85;85;122 03:36:45 INFO - PROCESS | 331 | |5;imaging-gaussian-blur;117;117;117;116;116;116;117;117;117;117 03:36:45 INFO - PROCESS | 331 | |6;imaging-darkroom;146;146;146;146;147;145;146;146;145;146 03:36:45 INFO - PROCESS | 331 | |7;imaging-desaturate;94;94;95;94;95;94;94;95;96;95 03:36:45 INFO - PROCESS | 331 | |8;json-parse-financial;50;53;51;50;50;51;50;50;50;51 03:36:45 INFO - PROCESS | 331 | |9;json-stringify-tinderbox;59;61;60;60;60;60;60;60;61;61 03:36:45 INFO - PROCESS | 331 | |10;stanford-crypto-aes;75;75;75;81;80;76;76;76;113;76 03:36:45 INFO - PROCESS | 331 | |11;stanford-crypto-ccm;117;127;118;129;114;121;116;118;147;122 03:36:45 INFO - PROCESS | 331 | |12;stanford-crypto-pbkdf2;158;158;154;160;151;154;152;159;153;153 03:36:45 INFO - PROCESS | 331 | |13;stanford-crypto-sha256-iterative;65;60;62;61;62;64;61;61;60;59 03:36:45 INFO - PROCESS | 331 | __end_tp_report 03:36:45 INFO - PROCESS | 331 | __start_cc_report 03:36:45 INFO - PROCESS | 331 | _x_x_mozilla_cycle_collect,1590 03:36:45 INFO - PROCESS | 331 | __end_cc_report 03:36:45 INFO - PROCESS | 331 | __startTimestamp1468492605389__endTimestamp 03:36:45 INFO - PROCESS | 331 | 03:36:45 INFO - PROCESS | 331 | ------- Summary: start ------- 03:36:45 INFO - PROCESS | 331 | Number of tests: 14 03:36:45 INFO - PROCESS | 331 | 03:36:45 INFO - PROCESS | 331 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.00 stddev:2.00 (1.8%) stddev-sans-first:1.73 03:36:45 INFO - PROCESS | 331 | Values: 113.0 105.0 110.0 111.0 109.0 110.0 110.0 110.0 109.0 110.0 03:36:45 INFO - PROCESS | 331 | 03:36:45 INFO - PROCESS | 331 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:139.00 stddev:19.11 (13.8%) stddev-sans-first:20.02 03:36:45 INFO - PROCESS | 331 | Values: 148.0 123.0 130.0 179.0 124.0 124.0 155.0 125.0 156.0 130.0 03:36:45 INFO - PROCESS | 331 | 03:36:45 INFO - PROCESS | 331 | [#2] audio-dft Cycles:10 Average:160.70 Median:160.00 stddev:1.95 (1.2%) stddev-sans-first:2.06 03:36:45 INFO - PROCESS | 331 | Values: 161.0 160.0 160.0 159.0 160.0 161.0 160.0 160.0 160.0 166.0 03:36:45 INFO - PROCESS | 331 | 03:36:45 INFO - PROCESS | 331 | [#3] audio-fft Cycles:10 Average:83.40 Median:75.50 stddev:18.70 (24.8%) stddev-sans-first:19.59 03:36:45 INFO - PROCESS | 331 | Values: 75.0 75.0 76.0 133.0 75.0 77.0 75.0 76.0 97.0 75.0 03:36:45 INFO - PROCESS | 331 | 03:36:45 INFO - PROCESS | 331 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:85.00 stddev:14.52 (17.1%) stddev-sans-first:14.92 03:36:45 INFO - PROCESS | 331 | Values: 83.0 84.0 107.0 85.0 85.0 85.0 112.0 85.0 85.0 122.0 03:36:45 INFO - PROCESS | 331 | 03:36:45 INFO - PROCESS | 331 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:36:45 INFO - PROCESS | 331 | Values: 117.0 117.0 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 03:36:45 INFO - PROCESS | 331 | 03:36:45 INFO - PROCESS | 331 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 03:36:45 INFO - PROCESS | 331 | Values: 146.0 146.0 146.0 146.0 147.0 145.0 146.0 146.0 145.0 146.0 03:36:45 INFO - PROCESS | 331 | 03:36:45 INFO - PROCESS | 331 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 03:36:45 INFO - PROCESS | 331 | Values: 94.0 94.0 95.0 94.0 95.0 94.0 94.0 95.0 96.0 95.0 03:36:45 INFO - PROCESS | 331 | 03:36:45 INFO - PROCESS | 331 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:50.50 stddev:0.97 (1.9%) stddev-sans-first:1.00 03:36:45 INFO - PROCESS | 331 | Values: 50.0 53.0 51.0 50.0 50.0 51.0 50.0 50.0 50.0 51.0 03:36:45 INFO - PROCESS | 331 | 03:36:45 INFO - PROCESS | 331 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.50 03:36:45 INFO - PROCESS | 331 | Values: 59.0 61.0 60.0 60.0 60.0 60.0 60.0 60.0 61.0 61.0 03:36:45 INFO - PROCESS | 331 | 03:36:45 INFO - PROCESS | 331 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:76.00 stddev:11.68 (15.4%) stddev-sans-first:12.23 03:36:45 INFO - PROCESS | 331 | Values: 75.0 75.0 75.0 81.0 80.0 76.0 76.0 76.0 113.0 76.0 03:36:45 INFO - PROCESS | 331 | 03:36:45 INFO - PROCESS | 331 | [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:121.50 stddev:9.71 (8.0%) stddev-sans-first:10.06 03:36:45 INFO - PROCESS | 331 | Values: 117.0 127.0 118.0 129.0 114.0 121.0 116.0 118.0 147.0 122.0 03:36:45 INFO - PROCESS | 331 | 03:36:45 INFO - PROCESS | 331 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:156.00 stddev:3.22 (2.1%) stddev-sans-first:3.26 03:36:45 INFO - PROCESS | 331 | Values: 158.0 158.0 154.0 160.0 151.0 154.0 152.0 159.0 153.0 153.0 03:36:45 INFO - PROCESS | 331 | 03:36:45 INFO - PROCESS | 331 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.50 stddev:1.84 (3.0%) stddev-sans-first:1.45 03:36:45 INFO - PROCESS | 331 | Values: 65.0 60.0 62.0 61.0 62.0 64.0 61.0 61.0 60.0 59.0 03:36:45 INFO - PROCESS | 331 | -------- Summary: end -------- 03:36:45 INFO - PROCESS | 331 | 03:36:46 INFO - TEST-INFO | 331: exit 0 03:36:46 INFO - TEST-OK | kraken | took 60457ms 03:36:46 INFO - SUITE-END | took 1173s 03:36:46 INFO - Completed test suite (00:19:33) 03:36:46 INFO - javascript benchmark 03:36:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3235.870565177393, 3268.0849362178596, 3269.9509507357393, 3305.8677652893884, 3322.202671358873, 5494.725263736812, 5571.637843540167, 5575.832725018251, 5606.103023516238, 5623.803166889154, 5502.58730595205, 5558.805441809537, 5560.499555040045, 5565.41563135871, 5595.272614560102, 4959.8016079356785, 4965.255211718253, 5010.273510341008, 5024.572911302544, 5070.898582028357, 5022.924656130161, 5088.0, 5100.897982040357, 5101.948980510203, 5104.5405913467785, 5003.14946459101, 5021.623378246646, 5039.899202015958, 5050.924236136461, 5064.3922729272535, 5107.106256405114, 5128.461511541272, 5131.974340128313, 5137.17805151174, 5151.278820965068, 4852.878678033042, 4888.73111978841, 4952.380952380952, 5044.596432285445, 5076.390833100052, 5386.1920711893135, 5414.296141501619, 5433.891322173574, 5461.1808228766, 5487.012337779198, 5966.105084237399, 5998.460138587505, 6006.249218847644, 6012.5791194616395, 6012.939870601325, 5885.382034886361, 5929.703514824241, 5935.080062590262, 5950.315713692894, 6051.606645568068, 5581.748821303051, 5599.300087489105, 5624.128260119647, 5630.887382252332, 5634.295713035871, 5903.291605007341, 6094.146819445281, 6094.8171554853425, 6099.047086321597, 6119.571629985859, 5791.82624521265, 5835.912461313083, 5849.707514624251, 5947.791827286111, 5951.0, 5955.37468565803, 5977.760889564455, 5978.8206353809455, 6017.2779266488305, 6024.457798798042, 5715.199872017921, 5816.360200377955, 5957.940420595825, 5970.940290597038, 5983.222181116427, 5876.294844618673, 5932.703364831741, 5939.4951429129005, 5960.165576819249, 5989.041753319448, 4542.341360502709, 4547.454305483297, 4548.181327361107, 4571.428571428572, 4575.336576196433, 4028.697847661437, 4031.2945234584417, 4066.430699702044, 4083.2650122977557, 4123.484564429446, 5574.58190635704, 5593.972030139823, 5596.804111856066, 5597.524210442158, 5628.802991895264, 5903.704814759245, 5949.0481522956115, 5956.880862382728, 5959.344472108065, 5990.341062483123, 5394.433584473652, 5480.780768769284, 5515.448455154533, 5526.50261476469, 5535.612507124543, 5102.923456148161, 5112.9744351278005, 5116.079105760924, 5116.718580478109, 5125.743712814345, 5963.940360596425, 5966.671833049137, 5975.193348897843, 5980.222571065734, 6017.969910150508, 5778.075507918713, 5857.4435428634215, 5902.704864756831, 5912.054071348563, 5968.104784282393, 5997.31030931431, 6000.429959153874, 6010.068439391901, 6016.2479690038745, 6018.849528761816, 5643.125315576092, 5852.209951656472, 5852.7658893643775, 5861.794837180849, 5862.765489380377, 5801.5938884279385, 5862.824115276378, 5895.9115613266695, 5902.144189092472, 5937.0, 5779.393163717749, 5782.739776710142, 5788.53691704671, 5791.044477661138, 5800.50695690871, 5580.302462192226, 5730.627509212055, 5775.27809023872, 5780.682062486603, 5783.508401785727, 5656.208130861765, 5728.656280623176, 5745.454181852718, 5756.94243057564, 5776.682282474336, 5793.449622285876, 5841.4450627190345, 5894.528437725057, 5898.144769008555, 5906.940930590811, 5577.916331254954, 5578.3584887738425, 5634.802781902614, 5755.453231942959, 5782.710864456844], "value": 5460.906180351908, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.6671847124846, 647.6308504152632, 648.7048392981193, 650.7494614573391, 665.640554100785, 32591.0, 45857.77071114644, 46773.76613116938, 46806.0, 46883.765581172134, 48740.75629621847, 49383.50616493834, 49404.752976235155, 49424.0, 49474.75262623682, 8196.385271104662, 9091.954540227307, 9231.353805233637, 9238.538073096319, 10853.0, 10874.075703565206, 10970.945145274263, 10990.615328463506, 10996.0, 10999.395033273167, 10824.079953203987, 10942.288751231144, 10947.945260273687, 10951.726206844813, 10959.287646303004, 8289.461185022954, 10795.78408431831, 10853.620123295646, 11174.832377514344, 11194.216404851664, 10632.78734425307, 11003.33979961197, 11027.944860275727, 11030.448477576168, 11039.668809935714, 45108.77445612784, 45417.31874021892, 45518.31722524165, 45565.0, 45631.54368456306, 3597.3524765542193, 3765.6987441004653, 3770.000949748319, 3993.101552150772, 4043.17114991429, 34478.0, 34927.825360873285, 35058.64941350605, 35192.0, 35481.46777798335, 4705.341252224691, 4779.880502987418, 4795.0, 4795.58340793795, 4840.346553215341, 364486.0, 366160.0, 366677.0, 367116.0, 368778.0, 39500.60499395027, 70394.29605703878, 71050.0, 71153.64423177954, 71241.0, 40060.79969600133, 41967.79016104961, 42373.788131059766, 42484.575154248065, 42488.78755606202, 13881.236531990837, 13919.304034798219, 13944.954128440408, 13951.232682202577, 13960.2321872298, 11043.116550675926, 12723.872761272454, 12951.935240323737, 13022.348882555834, 13076.411561479756, 9482.099200575934, 9498.620055197853, 9510.809783804285, 9529.237660987104, 9541.0, 3584.874529391459, 3586.7668601540818, 3635.709143268532, 3685.9078523037138, 3695.5380577427823, 1042.3276986343765, 1046.6336782126195, 1110.6001839337832, 1127.577158565538, 1223.6879595703217, 32782.50826237608, 34069.99716348746, 34087.65912340894, 34257.82871085629, 34644.826775866466, 1127.3912087472836, 1150.1603829204728, 1206.21595962625, 1208.3474923541364, 1224.094170313979, 17262.65474690499, 17871.910640446713, 18185.272589096287, 18190.0, 18338.449846504627, 165029.0, 166207.0, 166681.0, 166880.0, 167270.0, 64054.0, 65141.67429162824, 65207.0, 65311.67344163249, 65458.0, 1350.6690860739182, 1424.964375890611, 1428.8071110399962, 1434.684369438722, 1466.552701426054, 34118.82940585281, 35102.47346289859, 35451.0, 35607.465888012215, 35804.0, 54736.726316368164, 55358.169627456424, 55391.72304138453, 55412.445875540725, 55467.445325547844, 413177.0, 420276.0, 420743.0, 420860.0, 422209.0, 27936.720632794226, 28604.713952860206, 30325.848370758005, 31445.528317074804, 31593.36813263768, 52506.212406814695, 53157.20264196117, 53694.46305537051, 53763.73118134541, 54108.45891541192, 44004.77997609991, 44273.55726442694, 44413.77793111014, 45247.547524524336, 45972.770136149105, 43467.13065738731, 43593.56406436022, 43609.56390436182, 44051.0, 44699.10601788011, 43314.78342608393, 43712.78143609261, 44217.11565768602, 44253.55746442494, 44545.0, 36946.0, 39111.0, 39333.21333573255, 40191.0, 40267.3959890596, 28947.65785132247, 29240.853795730884, 29326.0, 29626.55560166556, 29887.850560747058], "value": 19826.75540158335, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.81835992163445, 417.23853966511126, 421.81440166326814, 426.24341793316876, 437.302502508499, 18053.0, 19252.903735481337, 19405.32081377152, 19447.31934382297, 19997.100130494127, 18774.249030038784, 18841.340553080645, 19359.70960435591, 19619.705704414446, 19647.60704785907, 5591.720413979305, 5787.3923238059815, 5788.71056447178, 5789.942100578983, 5801.883962320751, 4149.771762553059, 5422.186671999192, 5659.547236221092, 5744.16709577111, 6420.101185833987, 6488.221413430395, 6517.641529715864, 6521.739130434777, 6523.4455071319, 6531.346865313478, 6309.684515774239, 6396.2964073951825, 6455.870882582322, 6460.063290822804, 6492.415682588566, 3767.6420740029653, 5444.945550544483, 5752.5110365618975, 5757.884842303172, 5779.104238842986, 22447.0, 22932.19737309186, 23080.88459557708, 23376.64935025976, 23464.0, 2064.566441047382, 2398.2805158452393, 2538.23852844146, 2600.6099085137193, 3112.439760843047, 10571.154307655446, 10762.0, 10954.452277386179, 11054.336739795637, 11156.665300041012, 2035.531827679642, 2112.1445814445174, 2131.936041918729, 2133.370655656585, 2161.2867753641262, 82027.58986205091, 86191.56904215501, 87866.5606671969, 88015.11984880133, 88164.55917720434, 11633.76732465346, 11651.650450486499, 11653.359065251492, 11712.121590880719, 11954.760904781855, 16055.197240137946, 16354.754678679828, 16807.41174058902, 16815.2433140509, 16817.579560511083, 7890.842183156305, 7894.802629934297, 8070.959645201737, 8198.918010819816, 8215.383846211558, 7121.501494895411, 7232.602206878567, 7251.456140789462, 7393.223711510322, 7486.251374862579, 5069.873253168626, 5070.706969722771, 5088.211327244283, 5094.541491265803, 5114.897702045938, 1992.4620352504742, 2051.9589608208053, 2055.3320170944503, 2078.4803799050237, 2092.225876425732, 976.7802244494932, 999.8700168978132, 1013.9746506337253, 1036.3004971644261, 1046.1787496815116, 18712.53218669517, 19316.130774115198, 19322.71015934762, 19655.50861228452, 19659.705104423447, 985.8866230383597, 1000.4397537379091, 1027.9331843430152, 1047.5233768635253, 1060.4220699718671, 10579.84130238047, 10819.567217311376, 10866.891331086588, 10977.615783447542, 11100.278481898813, 515340.0, 518312.0, 524001.0, 532455.0, 533058.0, 72112.63943680248, 92737.0, 93412.0, 94855.52572237095, 95995.52002239945, 1061.6443491430302, 1072.855164552791, 1077.1329080090445, 1085.2240647936762, 1098.2861140258897, 17166.39917602878, 17311.48065558035, 17359.826401736325, 17615.735763963294, 17693.11534423248, 40856.0, 41272.79363603283, 42162.0, 42728.0, 42897.142057159304, 54091.72954135361, 57662.7116864413, 58696.06519674085, 58747.70626147013, 59208.0, 8427.115152909102, 8596.312295016258, 8622.655093796178, 8689.217970382695, 8871.379003469696, 9575.952120239353, 9882.407055576401, 10130.240231982483, 13261.0, 13552.864471355555, 12199.451024704087, 12254.448549815457, 12305.56930507428, 12368.381580921097, 12471.563495277622, 11974.22167559106, 12079.456424460745, 12162.391880406121, 12229.87770122323, 12363.814542781685, 11939.820902686293, 12523.686907827378, 12628.810567841307, 12671.493140274655, 12734.687405542898, 8530.488170709777, 8580.399372043898, 8699.869501957603, 8722.956385218033, 9327.766805829908, 11063.778724425627, 11996.340201289013, 12000.15998880105, 12536.74926501483, 12674.936625316814], "value": 9466.383686301546, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.749485092683, 1561.9531414057576, 1595.768613551035, 1793.1930631215955, 1904.4667493101936, 9211.078892110785, 9620.567074481647, 9687.467189304585, 9830.410175389481, 9945.751356216098, 9634.855477167848, 9779.364341317827, 9804.803903921935, 9811.215102791777, 9816.55825487853, 2176.749673787511, 2239.55208958209, 2243.0354947372625, 2514.8742562871876, 2548.745125487446, 2498.650188973545, 2590.44305474323, 2593.1313010141625, 2600.4409052053807, 2605.101240072172, 2414.541237164942, 2444.425559993409, 2469.839460435075, 2507.1726330310953, 2510.79913606911, 2127.2129312154448, 2205.514786746913, 2484.7515248475097, 2486.950260994779, 2518.320053585531, 2186.7703891091364, 2419.8911049002836, 2493.9127130550523, 2494.675692160026, 2507.949841003188, 9577.856332155023, 9604.951975240148, 9629.903700963041, 9633.325667203299, 9640.132388085107, 5545.833624991256, 5626.212330273765, 5627.380988091307, 5681.23303354046, 5682.573806964453, 3702.333579955607, 3758.1919887224103, 3840.9423858642144, 3896.493455850721, 3901.7073719471155, 1294.9093563450563, 1299.6036208956264, 1307.3136603283258, 1313.487739781486, 1349.305107869448, 14197.858021419757, 14198.57404277863, 14203.57389278313, 14204.431822727078, 14219.36012879423, 4928.802847886116, 4973.303737476756, 5085.1355269604255, 5106.872328191825, 5139.922901156486, 11741.88258117425, 11754.29474231549, 11760.35318057515, 11846.466908989116, 11858.407079645984, 5734.77060917567, 5742.942570574324, 5745.3105627324985, 5746.138079288056, 5747.48272655463, 4451.621612162938, 5023.773930173151, 5211.166213405837, 5339.973300133474, 5350.571954243651, 4261.913212130887, 4266.488021437447, 4319.5464476229545, 4350.0, 4351.151525452569, 1362.3664995777012, 1380.882624976888, 1385.2727318158047, 1389.7081612861411, 1391.2070120031485, 898.4384759525296, 996.5764550066338, 1005.8440941654055, 1010.5351538292321, 1021.836506159011, 5977.611455255482, 6193.504519638418, 6344.651044192614, 6360.268569114611, 6434.64609446485, 959.5346257065318, 991.3358050106445, 1049.41757324684, 1060.9045185933303, 1124.2860783402434, 4126.938095928564, 4145.854895078658, 4148.253314403436, 4161.583841615814, 4203.138356636882, 12160.331181785086, 12435.253884766942, 12455.252684838757, 12460.688482788002, 12472.750544989049, 12287.385630718429, 12304.507819687291, 12314.261144331369, 12377.319247441297, 12406.565770198, 8762.0, 9144.63421463134, 9162.81674366509, 9372.20336271411, 9372.718818435458, 6399.840003999937, 6621.602703837592, 6717.462602991846, 6724.058631791455, 6749.257581666111, 10930.070943969851, 11339.829902551633, 11410.201285909907, 11456.82814757796, 11666.824997624874, 11476.13928955315, 11592.420378980849, 11680.649580512598, 11701.76596468083, 11720.648380548597, 8301.792455188668, 8640.56797160152, 8761.780955476164, 8857.955710221408, 9320.860187097334, 8964.282857371525, 9171.312151588523, 9207.723768286962, 9254.12085851843, 9264.629414823332, 7935.841283174189, 8053.395995300493, 8084.595770211348, 8125.431219814556, 8281.17188281167, 7937.563434011185, 7942.761717148494, 7966.243206895336, 8112.310453611509, 8243.793905152419, 7545.434092443198, 7609.961950190213, 7907.288344049063, 7991.200879912195, 8029.959850200712, 5043.142665746906, 5435.592330575144, 5450.073487507213, 5453.672779633234, 5473.808416705396, 5485.424030476743, 5529.668219906818, 5549.334079910436, 5658.462446067617, 5659.717014149193], "value": 5053.687535320315, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.60083104014853, 356.30164876841394, 360.67899569383246, 362.2718336144349, 366.44849501500255, 5238.554722848553, 5357.169638705997, 5399.7030163341, 5471.59249930031, 5471.863203419912, 5363.168708850135, 5380.0, 5394.406615272317, 5397.109476936311, 5416.0, 4284.164587905359, 4289.957100428987, 4298.9785051074705, 4312.913741725163, 4325.178216138939, 3991.7604943703473, 4167.666586673059, 4267.893302667442, 4285.764282964436, 4321.58944900234, 4231.386448964899, 4282.0, 4303.364721405861, 4318.676099292566, 4331.956680433187, 4255.702100852942, 4259.51015633203, 4264.083222107246, 4299.871003869889, 4312.4906282801085, 3717.6616418089466, 3832.329342365075, 3858.8070596470343, 3868.2070175614213, 3878.553966293884, 5149.201873709543, 5176.145935920568, 5192.350956130484, 5196.792128314863, 5205.843824685227, 4901.289313049588, 4945.477806318768, 4955.454899961038, 4980.327655766461, 4998.700077995296, 5369.543588794957, 5651.632643878134, 5688.544916406678, 5703.914441283384, 5724.341700704431, 4166.66666666666, 4172.3532852407925, 4173.582641735832, 4177.289860723684, 4180.686448516343, 5883.352831188566, 5900.1739756434135, 5914.822555323347, 5952.851178720567, 5956.434138756811, 4186.853460128881, 4207.915841683149, 4237.470316210473, 4288.635465985426, 4289.721168124062, 4294.871153865389, 4296.0, 4308.892277693083, 4331.436913201263, 4351.564843515623, 4841.903161936812, 4867.58625516835, 4917.87705307363, 4939.580135688435, 4951.183054795991, 5551.250581171571, 5686.744096515667, 5703.828885133453, 5719.456651618089, 5719.685417302005, 1392.436063394327, 1417.4046900301898, 1417.922014289224, 1430.3920833645866, 1458.3000159923297, 948.2082461144884, 949.9977523712549, 952.1668540027476, 966.9613215471302, 975.7658162041059, 4852.393450818648, 4861.562459378673, 4877.975610121926, 4886.975565122223, 4890.290907818347, 5132.0, 5136.383633963948, 5137.434882162959, 5169.663971841818, 5195.948040519622, 4847.830325938575, 4893.510648935078, 4896.192128298862, 4910.0, 5134.151705386058, 3120.8751649933747, 3124.9219019438256, 3132.060381885425, 3136.8274744888795, 3147.921301967469, 5946.405359464019, 5948.286205655262, 5956.255468066492, 5956.493698035629, 5957.344692083867, 5669.546436285087, 5930.0, 6007.828473447723, 6037.939620603738, 6046.0, 5942.257217847769, 5953.404659534012, 5953.732082056405, 5964.731587078505, 5989.2812862456785, 5716.228309178374, 5850.678212698343, 5863.384344643921, 5954.0, 5958.344582096052, 5729.71351432435, 5775.162601422686, 5839.854003649943, 5881.617694849821, 5901.409859014064, 5903.793367232126, 5937.6249500200265, 5947.910781338197, 5952.791652292149, 5957.761689532544, 4152.5432202457105, 4179.289520781414, 4257.445532680367, 4273.9358909617, 4276.310857211446, 5689.971550142222, 5841.94158058431, 5912.231409916683, 5922.7334769936315, 5930.495907847709, 5659.236003139688, 5714.285714285715, 5717.885642287214, 5726.312842458931, 5773.769049237983, 5677.9211949729415, 5679.290088738908, 5688.573356998324, 5695.174199741097, 5703.258576385043, 5368.731563421891, 5586.0673146598365, 5602.887942241214, 5677.545796336366, 5696.743646535999, 5776.42235776419, 5804.100364443518, 5805.635675616142, 5821.534277257724, 5829.0, 5544.889102217852, 5708.315002199763, 5710.428957104256, 5713.485786279255, 5735.4551317624755], "value": 4329.425350184686, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [799.9240072193144, 803.2931020701783, 835.5321020228672, 849.9150084991502, 869.5695630662823, 14938.477153299636, 15088.245587720598, 15758.133302668377, 15962.840371596281, 16016.199190040496, 14469.421223151088, 14565.198914059722, 14617.196054217015, 14620.268986550656, 14637.634059148526, 730.5872182217057, 855.9186877246651, 865.969691060813, 885.7741275974618, 885.9158379953894, 875.0636818604096, 890.6170346750895, 892.9687460938868, 896.5651658945407, 896.932730045246, 932.2914584915479, 936.148105224246, 937.6718148647986, 937.8218138553653, 937.9390339627937, 767.9232076792332, 881.9823603527958, 913.0139449394638, 927.5269612497641, 927.8051609162084, 669.4477056428417, 670.1656437735003, 670.299536983853, 670.3932940688685, 670.4301343857682, 14307.499237526637, 14378.35297411619, 14407.639809004859, 14409.13545187292, 14422.35099420518, 14090.647733806634, 14476.927615361856, 14579.562613121623, 14793.778093328609, 14851.70296594062, 11441.313521188755, 11514.481848316846, 11742.765144697058, 11819.881801181964, 12259.816102758467, 4710.3405523226775, 4746.169420351424, 4799.928001079987, 4844.297576851337, 4910.288008238786, 74152.62923685402, 75538.62230688866, 75826.0, 76499.6175019127, 77519.6124019382, 12044.33756143403, 12077.154599177973, 12132.757344853053, 12151.696207594881, 12249.265044097383, 21036.684449733268, 21046.0, 21058.0, 21078.89460552718, 21104.577908441745, 8701.390902636755, 8774.0, 8798.252148567444, 8939.687110951085, 9033.593488293043, 4910.729909854992, 4919.803207871645, 4951.356323677899, 5042.546170844568, 5088.414832294259, 3708.517892673935, 3804.5434547854434, 3807.1814559869763, 3813.1801662642665, 3816.809159542012, 622.4429135923414, 628.6542401679059, 628.7704987679556, 635.4566845347254, 639.7568923808923, 668.3951024322995, 679.5786612300307, 765.8927750114989, 769.1308821032197, 781.8631739445574, 9317.580708868118, 9498.430094194371, 9546.904530954602, 9573.18627916621, 9599.10724516388, 702.2731472925498, 704.3766266853871, 718.3570704219799, 728.3190217146879, 733.2740586819117, 4264.978675106605, 4398.670099742468, 4462.129884672458, 4473.4408198975125, 4498.910021799546, 108629.0, 110364.0, 111106.0, 112522.0, 113740.43129784298, 63536.36463635304, 77971.0, 90884.5455772717, 98201.50899245602, 100735.0, 87905.56047219723, 89200.5539972296, 89701.99999999869, 89934.0, 90494.09505904857, 8968.865467018131, 8980.146886045815, 9021.233195178484, 9100.453972761656, 9207.907920920705, 46438.30342544932, 51205.7439712799, 51333.48666513287, 52115.0, 53689.46310537001, 75005.62497187479, 76927.0, 77260.61369693115, 77754.6112269435, 79481.60259198667, 13504.797428038784, 13558.322083895568, 13628.182309061489, 13729.519466818614, 13932.93033534826, 14477.05899116554, 14930.328135234158, 15092.849071509583, 15315.15766632846, 16457.91771041137, 14257.144571325754, 14525.0, 14587.19770412595, 14726.484573039892, 14769.778453322993, 12853.0, 12985.091043626855, 13576.93211533936, 13922.51271205503, 14467.565973020826, 13953.651158721113, 14110.435582576582, 14119.503252278922, 14191.787123192953, 14208.644783880072, 10328.225383096447, 10444.791104178026, 10534.447783808595, 10623.468826558486, 10849.891501084889, 11523.107783360594, 11527.8270825936, 11579.8263026053, 11613.477393517482, 11768.352740599006], "value": 7726.022434846482, "unit": "score"}], "name": "dromaeo_css", "value": 7466.59578264632, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 110.0, 111.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 130.0, 179.0, 124.0, 124.0, 155.0, 125.0, 156.0, 130.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 159.0, 160.0, 161.0, 160.0, 160.0, 160.0, 166.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 133.0, 75.0, 77.0, 75.0, 76.0, 97.0, 75.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 107.0, 85.0, 85.0, 85.0, 112.0, 85.0, 85.0, 122.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 96.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 53.0, 51.0, 50.0, 50.0, 51.0, 50.0, 50.0, 50.0, 51.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 61.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 81.0, 80.0, 76.0, 76.0, 76.0, 113.0, 76.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 127.0, 118.0, 129.0, 114.0, 121.0, 116.0, 118.0, 147.0, 122.0], "value": 122.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 158.0, 154.0, 160.0, 151.0, 154.0, 152.0, 159.0, 153.0, 153.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 60.0, 62.0, 61.0, 62.0, 64.0, 61.0, 61.0, 60.0, 59.0], "value": 61.5, "unit": "score"}], "name": "kraken", "value": 1474.4, "alertThreshold": 2.0}]} 03:36:46 INFO - Return code: 0 03:36:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:36:46 ERROR - # TBPL SUCCESS # 03:36:46 INFO - Running post-action listener: _resource_record_post_action 03:36:46 INFO - ##### 03:36:46 INFO - ##### Finished run-tests step (success) 03:36:46 INFO - ##### 03:36:46 INFO - Running post-run listener: _resource_record_post_run 03:36:46 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 510328832; Read time: 224; Write time: 470232 03:36:46 INFO - TinderboxPrint: CPU usage
13.1% 03:36:46 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 224 03:36:46 INFO - TinderboxPrint: I/O write bytes / time
510,328,832 / 470,232 03:36:46 INFO - TinderboxPrint: CPU idle
8,263.2 (86.9%) 03:36:46 INFO - TinderboxPrint: CPU user
1,196.5 (12.6%) 03:36:46 INFO - TinderboxPrint: Swap in / out
0 / 0 03:36:46 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 260182016; Read time: 128; Write time: 279788 03:36:46 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 250146816; Read time: 96; Write time: 190444 03:36:47 INFO - Running post-run listener: _upload_blobber_files 03:36:47 INFO - Blob upload gear active. 03:36:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:36:47 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 03:36:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:36:47 INFO - (blobuploader) - INFO - Open directory for files ... 03:36:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:36:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:36:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:48 INFO - (blobuploader) - INFO - Done attempting. 03:36:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:36:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:36:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:52 INFO - (blobuploader) - INFO - Done attempting. 03:36:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:36:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:36:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:36:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:36:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:36:53 INFO - (blobuploader) - INFO - Done attempting. 03:36:53 INFO - (blobuploader) - INFO - Iteration through files over. 03:36:53 INFO - Return code: 0 03:36:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:36:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:36:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b62ddf098fe6d5d5afeec4ec9b78b30e393c3111a736d9b929f8bddad142c3fdc5c726f220d05146caabec0a552da97a8db3151eb20e2379259288eaa1e1d31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e9fc6fb5b17404c637b41cbe1d7f3078c85fa5b8acfd4474eda91dbed376d9016cfab36b995ffb203376eb4eba0192ead2c1a685a3aad8db2ec8c2b57d415aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eec9552d55d34a9d93a4f68a7e469f40b4edae48f9d7a835b4c3103b2347964180c8788ef410678b182bc488f7a94034cfd2e672e02567cf439ab4c9426910a2"} 03:36:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:36:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:36:53 INFO - Contents: 03:36:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b62ddf098fe6d5d5afeec4ec9b78b30e393c3111a736d9b929f8bddad142c3fdc5c726f220d05146caabec0a552da97a8db3151eb20e2379259288eaa1e1d31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e9fc6fb5b17404c637b41cbe1d7f3078c85fa5b8acfd4474eda91dbed376d9016cfab36b995ffb203376eb4eba0192ead2c1a685a3aad8db2ec8c2b57d415aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eec9552d55d34a9d93a4f68a7e469f40b4edae48f9d7a835b4c3103b2347964180c8788ef410678b182bc488f7a94034cfd2e672e02567cf439ab4c9426910a2"} 03:36:53 INFO - Running post-run listener: copy_logs_to_upload_dir 03:36:53 INFO - Copying logs to upload dir... 03:36:53 INFO - mkdir: /builds/slave/test/build/upload/logs 03:36:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.396433 ========= master_lag: 177.22 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 30 secs) (at 2016-07-14 03:39:49.568210) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-07-14 03:39:49.572769) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b62ddf098fe6d5d5afeec4ec9b78b30e393c3111a736d9b929f8bddad142c3fdc5c726f220d05146caabec0a552da97a8db3151eb20e2379259288eaa1e1d31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e9fc6fb5b17404c637b41cbe1d7f3078c85fa5b8acfd4474eda91dbed376d9016cfab36b995ffb203376eb4eba0192ead2c1a685a3aad8db2ec8c2b57d415aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eec9552d55d34a9d93a4f68a7e469f40b4edae48f9d7a835b4c3103b2347964180c8788ef410678b182bc488f7a94034cfd2e672e02567cf439ab4c9426910a2"} build_url:https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011380 build_url: 'https://queue.taskcluster.net/v1/task/I9Z1cDprQPaRbSScJInuVw/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b62ddf098fe6d5d5afeec4ec9b78b30e393c3111a736d9b929f8bddad142c3fdc5c726f220d05146caabec0a552da97a8db3151eb20e2379259288eaa1e1d31", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e9fc6fb5b17404c637b41cbe1d7f3078c85fa5b8acfd4474eda91dbed376d9016cfab36b995ffb203376eb4eba0192ead2c1a685a3aad8db2ec8c2b57d415aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eec9552d55d34a9d93a4f68a7e469f40b4edae48f9d7a835b4c3103b2347964180c8788ef410678b182bc488f7a94034cfd2e672e02567cf439ab4c9426910a2"}' ========= master_lag: 1.25 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-07-14 03:39:50.836506) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:39:50.836820) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1468490515.860347-617299087 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.09 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:39:50.930823) ========= ========= Started reboot skipped (results: 3, elapsed: 4 secs) (at 2016-07-14 03:39:50.931108) ========= ========= Finished reboot skipped (results: 3, elapsed: 4 secs) (at 2016-07-14 03:39:55.668713) ========= ========= Total master_lag: 178.64 =========