builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1470075854.56 results: success (0) buildid: 20160801070053 builduid: eaf10adbc6074edb9e3b1e3d32dab73b revision: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.558387) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.558843) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.559137) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.769313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.769560) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 11:24:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-08-01 11:24:15 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075839 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.867600) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.870924) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022151 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.920516) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.920853) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 --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=7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 11:24:15,166 truncating revision to first 12 chars 2016-08-01 11:24:15,166 Setting DEBUG logging. 2016-08-01 11:24:15,166 attempt 1/10 2016-08-01 11:24:15,167 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/bad9d4f5bf7e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 11:24:15,461 unpacking tar archive at: mozilla-beta-bad9d4f5bf7e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655897 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:15.590484) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:15.590814) ========= script_repo_revision: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:15.591221) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:15.591529) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:15.602325) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-01 11:24:15.602609) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:24:15 INFO - MultiFileLogger online at 20160801 11:24:15 in /builds/slave/test 11:24:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:24:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:24:15 INFO - {'append_to_log': False, 11:24:15 INFO - 'base_work_dir': '/builds/slave/test', 11:24:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:24:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:24:15 INFO - 'branch': 'Mozilla-Beta', 11:24:15 INFO - 'buildbot_json_path': 'buildprops.json', 11:24:15 INFO - 'config_files': ('talos/linux_config.py',), 11:24:15 INFO - 'default_actions': ('clobber', 11:24:15 INFO - 'read-buildbot-config', 11:24:15 INFO - 'download-and-extract', 11:24:15 INFO - 'populate-webroot', 11:24:15 INFO - 'create-virtualenv', 11:24:15 INFO - 'install', 11:24:15 INFO - 'run-tests'), 11:24:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:24:15 INFO - 'download_minidump_stackwalk': True, 11:24:15 INFO - 'download_symbols': 'ondemand', 11:24:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:24:15 INFO - 'tooltool.py': '/tools/tooltool.py', 11:24:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:24:15 INFO - '/tools/misc-python/virtualenv.py')}, 11:24:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:24:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:24:15 INFO - 'installer_path': 'installer.exe', 11:24:15 INFO - 'log_level': 'info', 11:24:15 INFO - 'log_name': 'talos', 11:24:15 INFO - 'log_to_console': True, 11:24:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:24:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:24:15 INFO - 'opt_config_files': (), 11:24:15 INFO - 'pip_index': False, 11:24:15 INFO - 'sps_profile': False, 11:24:15 INFO - 'sps_profile_interval': 0, 11:24:15 INFO - 'suite': 'dromaeojs', 11:24:15 INFO - 'system_bits': '32', 11:24:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:24:15 INFO - 'title': 'talos-linux64-ix-005', 11:24:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:24:15 INFO - 'use_talos_json': True, 11:24:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:24:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:24:15 INFO - 'work_dir': 'build'} 11:24:15 INFO - ##### 11:24:15 INFO - ##### Running clobber step. 11:24:15 INFO - ##### 11:24:15 INFO - Running pre-action listener: _resource_record_pre_action 11:24:15 INFO - Running main action method: clobber 11:24:15 INFO - rmtree: /builds/slave/test/build 11:24:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:24:16 INFO - Running post-action listener: _resource_record_post_action 11:24:16 INFO - ##### 11:24:16 INFO - ##### Finished clobber step (success) 11:24:16 INFO - ##### 11:24:16 INFO - ##### 11:24:16 INFO - ##### Running read-buildbot-config step. 11:24:16 INFO - ##### 11:24:16 INFO - Running pre-action listener: _resource_record_pre_action 11:24:16 INFO - Running main action method: read_buildbot_config 11:24:16 INFO - Using buildbot properties: 11:24:16 INFO - { 11:24:16 INFO - "project": "", 11:24:16 INFO - "product": "firefox", 11:24:16 INFO - "script_repo_revision": "production", 11:24:16 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:24:16 INFO - "repository": "", 11:24:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:24:16 INFO - "buildid": "20160801070053", 11:24:16 INFO - "pgo_build": "True", 11:24:16 INFO - "basedir": "/builds/slave/test", 11:24:16 INFO - "buildnumber": 183, 11:24:16 INFO - "slavename": "talos-linux64-ix-005", 11:24:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:24:16 INFO - "platform": "ubuntu64_hw", 11:24:16 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:24:16 INFO - "branch": "mozilla-beta", 11:24:16 INFO - "repo_path": "releases/mozilla-beta", 11:24:16 INFO - "revision": "bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2", 11:24:16 INFO - "stage_platform": "linux64-pgo", 11:24:16 INFO - "builduid": "eaf10adbc6074edb9e3b1e3d32dab73b", 11:24:16 INFO - "slavebuilddir": "test" 11:24:16 INFO - } 11:24:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2. 11:24:16 INFO - Running post-action listener: _resource_record_post_action 11:24:16 INFO - ##### 11:24:16 INFO - ##### Finished read-buildbot-config step (success) 11:24:16 INFO - ##### 11:24:16 INFO - ##### 11:24:16 INFO - ##### Running download-and-extract step. 11:24:16 INFO - ##### 11:24:16 INFO - Running pre-action listener: _resource_record_pre_action 11:24:16 INFO - Running main action method: download_and_extract 11:24:16 INFO - mkdir: /builds/slave/test/build/tests 11:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:16 INFO - https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:24:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:24:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:24:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:24:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:24:18 INFO - Downloaded 1327 bytes. 11:24:18 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:24:18 INFO - Using the following test package requirements: 11:24:18 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 11:24:18 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:18 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:24:18 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:18 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 11:24:18 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:18 INFO - u'jsshell-linux-x86_64.zip'], 11:24:18 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:18 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:24:18 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 11:24:18 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:18 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 11:24:18 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:18 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 11:24:18 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:18 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:24:18 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:18 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:24:18 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:18 INFO - https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:24:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:24:19 INFO - Downloaded 21968684 bytes. 11:24:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:24:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:24:21 INFO - Return code: 0 11:24:21 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:24: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')]} 11:24:21 INFO - https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:24:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip 11:24:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:24:26 INFO - Downloaded 21968684 bytes. 11:24:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:24:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 11:24:27 INFO - Return code: 0 11:24: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')]} 11:24:27 INFO - https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:24:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 11:24:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 11:24:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip 11:24:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:24:29 INFO - Downloaded 10833369 bytes. 11:24:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 11:24:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 11:24:29 INFO - Return code: 0 11:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:29 INFO - https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:24:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:24:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:24:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:24:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:24:30 INFO - Downloaded 55264299 bytes. 11:24:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:24:30 INFO - mkdir: /builds/slave/test/properties 11:24:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:30 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:30 INFO - Contents: 11:24:30 INFO - build_url:https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 11:24:31 INFO - Running post-action listener: _resource_record_post_action 11:24:31 INFO - Running post-action listener: set_extra_try_arguments 11:24:31 INFO - ##### 11:24:31 INFO - ##### Finished download-and-extract step (success) 11:24:31 INFO - ##### 11:24:31 INFO - ##### 11:24:31 INFO - ##### Running populate-webroot step. 11:24:31 INFO - ##### 11:24:31 INFO - Running pre-action listener: _resource_record_pre_action 11:24:31 INFO - Running main action method: populate_webroot 11:24:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:24:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:24:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:24:31 INFO - '--tppagecycles', 11:24:31 INFO - '7'], 11:24:31 INFO - 'tests': ['tsvgm']}}, 11:24:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:24:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:24:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:24:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:24:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:24:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:24:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:31 INFO - 'talos_options': ['--disable-e10s'], 11:24:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:31 INFO - 'talos_options': ['--disable-e10s'], 11:24:31 INFO - 'tests': ['damp', 'tps']}, 11:24:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:31 INFO - 'tests': ['damp', 'tps']}, 11:24:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:24:31 INFO - 'tests': ['dromaeo_dom']}, 11:24:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:24:31 INFO - 'tests': ['a11yr', 11:24:31 INFO - 'ts_paint', 11:24:31 INFO - 'tpaint', 11:24:31 INFO - 'sessionrestore', 11:24:31 INFO - 'sessionrestore_no_auto_restore', 11:24:31 INFO - 'tabpaint']}, 11:24:31 INFO - 'other-e10s': {'tests': ['a11yr', 11:24:31 INFO - 'ts_paint', 11:24:31 INFO - 'tpaint', 11:24:31 INFO - 'sessionrestore', 11:24:31 INFO - 'sessionrestore_no_auto_restore', 11:24:31 INFO - 'tabpaint']}, 11:24:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:24:31 INFO - 'ts_paint', 11:24:31 INFO - 'tpaint', 11:24:31 INFO - 'sessionrestore', 11:24:31 INFO - 'sessionrestore_no_auto_restore', 11:24:31 INFO - 'tabpaint']}, 11:24:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:24:31 INFO - 'ts_paint', 11:24:31 INFO - 'tpaint', 11:24:31 INFO - 'sessionrestore', 11:24:31 INFO - 'sessionrestore_no_auto_restore', 11:24:31 INFO - 'tabpaint']}, 11:24:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:24:31 INFO - 'tests': ['a11yr', 11:24:31 INFO - 'ts_paint', 11:24:31 INFO - 'tpaint', 11:24:31 INFO - 'sessionrestore', 11:24:31 INFO - 'sessionrestore_no_auto_restore', 11:24:31 INFO - 'tabpaint']}, 11:24:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:24:31 INFO - 'tests': ['a11yr', 11:24:31 INFO - 'ts_paint', 11:24:31 INFO - 'tpaint', 11:24:31 INFO - 'sessionrestore', 11:24:31 INFO - 'sessionrestore_no_auto_restore', 11:24:31 INFO - 'tabpaint']}, 11:24:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:24:31 INFO - 'tests': ['tsvgx', 11:24:31 INFO - 'tsvgr_opacity', 11:24:31 INFO - 'tart', 11:24:31 INFO - 'tscrollx', 11:24:31 INFO - 'cart']}, 11:24:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:24:31 INFO - 'tsvgr_opacity', 11:24:31 INFO - 'tart', 11:24:31 INFO - 'tscrollx', 11:24:31 INFO - 'cart']}, 11:24:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:31 INFO - 'talos_options': ['--disable-e10s'], 11:24:31 INFO - 'tests': ['tp5o']}, 11:24:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:31 INFO - 'tests': ['tp5o']}, 11:24:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:31 INFO - 'talos_options': ['--disable-e10s', 11:24:31 INFO - '--xperf_path', 11:24:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:31 INFO - 'tests': ['tp5n']}, 11:24:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:31 INFO - 'talos_options': ['--xperf_path', 11:24:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:31 INFO - 'tests': ['tp5n']}}, 11:24:31 INFO - 'talos.zip': {'path': '', 11:24:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:24:31 INFO - Running post-action listener: _resource_record_post_action 11:24:31 INFO - ##### 11:24:31 INFO - ##### Finished populate-webroot step (success) 11:24:31 INFO - ##### 11:24:31 INFO - ##### 11:24:31 INFO - ##### Running create-virtualenv step. 11:24:31 INFO - ##### 11:24:31 INFO - Running pre-action listener: _resource_record_pre_action 11:24:31 INFO - Running main action method: create_virtualenv 11:24:31 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:31 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 11:24:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:24:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:31 INFO - Using real prefix '/usr' 11:24:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:32 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:33 INFO - Installing pip.................done. 11:24:33 INFO - Return code: 0 11:24:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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')]} 11:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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 0x7f3817bfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d1c0>, '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 0x1a7e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', '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 11:24: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 11:24: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 11:24:33 INFO - Using env: {'DISPLAY': ':0', 11:24:33 INFO - 'HOME': '/home/cltbld', 11:24:33 INFO - 'LANG': 'en_US.UTF-8', 11:24:33 INFO - 'LANGUAGE': 'en_US:en', 11:24:33 INFO - 'LOGNAME': 'cltbld', 11:24:33 INFO - 'MAIL': '/var/mail/cltbld', 11:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:33 INFO - 'MOZ_NO_REMOTE': '1', 11:24:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:33 INFO - 'NO_EM_RESTART': '1', 11:24:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:33 INFO - 'PWD': '/builds/slave/test', 11:24:33 INFO - 'SHELL': '/bin/bash', 11:24:33 INFO - 'SHLVL': '1', 11:24:33 INFO - 'TERM': 'linux', 11:24:33 INFO - 'TMOUT': '86400', 11:24:33 INFO - 'USER': 'cltbld', 11:24:33 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', 11:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:33 INFO - '_': '/tools/buildbot/bin/python'} 11:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:34 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 11:24:34 INFO - Cleaning up... 11:24:34 INFO - Return code: 0 11:24:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:24:34 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')]} 11:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:34 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')]} 11:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:34 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 0x7f3817bfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d1c0>, '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 0x1a7e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', '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 11:24:34 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 11:24:34 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 11:24:34 INFO - Using env: {'DISPLAY': ':0', 11:24:34 INFO - 'HOME': '/home/cltbld', 11:24:34 INFO - 'LANG': 'en_US.UTF-8', 11:24:34 INFO - 'LANGUAGE': 'en_US:en', 11:24:34 INFO - 'LOGNAME': 'cltbld', 11:24:34 INFO - 'MAIL': '/var/mail/cltbld', 11:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:34 INFO - 'MOZ_NO_REMOTE': '1', 11:24:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:34 INFO - 'NO_EM_RESTART': '1', 11:24:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:34 INFO - 'PWD': '/builds/slave/test', 11:24:34 INFO - 'SHELL': '/bin/bash', 11:24:34 INFO - 'SHLVL': '1', 11:24:34 INFO - 'TERM': 'linux', 11:24:34 INFO - 'TMOUT': '86400', 11:24:34 INFO - 'USER': 'cltbld', 11:24:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', 11:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:34 INFO - '_': '/tools/buildbot/bin/python'} 11:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:34 INFO - Downloading/unpacking psutil>=3.1.1 11:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:24:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:36 INFO - Installing collected packages: psutil 11:24:36 INFO - Running setup.py install for psutil 11:24:36 INFO - building 'psutil._psutil_linux' extension 11:24:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:24: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 11:24:36 INFO - building 'psutil._psutil_posix' extension 11:24: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 11:24: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 11:24:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:36 INFO - Successfully installed psutil 11:24:36 INFO - Cleaning up... 11:24:36 INFO - Return code: 0 11:24:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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')]} 11:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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 0x7f3817bfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d1c0>, '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 0x1a7e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', '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 11:24: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 11:24: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 11:24:36 INFO - Using env: {'DISPLAY': ':0', 11:24:36 INFO - 'HOME': '/home/cltbld', 11:24:36 INFO - 'LANG': 'en_US.UTF-8', 11:24:36 INFO - 'LANGUAGE': 'en_US:en', 11:24:36 INFO - 'LOGNAME': 'cltbld', 11:24:36 INFO - 'MAIL': '/var/mail/cltbld', 11:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:36 INFO - 'MOZ_NO_REMOTE': '1', 11:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:36 INFO - 'NO_EM_RESTART': '1', 11:24:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:36 INFO - 'PWD': '/builds/slave/test', 11:24:36 INFO - 'SHELL': '/bin/bash', 11:24:36 INFO - 'SHLVL': '1', 11:24:36 INFO - 'TERM': 'linux', 11:24:36 INFO - 'TMOUT': '86400', 11:24:36 INFO - 'USER': 'cltbld', 11:24:36 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', 11:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:36 INFO - '_': '/tools/buildbot/bin/python'} 11:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:24:37 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 11:24:37 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 11:24:37 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 11:24:37 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 11:24:37 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 11:24:37 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 11:24:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:24:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:24:39 INFO - Installing collected packages: mozsystemmonitor 11:24:39 INFO - Running setup.py install for mozsystemmonitor 11:24:39 INFO - Successfully installed mozsystemmonitor 11:24:39 INFO - Cleaning up... 11:24:39 INFO - Return code: 0 11:24:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:24:39 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')]} 11:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:39 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')]} 11:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:39 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 0x7f3817bfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d1c0>, '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 0x1a7e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', '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 11:24:39 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 11:24:39 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 11:24:39 INFO - Using env: {'DISPLAY': ':0', 11:24:39 INFO - 'HOME': '/home/cltbld', 11:24:39 INFO - 'LANG': 'en_US.UTF-8', 11:24:39 INFO - 'LANGUAGE': 'en_US:en', 11:24:39 INFO - 'LOGNAME': 'cltbld', 11:24:39 INFO - 'MAIL': '/var/mail/cltbld', 11:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:39 INFO - 'MOZ_NO_REMOTE': '1', 11:24:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:39 INFO - 'NO_EM_RESTART': '1', 11:24:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:39 INFO - 'PWD': '/builds/slave/test', 11:24:39 INFO - 'SHELL': '/bin/bash', 11:24:39 INFO - 'SHLVL': '1', 11:24:39 INFO - 'TERM': 'linux', 11:24:39 INFO - 'TMOUT': '86400', 11:24:39 INFO - 'USER': 'cltbld', 11:24:39 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', 11:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:39 INFO - '_': '/tools/buildbot/bin/python'} 11:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:39 INFO - Downloading/unpacking jsonschema==2.5.1 11:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:24:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24:41 INFO - Downloading functools32-3.2.3-2.tar.gz 11:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:24:41 INFO - warning: no files found matching '*.txt' 11:24:41 INFO - no previously-included directories found matching 'build' 11:24:41 INFO - no previously-included directories found matching 'dist' 11:24:41 INFO - no previously-included directories found matching '.git*' 11:24:41 INFO - Installing collected packages: jsonschema, functools32 11:24:41 INFO - Running setup.py install for functools32 11:24:41 INFO - warning: no files found matching '*.txt' 11:24:41 INFO - no previously-included directories found matching 'build' 11:24:41 INFO - no previously-included directories found matching 'dist' 11:24:41 INFO - no previously-included directories found matching '.git*' 11:24:41 INFO - Successfully installed jsonschema functools32 11:24:41 INFO - Cleaning up... 11:24:41 INFO - Return code: 0 11:24:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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')]} 11:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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 0x7f3817bfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d1c0>, '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 0x1a7e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', '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 11:24: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 11:24: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 11:24:41 INFO - Using env: {'DISPLAY': ':0', 11:24:41 INFO - 'HOME': '/home/cltbld', 11:24:41 INFO - 'LANG': 'en_US.UTF-8', 11:24:41 INFO - 'LANGUAGE': 'en_US:en', 11:24:41 INFO - 'LOGNAME': 'cltbld', 11:24:41 INFO - 'MAIL': '/var/mail/cltbld', 11:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:41 INFO - 'MOZ_NO_REMOTE': '1', 11:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:41 INFO - 'NO_EM_RESTART': '1', 11:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:41 INFO - 'PWD': '/builds/slave/test', 11:24:41 INFO - 'SHELL': '/bin/bash', 11:24:41 INFO - 'SHLVL': '1', 11:24:41 INFO - 'TERM': 'linux', 11:24:41 INFO - 'TMOUT': '86400', 11:24:41 INFO - 'USER': 'cltbld', 11:24:41 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', 11:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:41 INFO - '_': '/tools/buildbot/bin/python'} 11:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:42 INFO - Downloading/unpacking blobuploader==1.2.4 11:24:42 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 11:24:42 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 11:24:42 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 11:24:42 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 11:24:42 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 11:24:42 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 11:24:43 INFO - Downloading blobuploader-1.2.4.tar.gz 11:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:24:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:24:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24:44 INFO - Downloading docopt-0.6.1.tar.gz 11:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:24:44 INFO - Installing collected packages: blobuploader, requests, docopt 11:24:44 INFO - Running setup.py install for blobuploader 11:24:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:24:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:24:44 INFO - Running setup.py install for requests 11:24:45 INFO - Running setup.py install for docopt 11:24:45 INFO - Successfully installed blobuploader requests docopt 11:24:45 INFO - Cleaning up... 11:24:45 INFO - Return code: 0 11:24:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3817bfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d1c0>, '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 0x1a7e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', '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 11:24:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:24:45 INFO - Using env: {'DISPLAY': ':0', 11:24:45 INFO - 'HOME': '/home/cltbld', 11:24:45 INFO - 'LANG': 'en_US.UTF-8', 11:24:45 INFO - 'LANGUAGE': 'en_US:en', 11:24:45 INFO - 'LOGNAME': 'cltbld', 11:24:45 INFO - 'MAIL': '/var/mail/cltbld', 11:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:45 INFO - 'MOZ_NO_REMOTE': '1', 11:24:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:45 INFO - 'NO_EM_RESTART': '1', 11:24:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:45 INFO - 'PWD': '/builds/slave/test', 11:24:45 INFO - 'SHELL': '/bin/bash', 11:24:45 INFO - 'SHLVL': '1', 11:24:45 INFO - 'TERM': 'linux', 11:24:45 INFO - 'TMOUT': '86400', 11:24:45 INFO - 'USER': 'cltbld', 11:24:45 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', 11:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:45 INFO - '_': '/tools/buildbot/bin/python'} 11:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:45 INFO - Running setup.py (path:/tmp/pip-lzmVh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:45 INFO - Running setup.py (path:/tmp/pip-EJ9otf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:45 INFO - Running setup.py (path:/tmp/pip-uZHd_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:45 INFO - Running setup.py (path:/tmp/pip-FtffK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:45 INFO - Running setup.py (path:/tmp/pip-Zs_O2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:45 INFO - Running setup.py (path:/tmp/pip-rliS2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:45 INFO - Running setup.py (path:/tmp/pip-OM2ME1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:46 INFO - Running setup.py (path:/tmp/pip-PRkduj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:46 INFO - Running setup.py (path:/tmp/pip-9QrFLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:46 INFO - Running setup.py (path:/tmp/pip-obEJI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:46 INFO - Running setup.py (path:/tmp/pip-8ovuoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:46 INFO - Running setup.py (path:/tmp/pip-td9oNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:46 INFO - Running setup.py (path:/tmp/pip-IwTZXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:46 INFO - Running setup.py (path:/tmp/pip-JMELUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:46 INFO - Running setup.py (path:/tmp/pip-6n1t1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:46 INFO - Running setup.py (path:/tmp/pip-R6K0qT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:46 INFO - Running setup.py (path:/tmp/pip-TRPi03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:24:46 INFO - Running setup.py install for manifestparser 11:24:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:24:46 INFO - Running setup.py install for mozcrash 11:24:46 INFO - Running setup.py install for mozdebug 11:24:47 INFO - Running setup.py install for mozdevice 11:24:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Running setup.py install for mozfile 11:24:47 INFO - Running setup.py install for mozhttpd 11:24:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Running setup.py install for mozinfo 11:24:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Running setup.py install for mozInstall 11:24:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Running setup.py install for mozleak 11:24:47 INFO - Running setup.py install for mozlog 11:24:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Running setup.py install for moznetwork 11:24:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:24:47 INFO - Running setup.py install for mozprocess 11:24:47 INFO - Running setup.py install for mozprofile 11:24:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:24:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:24:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:24:48 INFO - Running setup.py install for mozrunner 11:24:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:24:48 INFO - Running setup.py install for mozscreenshot 11:24:48 INFO - Running setup.py install for moztest 11:24:48 INFO - Running setup.py install for mozversion 11:24:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:24:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:24:48 INFO - Cleaning up... 11:24:48 INFO - Return code: 0 11:24:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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')]} 11:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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 0x7f3817bfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d1c0>, '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 0x1a7e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', '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 11:24: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 11:24: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 11:24:48 INFO - Using env: {'DISPLAY': ':0', 11:24:48 INFO - 'HOME': '/home/cltbld', 11:24:48 INFO - 'LANG': 'en_US.UTF-8', 11:24:48 INFO - 'LANGUAGE': 'en_US:en', 11:24:48 INFO - 'LOGNAME': 'cltbld', 11:24:48 INFO - 'MAIL': '/var/mail/cltbld', 11:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:48 INFO - 'MOZ_NO_REMOTE': '1', 11:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:48 INFO - 'NO_EM_RESTART': '1', 11:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:48 INFO - 'PWD': '/builds/slave/test', 11:24:48 INFO - 'SHELL': '/bin/bash', 11:24:48 INFO - 'SHLVL': '1', 11:24:48 INFO - 'TERM': 'linux', 11:24:48 INFO - 'TMOUT': '86400', 11:24:48 INFO - 'USER': 'cltbld', 11:24:48 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', 11:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:48 INFO - '_': '/tools/buildbot/bin/python'} 11:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:48 INFO - Running setup.py (path:/tmp/pip-yZjvrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24: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)) 11:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:48 INFO - Running setup.py (path:/tmp/pip-swpT_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24: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)) 11:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:48 INFO - Running setup.py (path:/tmp/pip-asl1Mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24: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)) 11:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:48 INFO - Running setup.py (path:/tmp/pip-AlTdpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:49 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)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:49 INFO - Running setup.py (path:/tmp/pip-8LS6v0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:49 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)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:49 INFO - Running setup.py (path:/tmp/pip-sPdcpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:49 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)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:49 INFO - Running setup.py (path:/tmp/pip-omwM3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:49 INFO - Running setup.py (path:/tmp/pip-OPwHcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:49 INFO - Running setup.py (path:/tmp/pip-XwJeRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24: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)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:49 INFO - Running setup.py (path:/tmp/pip-oORCPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24: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)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:49 INFO - Running setup.py (path:/tmp/pip-Wi0Y6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24: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)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:49 INFO - Running setup.py (path:/tmp/pip-PO1UxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24: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)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:49 INFO - Running setup.py (path:/tmp/pip-b8LlUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24: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)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:49 INFO - Running setup.py (path:/tmp/pip-IdZLWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24: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)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:49 INFO - Running setup.py (path:/tmp/pip-imcd2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24: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)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:49 INFO - Running setup.py (path:/tmp/pip-k7nSo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24: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)) 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:49 INFO - Running setup.py (path:/tmp/pip-nQmaqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24: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)) 11:24: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)) 11:24: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)) 11:24: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)) 11:24: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)) 11:24: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)) 11:24:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:24:50 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 11:24:50 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 11:24:50 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 11:24:50 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 11:24:50 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 11:24:50 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 11:24:51 INFO - Downloading blessings-1.6.tar.gz 11:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:24:51 INFO - Installing collected packages: blessings 11:24:51 INFO - Running setup.py install for blessings 11:24:52 INFO - Successfully installed blessings 11:24:52 INFO - Cleaning up... 11:24:52 INFO - Return code: 0 11:24:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:24:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:52 INFO - Reading from file tmpfile_stdout 11:24:52 INFO - Current package versions: 11:24:52 INFO - argparse == 1.2.1 11:24:52 INFO - blessings == 1.6 11:24:52 INFO - blobuploader == 1.2.4 11:24:52 INFO - docopt == 0.6.1 11:24:52 INFO - functools32 == 3.2.3-2 11:24:52 INFO - jsonschema == 2.5.1 11:24:52 INFO - manifestparser == 1.1 11:24:52 INFO - mozInstall == 1.12 11:24:52 INFO - mozcrash == 0.17 11:24:52 INFO - mozdebug == 0.1 11:24:52 INFO - mozdevice == 0.48 11:24:52 INFO - mozfile == 1.2 11:24:52 INFO - mozhttpd == 0.7 11:24:52 INFO - mozinfo == 0.9 11:24:52 INFO - mozleak == 0.1 11:24:52 INFO - mozlog == 3.2 11:24:52 INFO - moznetwork == 0.27 11:24:52 INFO - mozprocess == 0.23 11:24:52 INFO - mozprofile == 0.28 11:24:52 INFO - mozrunner == 6.12 11:24:52 INFO - mozscreenshot == 0.1 11:24:52 INFO - mozsystemmonitor == 0.3 11:24:52 INFO - moztest == 0.7 11:24:52 INFO - mozversion == 1.4 11:24:52 INFO - psutil == 3.1.1 11:24:52 INFO - requests == 1.2.3 11:24:52 INFO - wsgiref == 0.1.2 11:24:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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')]} 11:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3817bfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d1c0>, '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 0x1a7e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', '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 11:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:24:52 INFO - Using env: {'DISPLAY': ':0', 11:24:52 INFO - 'HOME': '/home/cltbld', 11:24:52 INFO - 'LANG': 'en_US.UTF-8', 11:24:52 INFO - 'LANGUAGE': 'en_US:en', 11:24:52 INFO - 'LOGNAME': 'cltbld', 11:24:52 INFO - 'MAIL': '/var/mail/cltbld', 11:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:52 INFO - 'MOZ_NO_REMOTE': '1', 11:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:52 INFO - 'NO_EM_RESTART': '1', 11:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:52 INFO - 'PWD': '/builds/slave/test', 11:24:52 INFO - 'SHELL': '/bin/bash', 11:24:52 INFO - 'SHLVL': '1', 11:24:52 INFO - 'TERM': 'linux', 11:24:52 INFO - 'TMOUT': '86400', 11:24:52 INFO - 'USER': 'cltbld', 11:24:52 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', 11:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:52 INFO - '_': '/tools/buildbot/bin/python'} 11:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24: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)) 11:24: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)) 11:24: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)) 11:24: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)) 11:24: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)) 11:24: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)) 11:24: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)) 11:24: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)) 11:24: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)) 11:24: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)) 11:24: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)) 11:24:52 INFO - Cleaning up... 11:24:52 INFO - Return code: 0 11:24:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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')]} 11:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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 0x7f3817bfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d1c0>, '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 0x1a7e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', '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 11:24: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 11:24: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 11:24:52 INFO - Using env: {'DISPLAY': ':0', 11:24:52 INFO - 'HOME': '/home/cltbld', 11:24:52 INFO - 'LANG': 'en_US.UTF-8', 11:24:52 INFO - 'LANGUAGE': 'en_US:en', 11:24:52 INFO - 'LOGNAME': 'cltbld', 11:24:52 INFO - 'MAIL': '/var/mail/cltbld', 11:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:52 INFO - 'MOZ_NO_REMOTE': '1', 11:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:52 INFO - 'NO_EM_RESTART': '1', 11:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:52 INFO - 'PWD': '/builds/slave/test', 11:24:52 INFO - 'SHELL': '/bin/bash', 11:24:52 INFO - 'SHLVL': '1', 11:24:52 INFO - 'TERM': 'linux', 11:24:52 INFO - 'TMOUT': '86400', 11:24:52 INFO - 'USER': 'cltbld', 11:24:52 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', 11:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:52 INFO - '_': '/tools/buildbot/bin/python'} 11:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:24:52 INFO - Cleaning up... 11:24:52 INFO - Return code: 0 11:24:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:24: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')]} 11:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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')]} 11:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24: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 0x7f3817bfef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19238a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d1c0>, '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 0x1a7e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e550>, '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': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', '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 11:24: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 11:24: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 11:24:52 INFO - Using env: {'DISPLAY': ':0', 11:24:52 INFO - 'HOME': '/home/cltbld', 11:24:52 INFO - 'LANG': 'en_US.UTF-8', 11:24:52 INFO - 'LANGUAGE': 'en_US:en', 11:24:52 INFO - 'LOGNAME': 'cltbld', 11:24:52 INFO - 'MAIL': '/var/mail/cltbld', 11:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:52 INFO - 'MOZ_NO_REMOTE': '1', 11:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:52 INFO - 'NO_EM_RESTART': '1', 11:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:52 INFO - 'PWD': '/builds/slave/test', 11:24:52 INFO - 'SHELL': '/bin/bash', 11:24:52 INFO - 'SHLVL': '1', 11:24:52 INFO - 'TERM': 'linux', 11:24:52 INFO - 'TMOUT': '86400', 11:24:52 INFO - 'USER': 'cltbld', 11:24:52 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', 11:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:52 INFO - '_': '/tools/buildbot/bin/python'} 11:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:52 INFO - Downloading/unpacking flake8 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:24:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24: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 11:24:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:24:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:24:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:24:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:24:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:24:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:24:55 INFO - no previously-included directories found matching 'docs/_build' 11:24:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:24:55 INFO - Running setup.py install for pep8 11:24:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:24:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:24:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:24:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:24:55 INFO - no previously-included directories found matching 'docs/_build' 11:24:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:24:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:24:55 INFO - Cleaning up... 11:24:55 INFO - Return code: 0 11:24:55 INFO - Running post-action listener: _resource_record_post_action 11:24:55 INFO - Running post-action listener: _start_resource_monitoring 11:24:55 INFO - Starting resource monitoring. 11:24:55 INFO - ##### 11:24:55 INFO - ##### Finished create-virtualenv step (success) 11:24:55 INFO - ##### 11:24:55 INFO - ##### 11:24:55 INFO - ##### Running install step. 11:24:55 INFO - ##### 11:24:55 INFO - Running pre-action listener: _resource_record_pre_action 11:24:55 INFO - Running main action method: install 11:24:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:56 INFO - Reading from file tmpfile_stdout 11:24:56 INFO - Detecting whether we're running mozinstall >=1.0... 11:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:24:56 INFO - Reading from file tmpfile_stdout 11:24:56 INFO - Output received: 11:24:56 INFO - Usage: mozinstall [options] installer 11:24:56 INFO - Options: 11:24:56 INFO - -h, --help show this help message and exit 11:24:56 INFO - -d DEST, --destination=DEST 11:24:56 INFO - Directory to install application into. [default: 11:24:56 INFO - "/builds/slave/test"] 11:24:56 INFO - --app=APP Application being installed. [default: firefox] 11:24:56 INFO - mkdir: /builds/slave/test/build/application 11:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:25:09 INFO - Reading from file tmpfile_stdout 11:25:09 INFO - Output received: 11:25:09 INFO - /builds/slave/test/build/application/firefox/firefox 11:25:09 INFO - Running post-action listener: _resource_record_post_action 11:25:09 INFO - ##### 11:25:09 INFO - ##### Finished install step (success) 11:25:09 INFO - ##### 11:25:09 INFO - ##### 11:25:09 INFO - ##### Running run-tests step. 11:25:09 INFO - ##### 11:25:09 INFO - Running pre-action listener: _resource_record_pre_action 11:25:09 INFO - Running main action method: run_tests 11:25:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:09 INFO - Python 2.7.3 11:25:09 INFO - Return code: 0 11:25:09 INFO - grabbing minidump binary from tooltool 11:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:25:09 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7d1c0>, '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 0x1a7e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:25:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:25:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:25:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:09 INFO - Return code: 0 11:25:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:25:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:25:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:25:10 INFO - Return code: 0 11:25:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 11:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 11:25:10 INFO - Using env: {'DISPLAY': ':0', 11:25:10 INFO - 'HOME': '/home/cltbld', 11:25:10 INFO - 'LANG': 'en_US.UTF-8', 11:25:10 INFO - 'LANGUAGE': 'en_US:en', 11:25:10 INFO - 'LOGNAME': 'cltbld', 11:25:10 INFO - 'MAIL': '/var/mail/cltbld', 11:25:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:10 INFO - 'MOZ_NO_REMOTE': '1', 11:25:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:10 INFO - 'NO_EM_RESTART': '1', 11:25:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:10 INFO - 'PWD': '/builds/slave/test', 11:25:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:10 INFO - 'SHELL': '/bin/bash', 11:25:10 INFO - 'SHLVL': '1', 11:25:10 INFO - 'TERM': 'linux', 11:25:10 INFO - 'TMOUT': '86400', 11:25:10 INFO - 'USER': 'cltbld', 11:25:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085', 11:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:10 INFO - '_': '/tools/buildbot/bin/python'} 11:25:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 11:25:10 INFO - mozversion application_buildid: 20160801070053 11:25:10 INFO - mozversion application_changeset: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 11:25:10 INFO - mozversion application_display_name: Firefox 11:25:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:10 INFO - mozversion application_name: Firefox 11:25:10 INFO - mozversion application_remotingname: firefox 11:25:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:25:10 INFO - mozversion application_vendor: Mozilla 11:25:10 INFO - mozversion application_version: 49.0 11:25:10 INFO - mozversion platform_buildid: 20160801070053 11:25:10 INFO - mozversion platform_changeset: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 11:25:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:25:10 INFO - mozversion platform_version: 49.0 11:25:10 INFO - using testdate: 1470075910 11:25:10 INFO - actual date: 1470075910 11:25:10 INFO - starting webserver on 'localhost:60984' 11:25:10 INFO - SUITE-START | Running 2 tests 11:25:10 INFO - TEST-START | dromaeo_css 11:25:10 INFO - operating with platform_type : linux_ 11:25:10 INFO - Initialising browser for dromaeo_css test... 11:25:10 INFO - TEST-INFO | started process 17887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJvfZxL/profile http://localhost:60984/getInfo.html) 11:25:14 INFO - PROCESS | 17887 | __metrics Screen width/height:1600/1200 11:25:14 INFO - PROCESS | 17887 | colorDepth:24 11:25:14 INFO - PROCESS | 17887 | Browser inner width/height: 1024/697 11:25:14 INFO - PROCESS | 17887 | __metrics 11:25:15 INFO - PROCESS | 17887 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:25:15 ERROR - PROCESS | 17887 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:25:16 INFO - TEST-INFO | 17887: exit 0 11:25:16 INFO - Browser initialized. 11:25:16 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:16 INFO - TEST-INFO | started process 17982 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJvfZxL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:27 INFO - PROCESS | 17982 | RSS: Main: 141737984 11:25:27 INFO - PROCESS | 17982 | 11:26:18 INFO - PROCESS | 17982 | 1470075978700 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] 11:28:27 INFO - PROCESS | 17982 | Cycle 1(1): loaded http://localhost:60984/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60984/tests/dromaeo/cssquery-ext.html) 11:28:28 INFO - PROCESS | 17982 | RSS: Main: 255348736 11:28:28 INFO - PROCESS | 17982 | 11:31:30 INFO - PROCESS | 17982 | Cycle 1(1): loaded http://localhost:60984/tests/dromaeo/cssquery-ext.html (next: http://localhost:60984/tests/dromaeo/cssquery-jquery.html) 11:31:31 INFO - PROCESS | 17982 | RSS: Main: 229507072 11:31:31 INFO - PROCESS | 17982 | 11:34:32 INFO - PROCESS | 17982 | Cycle 1(1): loaded http://localhost:60984/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60984/tests/dromaeo/cssquery-mootools.html) 11:34:33 INFO - PROCESS | 17982 | RSS: Main: 217088000 11:34:33 INFO - PROCESS | 17982 | 11:37:35 INFO - PROCESS | 17982 | Cycle 1(1): loaded http://localhost:60984/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60984/tests/dromaeo/cssquery-prototype.html) 11:37:36 INFO - PROCESS | 17982 | RSS: Main: 221741056 11:37:36 INFO - PROCESS | 17982 | 11:40:38 INFO - PROCESS | 17982 | Cycle 1(1): loaded http://localhost:60984/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60984/tests/dromaeo/cssquery-yui.html) 11:40:39 INFO - PROCESS | 17982 | RSS: Main: 209575936 11:40:39 INFO - PROCESS | 17982 | 11:43:41 INFO - PROCESS | 17982 | Cycle 1(1): loaded http://localhost:60984/tests/dromaeo/cssquery-yui.html (next: http://localhost:60984/tests/dromaeo/cssquery-dojo.html) 11:43:41 INFO - PROCESS | 17982 | RSS: Main: 261545984 11:43:41 INFO - PROCESS | 17982 | 11:43:41 INFO - PROCESS | 17982 | __start_tp_report 11:43:41 INFO - PROCESS | 17982 | _x_x_mozilla_page_load 11:43:41 INFO - PROCESS | 17982 | _x_x_mozilla_page_load_details 11:43:41 INFO - PROCESS | 17982 | |i|pagename|runs| 11:43:41 INFO - PROCESS | 17982 | |0;dojo.html;3445.6037555681096;3449.8792542261012;3455.896323110306;3473.1664400543877;3477.8782742604;5643.46387093226;5726.026575482168;5727.140928860673;5749.683767392792;5759.424057594244;5688.800891968782;5750.568707346944;5753.913691294634;5754.510866576346;5761.510271626917;5023.773930173151;5122.743862806863;5141.280220769096;5173.068847607429;5195.19474481456;5167.328247327842;5183.714895680736;5199.948000520003;5220.347456567929;5273.815416460425;5199.2461093141665;5222.190560463135;5229.921551176735;5262.789488420459;5297.205419187134;5290.074237008508;5302.655327403706;5305.999999999981;5311.946880531223;5334.386545547273;5042.621803364726;5077.974610126963;5099.33708617881;5199.14214154664;5205.635605507616;5612.07400778871;5630.521405680522;5633.014222511044;5662.065759149736;5665.150227465913;6085.421884920926;6099.041964647143;6132.294786099566;6149.3235744068115;6156.168917196166;5968.791092311748;6042.033274676075;6084.817455476343;6088;6167.907481387782;5748.741306641253;5748.913766293509;5753.906757716104;5756.194132821408;5763.827085187451;6252.124702541648;6253.093301471261;6268.122462855204;6268.937310626927;6269.62382257066;5900.793472228452;5963.821085367446;6018.15745795589;6019.187409699722;6107.633541987495;6147.200863887666;6155.6614386209185;6155.891939450942;6156.168917196122;6160.10678451622;5929;6097.298810636745;6123.020316749299;6126.448619624166;6132.6933653317155;5972.552058595623;6010.969945150334;6022.156898034279;6087.391260873966;6087.482563982023;4596.632269418438;4610.216263235258;4611.354410382549;4622.907541849144;4643.071385722869;4067.7559346439307;4075.1645912587846;4119.485064366954;4159.729617574848;4194.161167766459;5805.187273781674;5840.153177789197;5853.151293062482;5865.970670146622;5906.40935906406;6142.078688196806;6151.569390142647;6152.169457123231;6157.599756015845;6188.907166392508;5683.77264909399;5813.505852002542;5843.941560584425;5849.356570777211;5874.882502349929;5084.3644544431945;5303.893922121536;5307.548858347083;5313.787448502017;5339.038972984822;6392.3927226913365;6417;6425.807225783234;6428.614283143026;6438.581492203086;6028.246469191351;6031.306399764083;6043.909341359971;6073.605215660968;6210.5031597473;6264.968675156595;6280.811575652738;6304.117423560797;6314.431701146918;6318.968405157945;5992.43071908168;6002.039673652194;6002.399760023963;6020.367861374668;6025.78909738157;5897.970510147422;6127.1589861177945;6131.693415329305;6154.476869465966;6265.530085243534;6076.3012253591405;6077;6082.787102451393;6082.878342433215;6088.817335479943;5850.853728656818;6070.908936366046;6090.9390906090375;6099.207103076572;6101.725422356093;5861.472467477947;5899.115132730125;5912.083627037816;5921.052631578927;5954.702264886825;6068.544859135671;6076.574639775174;6090.288122842054;6095.007769910716;6118.326984031842;5791.884162316645;5850.5027072699295;5949.137375080676;5953.613015154001;5982.162497250475 11:43:41 INFO - PROCESS | 17982 | |1;ext.html;607.8055022392833;657.7763560389467;664.5945972956496;670.2894931372748;679.4768028617966;33695.66304336956;46948.295775563354;48024.75987620057;48064.51935480644;48120.518794812;49093.50906490934;49636;49804;49804.50195498044;49851.25223121647;8048.919510804905;9050.04974477682;9207.171354578086;10800.783984320347;11073.778524429506;10761.83857242142;10770.515326810273;10773.461326933622;10871.184661150406;10872;10861.782764344709;10940.945295273512;10942.398168100752;10944.45277736114;10945.671629851078;10891.07425868802;10919.39943303118;10951.397673127974;10959.178061645329;10959.83560246601;10786.406747628876;10797;10861.67414977552;10868;10871.619493317776;43946.78026609879;44429.777851110535;44464.55535444636;44497.33254001193;44571.108577828265;3906.2187562487334;3945.4081887716784;4002.139539998914;4002.199560087994;4115.259253334399;33664.32671346584;34298.82850585731;34429.31141377184;34515.65484345149;34653.30693386118;3918.5689574146822;3922.5685174630767;3930;3942.3298039333094;3970.047188674726;363534;364025;365071.9999999973;367494;369343;61796.382036179064;62702.686486568186;62788.68605657034;62951.6852415735;63013;39343;40286.39570406446;40374.59625403767;42484.78757606254;42567.78716106462;17174.74237886433;17738.29046838138;17798.555036124202;17875.37436189727;17877.553061173574;13882.722345553033;14177.432902683777;14199.929000354932;14467.92766036163;14476.203808790618;20668.58662826735;20829.68755468669;20888.373348799258;20888.47778805542;20951.8952405237;7429.85140297191;7605.733799316998;7636.732714354971;7837.451378403571;7849.843003139905;1031.5564307347763;1087.5758454202867;1138.8633363996207;1209.449700386322;1266.6200139957975;33295.83352083224;33839.66160338414;33965.830170849484;34273;34817.30365392678;1150.5685367987005;1168.7779321928806;1212.1757205100616;1226.2458587968335;1285.749278890626;16262;16429.26068326928;16438.178091095397;16489;16546;535729;540584;542917;545291;545671;61201.38798612046;62303.376966230666;62455.37544624587;62458;62518.0622290666;1375.910565813219;1414.1252966870904;1444.1984698492438;1517.8026856508804;1526.6107142678545;31185.376292474477;34004.82997584996;34243.82878085594;34685.65314346824;34998.30003399969;54302.18546721881;54726.72636636791;55002.17496737472;55014.17478737902;55023;467486;471319;471398;472188;472296;26439;29019.41961160807;29617.851910740308;29952;30004;50330;50522.74738626283;50805.237921431944;51290.74354628203;51626.22560661668;41624.375634366115;42181.367279491446;42817.78591107025;43190.78404607957;43939;42486.78756606197;42500.78749606232;43221.351679725456;43651.345229820945;43656.78171609122;39857.80071099626;40370;41179.1764164709;42295.57704422916;43083.78458107689;36011.45982810207;38651.2159944307;39527.209455810145;39570.208595828495;39692.80153599329;28709;28762.712372876;28899.56650650284;29325.26686832846;29482 11:43:41 INFO - PROCESS | 17982 | |2;jquery.html;412.54619918090106;415.4764996104907;416.62503746628033;417.709691764224;441.8056055335652;18184.81815181848;19700.60598788025;19919.103640336183;20556.794432055674;21207.469813254676;19419.902900485515;19577.804221957776;20193.394198174043;20293.594128117467;20360.18559257628;5799.942000579993;5961.493273071794;5985.162077309158;5985.6408615483;6005.579609427342;4250.936235956463;4542.477615074259;5886.705664716768;5947.791827286046;6762.087118239024;6791.830204244909;6811.693473793691;6838.555493892906;6852.794416167523;6858.451323894076;5424.105022671274;5738.626989245686;5756.395578464285;5805.593608447411;6798.52410331277;3819.1216020315483;5536.307961504812;5622.465865742748;5625.578081643893;5815.941840581582;14601.196934168616;14603.853961460462;15093.622659433493;23387.76612233873;23942.401439963967;2415.6618073469726;2476.1333533263396;2492.7382624824495;2543.300592337104;2625.540530407171;10406.687799366031;10459.529321180566;10553.261271710984;12723.872761272361;13908.721825563533;2023.7470316210474;2043.1827269092332;2044.7137400763756;2104;2129.7550781659997;66888;71274.28725712729;74785;75727.62136189338;84078.57960710219;9960.352577082467;10502.789944201226;11507.367094809699;11787.587434439753;11825.467853946593;16470.917645411697;16566.17169141538;16654.084025378477;16656.41702540405;16666.083365414775;8487.745367638981;8706.912930870736;8801.779955501164;8822.51476168804;8827;8369.121242269595;8384.16158384169;8417.915820841836;8479.576021198915;8552.315814734806;5004.699718016931;5036.093503169464;5059.367579052619;5089.643724939218;5143;1976.4861136104716;2007.207153174488;2014.8186663200383;2037.6785839082202;2040.1227472186806;995.9203263738883;1039.9168066554657;1052.147760314148;1095.5891540672249;1121.3272036777869;19386.90306548458;19543.12055957457;19618;19662.803371966384;20108.665825146833;1000.5297510170354;1007.2797949466167;1017.9898201018043;1021.6781713760141;1029.5418538750184;10537.631182908715;11057.11543076552;11064.944675276573;11074.667759967213;11090.223684342018;504974;517335;518835;562248;564335;89746;92831;94590;94860.52569737108;95938.5203073994;1066.989330106689;1077.5420446310443;1081.378207530673;1096.8848270931596;1100.471773548701;17444.302227910743;17575.29698812033;17582.296708131533;17585.384511542034;17967.191476383854;40818.79590602028;41508.792456037525;42369.15261694811;42974.355384668626;43125.78437107794;58142.41857581539;58334.4166558329;58398;58500;58817.411825882904;7437.479376443597;8801.207891289814;8808.119188081397;8963.820723585623;9054;11188.608398706006;12642.683932901751;13303.46786128544;13359.398827053;13511.662208444868;11376;11772.764544708887;12081.275123492618;12085.39573021363;12160.209586376857;11665.650030499099;11794.29234245948;12018.819717704067;12104.394780260776;12204.267743935392;11446.713832154262;12001.579944701894;12023.398830058288;12286.692832679255;12364.690882728004;7903.328217101611;7932.444728868923;8003;8004.279614834692;8014.559199244098;8894.155055269739;11364;12033.097517686034;12110.152289339661;12121.515139394325 11:43:41 INFO - PROCESS | 17982 | |3;mootools.html;1422.1253928833771;1589.6184915620254;1647.8105017922937;1828.8354048135673;1932.3816378758786;9037.909620903789;9487.14615684589;9514.143727064562;9769.218462522998;9789.216862650988;9453.24374050076;9678.080582344684;9679.225661947045;9680.322377433566;9691.709248722533;2457.5084983003426;2491.750824917512;2492.675952126221;2496;2496.1762618335997;2426.4055306449854;2522.016413598698;2523.8485690858515;2524.4193835417864;2526.1916186820226;2473.122041675206;2476.6532685424054;2482.255323402981;2486.3784053986506;2487.092211342865;2313.144136669443;2330.4290448840056;2338.894749736266;2379.3575734551746;2382.952340953171;2277.851939623936;2323.1520495019195;2323.4307594639254;2327.511222643247;2330.0679728108894;8119.95940020302;8379.95810020946;9575.61697532098;9614.95192524033;9626.133647971716;5244.763985620656;5400.567954563626;5517.227588137664;5680.460356266148;5705.258316418839;3577.0878426001464;3578.499010138583;3613.5483064616924;3634.7092232621326;3642.9271414571826;1048.2609760119099;1051.558345494894;1066.4188017530387;1075.2526993739355;1092.2245205903819;13637.181769093886;13697.178169309873;13712.725745485133;13746.65633359164;13755.587332380044;4861.222204447342;4894.2658601210105;5006.849794506171;5161.071007218737;5185.429602743695;11735.23720958135;11789.646310610695;11791.410429478492;11799.587014454453;11803;5836.416358364215;5842.795502157404;5844.298684157843;5846.239988801429;5853.502452291517;5197;5269.789208431696;5348.759305831247;5391.460853914656;5395.946040539623;4087.61167689075;4117.07365842683;4119.505659320841;4135.234981528427;4154.896127596834;1169.2925779903205;1181.4506254591656;1184.040926849255;1184.934828584419;1212.3574505512092;1011.8684571005722;1057.7620035492107;1061.0609610494614;1066.7546464313252;1078.9730256743644;6391.041343798374;6473.287938326875;6544.181977252843;6560.302246412576;6645.767398141042;472.8723244723905;481.57140145270034;1095.5891540672249;1100.02098132662;1128.418864284894;4222.4299719538085;4269.210196113729;4290.163418133434;4331.675124365685;4349.565043495689;11926.403679815974;12205.816912746315;12209.69475763113;12210.938945305217;12226.449809758582;11586.826197607043;11888.821667674993;11896.762064758655;12156.635300940809;12161.14871958972;8687.348448866234;8796.95601522001;8802.383833131747;8851.557422128997;8864.73405797827;6510.641914694548;6539.509536784855;6579.769708060195;6669.433098186709;6778.152730908637;10706.946465267623;11067.446627668745;11246.931541503543;11390.25963312382;11417.200795944203;11440.94279528597;11444.771104578029;11445.370504622326;11462.4268786562;11567;8613.26787223093;8729.781755456164;8751.868721969304;8782.385233033627;8813.074627164055;9275.39709918853;9376.718698439057;9384.296177786557;9390.201832844285;9413.811723765622;8500.659973600987;8512.446690965067;8544.2310192083;8555.401121921406;8648.221660050625;8156.8368632625825;8334.541600212047;8355;8361.205685459872;8680.609372578376;7509.924900751141;7683.0780306363595;7764.301212890867;7775.805604859924;7779.649915753692;5048.596112310933;5214.139666955061;5230.633855630222;5239.29269548606;5335.253064570886;4759.809607615656;5411.972940135274;5529.612927095065;5639.01317269468;5729.369769325288 11:43:41 INFO - PROCESS | 17982 | |4;prototype.html;345.76142461701426;354.67901549098065;357.5834153211509;359.6367668654658;359.8632519642536;5460.1536761801935;5496.587755918312;5522.66863988161;5549.1676248562735;5584.301962254718;5419.891602167954;5439.5376393006645;5453.291072160623;5454.863628409292;5518.365387980383;3972.2055588882195;4096.283150448675;4347.934780978288;4352.412424322723;4363.694541382105;4249.128928569651;4296.763677997709;4306.547812479692;4315.762633055181;4320.891977700551;4258.297380932158;4297.441332626754;4314.97842510787;4319.2657248267715;4326.480822301328;4127.587241275878;4178.6865985051245;4285.892852678677;4322.8703138905885;4334.176506463762;3857.035741064734;3857.6528112470014;3868.400397938324;3879.3405121129194;3888.0645112939833;5245.665678772948;5258.579313654898;5311.123664595337;5324.973375133139;5351.117065684158;4929.383827021622;4960.603151747888;4972.602191824645;4975.203967365241;5001.124803159469;5771.105478650816;5774.105013722879;5789.681567513785;5789.855253618651;5824.475797178275;4094.651954583864;4100.36444351126;4137.420761093449;4262.232798096373;4279.957200428018;5942.197803296543;5947.851303717398;5957.493613042853;5973.910391344133;5978.461938425563;4385.51759306476;4388.517263101056;4395.230834603932;4405.515393306734;4411.669124815651;4099.426080348753;4293.175400454857;4298.828046878152;4316.6330861877095;4337.956620433818;4895.412550493964;4896.387951506062;4924.212126059813;4924.4583095859425;4940.752962351868;5675.529895918656;5785.334686511105;5795.8551036224435;5799.507041901401;5816.970915145397;1460.7954886315924;1477.5124209011;1485.4652325162933;1488.6650503636595;1495.2673190136754;939.8825146856643;948.2082461144884;950.6910254167424;967.1778987860403;974.1865542272141;5053.620978426559;5082.2047873669335;5085.711429856579;5095.87260318495;5118.846434606968;5172.5603323717905;5239.947600524022;5240.502152295526;5257.316548848626;5268.736563171826;4768.880777980578;5049.566294919417;5064.316317297118;5078.619103567247;5098.515641014098;2847.572864070406;2855.4289142171647;2856.614541947154;2858.9428211435657;2859.4852926473436;5369.6509726867625;5417.891642167214;5456.836294911159;5457;5493.692649087313;5193.610479214074;5327.987682340343;5349.598780091431;5405.675659460445;5407.567394608422;5478.397376288684;5486.890262194814;5507.807226747044;5526.834194974157;5532.5020748132865;5346.87715579717;5716.9142462862255;5811.360750317546;5903.380145084704;5944.5838791284195;5858.209141765807;5867.501262392574;5870.295564532284;5871.442212989759;5875.50058245054;5950.702464876826;6039.855851172946;6146.033269353943;6149.7847575334645;6251.093591429309;4299.484061912465;4310.719803212781;4318.546552612056;4324.372965919861;4325.826966921288;6067.575269731076;6072.210612620331;6078.45293923549;6079.604825686316;6084.178635884099;5682.488576028178;5890.263717035371;5902.61632993854;5903.793367232126;5920.319163296103;5853.678047707417;5878.617889837147;5889.558283128868;5889.852753681193;5892.764289428546;5521.171824226398;5799.449052340021;5804.796832110856;5815.79644712433;5821;5785.566082543742;5905.586608937333;5923.134212722978;5925.881482370242;5937.614055086406;5674.290713660793;5711.400302968294;5726.9713651431475;5749.655020698771;5761.8559536011935 11:43:41 INFO - PROCESS | 17982 | |5;yui.html;811.7240138352962;840.5041025794784;865.8441480533504;868.9913100868991;890.1943740914475;15538.1454020029;15579.766303505456;15592.84407155928;15871.603209919744;17111.973281603096;16021.919890400532;16069.196540173003;16177.19114044299;16178.83821161788;16183.433579824708;738.0516036892594;881.6297155194834;884.3279107878027;911.8221946720392;920.1902325953185;873.9257163141141;874.5583480342418;876.5792419638545;876.8640860666575;884.5754038061734;953.2516974175273;958.5925981457888;959.4866746290736;960.8510680844445;961.1205746741723;750.8198032472222;916.3356566489275;937.1893312284893;937.3813283233034;940.0270719804969;694.298758254167;695.8469136789898;698.6855914838292;698.6890833579059;698.8672152291049;15959.92020039904;15998.44005459815;16019;16034.198290085566;16041.518754437386;14295.642608934755;14610.488632897905;14616.634584135376;14767.70464590713;14835.480758173411;13592.796108058288;13931.164130152223;14013.089149205269;14096.436142554285;14118.435262589484;4696.8590942271785;4741.905161896777;4745.9525404745855;4784.712917224942;4789.3294938708605;57296.14055789167;60923;76789.99999999945;79113.60443197747;79124;12225.08311876595;12295.262284262973;12409.193402428993;12409.62771116868;12518.935890449231;23185.3044408668;23389.883050584638;23389.88305058498;23391.415214619432;23687.05251789909;8661.263792577576;8663.783405414915;8823.602937867812;8834.293256539462;8871.64513419456;4848.878778030577;4881.780319885543;4881.9093601453;4958.776855041532;4998.875028124253;3725.068732816796;3920.098377373163;3925;3927.9018024549614;3928.9214215716097;636.6371168434041;649.5420728386476;689.2246222999127;766.3945483068425;770.8342706318057;694.3854688600625;724.2829598697252;728.9416846652255;761.6991288441035;781.8436312737362;10032.69901902944;10124.34191777532;10248.538815753309;10377.273590848568;10449.425281609432;637.3944752485157;697.4385619576188;699.6117154979036;789.9170587088388;791.3194652598761;4481.462224533077;4504.684672072924;4581.450225972838;4970.304157417964;4976.950230497721;117526;123761;124003.37998309951;127145;129659;66219;100665.49001764979;107093;107725.4613726942;109852.4507377458;91554.54222728843;91707;91896;91956.54021729983;92957.5352123235;8962.32782541299;9069.909300907171;9151.130642588943;9178.908210918073;9295.581698823704;55616.16575751448;55875.441245587026;56093.43906560882;57394.13908791288;57716.711416442646;78827.60586197033;83790;84759.5762021186;86867.13132868591;87153.56423217844;11832.58585949522;12040;12139.332336721212;12223.20549164337;12384.256944583354;12615.684607884876;12888.548900788428;13450.327483625584;13664.180149191081;13684.110532815335;12272.325022123869;12325.322107284186;12562.685932851751;12644.747105058032;12778.936105319413;11695.356755378196;11910.702232444259;11977.820332695192;12185.69535761613;12861.742765144832;11647.475863585989;11812.291262524275;11895.821562676394;12244.265344079384;13013.674658133623;9994.800103997733;10005.949970250102;10042.648507302501;10251.897481025095;10311.175105991353;9924.255680824112;10444.321119127233;10477.476126193813;10490.160787137163;10490.265681402228 11:43:41 INFO - PROCESS | 17982 | __end_tp_report 11:43:41 INFO - PROCESS | 17982 | __start_cc_report 11:43:41 INFO - PROCESS | 17982 | _x_x_mozilla_cycle_collect,905 11:43:41 INFO - PROCESS | 17982 | __end_cc_report 11:43:41 INFO - PROCESS | 17982 | __startTimestamp1470077021924__endTimestamp 11:43:41 INFO - PROCESS | 17982 | 11:43:41 INFO - PROCESS | 17982 | ------- Summary: start ------- 11:43:41 INFO - PROCESS | 17982 | Number of tests: 6 11:43:41 INFO - PROCESS | 17982 | 11:43:41 INFO - PROCESS | 17982 | [#0] dojo.html Cycles:165 Average:5692.43 Median:5912.08 stddev:639.94 (10.8%) stddev-sans-first:617.15 11:43:41 INFO - PROCESS | 17982 | Values: 3445.6 3449.9 3455.9 3473.2 3477.9 5643.5 5726.0 5727.1 5749.7 5759.4 5688.8 5750.6 5753.9 5754.5 5761.5 5023.8 5122.7 5141.3 5173.1 5195.2 5167.3 5183.7 5199.9 5220.3 5273.8 5199.2 5222.2 5229.9 5262.8 5297.2 5290.1 5302.7 5306.0 5311.9 5334.4 5042.6 5078.0 5099.3 5199.1 5205.6 5612.1 5630.5 5633.0 5662.1 5665.2 6085.4 6099.0 6132.3 6149.3 6156.2 5968.8 6042.0 6084.8 6088.0 6167.9 5748.7 5748.9 5753.9 5756.2 5763.8 6252.1 6253.1 6268.1 6268.9 6269.6 5900.8 5963.8 6018.2 6019.2 6107.6 6147.2 6155.7 6155.9 6156.2 6160.1 5929.0 6097.3 6123.0 6126.4 6132.7 5972.6 6011.0 6022.2 6087.4 6087.5 4596.6 4610.2 4611.4 4622.9 4643.1 4067.8 4075.2 4119.5 4159.7 4194.2 5805.2 5840.2 5853.2 5866.0 5906.4 6142.1 6151.6 6152.2 6157.6 6188.9 5683.8 5813.5 5843.9 5849.4 5874.9 5084.4 5303.9 5307.5 5313.8 5339.0 6392.4 6417.0 6425.8 6428.6 6438.6 6028.2 6031.3 6043.9 6073.6 6210.5 6265.0 6280.8 6304.1 6314.4 6319.0 5992.4 6002.0 6002.4 6020.4 6025.8 5898.0 6127.2 6131.7 6154.5 6265.5 6076.3 6077.0 6082.8 6082.9 6088.8 5850.9 6070.9 6090.9 6099.2 6101.7 5861.5 5899.1 5912.1 5921.1 5954.7 6068.5 6076.6 6090.3 6095.0 6118.3 5791.9 5850.5 5949.1 5953.6 5982.2 11:43:41 INFO - PROCESS | 17982 | 11:43:41 INFO - PROCESS | 17982 | [#1] ext.html Cycles:180 Average:62721.78 Median:3912.39 stddev:123199.13 (3148.9%) stddev-sans-first:123456.47 11:43:41 INFO - PROCESS | 17982 | Values: 607.8 657.8 664.6 670.3 679.5 33695.7 46948.3 48024.8 48064.5 48120.5 49093.5 49636.0 49804.0 49804.5 49851.3 8048.9 9050.0 9207.2 10800.8 11073.8 10761.8 10770.5 10773.5 10871.2 10872.0 10861.8 10940.9 10942.4 10944.5 10945.7 10891.1 10919.4 10951.4 10959.2 10959.8 10786.4 10797.0 10861.7 10868.0 10871.6 43946.8 44429.8 44464.6 44497.3 44571.1 3906.2 3945.4 4002.1 4002.2 4115.3 33664.3 34298.8 34429.3 34515.7 34653.3 3918.6 3922.6 3930.0 3942.3 3970.0 363534.0 364025.0 365072.0 367494.0 369343.0 61796.4 62702.7 62788.7 62951.7 63013.0 39343.0 40286.4 40374.6 42484.8 42567.8 17174.7 17738.3 17798.6 17875.4 17877.6 13882.7 14177.4 14199.9 14467.9 14476.2 20668.6 20829.7 20888.4 20888.5 20951.9 7429.9 7605.7 7636.7 7837.5 7849.8 1031.6 1087.6 1138.9 1209.4 1266.6 33295.8 33839.7 33965.8 34273.0 34817.3 1150.6 1168.8 1212.2 1226.2 1285.7 16262.0 16429.3 16438.2 16489.0 16546.0 535729.0 540584.0 542917.0 545291.0 545671.0 61201.4 62303.4 62455.4 62458.0 62518.1 1375.9 1414.1 1444.2 1517.8 1526.6 31185.4 34004.8 34243.8 34685.7 34998.3 54302.2 54726.7 55002.2 55014.2 55023.0 467486.0 471319.0 471398.0 472188.0 472296.0 26439.0 29019.4 29617.9 29952.0 30004.0 50330.0 50522.7 50805.2 51290.7 51626.2 41624.4 42181.4 42817.8 43190.8 43939.0 42486.8 42500.8 43221.4 43651.3 43656.8 39857.8 40370.0 41179.2 42295.6 43083.8 36011.5 38651.2 39527.2 39570.2 39692.8 28709.0 28762.7 28899.6 29325.3 29482.0 11:43:41 INFO - PROCESS | 17982 | 11:43:41 INFO - PROCESS | 17982 | [#2] jquery.html Cycles:180 Average:30180.85 Median:23665.08 stddev:87767.98 (370.9%) stddev-sans-first:87985.73 11:43:41 INFO - PROCESS | 17982 | Values: 412.5 415.5 416.6 417.7 441.8 18184.8 19700.6 19919.1 20556.8 21207.5 19419.9 19577.8 20193.4 20293.6 20360.2 5799.9 5961.5 5985.2 5985.6 6005.6 4250.9 4542.5 5886.7 5947.8 6762.1 6791.8 6811.7 6838.6 6852.8 6858.5 5424.1 5738.6 5756.4 5805.6 6798.5 3819.1 5536.3 5622.5 5625.6 5815.9 14601.2 14603.9 15093.6 23387.8 23942.4 2415.7 2476.1 2492.7 2543.3 2625.5 10406.7 10459.5 10553.3 12723.9 13908.7 2023.7 2043.2 2044.7 2104.0 2129.8 66888.0 71274.3 74785.0 75727.6 84078.6 9960.4 10502.8 11507.4 11787.6 11825.5 16470.9 16566.2 16654.1 16656.4 16666.1 8487.7 8706.9 8801.8 8822.5 8827.0 8369.1 8384.2 8417.9 8479.6 8552.3 5004.7 5036.1 5059.4 5089.6 5143.0 1976.5 2007.2 2014.8 2037.7 2040.1 995.9 1039.9 1052.1 1095.6 1121.3 19386.9 19543.1 19618.0 19662.8 20108.7 1000.5 1007.3 1018.0 1021.7 1029.5 10537.6 11057.1 11064.9 11074.7 11090.2 504974.0 517335.0 518835.0 562248.0 564335.0 89746.0 92831.0 94590.0 94860.5 95938.5 1067.0 1077.5 1081.4 1096.9 1100.5 17444.3 17575.3 17582.3 17585.4 17967.2 40818.8 41508.8 42369.2 42974.4 43125.8 58142.4 58334.4 58398.0 58500.0 58817.4 7437.5 8801.2 8808.1 8963.8 9054.0 11188.6 12642.7 13303.5 13359.4 13511.7 11376.0 11772.8 12081.3 12085.4 12160.2 11665.7 11794.3 12018.8 12104.4 12204.3 11446.7 12001.6 12023.4 12286.7 12364.7 7903.3 7932.4 8003.0 8004.3 8014.6 8894.2 11364.0 12033.1 12110.2 12121.5 11:43:41 INFO - PROCESS | 17982 | 11:43:41 INFO - PROCESS | 17982 | [#3] mootools.html Cycles:180 Average:6318.26 Median:4310.92 stddev:3711.54 (86.1%) stddev-sans-first:3703.72 11:43:41 INFO - PROCESS | 17982 | Values: 1422.1 1589.6 1647.8 1828.8 1932.4 9037.9 9487.1 9514.1 9769.2 9789.2 9453.2 9678.1 9679.2 9680.3 9691.7 2457.5 2491.8 2492.7 2496.0 2496.2 2426.4 2522.0 2523.8 2524.4 2526.2 2473.1 2476.7 2482.3 2486.4 2487.1 2313.1 2330.4 2338.9 2379.4 2383.0 2277.9 2323.2 2323.4 2327.5 2330.1 8120.0 8380.0 9575.6 9615.0 9626.1 5244.8 5400.6 5517.2 5680.5 5705.3 3577.1 3578.5 3613.5 3634.7 3642.9 1048.3 1051.6 1066.4 1075.3 1092.2 13637.2 13697.2 13712.7 13746.7 13755.6 4861.2 4894.3 5006.8 5161.1 5185.4 11735.2 11789.6 11791.4 11799.6 11803.0 5836.4 5842.8 5844.3 5846.2 5853.5 5197.0 5269.8 5348.8 5391.5 5395.9 4087.6 4117.1 4119.5 4135.2 4154.9 1169.3 1181.5 1184.0 1184.9 1212.4 1011.9 1057.8 1061.1 1066.8 1079.0 6391.0 6473.3 6544.2 6560.3 6645.8 472.9 481.6 1095.6 1100.0 1128.4 4222.4 4269.2 4290.2 4331.7 4349.6 11926.4 12205.8 12209.7 12210.9 12226.4 11586.8 11888.8 11896.8 12156.6 12161.1 8687.3 8797.0 8802.4 8851.6 8864.7 6510.6 6539.5 6579.8 6669.4 6778.2 10706.9 11067.4 11246.9 11390.3 11417.2 11440.9 11444.8 11445.4 11462.4 11567.0 8613.3 8729.8 8751.9 8782.4 8813.1 9275.4 9376.7 9384.3 9390.2 9413.8 8500.7 8512.4 8544.2 8555.4 8648.2 8156.8 8334.5 8355.0 8361.2 8680.6 7509.9 7683.1 7764.3 7775.8 7779.6 5048.6 5214.1 5230.6 5239.3 5335.3 4759.8 5412.0 5529.6 5639.0 5729.4 11:43:41 INFO - PROCESS | 17982 | 11:43:41 INFO - PROCESS | 17982 | [#4] prototype.html Cycles:180 Average:4776.89 Median:5337.43 stddev:1390.22 (26.0%) stddev-sans-first:1353.76 11:43:41 INFO - PROCESS | 17982 | Values: 345.8 354.7 357.6 359.6 359.9 5460.2 5496.6 5522.7 5549.2 5584.3 5419.9 5439.5 5453.3 5454.9 5518.4 3972.2 4096.3 4347.9 4352.4 4363.7 4249.1 4296.8 4306.5 4315.8 4320.9 4258.3 4297.4 4315.0 4319.3 4326.5 4127.6 4178.7 4285.9 4322.9 4334.2 3857.0 3857.7 3868.4 3879.3 3888.1 5245.7 5258.6 5311.1 5325.0 5351.1 4929.4 4960.6 4972.6 4975.2 5001.1 5771.1 5774.1 5789.7 5789.9 5824.5 4094.7 4100.4 4137.4 4262.2 4280.0 5942.2 5947.9 5957.5 5973.9 5978.5 4385.5 4388.5 4395.2 4405.5 4411.7 4099.4 4293.2 4298.8 4316.6 4338.0 4895.4 4896.4 4924.2 4924.5 4940.8 5675.5 5785.3 5795.9 5799.5 5817.0 1460.8 1477.5 1485.5 1488.7 1495.3 939.9 948.2 950.7 967.2 974.2 5053.6 5082.2 5085.7 5095.9 5118.8 5172.6 5239.9 5240.5 5257.3 5268.7 4768.9 5049.6 5064.3 5078.6 5098.5 2847.6 2855.4 2856.6 2858.9 2859.5 5369.7 5417.9 5456.8 5457.0 5493.7 5193.6 5328.0 5349.6 5405.7 5407.6 5478.4 5486.9 5507.8 5526.8 5532.5 5346.9 5716.9 5811.4 5903.4 5944.6 5858.2 5867.5 5870.3 5871.4 5875.5 5950.7 6039.9 6146.0 6149.8 6251.1 4299.5 4310.7 4318.5 4324.4 4325.8 6067.6 6072.2 6078.5 6079.6 6084.2 5682.5 5890.3 5902.6 5903.8 5920.3 5853.7 5878.6 5889.6 5889.9 5892.8 5521.2 5799.4 5804.8 5815.8 5821.0 5785.6 5905.6 5923.1 5925.9 5937.6 5674.3 5711.4 5727.0 5749.7 5761.9 11:43:41 INFO - PROCESS | 17982 | 11:43:41 INFO - PROCESS | 17982 | [#5] yui.html Cycles:180 Average:21527.78 Median:4719.38 stddev:31632.95 (670.3%) stddev-sans-first:31683.44 11:43:41 INFO - PROCESS | 17982 | Values: 811.7 840.5 865.8 869.0 890.2 15538.1 15579.8 15592.8 15871.6 17112.0 16021.9 16069.2 16177.2 16178.8 16183.4 738.1 881.6 884.3 911.8 920.2 873.9 874.6 876.6 876.9 884.6 953.3 958.6 959.5 960.9 961.1 750.8 916.3 937.2 937.4 940.0 694.3 695.8 698.7 698.7 698.9 15959.9 15998.4 16019.0 16034.2 16041.5 14295.6 14610.5 14616.6 14767.7 14835.5 13592.8 13931.2 14013.1 14096.4 14118.4 4696.9 4741.9 4746.0 4784.7 4789.3 57296.1 60923.0 76790.0 79113.6 79124.0 12225.1 12295.3 12409.2 12409.6 12518.9 23185.3 23389.9 23389.9 23391.4 23687.1 8661.3 8663.8 8823.6 8834.3 8871.6 4848.9 4881.8 4881.9 4958.8 4998.9 3725.1 3920.1 3925.0 3927.9 3928.9 636.6 649.5 689.2 766.4 770.8 694.4 724.3 728.9 761.7 781.8 10032.7 10124.3 10248.5 10377.3 10449.4 637.4 697.4 699.6 789.9 791.3 4481.5 4504.7 4581.5 4970.3 4977.0 117526.0 123761.0 124003.4 127145.0 129659.0 66219.0 100665.5 107093.0 107725.5 109852.5 91554.5 91707.0 91896.0 91956.5 92957.5 8962.3 9069.9 9151.1 9178.9 9295.6 55616.2 55875.4 56093.4 57394.1 57716.7 78827.6 83790.0 84759.6 86867.1 87153.6 11832.6 12040.0 12139.3 12223.2 12384.3 12615.7 12888.5 13450.3 13664.2 13684.1 12272.3 12325.3 12562.7 12644.7 12778.9 11695.4 11910.7 11977.8 12185.7 12861.7 11647.5 11812.3 11895.8 12244.3 13013.7 9994.8 10005.9 10042.6 10251.9 10311.2 9924.3 10444.3 10477.5 10490.2 10490.3 11:43:41 INFO - PROCESS | 17982 | -------- Summary: end -------- 11:43:41 INFO - PROCESS | 17982 | 11:43:42 INFO - TEST-INFO | 17982: exit 0 11:43:42 INFO - TEST-OK | dromaeo_css | took 1112107ms 11:43:42 INFO - TEST-START | kraken 11:43:42 INFO - operating with platform_type : linux_ 11:43:42 INFO - Initialising browser for kraken test... 11:43:42 INFO - TEST-INFO | started process 18173 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXiFZRo/profile http://localhost:60984/getInfo.html) 11:43:46 INFO - PROCESS | 18173 | __metrics Screen width/height:1600/1200 11:43:46 INFO - PROCESS | 18173 | colorDepth:24 11:43:46 INFO - PROCESS | 18173 | Browser inner width/height: 1024/697 11:43:46 INFO - PROCESS | 18173 | __metrics 11:43:47 INFO - PROCESS | 18173 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:43:47 ERROR - PROCESS | 18173 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:43:48 INFO - TEST-INFO | 18173: exit 0 11:43:48 INFO - Browser initialized. 11:43:48 INFO - Running cycle 1/1 for kraken test... 11:43:48 INFO - TEST-INFO | started process 18261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXiFZRo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:43:59 INFO - PROCESS | 18261 | RSS: Main: 141488128 11:43:59 INFO - PROCESS | 18261 | 11:44:02 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60984/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:03 INFO - PROCESS | 18261 | RSS: Main: 191971328 11:44:03 INFO - PROCESS | 18261 | 11:44:05 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60984/tests/kraken/driver.html?testName=audio-dft) 11:44:06 INFO - PROCESS | 18261 | RSS: Main: 189030400 11:44:06 INFO - PROCESS | 18261 | 11:44:09 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60984/tests/kraken/driver.html?testName=audio-fft) 11:44:09 INFO - PROCESS | 18261 | RSS: Main: 276951040 11:44:09 INFO - PROCESS | 18261 | 11:44:11 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60984/tests/kraken/driver.html?testName=audio-oscillator) 11:44:12 INFO - PROCESS | 18261 | RSS: Main: 184795136 11:44:12 INFO - PROCESS | 18261 | 11:44:14 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60984/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:15 INFO - PROCESS | 18261 | RSS: Main: 185393152 11:44:15 INFO - PROCESS | 18261 | 11:44:18 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60984/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:18 INFO - PROCESS | 18261 | RSS: Main: 220418048 11:44:18 INFO - PROCESS | 18261 | 11:44:22 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60984/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:22 INFO - PROCESS | 18261 | RSS: Main: 219488256 11:44:22 INFO - PROCESS | 18261 | 11:44:25 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60984/tests/kraken/driver.html?testName=json-parse-financial) 11:44:26 INFO - PROCESS | 18261 | RSS: Main: 219824128 11:44:26 INFO - PROCESS | 18261 | 11:44:27 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60984/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:28 INFO - PROCESS | 18261 | RSS: Main: 198443008 11:44:28 INFO - PROCESS | 18261 | 11:44:29 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60984/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:30 INFO - PROCESS | 18261 | RSS: Main: 200826880 11:44:30 INFO - PROCESS | 18261 | 11:44:32 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60984/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:44:33 INFO - PROCESS | 18261 | RSS: Main: 207450112 11:44:33 INFO - PROCESS | 18261 | 11:44:35 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60984/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:44:36 INFO - PROCESS | 18261 | RSS: Main: 209719296 11:44:36 INFO - PROCESS | 18261 | 11:44:39 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60984/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:44:39 INFO - PROCESS | 18261 | RSS: Main: 210550784 11:44:39 INFO - PROCESS | 18261 | 11:44:41 INFO - PROCESS | 18261 | Cycle 1(1): loaded http://localhost:60984/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60984/tests/kraken/driver.html?testName=ai-astar) 11:44:41 INFO - PROCESS | 18261 | RSS: Main: 252477440 11:44:41 INFO - PROCESS | 18261 | 11:44:41 INFO - PROCESS | 18261 | __start_tp_report 11:44:41 INFO - PROCESS | 18261 | _x_x_mozilla_page_load 11:44:41 INFO - PROCESS | 18261 | _x_x_mozilla_page_load_details 11:44:41 INFO - PROCESS | 18261 | |i|pagename|runs| 11:44:41 INFO - PROCESS | 18261 | |0;ai-astar;111;105;109;109;111;112;108;110;111;110 11:44:41 INFO - PROCESS | 18261 | |1;audio-beat-detection;153;124;124;170;125;123;153;124;149;122 11:44:41 INFO - PROCESS | 18261 | |2;audio-dft;160;160;160;163;162;159;160;158;160;158 11:44:41 INFO - PROCESS | 18261 | |3;audio-fft;79;75;76;108;75;75;74;74;98;74 11:44:41 INFO - PROCESS | 18261 | |4;audio-oscillator;83;84;113;84;85;85;113;84;85;129 11:44:41 INFO - PROCESS | 18261 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;116;116;116 11:44:41 INFO - PROCESS | 18261 | |6;imaging-darkroom;146;146;145;146;147;146;147;147;146;146 11:44:41 INFO - PROCESS | 18261 | |7;imaging-desaturate;94;95;95;95;94;94;95;95;95;95 11:44:41 INFO - PROCESS | 18261 | |8;json-parse-financial;50;51;52;51;53;53;51;53;51;54 11:44:41 INFO - PROCESS | 18261 | |9;json-stringify-tinderbox;60;61;60;61;60;59;59;60;61;61 11:44:41 INFO - PROCESS | 18261 | |10;stanford-crypto-aes;77;78;77;76;77;78;86;81;118;84 11:44:41 INFO - PROCESS | 18261 | |11;stanford-crypto-ccm;128;137;118;124;118;115;115;139;127;139 11:44:41 INFO - PROCESS | 18261 | |12;stanford-crypto-pbkdf2;156;152;154;159;156;157;154;152;153;154 11:44:41 INFO - PROCESS | 18261 | |13;stanford-crypto-sha256-iterative;61;61;66;61;61;62;62;61;60;64 11:44:41 INFO - PROCESS | 18261 | __end_tp_report 11:44:41 INFO - PROCESS | 18261 | __start_cc_report 11:44:41 INFO - PROCESS | 18261 | _x_x_mozilla_cycle_collect,1574 11:44:41 INFO - PROCESS | 18261 | __end_cc_report 11:44:41 INFO - PROCESS | 18261 | __startTimestamp1470077081545__endTimestamp 11:44:41 INFO - PROCESS | 18261 | 11:44:41 INFO - PROCESS | 18261 | ------- Summary: start ------- 11:44:41 INFO - PROCESS | 18261 | Number of tests: 14 11:44:41 INFO - PROCESS | 18261 | 11:44:41 INFO - PROCESS | 18261 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:2.01 (1.8%) stddev-sans-first:2.07 11:44:41 INFO - PROCESS | 18261 | Values: 111.0 105.0 109.0 109.0 111.0 112.0 108.0 110.0 111.0 110.0 11:44:41 INFO - PROCESS | 18261 | 11:44:41 INFO - PROCESS | 18261 | [#1] audio-beat-detection Cycles:10 Average:136.70 Median:137.00 stddev:17.69 (12.9%) stddev-sans-first:17.75 11:44:41 INFO - PROCESS | 18261 | Values: 153.0 124.0 124.0 170.0 125.0 123.0 153.0 124.0 149.0 122.0 11:44:41 INFO - PROCESS | 18261 | 11:44:41 INFO - PROCESS | 18261 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:1.56 (1.0%) stddev-sans-first:1.66 11:44:41 INFO - PROCESS | 18261 | Values: 160.0 160.0 160.0 163.0 162.0 159.0 160.0 158.0 160.0 158.0 11:44:41 INFO - PROCESS | 18261 | 11:44:41 INFO - PROCESS | 18261 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.00 stddev:12.03 (16.0%) stddev-sans-first:12.74 11:44:41 INFO - PROCESS | 18261 | Values: 79.0 75.0 76.0 108.0 75.0 75.0 74.0 74.0 98.0 74.0 11:44:41 INFO - PROCESS | 18261 | 11:44:41 INFO - PROCESS | 18261 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:84.00 stddev:17.02 (20.3%) stddev-sans-first:17.54 11:44:41 INFO - PROCESS | 18261 | Values: 83.0 84.0 113.0 84.0 85.0 85.0 113.0 84.0 85.0 129.0 11:44:41 INFO - PROCESS | 18261 | 11:44:41 INFO - PROCESS | 18261 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:44:41 INFO - PROCESS | 18261 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 116.0 11:44:41 INFO - PROCESS | 18261 | 11:44:41 INFO - PROCESS | 18261 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 11:44:41 INFO - PROCESS | 18261 | Values: 146.0 146.0 145.0 146.0 147.0 146.0 147.0 147.0 146.0 146.0 11:44:41 INFO - PROCESS | 18261 | 11:44:41 INFO - PROCESS | 18261 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 11:44:41 INFO - PROCESS | 18261 | Values: 94.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 11:44:41 INFO - PROCESS | 18261 | 11:44:41 INFO - PROCESS | 18261 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.50 stddev:1.29 (2.5%) stddev-sans-first:1.17 11:44:41 INFO - PROCESS | 18261 | Values: 50.0 51.0 52.0 51.0 53.0 53.0 51.0 53.0 51.0 54.0 11:44:41 INFO - PROCESS | 18261 | 11:44:41 INFO - PROCESS | 18261 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.50 stddev:0.79 (1.3%) stddev-sans-first:0.83 11:44:41 INFO - PROCESS | 18261 | Values: 60.0 61.0 60.0 61.0 60.0 59.0 59.0 60.0 61.0 61.0 11:44:41 INFO - PROCESS | 18261 | 11:44:41 INFO - PROCESS | 18261 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:78.00 stddev:12.67 (16.2%) stddev-sans-first:13.24 11:44:41 INFO - PROCESS | 18261 | Values: 77.0 78.0 77.0 76.0 77.0 78.0 86.0 81.0 118.0 84.0 11:44:41 INFO - PROCESS | 18261 | 11:44:41 INFO - PROCESS | 18261 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:127.50 stddev:9.65 (7.6%) stddev-sans-first:10.21 11:44:41 INFO - PROCESS | 18261 | Values: 128.0 137.0 118.0 124.0 118.0 115.0 115.0 139.0 127.0 139.0 11:44:41 INFO - PROCESS | 18261 | 11:44:41 INFO - PROCESS | 18261 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.70 Median:155.00 stddev:2.26 (1.5%) stddev-sans-first:2.35 11:44:41 INFO - PROCESS | 18261 | Values: 156.0 152.0 154.0 159.0 156.0 157.0 154.0 152.0 153.0 154.0 11:44:41 INFO - PROCESS | 18261 | 11:44:41 INFO - PROCESS | 18261 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:61.50 stddev:1.79 (2.9%) stddev-sans-first:1.87 11:44:41 INFO - PROCESS | 18261 | Values: 61.0 61.0 66.0 61.0 61.0 62.0 62.0 61.0 60.0 64.0 11:44:41 INFO - PROCESS | 18261 | -------- Summary: end -------- 11:44:41 INFO - PROCESS | 18261 | 11:44:42 INFO - TEST-INFO | 18261: exit 0 11:44:42 INFO - TEST-OK | kraken | took 59829ms 11:44:42 INFO - SUITE-END | took 1171s 11:44:42 INFO - Completed test suite (00:19:32) 11:44:42 INFO - javascript benchmark 11:44:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3445.6037555681096, 3449.8792542261012, 3455.896323110306, 3473.1664400543877, 3477.8782742604, 5643.46387093226, 5726.026575482168, 5727.140928860673, 5749.683767392792, 5759.424057594244, 5688.800891968782, 5750.568707346944, 5753.913691294634, 5754.510866576346, 5761.510271626917, 5023.773930173151, 5122.743862806863, 5141.280220769096, 5173.068847607429, 5195.19474481456, 5167.328247327842, 5183.714895680736, 5199.948000520003, 5220.347456567929, 5273.815416460425, 5199.2461093141665, 5222.190560463135, 5229.921551176735, 5262.789488420459, 5297.205419187134, 5290.074237008508, 5302.655327403706, 5305.999999999981, 5311.946880531223, 5334.386545547273, 5042.621803364726, 5077.974610126963, 5099.33708617881, 5199.14214154664, 5205.635605507616, 5612.07400778871, 5630.521405680522, 5633.014222511044, 5662.065759149736, 5665.150227465913, 6085.421884920926, 6099.041964647143, 6132.294786099566, 6149.3235744068115, 6156.168917196166, 5968.791092311748, 6042.033274676075, 6084.817455476343, 6088.0, 6167.907481387782, 5748.741306641253, 5748.913766293509, 5753.906757716104, 5756.194132821408, 5763.827085187451, 6252.124702541648, 6253.093301471261, 6268.122462855204, 6268.937310626927, 6269.62382257066, 5900.793472228452, 5963.821085367446, 6018.15745795589, 6019.187409699722, 6107.633541987495, 6147.200863887666, 6155.6614386209185, 6155.891939450942, 6156.168917196122, 6160.10678451622, 5929.0, 6097.298810636745, 6123.020316749299, 6126.448619624166, 6132.6933653317155, 5972.552058595623, 6010.969945150334, 6022.156898034279, 6087.391260873966, 6087.482563982023, 4596.632269418438, 4610.216263235258, 4611.354410382549, 4622.907541849144, 4643.071385722869, 4067.7559346439307, 4075.1645912587846, 4119.485064366954, 4159.729617574848, 4194.161167766459, 5805.187273781674, 5840.153177789197, 5853.151293062482, 5865.970670146622, 5906.40935906406, 6142.078688196806, 6151.569390142647, 6152.169457123231, 6157.599756015845, 6188.907166392508, 5683.77264909399, 5813.505852002542, 5843.941560584425, 5849.356570777211, 5874.882502349929, 5084.3644544431945, 5303.893922121536, 5307.548858347083, 5313.787448502017, 5339.038972984822, 6392.3927226913365, 6417.0, 6425.807225783234, 6428.614283143026, 6438.581492203086, 6028.246469191351, 6031.306399764083, 6043.909341359971, 6073.605215660968, 6210.5031597473, 6264.968675156595, 6280.811575652738, 6304.117423560797, 6314.431701146918, 6318.968405157945, 5992.43071908168, 6002.039673652194, 6002.399760023963, 6020.367861374668, 6025.78909738157, 5897.970510147422, 6127.1589861177945, 6131.693415329305, 6154.476869465966, 6265.530085243534, 6076.3012253591405, 6077.0, 6082.787102451393, 6082.878342433215, 6088.817335479943, 5850.853728656818, 6070.908936366046, 6090.9390906090375, 6099.207103076572, 6101.725422356093, 5861.472467477947, 5899.115132730125, 5912.083627037816, 5921.052631578927, 5954.702264886825, 6068.544859135671, 6076.574639775174, 6090.288122842054, 6095.007769910716, 6118.326984031842, 5791.884162316645, 5850.5027072699295, 5949.137375080676, 5953.613015154001, 5982.162497250475], "value": 5650.360067846456, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.8055022392833, 657.7763560389467, 664.5945972956496, 670.2894931372748, 679.4768028617966, 33695.66304336956, 46948.295775563354, 48024.75987620057, 48064.51935480644, 48120.518794812, 49093.50906490934, 49636.0, 49804.0, 49804.50195498044, 49851.25223121647, 8048.919510804905, 9050.04974477682, 9207.171354578086, 10800.783984320347, 11073.778524429506, 10761.83857242142, 10770.515326810273, 10773.461326933622, 10871.184661150406, 10872.0, 10861.782764344709, 10940.945295273512, 10942.398168100752, 10944.45277736114, 10945.671629851078, 10891.07425868802, 10919.39943303118, 10951.397673127974, 10959.178061645329, 10959.83560246601, 10786.406747628876, 10797.0, 10861.67414977552, 10868.0, 10871.619493317776, 43946.78026609879, 44429.777851110535, 44464.55535444636, 44497.33254001193, 44571.108577828265, 3906.2187562487334, 3945.4081887716784, 4002.139539998914, 4002.199560087994, 4115.259253334399, 33664.32671346584, 34298.82850585731, 34429.31141377184, 34515.65484345149, 34653.30693386118, 3918.5689574146822, 3922.5685174630767, 3930.0, 3942.3298039333094, 3970.047188674726, 363534.0, 364025.0, 365071.9999999973, 367494.0, 369343.0, 61796.382036179064, 62702.686486568186, 62788.68605657034, 62951.6852415735, 63013.0, 39343.0, 40286.39570406446, 40374.59625403767, 42484.78757606254, 42567.78716106462, 17174.74237886433, 17738.29046838138, 17798.555036124202, 17875.37436189727, 17877.553061173574, 13882.722345553033, 14177.432902683777, 14199.929000354932, 14467.92766036163, 14476.203808790618, 20668.58662826735, 20829.68755468669, 20888.373348799258, 20888.47778805542, 20951.8952405237, 7429.85140297191, 7605.733799316998, 7636.732714354971, 7837.451378403571, 7849.843003139905, 1031.5564307347763, 1087.5758454202867, 1138.8633363996207, 1209.449700386322, 1266.6200139957975, 33295.83352083224, 33839.66160338414, 33965.830170849484, 34273.0, 34817.30365392678, 1150.5685367987005, 1168.7779321928806, 1212.1757205100616, 1226.2458587968335, 1285.749278890626, 16262.0, 16429.26068326928, 16438.178091095397, 16489.0, 16546.0, 535729.0, 540584.0, 542917.0, 545291.0, 545671.0, 61201.38798612046, 62303.376966230666, 62455.37544624587, 62458.0, 62518.0622290666, 1375.910565813219, 1414.1252966870904, 1444.1984698492438, 1517.8026856508804, 1526.6107142678545, 31185.376292474477, 34004.82997584996, 34243.82878085594, 34685.65314346824, 34998.30003399969, 54302.18546721881, 54726.72636636791, 55002.17496737472, 55014.17478737902, 55023.0, 467486.0, 471319.0, 471398.0, 472188.0, 472296.0, 26439.0, 29019.41961160807, 29617.851910740308, 29952.0, 30004.0, 50330.0, 50522.74738626283, 50805.237921431944, 51290.74354628203, 51626.22560661668, 41624.375634366115, 42181.367279491446, 42817.78591107025, 43190.78404607957, 43939.0, 42486.78756606197, 42500.78749606232, 43221.351679725456, 43651.345229820945, 43656.78171609122, 39857.80071099626, 40370.0, 41179.1764164709, 42295.57704422916, 43083.78458107689, 36011.45982810207, 38651.2159944307, 39527.209455810145, 39570.208595828495, 39692.80153599329, 28709.0, 28762.712372876, 28899.56650650284, 29325.26686832846, 29482.0], "value": 21377.27466392485, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.54619918090106, 415.4764996104907, 416.62503746628033, 417.709691764224, 441.8056055335652, 18184.81815181848, 19700.60598788025, 19919.103640336183, 20556.794432055674, 21207.469813254676, 19419.902900485515, 19577.804221957776, 20193.394198174043, 20293.594128117467, 20360.18559257628, 5799.942000579993, 5961.493273071794, 5985.162077309158, 5985.6408615483, 6005.579609427342, 4250.936235956463, 4542.477615074259, 5886.705664716768, 5947.791827286046, 6762.087118239024, 6791.830204244909, 6811.693473793691, 6838.555493892906, 6852.794416167523, 6858.451323894076, 5424.105022671274, 5738.626989245686, 5756.395578464285, 5805.593608447411, 6798.52410331277, 3819.1216020315483, 5536.307961504812, 5622.465865742748, 5625.578081643893, 5815.941840581582, 14601.196934168616, 14603.853961460462, 15093.622659433493, 23387.76612233873, 23942.401439963967, 2415.6618073469726, 2476.1333533263396, 2492.7382624824495, 2543.300592337104, 2625.540530407171, 10406.687799366031, 10459.529321180566, 10553.261271710984, 12723.872761272361, 13908.721825563533, 2023.7470316210474, 2043.1827269092332, 2044.7137400763756, 2104.0, 2129.7550781659997, 66888.0, 71274.28725712729, 74785.0, 75727.62136189338, 84078.57960710219, 9960.352577082467, 10502.789944201226, 11507.367094809699, 11787.587434439753, 11825.467853946593, 16470.917645411697, 16566.17169141538, 16654.084025378477, 16656.41702540405, 16666.083365414775, 8487.745367638981, 8706.912930870736, 8801.779955501164, 8822.51476168804, 8827.0, 8369.121242269595, 8384.16158384169, 8417.915820841836, 8479.576021198915, 8552.315814734806, 5004.699718016931, 5036.093503169464, 5059.367579052619, 5089.643724939218, 5143.0, 1976.4861136104716, 2007.207153174488, 2014.8186663200383, 2037.6785839082202, 2040.1227472186806, 995.9203263738883, 1039.9168066554657, 1052.147760314148, 1095.5891540672249, 1121.3272036777869, 19386.90306548458, 19543.12055957457, 19618.0, 19662.803371966384, 20108.665825146833, 1000.5297510170354, 1007.2797949466167, 1017.9898201018043, 1021.6781713760141, 1029.5418538750184, 10537.631182908715, 11057.11543076552, 11064.944675276573, 11074.667759967213, 11090.223684342018, 504974.0, 517335.0, 518835.0, 562248.0, 564335.0, 89746.0, 92831.0, 94590.0, 94860.52569737108, 95938.5203073994, 1066.989330106689, 1077.5420446310443, 1081.378207530673, 1096.8848270931596, 1100.471773548701, 17444.302227910743, 17575.29698812033, 17582.296708131533, 17585.384511542034, 17967.191476383854, 40818.79590602028, 41508.792456037525, 42369.15261694811, 42974.355384668626, 43125.78437107794, 58142.41857581539, 58334.4166558329, 58398.0, 58500.0, 58817.411825882904, 7437.479376443597, 8801.207891289814, 8808.119188081397, 8963.820723585623, 9054.0, 11188.608398706006, 12642.683932901751, 13303.46786128544, 13359.398827053, 13511.662208444868, 11376.0, 11772.764544708887, 12081.275123492618, 12085.39573021363, 12160.209586376857, 11665.650030499099, 11794.29234245948, 12018.819717704067, 12104.394780260776, 12204.267743935392, 11446.713832154262, 12001.579944701894, 12023.398830058288, 12286.692832679255, 12364.690882728004, 7903.328217101611, 7932.444728868923, 8003.0, 8004.279614834692, 8014.559199244098, 8894.155055269739, 11364.0, 12033.097517686034, 12110.152289339661, 12121.515139394325], "value": 9436.913152394101, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1422.1253928833771, 1589.6184915620254, 1647.8105017922937, 1828.8354048135673, 1932.3816378758786, 9037.909620903789, 9487.14615684589, 9514.143727064562, 9769.218462522998, 9789.216862650988, 9453.24374050076, 9678.080582344684, 9679.225661947045, 9680.322377433566, 9691.709248722533, 2457.5084983003426, 2491.750824917512, 2492.675952126221, 2496.0, 2496.1762618335997, 2426.4055306449854, 2522.016413598698, 2523.8485690858515, 2524.4193835417864, 2526.1916186820226, 2473.122041675206, 2476.6532685424054, 2482.255323402981, 2486.3784053986506, 2487.092211342865, 2313.144136669443, 2330.4290448840056, 2338.894749736266, 2379.3575734551746, 2382.952340953171, 2277.851939623936, 2323.1520495019195, 2323.4307594639254, 2327.511222643247, 2330.0679728108894, 8119.95940020302, 8379.95810020946, 9575.61697532098, 9614.95192524033, 9626.133647971716, 5244.763985620656, 5400.567954563626, 5517.227588137664, 5680.460356266148, 5705.258316418839, 3577.0878426001464, 3578.499010138583, 3613.5483064616924, 3634.7092232621326, 3642.9271414571826, 1048.2609760119099, 1051.558345494894, 1066.4188017530387, 1075.2526993739355, 1092.2245205903819, 13637.181769093886, 13697.178169309873, 13712.725745485133, 13746.65633359164, 13755.587332380044, 4861.222204447342, 4894.2658601210105, 5006.849794506171, 5161.071007218737, 5185.429602743695, 11735.23720958135, 11789.646310610695, 11791.410429478492, 11799.587014454453, 11803.0, 5836.416358364215, 5842.795502157404, 5844.298684157843, 5846.239988801429, 5853.502452291517, 5197.0, 5269.789208431696, 5348.759305831247, 5391.460853914656, 5395.946040539623, 4087.61167689075, 4117.07365842683, 4119.505659320841, 4135.234981528427, 4154.896127596834, 1169.2925779903205, 1181.4506254591656, 1184.040926849255, 1184.934828584419, 1212.3574505512092, 1011.8684571005722, 1057.7620035492107, 1061.0609610494614, 1066.7546464313252, 1078.9730256743644, 6391.041343798374, 6473.287938326875, 6544.181977252843, 6560.302246412576, 6645.767398141042, 472.8723244723905, 481.57140145270034, 1095.5891540672249, 1100.02098132662, 1128.418864284894, 4222.4299719538085, 4269.210196113729, 4290.163418133434, 4331.675124365685, 4349.565043495689, 11926.403679815974, 12205.816912746315, 12209.69475763113, 12210.938945305217, 12226.449809758582, 11586.826197607043, 11888.821667674993, 11896.762064758655, 12156.635300940809, 12161.14871958972, 8687.348448866234, 8796.95601522001, 8802.383833131747, 8851.557422128997, 8864.73405797827, 6510.641914694548, 6539.509536784855, 6579.769708060195, 6669.433098186709, 6778.152730908637, 10706.946465267623, 11067.446627668745, 11246.931541503543, 11390.25963312382, 11417.200795944203, 11440.94279528597, 11444.771104578029, 11445.370504622326, 11462.4268786562, 11567.0, 8613.26787223093, 8729.781755456164, 8751.868721969304, 8782.385233033627, 8813.074627164055, 9275.39709918853, 9376.718698439057, 9384.296177786557, 9390.201832844285, 9413.811723765622, 8500.659973600987, 8512.446690965067, 8544.2310192083, 8555.401121921406, 8648.221660050625, 8156.8368632625825, 8334.541600212047, 8355.0, 8361.205685459872, 8680.609372578376, 7509.924900751141, 7683.0780306363595, 7764.301212890867, 7775.805604859924, 7779.649915753692, 5048.596112310933, 5214.139666955061, 5230.633855630222, 5239.29269548606, 5335.253064570886, 4759.809607615656, 5411.972940135274, 5529.612927095065, 5639.01317269468, 5729.369769325288], "value": 4958.585949281903, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.76142461701426, 354.67901549098065, 357.5834153211509, 359.6367668654658, 359.8632519642536, 5460.1536761801935, 5496.587755918312, 5522.66863988161, 5549.1676248562735, 5584.301962254718, 5419.891602167954, 5439.5376393006645, 5453.291072160623, 5454.863628409292, 5518.365387980383, 3972.2055588882195, 4096.283150448675, 4347.934780978288, 4352.412424322723, 4363.694541382105, 4249.128928569651, 4296.763677997709, 4306.547812479692, 4315.762633055181, 4320.891977700551, 4258.297380932158, 4297.441332626754, 4314.97842510787, 4319.2657248267715, 4326.480822301328, 4127.587241275878, 4178.6865985051245, 4285.892852678677, 4322.8703138905885, 4334.176506463762, 3857.035741064734, 3857.6528112470014, 3868.400397938324, 3879.3405121129194, 3888.0645112939833, 5245.665678772948, 5258.579313654898, 5311.123664595337, 5324.973375133139, 5351.117065684158, 4929.383827021622, 4960.603151747888, 4972.602191824645, 4975.203967365241, 5001.124803159469, 5771.105478650816, 5774.105013722879, 5789.681567513785, 5789.855253618651, 5824.475797178275, 4094.651954583864, 4100.36444351126, 4137.420761093449, 4262.232798096373, 4279.957200428018, 5942.197803296543, 5947.851303717398, 5957.493613042853, 5973.910391344133, 5978.461938425563, 4385.51759306476, 4388.517263101056, 4395.230834603932, 4405.515393306734, 4411.669124815651, 4099.426080348753, 4293.175400454857, 4298.828046878152, 4316.6330861877095, 4337.956620433818, 4895.412550493964, 4896.387951506062, 4924.212126059813, 4924.4583095859425, 4940.752962351868, 5675.529895918656, 5785.334686511105, 5795.8551036224435, 5799.507041901401, 5816.970915145397, 1460.7954886315924, 1477.5124209011, 1485.4652325162933, 1488.6650503636595, 1495.2673190136754, 939.8825146856643, 948.2082461144884, 950.6910254167424, 967.1778987860403, 974.1865542272141, 5053.620978426559, 5082.2047873669335, 5085.711429856579, 5095.87260318495, 5118.846434606968, 5172.5603323717905, 5239.947600524022, 5240.502152295526, 5257.316548848626, 5268.736563171826, 4768.880777980578, 5049.566294919417, 5064.316317297118, 5078.619103567247, 5098.515641014098, 2847.572864070406, 2855.4289142171647, 2856.614541947154, 2858.9428211435657, 2859.4852926473436, 5369.6509726867625, 5417.891642167214, 5456.836294911159, 5457.0, 5493.692649087313, 5193.610479214074, 5327.987682340343, 5349.598780091431, 5405.675659460445, 5407.567394608422, 5478.397376288684, 5486.890262194814, 5507.807226747044, 5526.834194974157, 5532.5020748132865, 5346.87715579717, 5716.9142462862255, 5811.360750317546, 5903.380145084704, 5944.5838791284195, 5858.209141765807, 5867.501262392574, 5870.295564532284, 5871.442212989759, 5875.50058245054, 5950.702464876826, 6039.855851172946, 6146.033269353943, 6149.7847575334645, 6251.093591429309, 4299.484061912465, 4310.719803212781, 4318.546552612056, 4324.372965919861, 4325.826966921288, 6067.575269731076, 6072.210612620331, 6078.45293923549, 6079.604825686316, 6084.178635884099, 5682.488576028178, 5890.263717035371, 5902.61632993854, 5903.793367232126, 5920.319163296103, 5853.678047707417, 5878.617889837147, 5889.558283128868, 5889.852753681193, 5892.764289428546, 5521.171824226398, 5799.449052340021, 5804.796832110856, 5815.79644712433, 5821.0, 5785.566082543742, 5905.586608937333, 5923.134212722978, 5925.881482370242, 5937.614055086406, 5674.290713660793, 5711.400302968294, 5726.9713651431475, 5749.655020698771, 5761.8559536011935], "value": 4337.258470821244, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.7240138352962, 840.5041025794784, 865.8441480533504, 868.9913100868991, 890.1943740914475, 15538.1454020029, 15579.766303505456, 15592.84407155928, 15871.603209919744, 17111.973281603096, 16021.919890400532, 16069.196540173003, 16177.19114044299, 16178.83821161788, 16183.433579824708, 738.0516036892594, 881.6297155194834, 884.3279107878027, 911.8221946720392, 920.1902325953185, 873.9257163141141, 874.5583480342418, 876.5792419638545, 876.8640860666575, 884.5754038061734, 953.2516974175273, 958.5925981457888, 959.4866746290736, 960.8510680844445, 961.1205746741723, 750.8198032472222, 916.3356566489275, 937.1893312284893, 937.3813283233034, 940.0270719804969, 694.298758254167, 695.8469136789898, 698.6855914838292, 698.6890833579059, 698.8672152291049, 15959.92020039904, 15998.44005459815, 16019.0, 16034.198290085566, 16041.518754437386, 14295.642608934755, 14610.488632897905, 14616.634584135376, 14767.70464590713, 14835.480758173411, 13592.796108058288, 13931.164130152223, 14013.089149205269, 14096.436142554285, 14118.435262589484, 4696.8590942271785, 4741.905161896777, 4745.9525404745855, 4784.712917224942, 4789.3294938708605, 57296.14055789167, 60923.0, 76789.99999999945, 79113.60443197747, 79124.0, 12225.08311876595, 12295.262284262973, 12409.193402428993, 12409.62771116868, 12518.935890449231, 23185.3044408668, 23389.883050584638, 23389.88305058498, 23391.415214619432, 23687.05251789909, 8661.263792577576, 8663.783405414915, 8823.602937867812, 8834.293256539462, 8871.64513419456, 4848.878778030577, 4881.780319885543, 4881.9093601453, 4958.776855041532, 4998.875028124253, 3725.068732816796, 3920.098377373163, 3925.0, 3927.9018024549614, 3928.9214215716097, 636.6371168434041, 649.5420728386476, 689.2246222999127, 766.3945483068425, 770.8342706318057, 694.3854688600625, 724.2829598697252, 728.9416846652255, 761.6991288441035, 781.8436312737362, 10032.69901902944, 10124.34191777532, 10248.538815753309, 10377.273590848568, 10449.425281609432, 637.3944752485157, 697.4385619576188, 699.6117154979036, 789.9170587088388, 791.3194652598761, 4481.462224533077, 4504.684672072924, 4581.450225972838, 4970.304157417964, 4976.950230497721, 117526.0, 123761.0, 124003.37998309951, 127145.0, 129659.0, 66219.0, 100665.49001764979, 107093.0, 107725.4613726942, 109852.4507377458, 91554.54222728843, 91707.0, 91896.0, 91956.54021729983, 92957.5352123235, 8962.32782541299, 9069.909300907171, 9151.130642588943, 9178.908210918073, 9295.581698823704, 55616.16575751448, 55875.441245587026, 56093.43906560882, 57394.13908791288, 57716.711416442646, 78827.60586197033, 83790.0, 84759.5762021186, 86867.13132868591, 87153.56423217844, 11832.58585949522, 12040.0, 12139.332336721212, 12223.20549164337, 12384.256944583354, 12615.684607884876, 12888.548900788428, 13450.327483625584, 13664.180149191081, 13684.110532815335, 12272.325022123869, 12325.322107284186, 12562.685932851751, 12644.747105058032, 12778.936105319413, 11695.356755378196, 11910.702232444259, 11977.820332695192, 12185.69535761613, 12861.742765144832, 11647.475863585989, 11812.291262524275, 11895.821562676394, 12244.265344079384, 13013.674658133623, 9994.800103997733, 10005.949970250102, 10042.648507302501, 10251.897481025095, 10311.175105991353, 9924.255680824112, 10444.321119127233, 10477.476126193813, 10490.160787137163, 10490.265681402228], "value": 7827.027451029758, "unit": "score"}], "name": "dromaeo_css", "value": 7594.723235565565, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 109.0, 109.0, 111.0, 112.0, 108.0, 110.0, 111.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 124.0, 170.0, 125.0, 123.0, 153.0, 124.0, 149.0, 122.0], "value": 136.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 163.0, 162.0, 159.0, 160.0, 158.0, 160.0, 158.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 75.0, 76.0, 108.0, 75.0, 75.0, 74.0, 74.0, 98.0, 74.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 113.0, 84.0, 85.0, 85.0, 113.0, 84.0, 85.0, 129.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 52.0, 51.0, 53.0, 53.0, 51.0, 53.0, 51.0, 54.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 60.0, 59.0, 59.0, 60.0, 61.0, 61.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 76.0, 77.0, 78.0, 86.0, 81.0, 118.0, 84.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 137.0, 118.0, 124.0, 118.0, 115.0, 115.0, 139.0, 127.0, 139.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 152.0, 154.0, 159.0, 156.0, 157.0, 154.0, 152.0, 153.0, 154.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 66.0, 61.0, 61.0, 62.0, 62.0, 61.0, 60.0, 64.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1477.0, "alertThreshold": 2.0}]} 11:44:42 INFO - Return code: 0 11:44:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:44:42 ERROR - # TBPL SUCCESS # 11:44:42 INFO - Running post-action listener: _resource_record_post_action 11:44:42 INFO - ##### 11:44:42 INFO - ##### Finished run-tests step (success) 11:44:42 INFO - ##### 11:44:42 INFO - Running post-run listener: _resource_record_post_run 11:44:42 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 28672; Write bytes: 457859072; Read time: 24; Write time: 289840 11:44:42 INFO - TinderboxPrint: CPU usage
13.1% 11:44:42 INFO - TinderboxPrint: I/O read bytes / time
28,672 / 24 11:44:42 INFO - TinderboxPrint: I/O write bytes / time
457,859,072 / 289,840 11:44:42 INFO - TinderboxPrint: CPU idle
8,228.8 (86.9%) 11:44:42 INFO - TinderboxPrint: CPU user
1,195.6 (12.6%) 11:44:42 INFO - TinderboxPrint: Swap in / out
0 / 0 11:44:42 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 234995712; Read time: 0; Write time: 198040 11:44:42 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 222498816; Read time: 12; Write time: 91776 11:44:43 INFO - Running post-run listener: _upload_blobber_files 11:44:43 INFO - Blob upload gear active. 11:44:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:44:43 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 11:44:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:44:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:44:43 INFO - (blobuploader) - INFO - Open directory for files ... 11:44:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:44:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:44:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:44 INFO - (blobuploader) - INFO - Done attempting. 11:44:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:44:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:44:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:45 INFO - (blobuploader) - INFO - Done attempting. 11:44:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:44:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:44:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:52 INFO - (blobuploader) - INFO - Done attempting. 11:44:52 INFO - (blobuploader) - INFO - Iteration through files over. 11:44:52 INFO - Return code: 0 11:44:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:44:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:44:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/97f2b562cdd2317f5a4d164783ee906f848093a65388366389cc5e3c3eefb6313d664f2a0e25c99c6903f6b68d2f77b35fb725eaaa6d66392c766b150a0175ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2e1bf07f2801bd7d7d225b39e21c715b6e596cacfdc5d47de08f1c43dac973814a101ebd3a3681114ab0d302cb14258c07928964da8cb9e8b592d1f2228959cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/342b6a3c3bf0bacef255474f20cfef40a0a5411b9cadd98cb4c9ed9911a819f46729071baef50413a6c15d62466113474e060650da48e03283d414f950e4f2e8"} 11:44:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:44:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:44:52 INFO - Contents: 11:44:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/97f2b562cdd2317f5a4d164783ee906f848093a65388366389cc5e3c3eefb6313d664f2a0e25c99c6903f6b68d2f77b35fb725eaaa6d66392c766b150a0175ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2e1bf07f2801bd7d7d225b39e21c715b6e596cacfdc5d47de08f1c43dac973814a101ebd3a3681114ab0d302cb14258c07928964da8cb9e8b592d1f2228959cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/342b6a3c3bf0bacef255474f20cfef40a0a5411b9cadd98cb4c9ed9911a819f46729071baef50413a6c15d62466113474e060650da48e03283d414f950e4f2e8"} 11:44:52 INFO - Running post-run listener: copy_logs_to_upload_dir 11:44:52 INFO - Copying logs to upload dir... 11:44:52 INFO - mkdir: /builds/slave/test/build/upload/logs 11:44:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.360294 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-01 11:44:51.976681) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 11:44:51.980388) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085 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-Beta/sha512/97f2b562cdd2317f5a4d164783ee906f848093a65388366389cc5e3c3eefb6313d664f2a0e25c99c6903f6b68d2f77b35fb725eaaa6d66392c766b150a0175ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2e1bf07f2801bd7d7d225b39e21c715b6e596cacfdc5d47de08f1c43dac973814a101ebd3a3681114ab0d302cb14258c07928964da8cb9e8b592d1f2228959cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/342b6a3c3bf0bacef255474f20cfef40a0a5411b9cadd98cb4c9ed9911a819f46729071baef50413a6c15d62466113474e060650da48e03283d414f950e4f2e8"} build_url:https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011157 build_url: 'https://queue.taskcluster.net/v1/task/cet431kUTUGquqQcQ5vlmg/artifacts/public/build/firefox-49.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/97f2b562cdd2317f5a4d164783ee906f848093a65388366389cc5e3c3eefb6313d664f2a0e25c99c6903f6b68d2f77b35fb725eaaa6d66392c766b150a0175ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2e1bf07f2801bd7d7d225b39e21c715b6e596cacfdc5d47de08f1c43dac973814a101ebd3a3681114ab0d302cb14258c07928964da8cb9e8b592d1f2228959cc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/342b6a3c3bf0bacef255474f20cfef40a0a5411b9cadd98cb4c9ed9911a819f46729071baef50413a6c15d62466113474e060650da48e03283d414f950e4f2e8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 11:44:52.005443) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:44:52.005765) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1470075028.559407-1502009085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004357 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:44:52.090586) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 11:44:52.091162) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 11:44:52.091685) ========= ========= Total master_lag: 0.17 =========