builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1470075854.57 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.567364) ========= 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.567812) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.568098) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.773742) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.774016) ========= 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=8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-01 11:24:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-08-01 11:24:15 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095745 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.886904) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.887190) ========= 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=8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020647 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.978638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:14.982007) ========= 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=8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-01 11:24:16,005 truncating revision to first 12 chars 2016-08-01 11:24:16,005 Setting DEBUG logging. 2016-08-01 11:24:16,005 attempt 1/10 2016-08-01 11:24:16,005 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:16,312 unpacking tar archive at: mozilla-beta-bad9d4f5bf7e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.724850 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:15.719894) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:15.720171) ========= script_repo_revision: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:15.720536) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:15.720832) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 11:24:15.728615) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-01 11:24:15.728888) ========= /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=8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:24:16 INFO - MultiFileLogger online at 20160801 11:24:16 in /builds/slave/test 11:24:16 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:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:24:16 INFO - {'append_to_log': False, 11:24:16 INFO - 'base_work_dir': '/builds/slave/test', 11:24:16 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:24:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:24:16 INFO - 'branch': 'Mozilla-Beta', 11:24:16 INFO - 'buildbot_json_path': 'buildprops.json', 11:24:16 INFO - 'config_files': ('talos/linux_config.py',), 11:24:16 INFO - 'default_actions': ('clobber', 11:24:16 INFO - 'read-buildbot-config', 11:24:16 INFO - 'download-and-extract', 11:24:16 INFO - 'populate-webroot', 11:24:16 INFO - 'create-virtualenv', 11:24:16 INFO - 'install', 11:24:16 INFO - 'run-tests'), 11:24:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:24:16 INFO - 'download_minidump_stackwalk': True, 11:24:16 INFO - 'download_symbols': 'ondemand', 11:24:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:24:16 INFO - 'tooltool.py': '/tools/tooltool.py', 11:24:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:24:16 INFO - '/tools/misc-python/virtualenv.py')}, 11:24:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:24:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:24:16 INFO - 'installer_path': 'installer.exe', 11:24:16 INFO - 'log_level': 'info', 11:24:16 INFO - 'log_name': 'talos', 11:24:16 INFO - 'log_to_console': True, 11:24:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:24:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:24:16 INFO - 'opt_config_files': (), 11:24:16 INFO - 'pip_index': False, 11:24:16 INFO - 'sps_profile': False, 11:24:16 INFO - 'sps_profile_interval': 0, 11:24:16 INFO - 'suite': 'dromaeojs', 11:24:16 INFO - 'system_bits': '32', 11:24:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:24:16 INFO - 'title': 'talos-linux64-ix-038', 11:24:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:24:16 INFO - 'use_talos_json': True, 11:24:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:24:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:24:16 INFO - 'work_dir': 'build'} 11:24:16 INFO - ##### 11:24:16 INFO - ##### Running clobber 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: clobber 11:24:16 INFO - rmtree: /builds/slave/test/build 11:24:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:24:17 INFO - Running post-action listener: _resource_record_post_action 11:24:17 INFO - ##### 11:24:17 INFO - ##### Finished clobber step (success) 11:24:17 INFO - ##### 11:24:17 INFO - ##### 11:24:17 INFO - ##### Running read-buildbot-config step. 11:24:17 INFO - ##### 11:24:17 INFO - Running pre-action listener: _resource_record_pre_action 11:24:17 INFO - Running main action method: read_buildbot_config 11:24:17 INFO - Using buildbot properties: 11:24:17 INFO - { 11:24:17 INFO - "project": "", 11:24:17 INFO - "product": "firefox", 11:24:17 INFO - "script_repo_revision": "production", 11:24:17 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 11:24:17 INFO - "repository": "", 11:24:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 11:24:17 INFO - "buildid": "20160801070053", 11:24:17 INFO - "pgo_build": "True", 11:24:17 INFO - "basedir": "/builds/slave/test", 11:24:17 INFO - "buildnumber": 184, 11:24:17 INFO - "slavename": "talos-linux64-ix-038", 11:24:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:24:17 INFO - "platform": "ubuntu64_hw", 11:24:17 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 11:24:17 INFO - "branch": "mozilla-beta", 11:24:17 INFO - "repo_path": "releases/mozilla-beta", 11:24:17 INFO - "revision": "bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2", 11:24:17 INFO - "stage_platform": "linux64-pgo", 11:24:17 INFO - "builduid": "eaf10adbc6074edb9e3b1e3d32dab73b", 11:24:17 INFO - "slavebuilddir": "test" 11:24:17 INFO - } 11:24:17 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:17 INFO - Running post-action listener: _resource_record_post_action 11:24:17 INFO - ##### 11:24:17 INFO - ##### Finished read-buildbot-config step (success) 11:24:17 INFO - ##### 11:24:17 INFO - ##### 11:24:17 INFO - ##### Running download-and-extract step. 11:24:17 INFO - ##### 11:24:17 INFO - Running pre-action listener: _resource_record_pre_action 11:24:17 INFO - Running main action method: download_and_extract 11:24:17 INFO - mkdir: /builds/slave/test/build/tests 11:24:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:17 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:17 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:17 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:17 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:17 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:23 INFO - Downloaded 1327 bytes. 11:24:23 INFO - Reading from file /builds/slave/test/build/firefox-49.0.en-US.linux-x86_64.test_packages.json 11:24:23 INFO - Using the following test package requirements: 11:24:23 INFO - {u'common': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 11:24:23 INFO - u'cppunittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:23 INFO - u'firefox-49.0.en-US.linux-x86_64.cppunittest.tests.zip'], 11:24:23 INFO - u'gtest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:23 INFO - u'firefox-49.0.en-US.linux-x86_64.gtest.tests.zip'], 11:24:23 INFO - u'jittest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:23 INFO - u'jsshell-linux-x86_64.zip'], 11:24:23 INFO - u'mochitest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:23 INFO - u'firefox-49.0.en-US.linux-x86_64.mochitest.tests.zip'], 11:24:23 INFO - u'mozbase': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'], 11:24:23 INFO - u'reftest': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:23 INFO - u'firefox-49.0.en-US.linux-x86_64.reftest.tests.zip'], 11:24:23 INFO - u'talos': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:23 INFO - u'firefox-49.0.en-US.linux-x86_64.talos.tests.zip'], 11:24:23 INFO - u'web-platform': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:23 INFO - u'firefox-49.0.en-US.linux-x86_64.web-platform.tests.zip'], 11:24:23 INFO - u'xpcshell': [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip', 11:24:23 INFO - u'firefox-49.0.en-US.linux-x86_64.xpcshell.tests.zip']} 11:24:23 INFO - Downloading packages: [u'firefox-49.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:23 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:23 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:23 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:23 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:23 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:24 INFO - Downloaded 21968684 bytes. 11:24:24 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:24 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:26 INFO - Return code: 0 11:24:26 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:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:26 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:26 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:26 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:26 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:26 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:30 INFO - Downloaded 21968684 bytes. 11:24:30 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:30 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:31 INFO - Return code: 0 11:24:31 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:31 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:31 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:31 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:31 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:31 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:32 INFO - Downloaded 10833369 bytes. 11:24:32 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:32 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:32 INFO - Return code: 0 11:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:32 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:32 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:32 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:32 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:32 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:34 INFO - Downloaded 55264299 bytes. 11:24:34 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:34 INFO - mkdir: /builds/slave/test/properties 11:24:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:34 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:34 INFO - Contents: 11:24:34 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:34 INFO - Running post-action listener: _resource_record_post_action 11:24:34 INFO - Running post-action listener: set_extra_try_arguments 11:24:34 INFO - ##### 11:24:34 INFO - ##### Finished download-and-extract step (success) 11:24:34 INFO - ##### 11:24:34 INFO - ##### 11:24:34 INFO - ##### Running populate-webroot step. 11:24:34 INFO - ##### 11:24:34 INFO - Running pre-action listener: _resource_record_pre_action 11:24:34 INFO - Running main action method: populate_webroot 11:24:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:24:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:24:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:24:34 INFO - '--tppagecycles', 11:24:34 INFO - '7'], 11:24:34 INFO - 'tests': ['tsvgm']}}, 11:24:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:24:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:24:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:24:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:24:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:24:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:24:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:34 INFO - 'talos_options': ['--disable-e10s'], 11:24:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:34 INFO - 'talos_options': ['--disable-e10s'], 11:24:34 INFO - 'tests': ['damp', 'tps']}, 11:24:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:34 INFO - 'tests': ['damp', 'tps']}, 11:24:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:24:34 INFO - 'tests': ['dromaeo_dom']}, 11:24:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:24:34 INFO - 'tests': ['a11yr', 11:24:34 INFO - 'ts_paint', 11:24:34 INFO - 'tpaint', 11:24:34 INFO - 'sessionrestore', 11:24:34 INFO - 'sessionrestore_no_auto_restore', 11:24:34 INFO - 'tabpaint']}, 11:24:34 INFO - 'other-e10s': {'tests': ['a11yr', 11:24:34 INFO - 'ts_paint', 11:24:34 INFO - 'tpaint', 11:24:34 INFO - 'sessionrestore', 11:24:34 INFO - 'sessionrestore_no_auto_restore', 11:24:34 INFO - 'tabpaint']}, 11:24:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:24:34 INFO - 'ts_paint', 11:24:34 INFO - 'tpaint', 11:24:34 INFO - 'sessionrestore', 11:24:34 INFO - 'sessionrestore_no_auto_restore', 11:24:34 INFO - 'tabpaint']}, 11:24:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:24:34 INFO - 'ts_paint', 11:24:34 INFO - 'tpaint', 11:24:34 INFO - 'sessionrestore', 11:24:34 INFO - 'sessionrestore_no_auto_restore', 11:24:34 INFO - 'tabpaint']}, 11:24:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:24:34 INFO - 'tests': ['a11yr', 11:24:34 INFO - 'ts_paint', 11:24:34 INFO - 'tpaint', 11:24:34 INFO - 'sessionrestore', 11:24:34 INFO - 'sessionrestore_no_auto_restore', 11:24:34 INFO - 'tabpaint']}, 11:24:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:24:34 INFO - 'tests': ['a11yr', 11:24:34 INFO - 'ts_paint', 11:24:34 INFO - 'tpaint', 11:24:34 INFO - 'sessionrestore', 11:24:34 INFO - 'sessionrestore_no_auto_restore', 11:24:34 INFO - 'tabpaint']}, 11:24:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:24:34 INFO - 'tests': ['tsvgx', 11:24:34 INFO - 'tsvgr_opacity', 11:24:34 INFO - 'tart', 11:24:34 INFO - 'tscrollx', 11:24:34 INFO - 'cart']}, 11:24:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:24:34 INFO - 'tsvgr_opacity', 11:24:34 INFO - 'tart', 11:24:34 INFO - 'tscrollx', 11:24:34 INFO - 'cart']}, 11:24:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:34 INFO - 'talos_options': ['--disable-e10s'], 11:24:34 INFO - 'tests': ['tp5o']}, 11:24:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:34 INFO - 'tests': ['tp5o']}, 11:24:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:34 INFO - 'talos_options': ['--disable-e10s', 11:24:34 INFO - '--xperf_path', 11:24:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:34 INFO - 'tests': ['tp5n']}, 11:24:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:24:34 INFO - 'talos_options': ['--xperf_path', 11:24:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:34 INFO - 'tests': ['tp5n']}}, 11:24:34 INFO - 'talos.zip': {'path': '', 11:24:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:24:34 INFO - Running post-action listener: _resource_record_post_action 11:24:34 INFO - ##### 11:24:34 INFO - ##### Finished populate-webroot step (success) 11:24:34 INFO - ##### 11:24:34 INFO - ##### 11:24:34 INFO - ##### Running create-virtualenv step. 11:24:34 INFO - ##### 11:24:34 INFO - Running pre-action listener: _resource_record_pre_action 11:24:34 INFO - Running main action method: create_virtualenv 11:24:34 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:34 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:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:24:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:34 INFO - Using real prefix '/usr' 11:24:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:35 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:37 INFO - Installing pip.................done. 11:24:37 INFO - Return code: 0 11:24:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24:37 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:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:37 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:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:37 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 0x7f3776216f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, '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': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', '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:37 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:37 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:37 INFO - Using env: {'DISPLAY': ':0', 11:24:37 INFO - 'HOME': '/home/cltbld', 11:24:37 INFO - 'LANG': 'en_US.UTF-8', 11:24:37 INFO - 'LANGUAGE': 'en_US:en', 11:24:37 INFO - 'LOGNAME': 'cltbld', 11:24:37 INFO - 'MAIL': '/var/mail/cltbld', 11:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:37 INFO - 'MOZ_NO_REMOTE': '1', 11:24:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:37 INFO - 'NO_EM_RESTART': '1', 11:24:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:37 INFO - 'PWD': '/builds/slave/test', 11:24:37 INFO - 'SHELL': '/bin/bash', 11:24:37 INFO - 'SHLVL': '1', 11:24:37 INFO - 'TERM': 'linux', 11:24:37 INFO - 'TMOUT': '86400', 11:24:37 INFO - 'USER': 'cltbld', 11:24:37 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', 11:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:37 INFO - '_': '/tools/buildbot/bin/python'} 11:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:37 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:37 INFO - Cleaning up... 11:24:37 INFO - Return code: 0 11:24:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:24:37 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:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:37 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:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:37 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 0x7f3776216f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, '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': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', '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:37 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:37 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:37 INFO - Using env: {'DISPLAY': ':0', 11:24:37 INFO - 'HOME': '/home/cltbld', 11:24:37 INFO - 'LANG': 'en_US.UTF-8', 11:24:37 INFO - 'LANGUAGE': 'en_US:en', 11:24:37 INFO - 'LOGNAME': 'cltbld', 11:24:37 INFO - 'MAIL': '/var/mail/cltbld', 11:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:37 INFO - 'MOZ_NO_REMOTE': '1', 11:24:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:37 INFO - 'NO_EM_RESTART': '1', 11:24:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:37 INFO - 'PWD': '/builds/slave/test', 11:24:37 INFO - 'SHELL': '/bin/bash', 11:24:37 INFO - 'SHLVL': '1', 11:24:37 INFO - 'TERM': 'linux', 11:24:37 INFO - 'TMOUT': '86400', 11:24:37 INFO - 'USER': 'cltbld', 11:24:37 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', 11:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:37 INFO - '_': '/tools/buildbot/bin/python'} 11:24:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:38 INFO - Downloading/unpacking psutil>=3.1.1 11:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:24:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:40 INFO - Installing collected packages: psutil 11:24:40 INFO - Running setup.py install for psutil 11:24:40 INFO - building 'psutil._psutil_linux' extension 11:24:40 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:40 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:40 INFO - building 'psutil._psutil_posix' extension 11:24:40 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:40 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:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:40 INFO - Successfully installed psutil 11:24:40 INFO - Cleaning up... 11:24:40 INFO - Return code: 0 11:24:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:40 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 0x7f3776216f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, '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': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', '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:40 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:40 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:40 INFO - Using env: {'DISPLAY': ':0', 11:24:40 INFO - 'HOME': '/home/cltbld', 11:24:40 INFO - 'LANG': 'en_US.UTF-8', 11:24:40 INFO - 'LANGUAGE': 'en_US:en', 11:24:40 INFO - 'LOGNAME': 'cltbld', 11:24:40 INFO - 'MAIL': '/var/mail/cltbld', 11:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:40 INFO - 'MOZ_NO_REMOTE': '1', 11:24:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:40 INFO - 'NO_EM_RESTART': '1', 11:24:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:40 INFO - 'PWD': '/builds/slave/test', 11:24:40 INFO - 'SHELL': '/bin/bash', 11:24:40 INFO - 'SHLVL': '1', 11:24:40 INFO - 'TERM': 'linux', 11:24:40 INFO - 'TMOUT': '86400', 11:24:40 INFO - 'USER': 'cltbld', 11:24:40 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', 11:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:40 INFO - '_': '/tools/buildbot/bin/python'} 11:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:24:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:24:42 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:42 INFO - Installing collected packages: mozsystemmonitor 11:24:42 INFO - Running setup.py install for mozsystemmonitor 11:24:42 INFO - Successfully installed mozsystemmonitor 11:24:42 INFO - Cleaning up... 11:24:43 INFO - Return code: 0 11:24:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:24:43 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:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:43 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:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:43 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 0x7f3776216f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, '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': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', '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:43 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:43 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:43 INFO - Using env: {'DISPLAY': ':0', 11:24:43 INFO - 'HOME': '/home/cltbld', 11:24:43 INFO - 'LANG': 'en_US.UTF-8', 11:24:43 INFO - 'LANGUAGE': 'en_US:en', 11:24:43 INFO - 'LOGNAME': 'cltbld', 11:24:43 INFO - 'MAIL': '/var/mail/cltbld', 11:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:43 INFO - 'MOZ_NO_REMOTE': '1', 11:24:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:43 INFO - 'NO_EM_RESTART': '1', 11:24:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:43 INFO - 'PWD': '/builds/slave/test', 11:24:43 INFO - 'SHELL': '/bin/bash', 11:24:43 INFO - 'SHLVL': '1', 11:24:43 INFO - 'TERM': 'linux', 11:24:43 INFO - 'TMOUT': '86400', 11:24:43 INFO - 'USER': 'cltbld', 11:24:43 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', 11:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:43 INFO - '_': '/tools/buildbot/bin/python'} 11:24:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:43 INFO - Downloading/unpacking jsonschema==2.5.1 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:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:24:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:24:45 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:45 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:45 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:45 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:45 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:45 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:45 INFO - Downloading functools32-3.2.3-2.tar.gz 11:24:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:24:45 INFO - warning: no files found matching '*.txt' 11:24:45 INFO - no previously-included directories found matching 'build' 11:24:45 INFO - no previously-included directories found matching 'dist' 11:24:45 INFO - no previously-included directories found matching '.git*' 11:24:45 INFO - Installing collected packages: jsonschema, functools32 11:24:45 INFO - Running setup.py install for functools32 11:24:45 INFO - warning: no files found matching '*.txt' 11:24:45 INFO - no previously-included directories found matching 'build' 11:24:45 INFO - no previously-included directories found matching 'dist' 11:24:45 INFO - no previously-included directories found matching '.git*' 11:24:45 INFO - Successfully installed jsonschema functools32 11:24:45 INFO - Cleaning up... 11:24:45 INFO - Return code: 0 11:24:45 INFO - Installing blobuploader==1.2.4 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', '--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 0x7f3776216f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, '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': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', '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', '--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:45 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: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': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', 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 - Downloading/unpacking blobuploader==1.2.4 11:24:45 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:45 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:45 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:45 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:45 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:45 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:47 INFO - Downloading blobuploader-1.2.4.tar.gz 11:24:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:24:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:24:47 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:47 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:47 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:47 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:47 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:47 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:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:24:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:24:48 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:48 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:48 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:48 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:48 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:48 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:48 INFO - Downloading docopt-0.6.1.tar.gz 11:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:24:48 INFO - Installing collected packages: blobuploader, requests, docopt 11:24:48 INFO - Running setup.py install for blobuploader 11:24:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:24:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:24:48 INFO - Running setup.py install for requests 11:24:48 INFO - Running setup.py install for docopt 11:24:48 INFO - Successfully installed blobuploader requests docopt 11:24:48 INFO - Cleaning up... 11:24:49 INFO - Return code: 0 11:24:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:49 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:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:49 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:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:49 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 0x7f3776216f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, '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': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', '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:49 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:49 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:49 INFO - Using env: {'DISPLAY': ':0', 11:24:49 INFO - 'HOME': '/home/cltbld', 11:24:49 INFO - 'LANG': 'en_US.UTF-8', 11:24:49 INFO - 'LANGUAGE': 'en_US:en', 11:24:49 INFO - 'LOGNAME': 'cltbld', 11:24:49 INFO - 'MAIL': '/var/mail/cltbld', 11:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:49 INFO - 'MOZ_NO_REMOTE': '1', 11:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:49 INFO - 'NO_EM_RESTART': '1', 11:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:49 INFO - 'PWD': '/builds/slave/test', 11:24:49 INFO - 'SHELL': '/bin/bash', 11:24:49 INFO - 'SHLVL': '1', 11:24:49 INFO - 'TERM': 'linux', 11:24:49 INFO - 'TMOUT': '86400', 11:24:49 INFO - 'USER': 'cltbld', 11:24:49 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', 11:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:49 INFO - '_': '/tools/buildbot/bin/python'} 11:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:49 INFO - Running setup.py (path:/tmp/pip-kzAZw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:49 INFO - Running setup.py (path:/tmp/pip-8lrLYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:49 INFO - Running setup.py (path:/tmp/pip-pA1VMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:49 INFO - Running setup.py (path:/tmp/pip-oytc76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:49 INFO - Running setup.py (path:/tmp/pip-zkOG3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:49 INFO - Running setup.py (path:/tmp/pip-AgkrEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:49 INFO - Running setup.py (path:/tmp/pip-XFFMEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:49 INFO - Running setup.py (path:/tmp/pip-2CordP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:49 INFO - Running setup.py (path:/tmp/pip-Vpsv8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:49 INFO - Running setup.py (path:/tmp/pip-IpKXhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:49 INFO - Running setup.py (path:/tmp/pip-E283Gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:50 INFO - Running setup.py (path:/tmp/pip-d5nvgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:50 INFO - Running setup.py (path:/tmp/pip-rBXV51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:50 INFO - Running setup.py (path:/tmp/pip-rWAcfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:50 INFO - Running setup.py (path:/tmp/pip-tR8yDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:50 INFO - Running setup.py (path:/tmp/pip-8qXNJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:50 INFO - Running setup.py (path:/tmp/pip-2i2rFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:24:50 INFO - Running setup.py install for manifestparser 11:24:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:24:50 INFO - Running setup.py install for mozcrash 11:24:50 INFO - Running setup.py install for mozdebug 11:24:50 INFO - Running setup.py install for mozdevice 11:24:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:24:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:24:50 INFO - Running setup.py install for mozfile 11:24:50 INFO - Running setup.py install for mozhttpd 11:24:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:24:51 INFO - Running setup.py install for mozinfo 11:24:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:24:51 INFO - Running setup.py install for mozInstall 11:24:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:24:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:24:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:24:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:24:51 INFO - Running setup.py install for mozleak 11:24:51 INFO - Running setup.py install for mozlog 11:24:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:24:51 INFO - Running setup.py install for moznetwork 11:24:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:24:51 INFO - Running setup.py install for mozprocess 11:24:51 INFO - Running setup.py install for mozprofile 11:24:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:24:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:24:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:24:51 INFO - Running setup.py install for mozrunner 11:24:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:24:51 INFO - Running setup.py install for mozscreenshot 11:24:52 INFO - Running setup.py install for moztest 11:24:52 INFO - Running setup.py install for mozversion 11:24:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:24:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:24:52 INFO - Cleaning up... 11:24:52 INFO - Return code: 0 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/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 0x7f3776216f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, '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': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', '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/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:52 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: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': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:24:52 INFO - Running setup.py (path:/tmp/pip-gy329j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:24:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:24:52 INFO - Running setup.py (path:/tmp/pip-mGV9ML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:24:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:24:52 INFO - Running setup.py (path:/tmp/pip-ap4s5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:24:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:24:52 INFO - Running setup.py (path:/tmp/pip-RTB0Bf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:24:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:24:52 INFO - Running setup.py (path:/tmp/pip-sh2dQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:24:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:24:52 INFO - Running setup.py (path:/tmp/pip-AxiNh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:24:52 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:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:24:52 INFO - Running setup.py (path:/tmp/pip-iCc0GH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:24:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:24:53 INFO - Running setup.py (path:/tmp/pip-vsJ_HH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:24:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:24:53 INFO - Running setup.py (path:/tmp/pip-qiXVGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:24:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:24:53 INFO - Running setup.py (path:/tmp/pip-2UuKaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:24:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:24:53 INFO - Running setup.py (path:/tmp/pip-F_j3Jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:24:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:24:53 INFO - Running setup.py (path:/tmp/pip-EMrjKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:24:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:24:53 INFO - Running setup.py (path:/tmp/pip-ym8yE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:24:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:24:53 INFO - Running setup.py (path:/tmp/pip-C_atLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:24:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:53 INFO - Running setup.py (path:/tmp/pip-J9FJcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:24:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:24:53 INFO - Running setup.py (path:/tmp/pip-Ranx7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:24:53 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:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:24:53 INFO - Running setup.py (path:/tmp/pip-akVeSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:24:53 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:53 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:53 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:53 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:53 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:53 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:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:24:53 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:53 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:53 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:53 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:53 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:53 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 blessings-1.6.tar.gz 11:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:24:55 INFO - Installing collected packages: blessings 11:24:55 INFO - Running setup.py install for blessings 11:24:55 INFO - Successfully installed blessings 11:24:55 INFO - Cleaning up... 11:24:56 INFO - Return code: 0 11:24:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:24:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:24:56 INFO - Reading from file tmpfile_stdout 11:24:56 INFO - Current package versions: 11:24:56 INFO - argparse == 1.2.1 11:24:56 INFO - blessings == 1.6 11:24:56 INFO - blobuploader == 1.2.4 11:24:56 INFO - docopt == 0.6.1 11:24:56 INFO - functools32 == 3.2.3-2 11:24:56 INFO - jsonschema == 2.5.1 11:24:56 INFO - manifestparser == 1.1 11:24:56 INFO - mozInstall == 1.12 11:24:56 INFO - mozcrash == 0.17 11:24:56 INFO - mozdebug == 0.1 11:24:56 INFO - mozdevice == 0.48 11:24:56 INFO - mozfile == 1.2 11:24:56 INFO - mozhttpd == 0.7 11:24:56 INFO - mozinfo == 0.9 11:24:56 INFO - mozleak == 0.1 11:24:56 INFO - mozlog == 3.2 11:24:56 INFO - moznetwork == 0.27 11:24:56 INFO - mozprocess == 0.23 11:24:56 INFO - mozprofile == 0.28 11:24:56 INFO - mozrunner == 6.12 11:24:56 INFO - mozscreenshot == 0.1 11:24:56 INFO - mozsystemmonitor == 0.3 11:24:56 INFO - moztest == 0.7 11:24:56 INFO - mozversion == 1.4 11:24:56 INFO - psutil == 3.1.1 11:24:56 INFO - requests == 1.2.3 11:24:56 INFO - wsgiref == 0.1.2 11:24:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:24:56 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:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:56 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:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:56 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 0x7f3776216f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, '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': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', '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:56 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:56 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:56 INFO - Using env: {'DISPLAY': ':0', 11:24:56 INFO - 'HOME': '/home/cltbld', 11:24:56 INFO - 'LANG': 'en_US.UTF-8', 11:24:56 INFO - 'LANGUAGE': 'en_US:en', 11:24:56 INFO - 'LOGNAME': 'cltbld', 11:24:56 INFO - 'MAIL': '/var/mail/cltbld', 11:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:56 INFO - 'MOZ_NO_REMOTE': '1', 11:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:56 INFO - 'NO_EM_RESTART': '1', 11:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:56 INFO - 'PWD': '/builds/slave/test', 11:24:56 INFO - 'SHELL': '/bin/bash', 11:24:56 INFO - 'SHLVL': '1', 11:24:56 INFO - 'TERM': 'linux', 11:24:56 INFO - 'TMOUT': '86400', 11:24:56 INFO - 'USER': 'cltbld', 11:24:56 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', 11:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:56 INFO - '_': '/tools/buildbot/bin/python'} 11:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 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:56 INFO - Cleaning up... 11:24:56 INFO - Return code: 0 11:24:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:24:56 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:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:56 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:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:56 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 0x7f3776216f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, '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': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', '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:56 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:56 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:56 INFO - Using env: {'DISPLAY': ':0', 11:24:56 INFO - 'HOME': '/home/cltbld', 11:24:56 INFO - 'LANG': 'en_US.UTF-8', 11:24:56 INFO - 'LANGUAGE': 'en_US:en', 11:24:56 INFO - 'LOGNAME': 'cltbld', 11:24:56 INFO - 'MAIL': '/var/mail/cltbld', 11:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:56 INFO - 'MOZ_NO_REMOTE': '1', 11:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:56 INFO - 'NO_EM_RESTART': '1', 11:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:56 INFO - 'PWD': '/builds/slave/test', 11:24:56 INFO - 'SHELL': '/bin/bash', 11:24:56 INFO - 'SHLVL': '1', 11:24:56 INFO - 'TERM': 'linux', 11:24:56 INFO - 'TMOUT': '86400', 11:24:56 INFO - 'USER': 'cltbld', 11:24:56 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', 11:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:56 INFO - '_': '/tools/buildbot/bin/python'} 11:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:24:56 INFO - Cleaning up... 11:24:56 INFO - Return code: 0 11:24:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:24:56 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:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:56 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:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:24:56 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 0x7f3776216f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, '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': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', '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:56 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:56 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:56 INFO - Using env: {'DISPLAY': ':0', 11:24:56 INFO - 'HOME': '/home/cltbld', 11:24:56 INFO - 'LANG': 'en_US.UTF-8', 11:24:56 INFO - 'LANGUAGE': 'en_US:en', 11:24:56 INFO - 'LOGNAME': 'cltbld', 11:24:56 INFO - 'MAIL': '/var/mail/cltbld', 11:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:56 INFO - 'MOZ_NO_REMOTE': '1', 11:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:56 INFO - 'NO_EM_RESTART': '1', 11:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:56 INFO - 'PWD': '/builds/slave/test', 11:24:56 INFO - 'SHELL': '/bin/bash', 11:24:56 INFO - 'SHLVL': '1', 11:24:56 INFO - 'TERM': 'linux', 11:24:56 INFO - 'TMOUT': '86400', 11:24:56 INFO - 'USER': 'cltbld', 11:24:56 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', 11:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:56 INFO - '_': '/tools/buildbot/bin/python'} 11:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:57 INFO - Downloading/unpacking flake8 11:24:57 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:57 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:57 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:57 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:57 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:57 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:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:24:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:24:59 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:59 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:59 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:59 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:59 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:59 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:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:24:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:24:59 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:59 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:59 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:59 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:59 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:59 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:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:24:59 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:59 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:59 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:59 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:59 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:59 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:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:24:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:24:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:24:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:24:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:24:59 INFO - no previously-included directories found matching 'docs/_build' 11:24:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:24:59 INFO - Running setup.py install for pep8 11:24:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:24:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:24:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:24:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:24:59 INFO - no previously-included directories found matching 'docs/_build' 11:25:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:25:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:25:00 INFO - Cleaning up... 11:25:00 INFO - Return code: 0 11:25:00 INFO - Running post-action listener: _resource_record_post_action 11:25:00 INFO - Running post-action listener: _start_resource_monitoring 11:25:00 INFO - Starting resource monitoring. 11:25:00 INFO - ##### 11:25:00 INFO - ##### Finished create-virtualenv step (success) 11:25:00 INFO - ##### 11:25:00 INFO - ##### 11:25:00 INFO - ##### Running install step. 11:25:00 INFO - ##### 11:25:00 INFO - Running pre-action listener: _resource_record_pre_action 11:25:00 INFO - Running main action method: install 11:25:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:00 INFO - Reading from file tmpfile_stdout 11:25:00 INFO - Detecting whether we're running mozinstall >=1.0... 11:25:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:25:00 INFO - Reading from file tmpfile_stdout 11:25:00 INFO - Output received: 11:25:00 INFO - Usage: mozinstall [options] installer 11:25:00 INFO - Options: 11:25:00 INFO - -h, --help show this help message and exit 11:25:00 INFO - -d DEST, --destination=DEST 11:25:00 INFO - Directory to install application into. [default: 11:25:00 INFO - "/builds/slave/test"] 11:25:00 INFO - --app=APP Application being installed. [default: firefox] 11:25:00 INFO - mkdir: /builds/slave/test/build/application 11:25:00 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:25:00 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:13 INFO - Reading from file tmpfile_stdout 11:25:13 INFO - Output received: 11:25:13 INFO - /builds/slave/test/build/application/firefox/firefox 11:25:13 INFO - Running post-action listener: _resource_record_post_action 11:25:13 INFO - ##### 11:25:13 INFO - ##### Finished install step (success) 11:25:13 INFO - ##### 11:25:13 INFO - ##### 11:25:13 INFO - ##### Running run-tests step. 11:25:13 INFO - ##### 11:25:13 INFO - Running pre-action listener: _resource_record_pre_action 11:25:13 INFO - Running main action method: run_tests 11:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:13 INFO - Python 2.7.3 11:25:13 INFO - Return code: 0 11:25:13 INFO - grabbing minidump binary from tooltool 11:25:13 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:13 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 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:13 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:13 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:13 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:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:13 INFO - Return code: 0 11:25:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:25:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:25:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:25:14 INFO - Return code: 0 11:25:14 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-038', '--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:14 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-038 --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:14 INFO - Using env: {'DISPLAY': ':0', 11:25:14 INFO - 'HOME': '/home/cltbld', 11:25:14 INFO - 'LANG': 'en_US.UTF-8', 11:25:14 INFO - 'LANGUAGE': 'en_US:en', 11:25:14 INFO - 'LOGNAME': 'cltbld', 11:25:14 INFO - 'MAIL': '/var/mail/cltbld', 11:25:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:14 INFO - 'MOZ_NO_REMOTE': '1', 11:25:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:14 INFO - 'NO_EM_RESTART': '1', 11:25:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:14 INFO - 'PWD': '/builds/slave/test', 11:25:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:14 INFO - 'SHELL': '/bin/bash', 11:25:14 INFO - 'SHLVL': '1', 11:25:14 INFO - 'TERM': 'linux', 11:25:14 INFO - 'TMOUT': '86400', 11:25:14 INFO - 'USER': 'cltbld', 11:25:14 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597', 11:25:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:14 INFO - '_': '/tools/buildbot/bin/python'} 11:25:14 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-038', '--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:14 INFO - mozversion application_buildid: 20160801070053 11:25:14 INFO - mozversion application_changeset: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 11:25:14 INFO - mozversion application_display_name: Firefox 11:25:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:14 INFO - mozversion application_name: Firefox 11:25:14 INFO - mozversion application_remotingname: firefox 11:25:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:25:14 INFO - mozversion application_vendor: Mozilla 11:25:14 INFO - mozversion application_version: 49.0 11:25:14 INFO - mozversion platform_buildid: 20160801070053 11:25:14 INFO - mozversion platform_changeset: bad9d4f5bf7e5ee3c0c9c443489694c90ef47af2 11:25:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:25:14 INFO - mozversion platform_version: 49.0 11:25:14 INFO - using testdate: 1470075914 11:25:14 INFO - actual date: 1470075914 11:25:14 INFO - starting webserver on 'localhost:35988' 11:25:14 INFO - SUITE-START | Running 2 tests 11:25:14 INFO - TEST-START | dromaeo_css 11:25:14 INFO - operating with platform_type : linux_ 11:25:14 INFO - Initialising browser for dromaeo_css test... 11:25:14 INFO - TEST-INFO | started process 23251 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDimAc7/profile http://localhost:35988/getInfo.html) 11:25:19 INFO - PROCESS | 23251 | __metrics Screen width/height:1600/1200 11:25:19 INFO - PROCESS | 23251 | colorDepth:24 11:25:19 INFO - PROCESS | 23251 | Browser inner width/height: 1024/697 11:25:19 INFO - PROCESS | 23251 | __metrics 11:25:20 INFO - PROCESS | 23251 | 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:20 ERROR - PROCESS | 23251 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:25:21 INFO - TEST-INFO | 23251: exit 0 11:25:21 INFO - Browser initialized. 11:25:21 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:21 INFO - TEST-INFO | started process 23342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDimAc7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:33 INFO - PROCESS | 23342 | RSS: Main: 140939264 11:25:33 INFO - PROCESS | 23342 | 11:26:24 INFO - PROCESS | 23342 | 1470075984358 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:32 INFO - PROCESS | 23342 | Cycle 1(1): loaded http://localhost:35988/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35988/tests/dromaeo/cssquery-ext.html) 11:28:34 INFO - PROCESS | 23342 | RSS: Main: 262586368 11:28:34 INFO - PROCESS | 23342 | 11:31:36 INFO - PROCESS | 23342 | Cycle 1(1): loaded http://localhost:35988/tests/dromaeo/cssquery-ext.html (next: http://localhost:35988/tests/dromaeo/cssquery-jquery.html) 11:31:37 INFO - PROCESS | 23342 | RSS: Main: 229629952 11:31:37 INFO - PROCESS | 23342 | 11:34:38 INFO - PROCESS | 23342 | Cycle 1(1): loaded http://localhost:35988/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35988/tests/dromaeo/cssquery-mootools.html) 11:34:39 INFO - PROCESS | 23342 | RSS: Main: 228401152 11:34:39 INFO - PROCESS | 23342 | 11:37:41 INFO - PROCESS | 23342 | Cycle 1(1): loaded http://localhost:35988/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35988/tests/dromaeo/cssquery-prototype.html) 11:37:41 INFO - PROCESS | 23342 | RSS: Main: 219500544 11:37:41 INFO - PROCESS | 23342 | 11:40:44 INFO - PROCESS | 23342 | Cycle 1(1): loaded http://localhost:35988/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35988/tests/dromaeo/cssquery-yui.html) 11:40:45 INFO - PROCESS | 23342 | RSS: Main: 213643264 11:40:45 INFO - PROCESS | 23342 | 11:43:47 INFO - PROCESS | 23342 | Cycle 1(1): loaded http://localhost:35988/tests/dromaeo/cssquery-yui.html (next: http://localhost:35988/tests/dromaeo/cssquery-dojo.html) 11:43:47 INFO - PROCESS | 23342 | RSS: Main: 248569856 11:43:47 INFO - PROCESS | 23342 | 11:43:47 INFO - PROCESS | 23342 | __start_tp_report 11:43:47 INFO - PROCESS | 23342 | _x_x_mozilla_page_load 11:43:47 INFO - PROCESS | 23342 | _x_x_mozilla_page_load_details 11:43:47 INFO - PROCESS | 23342 | |i|pagename|runs| 11:43:47 INFO - PROCESS | 23342 | |0;dojo.html;3414.4195486767253;3417.606975197852;3427.0061682112205;3461.2558299965503;3480.286541259042;5676.489115979566;5701.714914254291;5741;5742;5751.539876809856;5692.117721753135;5698.230738850254;5753.913691294634;5755.4244575542525;5761.9135712964335;5040.97479512602;5136.948630513684;5142.202958541432;5188.766505507261;5206.947930520703;5093.185090385539;5099.107656160176;5110.437851836314;5118.283440318359;5171.818986335479;5166.870828229286;5225.294585231002;5225.764840582183;5235;5261.39493958194;4983.202687570008;5153.716545589991;5172.9741351293005;5228.215767634866;5235.345581802256;5020.59835213182;5038.571721403685;5049.697018178921;5076.771545280471;5083.949160508385;5570.41510641385;5615.971920140373;5628.380878103405;5646.971765141189;5659.745311460994;6014.75940962361;6039.818805435844;6089.249836725939;6096.513138175633;6123.387661233841;6101.0848372744;6138.47822935051;6148.292946311187;6161.969190154021;6166.506679465632;5770.2498675171955;5790.826275211751;5799.478046975751;5803.767849286023;5804.419558044162;6134.252905685651;6161.537884658579;6176.7838125666285;6210.099535567318;6276.780312689034;6063.151158837766;6067.059605761114;6069;6071.574989750675;6072.757089716361;6123.648682309606;6124.11200375943;6125.9693701531205;6129.267100814801;6131.837503309146;5955.464008239279;6080.90878636812;6128.877422451526;6130.493792663006;6135.07973803933;6176.567640265228;6204;6207.81376558704;6211.09939058834;6215.844603884849;4681.578657920803;4683.437987441529;4685.99251161002;4703.717776933395;4725.929111063337;4101.118259574147;4129.938050929239;4161.875143745692;4174.874753757392;4196;5964.31410387811;5967.313758917693;5974.2830860297045;5980.102984552265;5983.102534619842;6102.7558897644485;6195.070739389128;6251.874962500725;6260.499160067184;6268.028455589391;5844.415558444121;5878.970605146947;5904.140195838298;5951.851203719942;5952.8809423812145;5305.098133317345;5305.708186049727;5320.600954928396;5324.094903866352;5324.8136315228785;6211.09939058843;6214.067889816563;6462.967685161544;6471.482281417475;6479.708413121421;6118.235220597426;6171.321154672893;6178.351273116258;6178.783742568989;6179.28938172098;6377.8724425512155;6385.361463853577;6391.32891046452;6392.296847346881;6393.840153996001;5953.642781433128;6046.90929636047;6058.212432383762;6058.3335833057445;6066.968615335315;6191.845203869759;6237.12680224778;6245.781397651061;6250;6251.4061164189325;6042.063480160582;6078.45293923549;6101.84745381369;6101.877962440815;6107.541934354852;5797.971010144923;5959.880802384015;5985.521158307238;5989.460948514655;6039.758409663565;5918.2898052234;5919.171316015675;5920;5932.139839723302;5943;6068.180795592539;6071.726772295346;6088.178095956989;6105.755769769159;6109.69451527413;5781.94218057814;5795.159701843293;5804;5812.18629391877;5815.273090863642 11:43:47 INFO - PROCESS | 23342 | |1;ext.html;603.7675494934451;654.3423859021683;657.0013579359373;666.6333516565887;685.7257097161137;32904.67095329046;46057;47191.29213061803;47301.76349118258;47307.76346118273;49250.75374623122;49453;49765.751171244185;50010;50153.74923125388;8296.170382961716;9061.818763624724;9255.583498742573;10789.514471848746;11024.779504409908;10815.891841081568;10915.508802103925;10928.398938058404;10933.781324373507;10938.781224375507;10992.615258465956;11058.170637202202;11100.666979990572;11109.055730262937;11112.055475284611;10966;10993.945030274877;11025.779484410266;11028.613998510014;11030.669079927615;11084.833727494093;11121.110311175087;11128.833067503994;11151.219414640978;11162.776744465147;44862;45128;45137.54862451366;45234.09531809345;45437.318440223426;3988.9202215955806;4144.274751918402;4471.150481408522;4601;4615.446146462446;34253.657463425545;34588.48117278243;35041.474377884355;35918.10204744876;36297.09257268563;4833.468318484964;4839.395075615548;4866.197077482211;4888.266759985995;4916.680415772963;370297;375327;375995;379443.99999999726;380521;38365.80817095897;65306.346936530026;65371.346286537475;65659.67170164119;65921;39113.60886391156;41854.37218441726;41880.79059604743;41908.58091419108;41920.580794191665;15769.29038193284;17099.74350384745;17218.225179866935;17225.1387430628;17232.569185770455;14238.359273832702;14519.201443920685;14546.563603091925;14848.777268340984;14865.851341486446;9299.814003720023;9368.812623747486;9375.812483750424;9396.248300136109;9448.291378146667;3525.9118522037156;3538.363094642989;3566.3937130687327;3586.2110335726097;3602.441621548664;1061.5117046158853;1065.3714308557987;1093.4040947683532;1134.9943250283695;1201.381288636353;32227.677723222467;33600.159995999806;34659.13352166166;34871;35133.47299790505;1131.1290306463977;1156.5720683347047;1175.6061719323952;1184.8163534652142;1277.7061275906594;17549.824501755076;18051.548711282325;18139.18373673188;18180.45458636243;18208.90895545514;164120;164773;165692;166031;166114;64079.35920640827;64954.67522662356;65206.347936520026;65358.34641653618;65411;1349.4534713441071;1432.2910159471128;1464.4727897956727;1475.6015875713713;1486.2271618758184;33664.66335336615;33907.64785052711;34688.306233875686;34903.476447852794;35192.29615407729;54241;54697;54871.176932345246;54891.17663234975;54931.725341373036;427792;428466;429241;429895;430663;27546.724532754415;49633.50366496289;49636.751816240685;50635;53869.46130538801;50280.24579631235;52224;54152.72923635514;55614.443855562546;55978.44021559895;45702;46261.30608040815;46709.532904670516;46923.530764693285;47866;44975.861569721244;45788;45999.540004600865;46156.769216153705;47226;45422.09155816799;46117.53882461267;46251.53748462607;46385.536144639475;46548.767256163504;38974.220515590096;40693.593064068984;41355.379669305585;41480.37779433371;41644.04462321928;29940.70059299466;29979.850100749358;30114.397712045196;30342.241443963194;30614.540781887845 11:43:47 INFO - PROCESS | 23342 | |2;jquery.html;409.82787229363663;416.91870085333335;424.5414951852;431.43482038529527;432.0990734318945;18303.3593824216;19835.801641983577;19866.602667946634;20093.598128037447;20434.08046637901;19632.214711411525;20411;20452.181912723474;21224.257150999718;21253.25613603524;5580.497755202041;5786.68173250471;5834.6790926499025;5834.912476312858;5835.708214589275;4155.522114956773;4225.746455212697;5686.744096515667;5724.112762521795;6359.586626869239;6482.6434546099945;6494.935050649504;6517.152770139875;6519;6527.249366322886;6380.0748891410485;6382.617042977413;6392.840178995516;6393.264774550939;6397.904031439532;3853.6339047790416;5403.432639572828;5619.915701264485;5685.630434021817;5766.279215098113;23978.400539986465;24148;24311.27066188017;24319.14882979105;24410.14564490252;2630.053180854891;2658.5214661360947;2678.6116013178175;3005.5341422079396;3078.415101130778;14515.70968580633;14803;14839.851601484062;14971.700565988727;15359.232038398035;1787.6603445345343;1947.3865732294423;2046.986741562921;2055.14711394771;2110.8416868734907;79446;80281.99999999942;80947;81464.18535814625;81898.59050704708;10583.57665693379;10702.73243168927;10971.39657318839;11140.888591114148;11188.272762270426;15520.767188492182;15608.921955390151;15614.219289035504;15626.140562269184;15641.217939102999;8360.58197090143;8837.116288371111;8906.55467226636;8949.194572488377;9083.091690830865;8649.783755406164;8844.73465796027;8894;8897.599608017656;8960.148785865333;6747.122874026345;6823.112995310578;6838.316168383122;6961.23426423093;6973.093497845349;1757.2914230624303;1822.83798041441;1919.8560107991957;1966.3511041356319;2014.0835919656522;1007.2043085962155;1067.8558394616782;1075.7525769073156;1118.3625333559792;1155.0066942429503;19172.616547668968;19532.609347812962;19629.50926226856;19759.209631614864;19993.700094498596;1024.0374048394485;1026.6150193677372;1043.7442826507554;1050.2648146297622;1124.6176300057855;11287.49206285719;11397.487113079931;11502.137339699557;11533;11551.075913926865;489854;491452;492681;492856;506749;82632;83752.58123709343;84489.15510844935;84836.57581712052;85263;1024.912882404989;1032.8708911386077;1040.625374865048;1060.4114716332356;1061.0291583201438;17390.73913891318;17543.210555524776;17623.823761762218;17831.554211144306;17841.46475605734;32883.34233315272;37426.84797872975;39727.00682482845;41167.588324116376;41359.586404136775;52229.7388513055;52243.73878130585;52287.21569176389;52511;52512;7505.66224519887;7831;8710.259627931444;8843.646254150019;8980.955095224483;13066.150700204456;13185.34073296312;13439.664008399477;13548.525801596898;13576;11992.400379980792;12008.579699710468;12070.27578345302;12244.204126732091;12258.141930065167;11078.446077696244;11575.942120289681;11764.882351176379;11860.76278474443;12036.097292702907;11914.285142891455;11940.70148246266;12275.570355037531;12393;12411.689707757378;8026.43814932949;8191.05802832658;8204.794880128045;8283.62723677448;8317.750467485985;10816.459177040959;11798.823017654913;11909.464074116513;12019.278843269432;12409.62771116868 11:43:47 INFO - PROCESS | 23342 | |3;mootools.html;1395.8045873577694;1599.8640115590174;1603.0702192728218;1791.8387345138935;1940.8156225158605;9166.220871225945;9662.227021838253;9681.806363872727;9963.701088967342;9966.302358834884;9640.180584650314;9864.062914023174;9868.06253405927;9876.111149996499;9887;2495.1641200197955;2530.709338237503;2531.898724051036;2533.265353047614;2536.061657186834;2417.9516409671796;2494.850308981458;2503.198976327576;2511.4098186926058;2516.924492265226;2462.507498500298;2482.6772519572432;2486.266551367342;2488.664030355906;2490.452100537888;2383.4994651123284;2388.080588973249;2395.7484464131276;2435.8538487690616;2453.58289090855;2354;2356.9864958068024;2358.9646155307682;2364.3498038039675;2456.828022038458;9525.714228573153;9681.806363872754;9687.660931867422;9764.072413120743;9765.169960553361;5880.353161152269;6022.277326720778;6026.457618814327;6032.336442991267;6033.426824451714;3677.8528858845616;3689.2805902848954;3705.888823335304;3707.073231692077;3797.050737315671;1042.8331466965326;1066.9745498701127;1078.5092782783815;1149.1036991146918;1173.8826117388278;14174.716505669932;14371.209583472904;14384.424623015067;14391.2084835334;14401.783973240304;4922.729249891218;4984.601231901439;5018.3476148101245;5050.0657378384385;5129.948700513021;10906.182036347305;10978;10986.505607247693;10987.835182472269;10992.340459572451;5655.3779084300695;5707.571932105108;5719.48524632785;5722.513586345207;5724.856878578069;4784.856454306307;4804.326761454624;4824.252240902666;5348.598855085884;5454.427285135003;4035.8183881725395;4037.6769858411258;4066.959330406658;4148.522919864194;4182.2890108681595;1137.2891942535914;1180.4451907603413;1182.355616189179;1185.612832985409;1191.862935762381;930.851063829784;972.9562169702381;1031.1493018259966;1047.471027131309;1078.9298695584919;6576.704048317837;6665.333466653296;6669.533132680763;6714.127163468718;6749.0551322814845;469.6266468157823;470.25464638548283;475.4603524999082;482.0383335246206;484.80365451992;4380.7371557706;4388.144311859221;4415.955840441618;4456.777161141995;4521.570450807168;12278.631641050604;12756.107072504836;12782.233066015882;12822.743545129046;12833.101682882108;12222.1444498886;12471.064670149775;12646.367681615882;12834.679133021562;12854.935725321313;9274.026227246177;9348.485833279236;9373.812523749486;9488.430694158234;9530;6633.502487313374;6664.067030615621;6692.130023097161;6785.355391237825;6793;11416.372099534274;11487.48306326234;11775.116866234895;11790.23363481371;11877.881221188023;11805.645830625095;11818.349990750592;11886.702832429259;12022.338771367658;12138.878611213775;7400.740974065882;7785.065792104983;7917.643706033357;7926.365890728844;8189.590520474072;9618.326717129734;9656.420614763138;9658.75853103678;9725;9732.902670973199;8345.54099524532;8385.58072096405;8410.285125764378;8419.663213471393;8567.057623661267;8165.305948994402;8334.708285209988;8354.373421993254;8373.49759014461;8498.065212826708;7889.960550197212;7917.881231781643;7983.1617680142745;7985.081715602548;7986.121526632182;5665.716714164193;5726.79956201531;5845.41545845412;5845.532357411312;5846.035404158436;5815.476607105381;5816.1857339973285;5874.089516125007;5907.852303692442;5979.282486101695 11:43:47 INFO - PROCESS | 23342 | |4;prototype.html;346.55986896641264;352.7372107779704;355.135245676777;360.6880048757824;360.83762306961876;5483.616146869721;5553.500184983351;5569.220309156722;5577.274954255946;5636.815199412329;5230.764615592298;5274.5780337573;5354.518093371596;5433.646812957165;5539.196816461611;4223.345381465878;4266.445362102922;4273.102648443831;4298.333758267474;4316.287812510932;4243.681723870706;4274.123804620061;4278.315469524877;4284.5715428457215;4305.375720520523;4003.9599604004025;4025.778582177979;4255.893602659928;4257.701960862741;4274.4229529013655;4184.958150418487;4202.516710578261;4203.47456567929;4213.9367909481225;4233.174530966463;3752.906177345561;3753.6434038766274;3796.7152463565067;3800.8859734208017;3806.695464362844;5073.568746656539;5217.191335343028;5236.947630523684;5267.28891599633;5277.788888444457;4843.854684359475;4846.442659094214;4917.434495033045;4921.114199444099;4937.629677774181;5641.323041235078;5649.23735295734;5669.659820410748;5718.34239062509;5726.713664316809;3947.98026009871;4162.687798415101;4169.687273454503;4182.769947652878;4241.766702831343;5837.182794408786;5902.822915312548;5921.200637913869;5955.553333499962;6001.459868611802;4204.831806727758;4210.85262015828;4214.662826973835;4224.51418086924;4232.365145228179;4144.933997077532;4267.957320426756;4272.209641216385;4280.72175308604;4293.3130699088;4810.470848206694;4817.253325734517;4863.367762190893;4875.488073752276;4894.241392584155;5718.971405142947;5727.828165154969;5747.511461525817;5752.798652047159;5763.308402991668;1393.3312010235145;1407.345584303304;1447.196805772806;1458.5332693537966;1466.332818567549;982.729749318943;1003.8003143715623;1007.7077647482148;1012.3976234140674;1014.761531040205;5513.8345849624575;5568.860778480571;5579.860503487364;5599.524040456607;5624.606277560613;5806.564507661942;5814.59297849155;5839.970800145972;5843.853903652358;5846.795362162304;5387.488188622075;5579.9163012554845;5582.358028826656;5589.4628977030825;5705.771769129188;3143.1984843864666;3149.7165255127147;3159;3167.5407065975305;3172.920676983094;6049.023267388329;6069;6105.572609917352;6109.541784366191;6134.355892631299;5806.506446951972;5928.673922934194;5929.555283353679;5992.730327135289;5995.220621319288;5904.940950590525;5970.507373156711;6019.548533859978;6034.155218269446;6038.879222415527;5629.240052593012;5855.707214639337;5869.647821130746;5883.499902508334;5913.5564832636865;5743.7989670363;5767.480926716616;5787.55311172207;5824.3593204748295;5837.307180917656;5872.564549738451;6032.90950635732;6094.847628809315;6104.053871649901;6118.694065296806;4176.895577610584;4189.979050104852;4222.345536441856;4238.749568877251;4243.936340954826;5930.733117009659;5953.732082056405;5977.402259773988;6002.459778619946;6020;5535.944640553543;5596.272484576979;5811;5820.214271073351;5855.853603659943;5713.457221563945;5714.485696287354;5720.399358067343;5746.683932383592;5788.160716696139;5557.777688892399;5585.273914391103;5680.32430433015;5707.373398581384;5722.113072473773;5802.390748971466;5820.341202757194;5823;5833.766649333979;5841.211436456024;5617;5640.32316122068;5665.376808550974;5676.77292908279;5720.313562372542 11:43:47 INFO - PROCESS | 23342 | |5;yui.html;793.2345286798242;794.805272708187;853.0658928473327;917.160797869949;922.5018490015392;15574.922125389372;17231;17250.0512471814;17264.82735172648;17273.654526909453;15688.76466852998;15813;15888.523344299689;15902.045877247374;15909.124998125099;727.1964479250419;874.54960695242;886.9600867960925;895.3419236860902;898.5372533145435;884.120300301198;887.077439462961;889.8264838356523;891.2558014058237;891.3537685178227;934.2245935873243;938.8638647396124;939.2626787971444;939.6147579492409;940.1068984464752;763.2825144364308;923.1553128887094;941.9717408477757;945.2390825385562;946.5693109635099;693.8022663540917;696.7770313499682;697.5431092634333;697.6755808549049;698.2947223304449;15678.294476748573;15682.902196846111;15728.842711572852;15758.527244182693;15768.211589420598;14615;15056.623584410368;15271.083734975826;15295.541133765893;15386.615334616612;11811.94094029533;11870.762584748343;12080.395980200954;13634.181949082988;14064.789028164585;4781.497942716;4796.664233503656;4801.111794318027;4812.855614331575;4940.4318503372215;76508;77012;77427;77613.61193194054;77636.61181694112;11791.88208117908;11952.521899123938;12035.939820301017;12036.338001409831;12532.310722910144;22061.227857024925;22063.33809985703;22087.33737987863;22147.557048859257;22183.1126754928;8629.987065963536;8659.13408659129;8703.129687031245;8708.259797917248;8815.823683526294;4925.113479573711;4942.579880710108;4956.752162391938;5044.268581055726;5068;3729.5151630287887;3787.8484860605818;3876.9030774230305;3881.437191607201;3882.941755873664;676.9593824370553;679.140886778226;683.064202043204;685.3660364163229;686.3479694290444;587.9088741245114;610.91141784441;680.9459573811451;716.4197000429668;730.7990302666702;9640.614375424904;9647.962214977331;9805.754856128511;9837.655682051094;9842.114209721016;610.1579819848581;630.165031333485;655.6459511863636;711.1892442615423;716.2228981555071;4534.909301813946;4569.383133277031;4592;4596.862094137181;4606.470255920545;109837.45081274543;110000;110079;110344.4482777581;111942;93297.53351233201;95387.52306238563;97055;97143.0285697148;101901.49049254706;57602;79655;87893;89059;89849.55075224713;8584.914150858662;8743.431676940978;8747.65009399617;8759.781005474913;8964.506952117696;38896;49406.50593494019;52814.47185528096;53132.734336328074;53757.73121134369;69004.65497672479;69140;75440;75712.62143689247;78647.60676196583;10389.740256493647;10548.578056877946;10611.491960613237;10812.837807432737;11005.834912476159;11599.710007249887;11919.46362413676;11961.521539138337;11974.58088966882;12042;11491.195616306779;11524.366159861289;11675.708107297385;11701.76596468083;12100.910918017069;12721.55474558423;12723.80914286305;12813.487460501476;13074.084814062924;13406.597802065953;12530.624081277576;12531.812022819848;12896.935515322364;12968.157069790434;13139.934300328438;10286.434246116536;10412.375257484575;10747;10812.080973117374;10832.945835270773;10664.466776661291;10673.46632668348;10768.838467422838;10916.454177290945;10926.672199834018 11:43:47 INFO - PROCESS | 23342 | __end_tp_report 11:43:47 INFO - PROCESS | 23342 | __start_cc_report 11:43:47 INFO - PROCESS | 23342 | _x_x_mozilla_cycle_collect,988 11:43:47 INFO - PROCESS | 23342 | __end_cc_report 11:43:47 INFO - PROCESS | 23342 | __startTimestamp1470077027639__endTimestamp 11:43:47 INFO - PROCESS | 23342 | 11:43:47 INFO - PROCESS | 23342 | ------- Summary: start ------- 11:43:47 INFO - PROCESS | 23342 | Number of tests: 6 11:43:47 INFO - PROCESS | 23342 | 11:43:47 INFO - PROCESS | 23342 | [#0] dojo.html Cycles:165 Average:5703.36 Median:5955.46 stddev:652.56 (11.0%) stddev-sans-first:629.37 11:43:47 INFO - PROCESS | 23342 | Values: 3414.4 3417.6 3427.0 3461.3 3480.3 5676.5 5701.7 5741.0 5742.0 5751.5 5692.1 5698.2 5753.9 5755.4 5761.9 5041.0 5136.9 5142.2 5188.8 5206.9 5093.2 5099.1 5110.4 5118.3 5171.8 5166.9 5225.3 5225.8 5235.0 5261.4 4983.2 5153.7 5173.0 5228.2 5235.3 5020.6 5038.6 5049.7 5076.8 5083.9 5570.4 5616.0 5628.4 5647.0 5659.7 6014.8 6039.8 6089.2 6096.5 6123.4 6101.1 6138.5 6148.3 6162.0 6166.5 5770.2 5790.8 5799.5 5803.8 5804.4 6134.3 6161.5 6176.8 6210.1 6276.8 6063.2 6067.1 6069.0 6071.6 6072.8 6123.6 6124.1 6126.0 6129.3 6131.8 5955.5 6080.9 6128.9 6130.5 6135.1 6176.6 6204.0 6207.8 6211.1 6215.8 4681.6 4683.4 4686.0 4703.7 4725.9 4101.1 4129.9 4161.9 4174.9 4196.0 5964.3 5967.3 5974.3 5980.1 5983.1 6102.8 6195.1 6251.9 6260.5 6268.0 5844.4 5879.0 5904.1 5951.9 5952.9 5305.1 5305.7 5320.6 5324.1 5324.8 6211.1 6214.1 6463.0 6471.5 6479.7 6118.2 6171.3 6178.4 6178.8 6179.3 6377.9 6385.4 6391.3 6392.3 6393.8 5953.6 6046.9 6058.2 6058.3 6067.0 6191.8 6237.1 6245.8 6250.0 6251.4 6042.1 6078.5 6101.8 6101.9 6107.5 5798.0 5959.9 5985.5 5989.5 6039.8 5918.3 5919.2 5920.0 5932.1 5943.0 6068.2 6071.7 6088.2 6105.8 6109.7 5781.9 5795.2 5804.0 5812.2 5815.3 11:43:47 INFO - PROCESS | 23342 | 11:43:47 INFO - PROCESS | 23342 | [#1] ext.html Cycles:180 Average:52072.51 Median:39043.91 stddev:90622.21 (232.1%) stddev-sans-first:90794.03 11:43:47 INFO - PROCESS | 23342 | Values: 603.8 654.3 657.0 666.6 685.7 32904.7 46057.0 47191.3 47301.8 47307.8 49250.8 49453.0 49765.8 50010.0 50153.7 8296.2 9061.8 9255.6 10789.5 11024.8 10815.9 10915.5 10928.4 10933.8 10938.8 10992.6 11058.2 11100.7 11109.1 11112.1 10966.0 10993.9 11025.8 11028.6 11030.7 11084.8 11121.1 11128.8 11151.2 11162.8 44862.0 45128.0 45137.5 45234.1 45437.3 3988.9 4144.3 4471.2 4601.0 4615.4 34253.7 34588.5 35041.5 35918.1 36297.1 4833.5 4839.4 4866.2 4888.3 4916.7 370297.0 375327.0 375995.0 379444.0 380521.0 38365.8 65306.3 65371.3 65659.7 65921.0 39113.6 41854.4 41880.8 41908.6 41920.6 15769.3 17099.7 17218.2 17225.1 17232.6 14238.4 14519.2 14546.6 14848.8 14865.9 9299.8 9368.8 9375.8 9396.2 9448.3 3525.9 3538.4 3566.4 3586.2 3602.4 1061.5 1065.4 1093.4 1135.0 1201.4 32227.7 33600.2 34659.1 34871.0 35133.5 1131.1 1156.6 1175.6 1184.8 1277.7 17549.8 18051.5 18139.2 18180.5 18208.9 164120.0 164773.0 165692.0 166031.0 166114.0 64079.4 64954.7 65206.3 65358.3 65411.0 1349.5 1432.3 1464.5 1475.6 1486.2 33664.7 33907.6 34688.3 34903.5 35192.3 54241.0 54697.0 54871.2 54891.2 54931.7 427792.0 428466.0 429241.0 429895.0 430663.0 27546.7 49633.5 49636.8 50635.0 53869.5 50280.2 52224.0 54152.7 55614.4 55978.4 45702.0 46261.3 46709.5 46923.5 47866.0 44975.9 45788.0 45999.5 46156.8 47226.0 45422.1 46117.5 46251.5 46385.5 46548.8 38974.2 40693.6 41355.4 41480.4 41644.0 29940.7 29979.9 30114.4 30342.2 30614.5 11:43:47 INFO - PROCESS | 23342 | 11:43:47 INFO - PROCESS | 23342 | [#2] jquery.html Cycles:180 Average:29082.59 Median:24063.20 stddev:81241.27 (337.6%) stddev-sans-first:81440.65 11:43:47 INFO - PROCESS | 23342 | Values: 409.8 416.9 424.5 431.4 432.1 18303.4 19835.8 19866.6 20093.6 20434.1 19632.2 20411.0 20452.2 21224.3 21253.3 5580.5 5786.7 5834.7 5834.9 5835.7 4155.5 4225.7 5686.7 5724.1 6359.6 6482.6 6494.9 6517.2 6519.0 6527.2 6380.1 6382.6 6392.8 6393.3 6397.9 3853.6 5403.4 5619.9 5685.6 5766.3 23978.4 24148.0 24311.3 24319.1 24410.1 2630.1 2658.5 2678.6 3005.5 3078.4 14515.7 14803.0 14839.9 14971.7 15359.2 1787.7 1947.4 2047.0 2055.1 2110.8 79446.0 80282.0 80947.0 81464.2 81898.6 10583.6 10702.7 10971.4 11140.9 11188.3 15520.8 15608.9 15614.2 15626.1 15641.2 8360.6 8837.1 8906.6 8949.2 9083.1 8649.8 8844.7 8894.0 8897.6 8960.1 6747.1 6823.1 6838.3 6961.2 6973.1 1757.3 1822.8 1919.9 1966.4 2014.1 1007.2 1067.9 1075.8 1118.4 1155.0 19172.6 19532.6 19629.5 19759.2 19993.7 1024.0 1026.6 1043.7 1050.3 1124.6 11287.5 11397.5 11502.1 11533.0 11551.1 489854.0 491452.0 492681.0 492856.0 506749.0 82632.0 83752.6 84489.2 84836.6 85263.0 1024.9 1032.9 1040.6 1060.4 1061.0 17390.7 17543.2 17623.8 17831.6 17841.5 32883.3 37426.8 39727.0 41167.6 41359.6 52229.7 52243.7 52287.2 52511.0 52512.0 7505.7 7831.0 8710.3 8843.6 8981.0 13066.2 13185.3 13439.7 13548.5 13576.0 11992.4 12008.6 12070.3 12244.2 12258.1 11078.4 11575.9 11764.9 11860.8 12036.1 11914.3 11940.7 12275.6 12393.0 12411.7 8026.4 8191.1 8204.8 8283.6 8317.8 10816.5 11798.8 11909.5 12019.3 12409.6 11:43:47 INFO - PROCESS | 23342 | 11:43:47 INFO - PROCESS | 23342 | [#3] mootools.html Cycles:180 Average:6440.30 Median:2630.16 stddev:3839.37 (146.0%) stddev-sans-first:3831.43 11:43:47 INFO - PROCESS | 23342 | Values: 1395.8 1599.9 1603.1 1791.8 1940.8 9166.2 9662.2 9681.8 9963.7 9966.3 9640.2 9864.1 9868.1 9876.1 9887.0 2495.2 2530.7 2531.9 2533.3 2536.1 2418.0 2494.9 2503.2 2511.4 2516.9 2462.5 2482.7 2486.3 2488.7 2490.5 2383.5 2388.1 2395.7 2435.9 2453.6 2354.0 2357.0 2359.0 2364.3 2456.8 9525.7 9681.8 9687.7 9764.1 9765.2 5880.4 6022.3 6026.5 6032.3 6033.4 3677.9 3689.3 3705.9 3707.1 3797.1 1042.8 1067.0 1078.5 1149.1 1173.9 14174.7 14371.2 14384.4 14391.2 14401.8 4922.7 4984.6 5018.3 5050.1 5129.9 10906.2 10978.0 10986.5 10987.8 10992.3 5655.4 5707.6 5719.5 5722.5 5724.9 4784.9 4804.3 4824.3 5348.6 5454.4 4035.8 4037.7 4067.0 4148.5 4182.3 1137.3 1180.4 1182.4 1185.6 1191.9 930.9 973.0 1031.1 1047.5 1078.9 6576.7 6665.3 6669.5 6714.1 6749.1 469.6 470.3 475.5 482.0 484.8 4380.7 4388.1 4416.0 4456.8 4521.6 12278.6 12756.1 12782.2 12822.7 12833.1 12222.1 12471.1 12646.4 12834.7 12854.9 9274.0 9348.5 9373.8 9488.4 9530.0 6633.5 6664.1 6692.1 6785.4 6793.0 11416.4 11487.5 11775.1 11790.2 11877.9 11805.6 11818.3 11886.7 12022.3 12138.9 7400.7 7785.1 7917.6 7926.4 8189.6 9618.3 9656.4 9658.8 9725.0 9732.9 8345.5 8385.6 8410.3 8419.7 8567.1 8165.3 8334.7 8354.4 8373.5 8498.1 7890.0 7917.9 7983.2 7985.1 7986.1 5665.7 5726.8 5845.4 5845.5 5846.0 5815.5 5816.2 5874.1 5907.9 5979.3 11:43:47 INFO - PROCESS | 23342 | 11:43:47 INFO - PROCESS | 23342 | [#4] prototype.html Cycles:180 Average:4832.17 Median:5569.04 stddev:1417.24 (25.4%) stddev-sans-first:1380.64 11:43:47 INFO - PROCESS | 23342 | Values: 346.6 352.7 355.1 360.7 360.8 5483.6 5553.5 5569.2 5577.3 5636.8 5230.8 5274.6 5354.5 5433.6 5539.2 4223.3 4266.4 4273.1 4298.3 4316.3 4243.7 4274.1 4278.3 4284.6 4305.4 4004.0 4025.8 4255.9 4257.7 4274.4 4185.0 4202.5 4203.5 4213.9 4233.2 3752.9 3753.6 3796.7 3800.9 3806.7 5073.6 5217.2 5236.9 5267.3 5277.8 4843.9 4846.4 4917.4 4921.1 4937.6 5641.3 5649.2 5669.7 5718.3 5726.7 3948.0 4162.7 4169.7 4182.8 4241.8 5837.2 5902.8 5921.2 5955.6 6001.5 4204.8 4210.9 4214.7 4224.5 4232.4 4144.9 4268.0 4272.2 4280.7 4293.3 4810.5 4817.3 4863.4 4875.5 4894.2 5719.0 5727.8 5747.5 5752.8 5763.3 1393.3 1407.3 1447.2 1458.5 1466.3 982.7 1003.8 1007.7 1012.4 1014.8 5513.8 5568.9 5579.9 5599.5 5624.6 5806.6 5814.6 5840.0 5843.9 5846.8 5387.5 5579.9 5582.4 5589.5 5705.8 3143.2 3149.7 3159.0 3167.5 3172.9 6049.0 6069.0 6105.6 6109.5 6134.4 5806.5 5928.7 5929.6 5992.7 5995.2 5904.9 5970.5 6019.5 6034.2 6038.9 5629.2 5855.7 5869.6 5883.5 5913.6 5743.8 5767.5 5787.6 5824.4 5837.3 5872.6 6032.9 6094.8 6104.1 6118.7 4176.9 4190.0 4222.3 4238.7 4243.9 5930.7 5953.7 5977.4 6002.5 6020.0 5535.9 5596.3 5811.0 5820.2 5855.9 5713.5 5714.5 5720.4 5746.7 5788.2 5557.8 5585.3 5680.3 5707.4 5722.1 5802.4 5820.3 5823.0 5833.8 5841.2 5617.0 5640.3 5665.4 5676.8 5720.3 11:43:47 INFO - PROCESS | 23342 | 11:43:47 INFO - PROCESS | 23342 | [#5] yui.html Cycles:180 Average:20365.43 Median:4868.98 stddev:29112.92 (597.9%) stddev-sans-first:29157.50 11:43:47 INFO - PROCESS | 23342 | Values: 793.2 794.8 853.1 917.2 922.5 15574.9 17231.0 17250.1 17264.8 17273.7 15688.8 15813.0 15888.5 15902.0 15909.1 727.2 874.5 887.0 895.3 898.5 884.1 887.1 889.8 891.3 891.4 934.2 938.9 939.3 939.6 940.1 763.3 923.2 942.0 945.2 946.6 693.8 696.8 697.5 697.7 698.3 15678.3 15682.9 15728.8 15758.5 15768.2 14615.0 15056.6 15271.1 15295.5 15386.6 11811.9 11870.8 12080.4 13634.2 14064.8 4781.5 4796.7 4801.1 4812.9 4940.4 76508.0 77012.0 77427.0 77613.6 77636.6 11791.9 11952.5 12035.9 12036.3 12532.3 22061.2 22063.3 22087.3 22147.6 22183.1 8630.0 8659.1 8703.1 8708.3 8815.8 4925.1 4942.6 4956.8 5044.3 5068.0 3729.5 3787.8 3876.9 3881.4 3882.9 677.0 679.1 683.1 685.4 686.3 587.9 610.9 680.9 716.4 730.8 9640.6 9648.0 9805.8 9837.7 9842.1 610.2 630.2 655.6 711.2 716.2 4534.9 4569.4 4592.0 4596.9 4606.5 109837.5 110000.0 110079.0 110344.4 111942.0 93297.5 95387.5 97055.0 97143.0 101901.5 57602.0 79655.0 87893.0 89059.0 89849.6 8584.9 8743.4 8747.7 8759.8 8964.5 38896.0 49406.5 52814.5 53132.7 53757.7 69004.7 69140.0 75440.0 75712.6 78647.6 10389.7 10548.6 10611.5 10812.8 11005.8 11599.7 11919.5 11961.5 11974.6 12042.0 11491.2 11524.4 11675.7 11701.8 12100.9 12721.6 12723.8 12813.5 13074.1 13406.6 12530.6 12531.8 12896.9 12968.2 13139.9 10286.4 10412.4 10747.0 10812.1 10832.9 10664.5 10673.5 10768.8 10916.5 10926.7 11:43:47 INFO - PROCESS | 23342 | -------- Summary: end -------- 11:43:47 INFO - PROCESS | 23342 | 11:43:48 INFO - TEST-INFO | 23342: exit 0 11:43:48 INFO - TEST-OK | dromaeo_css | took 1113691ms 11:43:48 INFO - TEST-START | kraken 11:43:48 INFO - operating with platform_type : linux_ 11:43:48 INFO - Initialising browser for kraken test... 11:43:48 INFO - TEST-INFO | started process 23536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBTXQfb/profile http://localhost:35988/getInfo.html) 11:43:52 INFO - PROCESS | 23536 | __metrics Screen width/height:1600/1200 11:43:52 INFO - PROCESS | 23536 | colorDepth:24 11:43:52 INFO - PROCESS | 23536 | Browser inner width/height: 1024/697 11:43:52 INFO - PROCESS | 23536 | __metrics 11:43:54 INFO - PROCESS | 23536 | 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:54 ERROR - PROCESS | 23536 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:43:54 INFO - TEST-INFO | 23536: exit 0 11:43:54 INFO - Browser initialized. 11:43:54 INFO - Running cycle 1/1 for kraken test... 11:43:54 INFO - TEST-INFO | started process 23627 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBTXQfb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:06 INFO - PROCESS | 23627 | RSS: Main: 144814080 11:44:06 INFO - PROCESS | 23627 | 11:44:09 INFO - PROCESS | 23627 | Cycle 1(1): loaded http://localhost:35988/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35988/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:10 INFO - PROCESS | 23627 | RSS: Main: 195481600 11:44:10 INFO - PROCESS | 23627 | 11:44:12 INFO - PROCESS | 23627 | Cycle 1(1): loaded http://localhost:35988/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35988/tests/kraken/driver.html?testName=audio-dft) 11:44:13 INFO - PROCESS | 23627 | RSS: Main: 194314240 11:44:13 INFO - PROCESS | 23627 | 11:44:16 INFO - PROCESS | 23627 | Cycle 1(1): loaded http://localhost:35988/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35988/tests/kraken/driver.html?testName=audio-fft) 11:44:16 INFO - PROCESS | 23627 | RSS: Main: 280625152 11:44:16 INFO - PROCESS | 23627 | 11:44:18 INFO - PROCESS | 23627 | Cycle 1(1): loaded http://localhost:35988/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35988/tests/kraken/driver.html?testName=audio-oscillator) 11:44:19 INFO - PROCESS | 23627 | RSS: Main: 189865984 11:44:19 INFO - PROCESS | 23627 | 11:44:21 INFO - PROCESS | 23627 | Cycle 1(1): loaded http://localhost:35988/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35988/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:22 INFO - PROCESS | 23627 | RSS: Main: 189415424 11:44:22 INFO - PROCESS | 23627 | 11:44:25 INFO - PROCESS | 23627 | Cycle 1(1): loaded http://localhost:35988/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35988/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:25 INFO - PROCESS | 23627 | RSS: Main: 224038912 11:44:25 INFO - PROCESS | 23627 | 11:44:29 INFO - PROCESS | 23627 | Cycle 1(1): loaded http://localhost:35988/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35988/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:29 INFO - PROCESS | 23627 | RSS: Main: 224927744 11:44:29 INFO - PROCESS | 23627 | 11:44:32 INFO - PROCESS | 23627 | Cycle 1(1): loaded http://localhost:35988/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35988/tests/kraken/driver.html?testName=json-parse-financial) 11:44:33 INFO - PROCESS | 23627 | RSS: Main: 224002048 11:44:33 INFO - PROCESS | 23627 | 11:44:34 INFO - PROCESS | 23627 | Cycle 1(1): loaded http://localhost:35988/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35988/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:35 INFO - PROCESS | 23627 | RSS: Main: 203599872 11:44:35 INFO - PROCESS | 23627 | 11:44:36 INFO - PROCESS | 23627 | Cycle 1(1): loaded http://localhost:35988/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35988/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:44:37 INFO - PROCESS | 23627 | RSS: Main: 202452992 11:44:37 INFO - PROCESS | 23627 | 11:44:39 INFO - PROCESS | 23627 | Cycle 1(1): loaded http://localhost:35988/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35988/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:44:40 INFO - PROCESS | 23627 | RSS: Main: 207282176 11:44:40 INFO - PROCESS | 23627 | 11:44:42 INFO - PROCESS | 23627 | Cycle 1(1): loaded http://localhost:35988/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35988/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:44:43 INFO - PROCESS | 23627 | RSS: Main: 211533824 11:44:43 INFO - PROCESS | 23627 | 11:44:45 INFO - PROCESS | 23627 | Cycle 1(1): loaded http://localhost:35988/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35988/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:44:46 INFO - PROCESS | 23627 | RSS: Main: 211587072 11:44:46 INFO - PROCESS | 23627 | 11:44:48 INFO - PROCESS | 23627 | Cycle 1(1): loaded http://localhost:35988/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35988/tests/kraken/driver.html?testName=ai-astar) 11:44:48 INFO - PROCESS | 23627 | RSS: Main: 253816832 11:44:48 INFO - PROCESS | 23627 | 11:44:48 INFO - PROCESS | 23627 | __start_tp_report 11:44:48 INFO - PROCESS | 23627 | _x_x_mozilla_page_load 11:44:48 INFO - PROCESS | 23627 | _x_x_mozilla_page_load_details 11:44:48 INFO - PROCESS | 23627 | |i|pagename|runs| 11:44:48 INFO - PROCESS | 23627 | |0;ai-astar;111;103;110;108;111;108;108;111;109;109 11:44:48 INFO - PROCESS | 23627 | |1;audio-beat-detection;153;123;123;181;122;135;123;151;170;124 11:44:48 INFO - PROCESS | 23627 | |2;audio-dft;160;162;160;161;162;161;162;161;160;161 11:44:48 INFO - PROCESS | 23627 | |3;audio-fft;74;74;75;111;75;77;74;76;121;75 11:44:48 INFO - PROCESS | 23627 | |4;audio-oscillator;84;83;108;84;83;84;127;84;84;136 11:44:48 INFO - PROCESS | 23627 | |5;imaging-gaussian-blur;116;116;116;116;116;117;117;116;117;117 11:44:48 INFO - PROCESS | 23627 | |6;imaging-darkroom;146;146;145;145;146;145;146;146;146;145 11:44:48 INFO - PROCESS | 23627 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 11:44:48 INFO - PROCESS | 23627 | |8;json-parse-financial;50;52;53;53;52;53;55;53;52;52 11:44:48 INFO - PROCESS | 23627 | |9;json-stringify-tinderbox;59;60;60;60;61;60;60;60;60;60 11:44:48 INFO - PROCESS | 23627 | |10;stanford-crypto-aes;76;76;75;82;78;77;77;81;117;77 11:44:48 INFO - PROCESS | 23627 | |11;stanford-crypto-ccm;117;130;117;128;116;122;127;116;137;122 11:44:48 INFO - PROCESS | 23627 | |12;stanford-crypto-pbkdf2;153;157;153;159;158;156;157;154;156;153 11:44:48 INFO - PROCESS | 23627 | |13;stanford-crypto-sha256-iterative;61;62;61;61;61;67;60;63;61;59 11:44:48 INFO - PROCESS | 23627 | __end_tp_report 11:44:48 INFO - PROCESS | 23627 | __start_cc_report 11:44:48 INFO - PROCESS | 23627 | _x_x_mozilla_cycle_collect,1570 11:44:48 INFO - PROCESS | 23627 | __end_cc_report 11:44:48 INFO - PROCESS | 23627 | __startTimestamp1470077088306__endTimestamp 11:44:48 INFO - PROCESS | 23627 | 11:44:48 INFO - PROCESS | 23627 | ------- Summary: start ------- 11:44:48 INFO - PROCESS | 23627 | Number of tests: 14 11:44:48 INFO - PROCESS | 23627 | 11:44:48 INFO - PROCESS | 23627 | [#0] ai-astar Cycles:10 Average:108.80 Median:109.50 stddev:2.39 (2.2%) stddev-sans-first:2.40 11:44:48 INFO - PROCESS | 23627 | Values: 111.0 103.0 110.0 108.0 111.0 108.0 108.0 111.0 109.0 109.0 11:44:48 INFO - PROCESS | 23627 | 11:44:48 INFO - PROCESS | 23627 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:143.00 stddev:21.96 (15.4%) stddev-sans-first:22.82 11:44:48 INFO - PROCESS | 23627 | Values: 153.0 123.0 123.0 181.0 122.0 135.0 123.0 151.0 170.0 124.0 11:44:48 INFO - PROCESS | 23627 | 11:44:48 INFO - PROCESS | 23627 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 11:44:48 INFO - PROCESS | 23627 | Values: 160.0 162.0 160.0 161.0 162.0 161.0 162.0 161.0 160.0 161.0 11:44:48 INFO - PROCESS | 23627 | 11:44:48 INFO - PROCESS | 23627 | [#3] audio-fft Cycles:10 Average:83.20 Median:75.00 stddev:17.47 (23.3%) stddev-sans-first:18.21 11:44:48 INFO - PROCESS | 23627 | Values: 74.0 74.0 75.0 111.0 75.0 77.0 74.0 76.0 121.0 75.0 11:44:48 INFO - PROCESS | 23627 | 11:44:48 INFO - PROCESS | 23627 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:84.00 stddev:20.45 (24.3%) stddev-sans-first:21.24 11:44:48 INFO - PROCESS | 23627 | Values: 84.0 83.0 108.0 84.0 83.0 84.0 127.0 84.0 84.0 136.0 11:44:48 INFO - PROCESS | 23627 | 11:44:48 INFO - PROCESS | 23627 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:44:48 INFO - PROCESS | 23627 | Values: 116.0 116.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 11:44:48 INFO - PROCESS | 23627 | 11:44:48 INFO - PROCESS | 23627 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:44:48 INFO - PROCESS | 23627 | Values: 146.0 146.0 145.0 145.0 146.0 145.0 146.0 146.0 146.0 145.0 11:44:48 INFO - PROCESS | 23627 | 11:44:48 INFO - PROCESS | 23627 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:44:48 INFO - PROCESS | 23627 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 11:44:48 INFO - PROCESS | 23627 | 11:44:48 INFO - PROCESS | 23627 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:53.00 stddev:1.27 (2.4%) stddev-sans-first:0.97 11:44:48 INFO - PROCESS | 23627 | Values: 50.0 52.0 53.0 53.0 52.0 53.0 55.0 53.0 52.0 52.0 11:44:48 INFO - PROCESS | 23627 | 11:44:48 INFO - PROCESS | 23627 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.47 (0.8%) stddev-sans-first:0.33 11:44:48 INFO - PROCESS | 23627 | Values: 59.0 60.0 60.0 60.0 61.0 60.0 60.0 60.0 60.0 60.0 11:44:48 INFO - PROCESS | 23627 | 11:44:48 INFO - PROCESS | 23627 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:77.00 stddev:12.63 (16.4%) stddev-sans-first:13.24 11:44:48 INFO - PROCESS | 23627 | Values: 76.0 76.0 75.0 82.0 78.0 77.0 77.0 81.0 117.0 77.0 11:44:48 INFO - PROCESS | 23627 | 11:44:48 INFO - PROCESS | 23627 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:124.50 stddev:7.13 (5.7%) stddev-sans-first:7.20 11:44:48 INFO - PROCESS | 23627 | Values: 117.0 130.0 117.0 128.0 116.0 122.0 127.0 116.0 137.0 122.0 11:44:48 INFO - PROCESS | 23627 | 11:44:48 INFO - PROCESS | 23627 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.60 Median:156.50 stddev:2.22 (1.4%) stddev-sans-first:2.15 11:44:48 INFO - PROCESS | 23627 | Values: 153.0 157.0 153.0 159.0 158.0 156.0 157.0 154.0 156.0 153.0 11:44:48 INFO - PROCESS | 23627 | 11:44:48 INFO - PROCESS | 23627 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.60 Median:61.00 stddev:2.17 (3.6%) stddev-sans-first:2.29 11:44:48 INFO - PROCESS | 23627 | Values: 61.0 62.0 61.0 61.0 61.0 67.0 60.0 63.0 61.0 59.0 11:44:48 INFO - PROCESS | 23627 | -------- Summary: end -------- 11:44:48 INFO - PROCESS | 23627 | 11:44:49 INFO - TEST-INFO | 23627: exit 0 11:44:49 INFO - TEST-OK | kraken | took 60912ms 11:44:49 INFO - SUITE-END | took 1174s 11:44:49 INFO - Completed test suite (00:19:34) 11:44:49 INFO - javascript benchmark 11:44:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3414.4195486767253, 3417.606975197852, 3427.0061682112205, 3461.2558299965503, 3480.286541259042, 5676.489115979566, 5701.714914254291, 5741.0, 5742.0, 5751.539876809856, 5692.117721753135, 5698.230738850254, 5753.913691294634, 5755.4244575542525, 5761.9135712964335, 5040.97479512602, 5136.948630513684, 5142.202958541432, 5188.766505507261, 5206.947930520703, 5093.185090385539, 5099.107656160176, 5110.437851836314, 5118.283440318359, 5171.818986335479, 5166.870828229286, 5225.294585231002, 5225.764840582183, 5235.0, 5261.39493958194, 4983.202687570008, 5153.716545589991, 5172.9741351293005, 5228.215767634866, 5235.345581802256, 5020.59835213182, 5038.571721403685, 5049.697018178921, 5076.771545280471, 5083.949160508385, 5570.41510641385, 5615.971920140373, 5628.380878103405, 5646.971765141189, 5659.745311460994, 6014.75940962361, 6039.818805435844, 6089.249836725939, 6096.513138175633, 6123.387661233841, 6101.0848372744, 6138.47822935051, 6148.292946311187, 6161.969190154021, 6166.506679465632, 5770.2498675171955, 5790.826275211751, 5799.478046975751, 5803.767849286023, 5804.419558044162, 6134.252905685651, 6161.537884658579, 6176.7838125666285, 6210.099535567318, 6276.780312689034, 6063.151158837766, 6067.059605761114, 6069.0, 6071.574989750675, 6072.757089716361, 6123.648682309606, 6124.11200375943, 6125.9693701531205, 6129.267100814801, 6131.837503309146, 5955.464008239279, 6080.90878636812, 6128.877422451526, 6130.493792663006, 6135.07973803933, 6176.567640265228, 6204.0, 6207.81376558704, 6211.09939058834, 6215.844603884849, 4681.578657920803, 4683.437987441529, 4685.99251161002, 4703.717776933395, 4725.929111063337, 4101.118259574147, 4129.938050929239, 4161.875143745692, 4174.874753757392, 4196.0, 5964.31410387811, 5967.313758917693, 5974.2830860297045, 5980.102984552265, 5983.102534619842, 6102.7558897644485, 6195.070739389128, 6251.874962500725, 6260.499160067184, 6268.028455589391, 5844.415558444121, 5878.970605146947, 5904.140195838298, 5951.851203719942, 5952.8809423812145, 5305.098133317345, 5305.708186049727, 5320.600954928396, 5324.094903866352, 5324.8136315228785, 6211.09939058843, 6214.067889816563, 6462.967685161544, 6471.482281417475, 6479.708413121421, 6118.235220597426, 6171.321154672893, 6178.351273116258, 6178.783742568989, 6179.28938172098, 6377.8724425512155, 6385.361463853577, 6391.32891046452, 6392.296847346881, 6393.840153996001, 5953.642781433128, 6046.90929636047, 6058.212432383762, 6058.3335833057445, 6066.968615335315, 6191.845203869759, 6237.12680224778, 6245.781397651061, 6250.0, 6251.4061164189325, 6042.063480160582, 6078.45293923549, 6101.84745381369, 6101.877962440815, 6107.541934354852, 5797.971010144923, 5959.880802384015, 5985.521158307238, 5989.460948514655, 6039.758409663565, 5918.2898052234, 5919.171316015675, 5920.0, 5932.139839723302, 5943.0, 6068.180795592539, 6071.726772295346, 6088.178095956989, 6105.755769769159, 6109.69451527413, 5781.94218057814, 5795.159701843293, 5804.0, 5812.18629391877, 5815.273090863642], "value": 5659.768389597435, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.7675494934451, 654.3423859021683, 657.0013579359373, 666.6333516565887, 685.7257097161137, 32904.67095329046, 46057.0, 47191.29213061803, 47301.76349118258, 47307.76346118273, 49250.75374623122, 49453.0, 49765.751171244185, 50010.0, 50153.74923125388, 8296.170382961716, 9061.818763624724, 9255.583498742573, 10789.514471848746, 11024.779504409908, 10815.891841081568, 10915.508802103925, 10928.398938058404, 10933.781324373507, 10938.781224375507, 10992.615258465956, 11058.170637202202, 11100.666979990572, 11109.055730262937, 11112.055475284611, 10966.0, 10993.945030274877, 11025.779484410266, 11028.613998510014, 11030.669079927615, 11084.833727494093, 11121.110311175087, 11128.833067503994, 11151.219414640978, 11162.776744465147, 44862.0, 45128.0, 45137.54862451366, 45234.09531809345, 45437.318440223426, 3988.9202215955806, 4144.274751918402, 4471.150481408522, 4601.0, 4615.446146462446, 34253.657463425545, 34588.48117278243, 35041.474377884355, 35918.10204744876, 36297.09257268563, 4833.468318484964, 4839.395075615548, 4866.197077482211, 4888.266759985995, 4916.680415772963, 370297.0, 375327.0, 375995.0, 379443.99999999726, 380521.0, 38365.80817095897, 65306.346936530026, 65371.346286537475, 65659.67170164119, 65921.0, 39113.60886391156, 41854.37218441726, 41880.79059604743, 41908.58091419108, 41920.580794191665, 15769.29038193284, 17099.74350384745, 17218.225179866935, 17225.1387430628, 17232.569185770455, 14238.359273832702, 14519.201443920685, 14546.563603091925, 14848.777268340984, 14865.851341486446, 9299.814003720023, 9368.812623747486, 9375.812483750424, 9396.248300136109, 9448.291378146667, 3525.9118522037156, 3538.363094642989, 3566.3937130687327, 3586.2110335726097, 3602.441621548664, 1061.5117046158853, 1065.3714308557987, 1093.4040947683532, 1134.9943250283695, 1201.381288636353, 32227.677723222467, 33600.159995999806, 34659.13352166166, 34871.0, 35133.47299790505, 1131.1290306463977, 1156.5720683347047, 1175.6061719323952, 1184.8163534652142, 1277.7061275906594, 17549.824501755076, 18051.548711282325, 18139.18373673188, 18180.45458636243, 18208.90895545514, 164120.0, 164773.0, 165692.0, 166031.0, 166114.0, 64079.35920640827, 64954.67522662356, 65206.347936520026, 65358.34641653618, 65411.0, 1349.4534713441071, 1432.2910159471128, 1464.4727897956727, 1475.6015875713713, 1486.2271618758184, 33664.66335336615, 33907.64785052711, 34688.306233875686, 34903.476447852794, 35192.29615407729, 54241.0, 54697.0, 54871.176932345246, 54891.17663234975, 54931.725341373036, 427792.0, 428466.0, 429241.0, 429895.0, 430663.0, 27546.724532754415, 49633.50366496289, 49636.751816240685, 50635.0, 53869.46130538801, 50280.24579631235, 52224.0, 54152.72923635514, 55614.443855562546, 55978.44021559895, 45702.0, 46261.30608040815, 46709.532904670516, 46923.530764693285, 47866.0, 44975.861569721244, 45788.0, 45999.540004600865, 46156.769216153705, 47226.0, 45422.09155816799, 46117.53882461267, 46251.53748462607, 46385.536144639475, 46548.767256163504, 38974.220515590096, 40693.593064068984, 41355.379669305585, 41480.37779433371, 41644.04462321928, 29940.70059299466, 29979.850100749358, 30114.397712045196, 30342.241443963194, 30614.540781887845], "value": 20496.21131571159, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.82787229363663, 416.91870085333335, 424.5414951852, 431.43482038529527, 432.0990734318945, 18303.3593824216, 19835.801641983577, 19866.602667946634, 20093.598128037447, 20434.08046637901, 19632.214711411525, 20411.0, 20452.181912723474, 21224.257150999718, 21253.25613603524, 5580.497755202041, 5786.68173250471, 5834.6790926499025, 5834.912476312858, 5835.708214589275, 4155.522114956773, 4225.746455212697, 5686.744096515667, 5724.112762521795, 6359.586626869239, 6482.6434546099945, 6494.935050649504, 6517.152770139875, 6519.0, 6527.249366322886, 6380.0748891410485, 6382.617042977413, 6392.840178995516, 6393.264774550939, 6397.904031439532, 3853.6339047790416, 5403.432639572828, 5619.915701264485, 5685.630434021817, 5766.279215098113, 23978.400539986465, 24148.0, 24311.27066188017, 24319.14882979105, 24410.14564490252, 2630.053180854891, 2658.5214661360947, 2678.6116013178175, 3005.5341422079396, 3078.415101130778, 14515.70968580633, 14803.0, 14839.851601484062, 14971.700565988727, 15359.232038398035, 1787.6603445345343, 1947.3865732294423, 2046.986741562921, 2055.14711394771, 2110.8416868734907, 79446.0, 80281.99999999942, 80947.0, 81464.18535814625, 81898.59050704708, 10583.57665693379, 10702.73243168927, 10971.39657318839, 11140.888591114148, 11188.272762270426, 15520.767188492182, 15608.921955390151, 15614.219289035504, 15626.140562269184, 15641.217939102999, 8360.58197090143, 8837.116288371111, 8906.55467226636, 8949.194572488377, 9083.091690830865, 8649.783755406164, 8844.73465796027, 8894.0, 8897.599608017656, 8960.148785865333, 6747.122874026345, 6823.112995310578, 6838.316168383122, 6961.23426423093, 6973.093497845349, 1757.2914230624303, 1822.83798041441, 1919.8560107991957, 1966.3511041356319, 2014.0835919656522, 1007.2043085962155, 1067.8558394616782, 1075.7525769073156, 1118.3625333559792, 1155.0066942429503, 19172.616547668968, 19532.609347812962, 19629.50926226856, 19759.209631614864, 19993.700094498596, 1024.0374048394485, 1026.6150193677372, 1043.7442826507554, 1050.2648146297622, 1124.6176300057855, 11287.49206285719, 11397.487113079931, 11502.137339699557, 11533.0, 11551.075913926865, 489854.0, 491452.0, 492681.0, 492856.0, 506749.0, 82632.0, 83752.58123709343, 84489.15510844935, 84836.57581712052, 85263.0, 1024.912882404989, 1032.8708911386077, 1040.625374865048, 1060.4114716332356, 1061.0291583201438, 17390.73913891318, 17543.210555524776, 17623.823761762218, 17831.554211144306, 17841.46475605734, 32883.34233315272, 37426.84797872975, 39727.00682482845, 41167.588324116376, 41359.586404136775, 52229.7388513055, 52243.73878130585, 52287.21569176389, 52511.0, 52512.0, 7505.66224519887, 7831.0, 8710.259627931444, 8843.646254150019, 8980.955095224483, 13066.150700204456, 13185.34073296312, 13439.664008399477, 13548.525801596898, 13576.0, 11992.400379980792, 12008.579699710468, 12070.27578345302, 12244.204126732091, 12258.141930065167, 11078.446077696244, 11575.942120289681, 11764.882351176379, 11860.76278474443, 12036.097292702907, 11914.285142891455, 11940.70148246266, 12275.570355037531, 12393.0, 12411.689707757378, 8026.43814932949, 8191.05802832658, 8204.794880128045, 8283.62723677448, 8317.750467485985, 10816.459177040959, 11798.823017654913, 11909.464074116513, 12019.278843269432, 12409.62771116868], "value": 9610.274032060188, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.8045873577694, 1599.8640115590174, 1603.0702192728218, 1791.8387345138935, 1940.8156225158605, 9166.220871225945, 9662.227021838253, 9681.806363872727, 9963.701088967342, 9966.302358834884, 9640.180584650314, 9864.062914023174, 9868.06253405927, 9876.111149996499, 9887.0, 2495.1641200197955, 2530.709338237503, 2531.898724051036, 2533.265353047614, 2536.061657186834, 2417.9516409671796, 2494.850308981458, 2503.198976327576, 2511.4098186926058, 2516.924492265226, 2462.507498500298, 2482.6772519572432, 2486.266551367342, 2488.664030355906, 2490.452100537888, 2383.4994651123284, 2388.080588973249, 2395.7484464131276, 2435.8538487690616, 2453.58289090855, 2354.0, 2356.9864958068024, 2358.9646155307682, 2364.3498038039675, 2456.828022038458, 9525.714228573153, 9681.806363872754, 9687.660931867422, 9764.072413120743, 9765.169960553361, 5880.353161152269, 6022.277326720778, 6026.457618814327, 6032.336442991267, 6033.426824451714, 3677.8528858845616, 3689.2805902848954, 3705.888823335304, 3707.073231692077, 3797.050737315671, 1042.8331466965326, 1066.9745498701127, 1078.5092782783815, 1149.1036991146918, 1173.8826117388278, 14174.716505669932, 14371.209583472904, 14384.424623015067, 14391.2084835334, 14401.783973240304, 4922.729249891218, 4984.601231901439, 5018.3476148101245, 5050.0657378384385, 5129.948700513021, 10906.182036347305, 10978.0, 10986.505607247693, 10987.835182472269, 10992.340459572451, 5655.3779084300695, 5707.571932105108, 5719.48524632785, 5722.513586345207, 5724.856878578069, 4784.856454306307, 4804.326761454624, 4824.252240902666, 5348.598855085884, 5454.427285135003, 4035.8183881725395, 4037.6769858411258, 4066.959330406658, 4148.522919864194, 4182.2890108681595, 1137.2891942535914, 1180.4451907603413, 1182.355616189179, 1185.612832985409, 1191.862935762381, 930.851063829784, 972.9562169702381, 1031.1493018259966, 1047.471027131309, 1078.9298695584919, 6576.704048317837, 6665.333466653296, 6669.533132680763, 6714.127163468718, 6749.0551322814845, 469.6266468157823, 470.25464638548283, 475.4603524999082, 482.0383335246206, 484.80365451992, 4380.7371557706, 4388.144311859221, 4415.955840441618, 4456.777161141995, 4521.570450807168, 12278.631641050604, 12756.107072504836, 12782.233066015882, 12822.743545129046, 12833.101682882108, 12222.1444498886, 12471.064670149775, 12646.367681615882, 12834.679133021562, 12854.935725321313, 9274.026227246177, 9348.485833279236, 9373.812523749486, 9488.430694158234, 9530.0, 6633.502487313374, 6664.067030615621, 6692.130023097161, 6785.355391237825, 6793.0, 11416.372099534274, 11487.48306326234, 11775.116866234895, 11790.23363481371, 11877.881221188023, 11805.645830625095, 11818.349990750592, 11886.702832429259, 12022.338771367658, 12138.878611213775, 7400.740974065882, 7785.065792104983, 7917.643706033357, 7926.365890728844, 8189.590520474072, 9618.326717129734, 9656.420614763138, 9658.75853103678, 9725.0, 9732.902670973199, 8345.54099524532, 8385.58072096405, 8410.285125764378, 8419.663213471393, 8567.057623661267, 8165.305948994402, 8334.708285209988, 8354.373421993254, 8373.49759014461, 8498.065212826708, 7889.960550197212, 7917.881231781643, 7983.1617680142745, 7985.081715602548, 7986.121526632182, 5665.716714164193, 5726.79956201531, 5845.41545845412, 5845.532357411312, 5846.035404158436, 5815.476607105381, 5816.1857339973285, 5874.089516125007, 5907.852303692442, 5979.282486101695], "value": 4958.161281898982, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.55986896641264, 352.7372107779704, 355.135245676777, 360.6880048757824, 360.83762306961876, 5483.616146869721, 5553.500184983351, 5569.220309156722, 5577.274954255946, 5636.815199412329, 5230.764615592298, 5274.5780337573, 5354.518093371596, 5433.646812957165, 5539.196816461611, 4223.345381465878, 4266.445362102922, 4273.102648443831, 4298.333758267474, 4316.287812510932, 4243.681723870706, 4274.123804620061, 4278.315469524877, 4284.5715428457215, 4305.375720520523, 4003.9599604004025, 4025.778582177979, 4255.893602659928, 4257.701960862741, 4274.4229529013655, 4184.958150418487, 4202.516710578261, 4203.47456567929, 4213.9367909481225, 4233.174530966463, 3752.906177345561, 3753.6434038766274, 3796.7152463565067, 3800.8859734208017, 3806.695464362844, 5073.568746656539, 5217.191335343028, 5236.947630523684, 5267.28891599633, 5277.788888444457, 4843.854684359475, 4846.442659094214, 4917.434495033045, 4921.114199444099, 4937.629677774181, 5641.323041235078, 5649.23735295734, 5669.659820410748, 5718.34239062509, 5726.713664316809, 3947.98026009871, 4162.687798415101, 4169.687273454503, 4182.769947652878, 4241.766702831343, 5837.182794408786, 5902.822915312548, 5921.200637913869, 5955.553333499962, 6001.459868611802, 4204.831806727758, 4210.85262015828, 4214.662826973835, 4224.51418086924, 4232.365145228179, 4144.933997077532, 4267.957320426756, 4272.209641216385, 4280.72175308604, 4293.3130699088, 4810.470848206694, 4817.253325734517, 4863.367762190893, 4875.488073752276, 4894.241392584155, 5718.971405142947, 5727.828165154969, 5747.511461525817, 5752.798652047159, 5763.308402991668, 1393.3312010235145, 1407.345584303304, 1447.196805772806, 1458.5332693537966, 1466.332818567549, 982.729749318943, 1003.8003143715623, 1007.7077647482148, 1012.3976234140674, 1014.761531040205, 5513.8345849624575, 5568.860778480571, 5579.860503487364, 5599.524040456607, 5624.606277560613, 5806.564507661942, 5814.59297849155, 5839.970800145972, 5843.853903652358, 5846.795362162304, 5387.488188622075, 5579.9163012554845, 5582.358028826656, 5589.4628977030825, 5705.771769129188, 3143.1984843864666, 3149.7165255127147, 3159.0, 3167.5407065975305, 3172.920676983094, 6049.023267388329, 6069.0, 6105.572609917352, 6109.541784366191, 6134.355892631299, 5806.506446951972, 5928.673922934194, 5929.555283353679, 5992.730327135289, 5995.220621319288, 5904.940950590525, 5970.507373156711, 6019.548533859978, 6034.155218269446, 6038.879222415527, 5629.240052593012, 5855.707214639337, 5869.647821130746, 5883.499902508334, 5913.5564832636865, 5743.7989670363, 5767.480926716616, 5787.55311172207, 5824.3593204748295, 5837.307180917656, 5872.564549738451, 6032.90950635732, 6094.847628809315, 6104.053871649901, 6118.694065296806, 4176.895577610584, 4189.979050104852, 4222.345536441856, 4238.749568877251, 4243.936340954826, 5930.733117009659, 5953.732082056405, 5977.402259773988, 6002.459778619946, 6020.0, 5535.944640553543, 5596.272484576979, 5811.0, 5820.214271073351, 5855.853603659943, 5713.457221563945, 5714.485696287354, 5720.399358067343, 5746.683932383592, 5788.160716696139, 5557.777688892399, 5585.273914391103, 5680.32430433015, 5707.373398581384, 5722.113072473773, 5802.390748971466, 5820.341202757194, 5823.0, 5833.766649333979, 5841.211436456024, 5617.0, 5640.32316122068, 5665.376808550974, 5676.77292908279, 5720.313562372542], "value": 4384.5310216786365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [793.2345286798242, 794.805272708187, 853.0658928473327, 917.160797869949, 922.5018490015392, 15574.922125389372, 17231.0, 17250.0512471814, 17264.82735172648, 17273.654526909453, 15688.76466852998, 15813.0, 15888.523344299689, 15902.045877247374, 15909.124998125099, 727.1964479250419, 874.54960695242, 886.9600867960925, 895.3419236860902, 898.5372533145435, 884.120300301198, 887.077439462961, 889.8264838356523, 891.2558014058237, 891.3537685178227, 934.2245935873243, 938.8638647396124, 939.2626787971444, 939.6147579492409, 940.1068984464752, 763.2825144364308, 923.1553128887094, 941.9717408477757, 945.2390825385562, 946.5693109635099, 693.8022663540917, 696.7770313499682, 697.5431092634333, 697.6755808549049, 698.2947223304449, 15678.294476748573, 15682.902196846111, 15728.842711572852, 15758.527244182693, 15768.211589420598, 14615.0, 15056.623584410368, 15271.083734975826, 15295.541133765893, 15386.615334616612, 11811.94094029533, 11870.762584748343, 12080.395980200954, 13634.181949082988, 14064.789028164585, 4781.497942716, 4796.664233503656, 4801.111794318027, 4812.855614331575, 4940.4318503372215, 76508.0, 77012.0, 77427.0, 77613.61193194054, 77636.61181694112, 11791.88208117908, 11952.521899123938, 12035.939820301017, 12036.338001409831, 12532.310722910144, 22061.227857024925, 22063.33809985703, 22087.33737987863, 22147.557048859257, 22183.1126754928, 8629.987065963536, 8659.13408659129, 8703.129687031245, 8708.259797917248, 8815.823683526294, 4925.113479573711, 4942.579880710108, 4956.752162391938, 5044.268581055726, 5068.0, 3729.5151630287887, 3787.8484860605818, 3876.9030774230305, 3881.437191607201, 3882.941755873664, 676.9593824370553, 679.140886778226, 683.064202043204, 685.3660364163229, 686.3479694290444, 587.9088741245114, 610.91141784441, 680.9459573811451, 716.4197000429668, 730.7990302666702, 9640.614375424904, 9647.962214977331, 9805.754856128511, 9837.655682051094, 9842.114209721016, 610.1579819848581, 630.165031333485, 655.6459511863636, 711.1892442615423, 716.2228981555071, 4534.909301813946, 4569.383133277031, 4592.0, 4596.862094137181, 4606.470255920545, 109837.45081274543, 110000.0, 110079.0, 110344.4482777581, 111942.0, 93297.53351233201, 95387.52306238563, 97055.0, 97143.0285697148, 101901.49049254706, 57602.0, 79655.0, 87893.0, 89059.0, 89849.55075224713, 8584.914150858662, 8743.431676940978, 8747.65009399617, 8759.781005474913, 8964.506952117696, 38896.0, 49406.50593494019, 52814.47185528096, 53132.734336328074, 53757.73121134369, 69004.65497672479, 69140.0, 75440.0, 75712.62143689247, 78647.60676196583, 10389.740256493647, 10548.578056877946, 10611.491960613237, 10812.837807432737, 11005.834912476159, 11599.710007249887, 11919.46362413676, 11961.521539138337, 11974.58088966882, 12042.0, 11491.195616306779, 11524.366159861289, 11675.708107297385, 11701.76596468083, 12100.910918017069, 12721.55474558423, 12723.80914286305, 12813.487460501476, 13074.084814062924, 13406.597802065953, 12530.624081277576, 12531.812022819848, 12896.935515322364, 12968.157069790434, 13139.934300328438, 10286.434246116536, 10412.375257484575, 10747.0, 10812.080973117374, 10832.945835270773, 10664.466776661291, 10673.46632668348, 10768.838467422838, 10916.454177290945, 10926.672199834018], "value": 7614.416991804473, "unit": "score"}], "name": "dromaeo_css", "value": 7545.505140042116, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 103.0, 110.0, 108.0, 111.0, 108.0, 108.0, 111.0, 109.0, 109.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 123.0, 181.0, 122.0, 135.0, 123.0, 151.0, 170.0, 124.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 161.0, 162.0, 161.0, 162.0, 161.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 111.0, 75.0, 77.0, 74.0, 76.0, 121.0, 75.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 108.0, 84.0, 83.0, 84.0, 127.0, 84.0, 84.0, 136.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 53.0, 53.0, 52.0, 53.0, 55.0, 53.0, 52.0, 52.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 82.0, 78.0, 77.0, 77.0, 81.0, 117.0, 77.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 130.0, 117.0, 128.0, 116.0, 122.0, 127.0, 116.0, 137.0, 122.0], "value": 123.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 157.0, 153.0, 159.0, 158.0, 156.0, 157.0, 154.0, 156.0, 153.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 61.0, 67.0, 60.0, 63.0, 61.0, 59.0], "value": 61.6, "unit": "score"}], "name": "kraken", "value": 1480.5999999999997, "alertThreshold": 2.0}]} 11:44:49 INFO - Return code: 0 11:44:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:44:49 ERROR - # TBPL SUCCESS # 11:44:49 INFO - Running post-action listener: _resource_record_post_action 11:44:49 INFO - ##### 11:44:49 INFO - ##### Finished run-tests step (success) 11:44:49 INFO - ##### 11:44:49 INFO - Running post-run listener: _resource_record_post_run 11:44:49 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 453697536; Read time: 8; Write time: 841236 11:44:49 INFO - TinderboxPrint: CPU usage
13.1% 11:44:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:44:49 INFO - TinderboxPrint: I/O write bytes / time
453,697,536 / 841,236 11:44:49 INFO - TinderboxPrint: CPU idle
8,246.6 (86.9%) 11:44:49 INFO - TinderboxPrint: CPU user
1,192.9 (12.6%) 11:44:49 INFO - TinderboxPrint: Swap in / out
0 / 0 11:44:49 INFO - install - Wall time: 13s; CPU: 18.0%; Read bytes: 0; Write bytes: 222920704; Read time: 0; Write time: 572596 11:44:49 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 217825280; Read time: 8; Write time: 267160 11:44:50 INFO - Running post-run listener: _upload_blobber_files 11:44:50 INFO - Blob upload gear active. 11:44:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:44:50 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:50 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:50 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:50 INFO - (blobuploader) - INFO - Open directory for files ... 11:44:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:44:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:44:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:51 INFO - (blobuploader) - INFO - Done attempting. 11:44:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:44:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:44:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:54 INFO - (blobuploader) - INFO - Done attempting. 11:44:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:44:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:44:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:44:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:44:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:44:55 INFO - (blobuploader) - INFO - Done attempting. 11:44:55 INFO - (blobuploader) - INFO - Iteration through files over. 11:44:55 INFO - Return code: 0 11:44:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:44:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:44:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2dfd0eca0023d6fae022f32128ec633d9c589b3c9402d17a00b906bdbfc3a3a1467eeee2d6548cf7bd56aba693fd9604f8f2b5ddcd340853a8e172398ea26b1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2102a1857753f34017c674a635424535f93bd154b2d4ebe644bd59aeb3498609aa938106da4a8c990bcbaac44e2ff171637815c40bcc82eb17f24ce4dc849d6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/60527fd6e92fd7303911778e3ea7a0c1cd1c5f9e4452622bedab1978f0c6bf00a422b0895f4f3dae6fd860e2d330a8668a44314d0b5656764daf5a1086fed5d4"} 11:44:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:44:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:44:55 INFO - Contents: 11:44:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2dfd0eca0023d6fae022f32128ec633d9c589b3c9402d17a00b906bdbfc3a3a1467eeee2d6548cf7bd56aba693fd9604f8f2b5ddcd340853a8e172398ea26b1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2102a1857753f34017c674a635424535f93bd154b2d4ebe644bd59aeb3498609aa938106da4a8c990bcbaac44e2ff171637815c40bcc82eb17f24ce4dc849d6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/60527fd6e92fd7303911778e3ea7a0c1cd1c5f9e4452622bedab1978f0c6bf00a422b0895f4f3dae6fd860e2d330a8668a44314d0b5656764daf5a1086fed5d4"} 11:44:55 INFO - Running post-run listener: copy_logs_to_upload_dir 11:44:55 INFO - Copying logs to upload dir... 11:44:55 INFO - mkdir: /builds/slave/test/build/upload/logs 11:44:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.085502 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-01 11:44:54.854002) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 11:44:54.860363) ========= 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=8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597 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/2dfd0eca0023d6fae022f32128ec633d9c589b3c9402d17a00b906bdbfc3a3a1467eeee2d6548cf7bd56aba693fd9604f8f2b5ddcd340853a8e172398ea26b1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2102a1857753f34017c674a635424535f93bd154b2d4ebe644bd59aeb3498609aa938106da4a8c990bcbaac44e2ff171637815c40bcc82eb17f24ce4dc849d6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/60527fd6e92fd7303911778e3ea7a0c1cd1c5f9e4452622bedab1978f0c6bf00a422b0895f4f3dae6fd860e2d330a8668a44314d0b5656764daf5a1086fed5d4"} 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.011361 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/2dfd0eca0023d6fae022f32128ec633d9c589b3c9402d17a00b906bdbfc3a3a1467eeee2d6548cf7bd56aba693fd9604f8f2b5ddcd340853a8e172398ea26b1a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2102a1857753f34017c674a635424535f93bd154b2d4ebe644bd59aeb3498609aa938106da4a8c990bcbaac44e2ff171637815c40bcc82eb17f24ce4dc849d6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/60527fd6e92fd7303911778e3ea7a0c1cd1c5f9e4452622bedab1978f0c6bf00a422b0895f4f3dae6fd860e2d330a8668a44314d0b5656764daf5a1086fed5d4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 11:44:54.885872) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:44:54.886192) ========= 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=8783db0840cc980e80bb0bd400000236-1470075591.630354-1288580597 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 11:44:54.972837) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 11:44:54.973160) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 11:44:54.973438) ========= ========= Total master_lag: 0.24 =========