builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1470323280.35 results: success (0) buildid: 20160804065423 builduid: dfa8307f89a746eebd016783d42eb5b3 revision: 62a983c56050b3ac647d8f95d9c2ca69c3ad2d91 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 08:08:00.350315) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 08:08:00.350804) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 08:08:00.351091) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 08:08:00.381239) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 08:08:00.381544) ========= 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=ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 08:08:01-- 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% 222M=0s 2016-08-04 08:08:01 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113623 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 08:08:00.509454) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 08:08:00.509835) ========= 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=ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014351 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 08:08:00.559898) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 08:08:00.560257) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 62a983c56050b3ac647d8f95d9c2ca69c3ad2d91 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 62a983c56050b3ac647d8f95d9c2ca69c3ad2d91 --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=ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 08:08:01,287 truncating revision to first 12 chars 2016-08-04 08:08:01,287 Setting DEBUG logging. 2016-08-04 08:08:01,287 attempt 1/10 2016-08-04 08:08:01,287 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/62a983c56050?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 08:08:01,614 unpacking tar archive at: mozilla-central-62a983c56050/testing/mozharness/ program finished with exit code 0 elapsedTime=0.730909 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 08:08:01.304248) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 08:08:01.304523) ========= script_repo_revision: 62a983c56050b3ac647d8f95d9c2ca69c3ad2d91 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 08:08:01.304914) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 08:08:01.305177) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 08:08:01.313746) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-04 08:08:01.314027) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:08:02 INFO - MultiFileLogger online at 20160804 08:08:02 in /builds/slave/test 08:08:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:08:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:08:02 INFO - {'append_to_log': False, 08:08:02 INFO - 'base_work_dir': '/builds/slave/test', 08:08:02 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:08:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:08:02 INFO - 'branch': 'Firefox-Non-PGO', 08:08:02 INFO - 'buildbot_json_path': 'buildprops.json', 08:08:02 INFO - 'config_files': ('talos/linux_config.py',), 08:08:02 INFO - 'default_actions': ('clobber', 08:08:02 INFO - 'read-buildbot-config', 08:08:02 INFO - 'download-and-extract', 08:08:02 INFO - 'populate-webroot', 08:08:02 INFO - 'create-virtualenv', 08:08:02 INFO - 'install', 08:08:02 INFO - 'run-tests'), 08:08:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:08:02 INFO - 'download_minidump_stackwalk': True, 08:08:02 INFO - 'download_symbols': 'ondemand', 08:08:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:08:02 INFO - 'tooltool.py': '/tools/tooltool.py', 08:08:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:08:02 INFO - '/tools/misc-python/virtualenv.py')}, 08:08:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:08:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:08:02 INFO - 'installer_path': 'installer.exe', 08:08:02 INFO - 'log_level': 'info', 08:08:02 INFO - 'log_name': 'talos', 08:08:02 INFO - 'log_to_console': True, 08:08:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:08:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:08:02 INFO - 'opt_config_files': (), 08:08:02 INFO - 'pip_index': False, 08:08:02 INFO - 'sps_profile': False, 08:08:02 INFO - 'sps_profile_interval': 0, 08:08:02 INFO - 'suite': 'dromaeojs', 08:08:02 INFO - 'system_bits': '32', 08:08:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:08:02 INFO - 'title': 'talos-linux64-ix-035', 08:08:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:08:02 INFO - 'use_talos_json': True, 08:08:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:08:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:08:02 INFO - 'work_dir': 'build'} 08:08:02 INFO - [mozharness: 2016-08-04 15:08:02.133394Z] Running clobber step. 08:08:02 INFO - Running pre-action listener: _resource_record_pre_action 08:08:02 INFO - Running main action method: clobber 08:08:02 INFO - rmtree: /builds/slave/test/build 08:08:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:08:02 INFO - Running post-action listener: _resource_record_post_action 08:08:02 INFO - [mozharness: 2016-08-04 15:08:02.590017Z] Finished clobber step (success) 08:08:02 INFO - [mozharness: 2016-08-04 15:08:02.590118Z] Running read-buildbot-config step. 08:08:02 INFO - Running pre-action listener: _resource_record_pre_action 08:08:02 INFO - Running main action method: read_buildbot_config 08:08:02 INFO - Using buildbot properties: 08:08:02 INFO - { 08:08:02 INFO - "project": "", 08:08:02 INFO - "product": "firefox", 08:08:02 INFO - "script_repo_revision": "production", 08:08:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:08:02 INFO - "repository": "", 08:08:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:08:02 INFO - "buildid": "20160804065423", 08:08:02 INFO - "pgo_build": "False", 08:08:02 INFO - "basedir": "/builds/slave/test", 08:08:02 INFO - "buildnumber": 173, 08:08:02 INFO - "slavename": "talos-linux64-ix-035", 08:08:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:08:02 INFO - "platform": "ubuntu64_hw", 08:08:02 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:08:02 INFO - "branch": "mozilla-central", 08:08:02 INFO - "repo_path": "mozilla-central", 08:08:02 INFO - "revision": "62a983c56050b3ac647d8f95d9c2ca69c3ad2d91", 08:08:02 INFO - "stage_platform": "linux64", 08:08:02 INFO - "builduid": "dfa8307f89a746eebd016783d42eb5b3", 08:08:02 INFO - "slavebuilddir": "test" 08:08:02 INFO - } 08:08:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:08:02 INFO - Running post-action listener: _resource_record_post_action 08:08:02 INFO - [mozharness: 2016-08-04 15:08:02.592536Z] Finished read-buildbot-config step (success) 08:08:02 INFO - [mozharness: 2016-08-04 15:08:02.592625Z] Running download-and-extract step. 08:08:02 INFO - Running pre-action listener: _resource_record_pre_action 08:08:02 INFO - Running main action method: download_and_extract 08:08:02 INFO - mkdir: /builds/slave/test/build/tests 08:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:02 INFO - https://queue.taskcluster.net/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:08:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:08:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:08:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:08:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:08:03 INFO - Downloaded 1361 bytes. 08:08:03 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:08:03 INFO - Using the following test package requirements: 08:08:03 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:03 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:08:03 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:08:03 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:03 INFO - u'jsshell-linux-x86_64.zip'], 08:08:03 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:08:03 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:08:03 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:08:03 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:08:03 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:08:03 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:08:03 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:08:03 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:08:03 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')]} 08:08:03 INFO - https://queue.taskcluster.net/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:08:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:08:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:08:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:08:05 INFO - Downloaded 20241054 bytes. 08:08:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:08:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:08:06 INFO - Return code: 0 08:08:06 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:08:06 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')]} 08:08:06 INFO - https://queue.taskcluster.net/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:08:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:08:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:08:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:08:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:08:07 INFO - Downloaded 20241054 bytes. 08:08:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:08:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:08:09 INFO - Return code: 0 08:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:09 INFO - https://queue.taskcluster.net/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:08:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:08:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:08:10 INFO - Downloaded 14413723 bytes. 08:08:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:08:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:08:10 INFO - Return code: 0 08:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:10 INFO - https://queue.taskcluster.net/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:08:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:08:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:08:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:08:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:08:12 INFO - Downloaded 55567070 bytes. 08:08:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:08:12 INFO - mkdir: /builds/slave/test/properties 08:08:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:08:12 INFO - Writing to file /builds/slave/test/properties/build_url 08:08:12 INFO - Contents: 08:08:12 INFO - build_url:https://queue.taskcluster.net/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:08:12 INFO - Running post-action listener: _resource_record_post_action 08:08:12 INFO - Running post-action listener: set_extra_try_arguments 08:08:12 INFO - [mozharness: 2016-08-04 15:08:12.826410Z] Finished download-and-extract step (success) 08:08:12 INFO - [mozharness: 2016-08-04 15:08:12.826641Z] Running populate-webroot step. 08:08:12 INFO - Running pre-action listener: _resource_record_pre_action 08:08:12 INFO - Running main action method: populate_webroot 08:08:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:08:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:08:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:08:12 INFO - '--tppagecycles', 08:08:12 INFO - '7'], 08:08:12 INFO - 'tests': ['tsvgm']}}, 08:08:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:08:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:08:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:08:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:08:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:12 INFO - 'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:08:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:12 INFO - 'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['damp', 'tps']}, 08:08:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:12 INFO - 'tests': ['damp', 'tps']}, 08:08:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['dromaeo_dom']}, 08:08:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:08:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['basic_compositor_video']}, 08:08:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:08:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['a11yr', 08:08:12 INFO - 'ts_paint', 08:08:12 INFO - 'tpaint', 08:08:12 INFO - 'sessionrestore', 08:08:12 INFO - 'sessionrestore_no_auto_restore', 08:08:12 INFO - 'tabpaint']}, 08:08:12 INFO - 'other-e10s': {'tests': ['a11yr', 08:08:12 INFO - 'ts_paint', 08:08:12 INFO - 'tpaint', 08:08:12 INFO - 'sessionrestore', 08:08:12 INFO - 'sessionrestore_no_auto_restore', 08:08:12 INFO - 'tabpaint']}, 08:08:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:08:12 INFO - 'ts_paint', 08:08:12 INFO - 'tpaint', 08:08:12 INFO - 'sessionrestore', 08:08:12 INFO - 'sessionrestore_no_auto_restore', 08:08:12 INFO - 'tabpaint']}, 08:08:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:08:12 INFO - 'ts_paint', 08:08:12 INFO - 'tpaint', 08:08:12 INFO - 'sessionrestore', 08:08:12 INFO - 'sessionrestore_no_auto_restore', 08:08:12 INFO - 'tabpaint']}, 08:08:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['a11yr', 08:08:12 INFO - 'ts_paint', 08:08:12 INFO - 'tpaint', 08:08:12 INFO - 'sessionrestore', 08:08:12 INFO - 'sessionrestore_no_auto_restore', 08:08:12 INFO - 'tabpaint']}, 08:08:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['a11yr', 08:08:12 INFO - 'ts_paint', 08:08:12 INFO - 'tpaint', 08:08:12 INFO - 'sessionrestore', 08:08:12 INFO - 'sessionrestore_no_auto_restore', 08:08:12 INFO - 'tabpaint']}, 08:08:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['tsvgx', 08:08:12 INFO - 'tsvgr_opacity', 08:08:12 INFO - 'tart', 08:08:12 INFO - 'tscrollx', 08:08:12 INFO - 'cart']}, 08:08:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:08:12 INFO - 'tsvgr_opacity', 08:08:12 INFO - 'tart', 08:08:12 INFO - 'tscrollx', 08:08:12 INFO - 'cart']}, 08:08:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:12 INFO - 'talos_options': ['--disable-e10s'], 08:08:12 INFO - 'tests': ['tp5o']}, 08:08:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:12 INFO - 'tests': ['tp5o']}, 08:08:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:12 INFO - 'talos_options': ['--disable-e10s', 08:08:12 INFO - '--xperf_path', 08:08:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:12 INFO - 'tests': ['tp5n']}, 08:08:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:08:12 INFO - 'talos_options': ['--xperf_path', 08:08:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:08:12 INFO - 'tests': ['tp5n']}}, 08:08:12 INFO - 'talos.zip': {'path': '', 08:08:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:08:12 INFO - Running post-action listener: _resource_record_post_action 08:08:12 INFO - [mozharness: 2016-08-04 15:08:12.844297Z] Finished populate-webroot step (success) 08:08:12 INFO - [mozharness: 2016-08-04 15:08:12.844386Z] Running create-virtualenv step. 08:08:12 INFO - Running pre-action listener: _resource_record_pre_action 08:08:12 INFO - Running main action method: create_virtualenv 08:08:12 INFO - Creating virtualenv /builds/slave/test/build/venv 08:08:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:08:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:08:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:08:12 INFO - Using real prefix '/usr' 08:08:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:08:13 INFO - Installing distribute.............................................................................................................................................................................................done. 08:08:15 INFO - Installing pip.................done. 08:08:15 INFO - Return code: 0 08:08:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1844030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b05180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b033b0>, '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 0x1b042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', '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 08:08:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:08:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:08:15 INFO - Using env: {'DISPLAY': ':0', 08:08:15 INFO - 'HOME': '/home/cltbld', 08:08:15 INFO - 'LANG': 'en_US.UTF-8', 08:08:15 INFO - 'LANGUAGE': 'en_US:en', 08:08:15 INFO - 'LOGNAME': 'cltbld', 08:08:15 INFO - 'MAIL': '/var/mail/cltbld', 08:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:15 INFO - 'MOZ_NO_REMOTE': '1', 08:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:15 INFO - 'NO_EM_RESTART': '1', 08:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:15 INFO - 'PWD': '/builds/slave/test', 08:08:15 INFO - 'SHELL': '/bin/bash', 08:08:15 INFO - 'SHLVL': '1', 08:08:15 INFO - 'TERM': 'linux', 08:08:15 INFO - 'TMOUT': '86400', 08:08:15 INFO - 'USER': 'cltbld', 08:08:15 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', 08:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:15 INFO - '_': '/tools/buildbot/bin/python'} 08:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:08:15 INFO - Cleaning up... 08:08:15 INFO - Return code: 0 08:08:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1844030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b05180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b033b0>, '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 0x1b042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', '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 08:08:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:08:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:08:15 INFO - Using env: {'DISPLAY': ':0', 08:08:15 INFO - 'HOME': '/home/cltbld', 08:08:15 INFO - 'LANG': 'en_US.UTF-8', 08:08:15 INFO - 'LANGUAGE': 'en_US:en', 08:08:15 INFO - 'LOGNAME': 'cltbld', 08:08:15 INFO - 'MAIL': '/var/mail/cltbld', 08:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:15 INFO - 'MOZ_NO_REMOTE': '1', 08:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:15 INFO - 'NO_EM_RESTART': '1', 08:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:15 INFO - 'PWD': '/builds/slave/test', 08:08:15 INFO - 'SHELL': '/bin/bash', 08:08:15 INFO - 'SHLVL': '1', 08:08:15 INFO - 'TERM': 'linux', 08:08:15 INFO - 'TMOUT': '86400', 08:08:15 INFO - 'USER': 'cltbld', 08:08:15 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', 08:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:15 INFO - '_': '/tools/buildbot/bin/python'} 08:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:15 INFO - Downloading/unpacking psutil>=3.1.1 08:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:08:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:17 INFO - Installing collected packages: psutil 08:08:17 INFO - Running setup.py install for psutil 08:08:17 INFO - building 'psutil._psutil_linux' extension 08:08:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:08:18 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 08:08:18 INFO - building 'psutil._psutil_posix' extension 08:08:18 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 08:08:18 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 08:08:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:08:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:08:18 INFO - Successfully installed psutil 08:08:18 INFO - Cleaning up... 08:08:18 INFO - Return code: 0 08:08:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:18 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 0x1844030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b05180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b033b0>, '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 0x1b042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', '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 08:08:18 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 08:08:18 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 08:08:18 INFO - Using env: {'DISPLAY': ':0', 08:08:18 INFO - 'HOME': '/home/cltbld', 08:08:18 INFO - 'LANG': 'en_US.UTF-8', 08:08:18 INFO - 'LANGUAGE': 'en_US:en', 08:08:18 INFO - 'LOGNAME': 'cltbld', 08:08:18 INFO - 'MAIL': '/var/mail/cltbld', 08:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:18 INFO - 'MOZ_NO_REMOTE': '1', 08:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:18 INFO - 'NO_EM_RESTART': '1', 08:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:18 INFO - 'PWD': '/builds/slave/test', 08:08:18 INFO - 'SHELL': '/bin/bash', 08:08:18 INFO - 'SHLVL': '1', 08:08:18 INFO - 'TERM': 'linux', 08:08:18 INFO - 'TMOUT': '86400', 08:08:18 INFO - 'USER': 'cltbld', 08:08:18 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', 08:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:18 INFO - '_': '/tools/buildbot/bin/python'} 08:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:08:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:08:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:08:20 INFO - Installing collected packages: mozsystemmonitor 08:08:20 INFO - Running setup.py install for mozsystemmonitor 08:08:20 INFO - Successfully installed mozsystemmonitor 08:08:20 INFO - Cleaning up... 08:08:20 INFO - Return code: 0 08:08:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1844030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b05180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b033b0>, '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 0x1b042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', '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 08:08:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:08:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:08:20 INFO - Using env: {'DISPLAY': ':0', 08:08:20 INFO - 'HOME': '/home/cltbld', 08:08:20 INFO - 'LANG': 'en_US.UTF-8', 08:08:20 INFO - 'LANGUAGE': 'en_US:en', 08:08:20 INFO - 'LOGNAME': 'cltbld', 08:08:20 INFO - 'MAIL': '/var/mail/cltbld', 08:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:20 INFO - 'MOZ_NO_REMOTE': '1', 08:08:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:20 INFO - 'NO_EM_RESTART': '1', 08:08:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:20 INFO - 'PWD': '/builds/slave/test', 08:08:20 INFO - 'SHELL': '/bin/bash', 08:08:20 INFO - 'SHLVL': '1', 08:08:20 INFO - 'TERM': 'linux', 08:08:20 INFO - 'TMOUT': '86400', 08:08:20 INFO - 'USER': 'cltbld', 08:08:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', 08:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:20 INFO - '_': '/tools/buildbot/bin/python'} 08:08:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:20 INFO - Downloading/unpacking jsonschema==2.5.1 08:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:08:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:22 INFO - Downloading functools32-3.2.3-2.tar.gz 08:08:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:08:23 INFO - warning: no files found matching '*.txt' 08:08:23 INFO - no previously-included directories found matching 'build' 08:08:23 INFO - no previously-included directories found matching 'dist' 08:08:23 INFO - no previously-included directories found matching '.git*' 08:08:23 INFO - Installing collected packages: jsonschema, functools32 08:08:23 INFO - Running setup.py install for functools32 08:08:23 INFO - warning: no files found matching '*.txt' 08:08:23 INFO - no previously-included directories found matching 'build' 08:08:23 INFO - no previously-included directories found matching 'dist' 08:08:23 INFO - no previously-included directories found matching '.git*' 08:08:23 INFO - Successfully installed jsonschema functools32 08:08:23 INFO - Cleaning up... 08:08:23 INFO - Return code: 0 08:08:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:08: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')]} 08:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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')]} 08:08:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:23 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1844030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b05180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b033b0>, '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 0x1b042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', '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 08:08:23 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:08:23 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 functools32==3.2.3-2 08:08:23 INFO - Using env: {'DISPLAY': ':0', 08:08:23 INFO - 'HOME': '/home/cltbld', 08:08:23 INFO - 'LANG': 'en_US.UTF-8', 08:08:23 INFO - 'LANGUAGE': 'en_US:en', 08:08:23 INFO - 'LOGNAME': 'cltbld', 08:08:23 INFO - 'MAIL': '/var/mail/cltbld', 08:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:23 INFO - 'MOZ_NO_REMOTE': '1', 08:08:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:23 INFO - 'NO_EM_RESTART': '1', 08:08:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:23 INFO - 'PWD': '/builds/slave/test', 08:08:23 INFO - 'SHELL': '/bin/bash', 08:08:23 INFO - 'SHLVL': '1', 08:08:23 INFO - 'TERM': 'linux', 08:08:23 INFO - 'TMOUT': '86400', 08:08:23 INFO - 'USER': 'cltbld', 08:08:23 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', 08:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:23 INFO - '_': '/tools/buildbot/bin/python'} 08:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:08:23 INFO - Cleaning up... 08:08:23 INFO - Return code: 0 08:08:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:08: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')]} 08:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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')]} 08:08:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:23 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 0x1844030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b05180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b033b0>, '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 0x1b042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', '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 08:08:23 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 08:08:23 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 08:08:23 INFO - Using env: {'DISPLAY': ':0', 08:08:23 INFO - 'HOME': '/home/cltbld', 08:08:23 INFO - 'LANG': 'en_US.UTF-8', 08:08:23 INFO - 'LANGUAGE': 'en_US:en', 08:08:23 INFO - 'LOGNAME': 'cltbld', 08:08:23 INFO - 'MAIL': '/var/mail/cltbld', 08:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:23 INFO - 'MOZ_NO_REMOTE': '1', 08:08:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:23 INFO - 'NO_EM_RESTART': '1', 08:08:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:23 INFO - 'PWD': '/builds/slave/test', 08:08:23 INFO - 'SHELL': '/bin/bash', 08:08:23 INFO - 'SHLVL': '1', 08:08:23 INFO - 'TERM': 'linux', 08:08:23 INFO - 'TMOUT': '86400', 08:08:23 INFO - 'USER': 'cltbld', 08:08:23 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', 08:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:23 INFO - '_': '/tools/buildbot/bin/python'} 08:08:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:23 INFO - Downloading/unpacking blobuploader==1.2.4 08:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:25 INFO - Downloading blobuploader-1.2.4.tar.gz 08:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:08:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:08:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:08:26 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 08:08:26 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 08:08:26 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 08:08:26 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 08:08:26 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 08:08:26 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 08:08:26 INFO - Downloading docopt-0.6.1.tar.gz 08:08:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:08:26 INFO - Installing collected packages: blobuploader, requests, docopt 08:08:26 INFO - Running setup.py install for blobuploader 08:08:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:08:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:08:26 INFO - Running setup.py install for requests 08:08:26 INFO - Running setup.py install for docopt 08:08:26 INFO - Successfully installed blobuploader requests docopt 08:08:26 INFO - Cleaning up... 08:08:26 INFO - Return code: 0 08:08:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08: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')]} 08:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08: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')]} 08:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1844030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b05180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b033b0>, '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 0x1b042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', '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 08:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:08:26 INFO - Using env: {'DISPLAY': ':0', 08:08:26 INFO - 'HOME': '/home/cltbld', 08:08:26 INFO - 'LANG': 'en_US.UTF-8', 08:08:26 INFO - 'LANGUAGE': 'en_US:en', 08:08:26 INFO - 'LOGNAME': 'cltbld', 08:08:26 INFO - 'MAIL': '/var/mail/cltbld', 08:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:26 INFO - 'MOZ_NO_REMOTE': '1', 08:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:26 INFO - 'NO_EM_RESTART': '1', 08:08:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:26 INFO - 'PWD': '/builds/slave/test', 08:08:26 INFO - 'SHELL': '/bin/bash', 08:08:26 INFO - 'SHLVL': '1', 08:08:26 INFO - 'TERM': 'linux', 08:08:26 INFO - 'TMOUT': '86400', 08:08:26 INFO - 'USER': 'cltbld', 08:08:26 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', 08:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:26 INFO - '_': '/tools/buildbot/bin/python'} 08:08:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:08:27 INFO - Running setup.py (path:/tmp/pip-RfkjwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:08:27 INFO - Running setup.py (path:/tmp/pip-TM6kv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:08:27 INFO - Running setup.py (path:/tmp/pip-RycudF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:08:27 INFO - Running setup.py (path:/tmp/pip-V7FmJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:08:27 INFO - Running setup.py (path:/tmp/pip-FWCuU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:08:27 INFO - Running setup.py (path:/tmp/pip-czPAtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:08:27 INFO - Running setup.py (path:/tmp/pip-Fszs_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:08:27 INFO - Running setup.py (path:/tmp/pip-JoAU4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:08:27 INFO - Running setup.py (path:/tmp/pip-rRrFqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:08:27 INFO - Running setup.py (path:/tmp/pip-xYc3w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:08:27 INFO - Running setup.py (path:/tmp/pip-DV64AO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:08:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:08:27 INFO - Running setup.py (path:/tmp/pip-xU7W4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:08:28 INFO - Running setup.py (path:/tmp/pip-5iZPyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:08:28 INFO - Running setup.py (path:/tmp/pip-DxtFkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:28 INFO - Running setup.py (path:/tmp/pip-6M_615-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:08:28 INFO - Running setup.py (path:/tmp/pip-s_85G7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:08:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:08:28 INFO - Running setup.py (path:/tmp/pip-7WrbMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:08:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:08:28 INFO - Running setup.py install for manifestparser 08:08:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:08:28 INFO - Running setup.py install for mozcrash 08:08:28 INFO - Running setup.py install for mozdebug 08:08:28 INFO - Running setup.py install for mozdevice 08:08:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:08:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:08:28 INFO - Running setup.py install for mozfile 08:08:28 INFO - Running setup.py install for mozhttpd 08:08:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:08:28 INFO - Running setup.py install for mozinfo 08:08:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:08:29 INFO - Running setup.py install for mozInstall 08:08:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:08:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:08:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:08:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:08:29 INFO - Running setup.py install for mozleak 08:08:29 INFO - Running setup.py install for mozlog 08:08:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:08:29 INFO - Running setup.py install for moznetwork 08:08:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:08:29 INFO - Running setup.py install for mozprocess 08:08:29 INFO - Running setup.py install for mozprofile 08:08:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:08:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:08:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:08:29 INFO - Running setup.py install for mozrunner 08:08:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:08:29 INFO - Running setup.py install for mozscreenshot 08:08:29 INFO - Running setup.py install for moztest 08:08:30 INFO - Running setup.py install for mozversion 08:08:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:08:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:08:30 INFO - Cleaning up... 08:08:30 INFO - Return code: 0 08:08:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:30 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')]} 08:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:30 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')]} 08:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:30 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 0x1844030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b05180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b033b0>, '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 0x1b042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', '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 08:08:30 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 08:08:30 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 08:08:30 INFO - Using env: {'DISPLAY': ':0', 08:08:30 INFO - 'HOME': '/home/cltbld', 08:08:30 INFO - 'LANG': 'en_US.UTF-8', 08:08:30 INFO - 'LANGUAGE': 'en_US:en', 08:08:30 INFO - 'LOGNAME': 'cltbld', 08:08:30 INFO - 'MAIL': '/var/mail/cltbld', 08:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:30 INFO - 'MOZ_NO_REMOTE': '1', 08:08:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:30 INFO - 'NO_EM_RESTART': '1', 08:08:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:30 INFO - 'PWD': '/builds/slave/test', 08:08:30 INFO - 'SHELL': '/bin/bash', 08:08:30 INFO - 'SHLVL': '1', 08:08:30 INFO - 'TERM': 'linux', 08:08:30 INFO - 'TMOUT': '86400', 08:08:30 INFO - 'USER': 'cltbld', 08:08:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', 08:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:30 INFO - '_': '/tools/buildbot/bin/python'} 08:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:08:30 INFO - Running setup.py (path:/tmp/pip-9F9L6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:08:30 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)) 08:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:08:30 INFO - Running setup.py (path:/tmp/pip-IQsT_t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:08:30 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)) 08:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:08:30 INFO - Running setup.py (path:/tmp/pip-L2NeTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:08:30 INFO - Running setup.py (path:/tmp/pip-SU37T8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:08:30 INFO - Running setup.py (path:/tmp/pip-2hcDS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:08:30 INFO - Running setup.py (path:/tmp/pip-Ndz4Lt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:08:30 INFO - Running setup.py (path:/tmp/pip-O8B3WJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:08:30 INFO - Running setup.py (path:/tmp/pip-FcVPEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:08:30 INFO - Running setup.py (path:/tmp/pip-ElypYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:08:31 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)) 08:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:08:31 INFO - Running setup.py (path:/tmp/pip-Gj1qgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 08:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:08:31 INFO - Running setup.py (path:/tmp/pip-MYrJly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:08:31 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)) 08:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:08:31 INFO - Running setup.py (path:/tmp/pip-x2QPaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:08:31 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)) 08:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:08:31 INFO - Running setup.py (path:/tmp/pip-iwTxYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:08:31 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)) 08:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:08:31 INFO - Running setup.py (path:/tmp/pip-3VN3IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:08:31 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)) 08:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:31 INFO - Running setup.py (path:/tmp/pip-Cv_wd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:08:31 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)) 08:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:08:31 INFO - Running setup.py (path:/tmp/pip-mERLQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:08:31 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)) 08:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:08:31 INFO - Running setup.py (path:/tmp/pip-hYsuVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:08:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:08:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:08:33 INFO - Downloading blessings-1.6.tar.gz 08:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:08:33 INFO - Installing collected packages: blessings 08:08:33 INFO - Running setup.py install for blessings 08:08:33 INFO - Successfully installed blessings 08:08:33 INFO - Cleaning up... 08:08:33 INFO - Return code: 0 08:08:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:08:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:33 INFO - Reading from file tmpfile_stdout 08:08:33 INFO - Current package versions: 08:08:33 INFO - argparse == 1.2.1 08:08:33 INFO - blessings == 1.6 08:08:33 INFO - blobuploader == 1.2.4 08:08:33 INFO - docopt == 0.6.1 08:08:33 INFO - functools32 == 3.2.3-2 08:08:33 INFO - jsonschema == 2.5.1 08:08:33 INFO - manifestparser == 1.1 08:08:33 INFO - mozInstall == 1.12 08:08:33 INFO - mozcrash == 0.17 08:08:33 INFO - mozdebug == 0.1 08:08:33 INFO - mozdevice == 0.48 08:08:33 INFO - mozfile == 1.2 08:08:33 INFO - mozhttpd == 0.7 08:08:33 INFO - mozinfo == 0.9 08:08:33 INFO - mozleak == 0.1 08:08:33 INFO - mozlog == 3.3 08:08:33 INFO - moznetwork == 0.27 08:08:33 INFO - mozprocess == 0.23 08:08:33 INFO - mozprofile == 0.28 08:08:33 INFO - mozrunner == 6.12 08:08:33 INFO - mozscreenshot == 0.1 08:08:33 INFO - mozsystemmonitor == 0.3 08:08:33 INFO - moztest == 0.7 08:08:33 INFO - mozversion == 1.4 08:08:33 INFO - psutil == 3.1.1 08:08:33 INFO - requests == 1.2.3 08:08:33 INFO - wsgiref == 0.1.2 08:08:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1844030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b05180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b033b0>, '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 0x1b042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', '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 08:08:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:08:33 INFO - Using env: {'DISPLAY': ':0', 08:08:33 INFO - 'HOME': '/home/cltbld', 08:08:33 INFO - 'LANG': 'en_US.UTF-8', 08:08:33 INFO - 'LANGUAGE': 'en_US:en', 08:08:33 INFO - 'LOGNAME': 'cltbld', 08:08:33 INFO - 'MAIL': '/var/mail/cltbld', 08:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:33 INFO - 'MOZ_NO_REMOTE': '1', 08:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:33 INFO - 'NO_EM_RESTART': '1', 08:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:33 INFO - 'PWD': '/builds/slave/test', 08:08:33 INFO - 'SHELL': '/bin/bash', 08:08:33 INFO - 'SHLVL': '1', 08:08:33 INFO - 'TERM': 'linux', 08:08:33 INFO - 'TMOUT': '86400', 08:08:33 INFO - 'USER': 'cltbld', 08:08:33 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', 08:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:33 INFO - '_': '/tools/buildbot/bin/python'} 08:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:34 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)) 08:08:34 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)) 08:08:34 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)) 08:08:34 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)) 08:08:34 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)) 08:08:34 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)) 08:08:34 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)) 08:08:34 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)) 08:08:34 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)) 08:08:34 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)) 08:08:34 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)) 08:08:34 INFO - Cleaning up... 08:08:34 INFO - Return code: 0 08:08:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:08:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1844030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b05180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b033b0>, '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 0x1b042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04740>, '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': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', '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 08:08:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:08:34 INFO - Using env: {'DISPLAY': ':0', 08:08:34 INFO - 'HOME': '/home/cltbld', 08:08:34 INFO - 'LANG': 'en_US.UTF-8', 08:08:34 INFO - 'LANGUAGE': 'en_US:en', 08:08:34 INFO - 'LOGNAME': 'cltbld', 08:08:34 INFO - 'MAIL': '/var/mail/cltbld', 08:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:34 INFO - 'MOZ_NO_REMOTE': '1', 08:08:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:34 INFO - 'NO_EM_RESTART': '1', 08:08:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:34 INFO - 'PWD': '/builds/slave/test', 08:08:34 INFO - 'SHELL': '/bin/bash', 08:08:34 INFO - 'SHLVL': '1', 08:08:34 INFO - 'TERM': 'linux', 08:08:34 INFO - 'TMOUT': '86400', 08:08:34 INFO - 'USER': 'cltbld', 08:08:34 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', 08:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:34 INFO - '_': '/tools/buildbot/bin/python'} 08:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:08:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:08:34 INFO - Cleaning up... 08:08:34 INFO - Return code: 0 08:08:34 INFO - Running post-action listener: _resource_record_post_action 08:08:34 INFO - Running post-action listener: _start_resource_monitoring 08:08:34 INFO - Starting resource monitoring. 08:08:34 INFO - [mozharness: 2016-08-04 15:08:34.450823Z] Finished create-virtualenv step (success) 08:08:34 INFO - [mozharness: 2016-08-04 15:08:34.451260Z] Running install step. 08:08:34 INFO - Running pre-action listener: _resource_record_pre_action 08:08:34 INFO - Running main action method: install 08:08:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:08:34 INFO - Reading from file tmpfile_stdout 08:08:34 INFO - Detecting whether we're running mozinstall >=1.0... 08:08:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:08:34 INFO - Reading from file tmpfile_stdout 08:08:34 INFO - Output received: 08:08:34 INFO - Usage: mozinstall [options] installer 08:08:34 INFO - Options: 08:08:34 INFO - -h, --help show this help message and exit 08:08:34 INFO - -d DEST, --destination=DEST 08:08:34 INFO - Directory to install application into. [default: 08:08:34 INFO - "/builds/slave/test"] 08:08:34 INFO - --app=APP Application being installed. [default: firefox] 08:08:34 INFO - mkdir: /builds/slave/test/build/application 08:08:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:08:51 INFO - Reading from file tmpfile_stdout 08:08:51 INFO - Output received: 08:08:51 INFO - /builds/slave/test/build/application/firefox/firefox 08:08:51 INFO - Running post-action listener: _resource_record_post_action 08:08:51 INFO - [mozharness: 2016-08-04 15:08:51.054584Z] Finished install step (success) 08:08:51 INFO - [mozharness: 2016-08-04 15:08:51.054859Z] Running run-tests step. 08:08:51 INFO - Running pre-action listener: _resource_record_pre_action 08:08:51 INFO - Running main action method: run_tests 08:08:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:08:51 INFO - Python 2.7.3 08:08:51 INFO - Return code: 0 08:08:51 INFO - grabbing minidump binary from tooltool 08:08:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:08:51 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 0x1b033b0>, '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 0x1b042b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b04740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:08:51 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 08:08:51 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 08:08:51 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 08:08:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:08:51 INFO - Return code: 0 08:08:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:08:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:08:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:08:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:08:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:08:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 08:08:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 08:08:51 INFO - Using env: {'DISPLAY': ':0', 08:08:51 INFO - 'HOME': '/home/cltbld', 08:08:51 INFO - 'LANG': 'en_US.UTF-8', 08:08:51 INFO - 'LANGUAGE': 'en_US:en', 08:08:51 INFO - 'LOGNAME': 'cltbld', 08:08:51 INFO - 'MAIL': '/var/mail/cltbld', 08:08:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:08:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:08:51 INFO - 'MOZ_NO_REMOTE': '1', 08:08:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:08:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:08:51 INFO - 'NO_EM_RESTART': '1', 08:08:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:08:51 INFO - 'PWD': '/builds/slave/test', 08:08:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:08:51 INFO - 'SHELL': '/bin/bash', 08:08:51 INFO - 'SHLVL': '1', 08:08:51 INFO - 'TERM': 'linux', 08:08:51 INFO - 'TMOUT': '86400', 08:08:51 INFO - 'USER': 'cltbld', 08:08:51 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673', 08:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:08:51 INFO - '_': '/tools/buildbot/bin/python'} 08:08:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 08:08:51 INFO - mozversion application_buildid: 20160804065423 08:08:51 INFO - mozversion application_changeset: 62a983c56050b3ac647d8f95d9c2ca69c3ad2d91 08:08:51 INFO - mozversion application_display_name: Nightly 08:08:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:08:51 INFO - mozversion application_name: Firefox 08:08:51 INFO - mozversion application_remotingname: firefox 08:08:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:08:51 INFO - mozversion application_vendor: Mozilla 08:08:51 INFO - mozversion application_version: 51.0a1 08:08:51 INFO - mozversion platform_buildid: 20160804065423 08:08:51 INFO - mozversion platform_changeset: 62a983c56050b3ac647d8f95d9c2ca69c3ad2d91 08:08:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:08:51 INFO - mozversion platform_version: 51.0a1 08:08:51 INFO - using testdate: 1470323331 08:08:51 INFO - actual date: 1470323331 08:08:51 INFO - starting webserver on 'localhost:58216' 08:08:51 INFO - SUITE-START | Running 2 tests 08:08:51 INFO - TEST-START | dromaeo_css 08:08:51 INFO - operating with platform_type : linux_ 08:08:51 INFO - Initialising browser for dromaeo_css test... 08:08:51 INFO - TEST-INFO | started process 328 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpewHnUC/profile http://localhost:58216/getInfo.html) 08:08:55 INFO - PROCESS | 328 | __metrics Screen width/height:1600/1200 08:08:55 INFO - PROCESS | 328 | colorDepth:24 08:08:55 INFO - PROCESS | 328 | Browser inner width/height: 1024/697 08:08:55 INFO - PROCESS | 328 | __metrics 08:08:56 INFO - PROCESS | 328 | 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" 08:08:56 INFO - PROCESS | 328 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:08:57 INFO - TEST-INFO | 328: exit 0 08:08:57 INFO - Browser initialized. 08:08:57 INFO - Running cycle 1/1 for dromaeo_css test... 08:08:57 INFO - TEST-INFO | started process 411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpewHnUC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:09:09 INFO - PROCESS | 411 | RSS: Main: 157855744 08:09:09 INFO - PROCESS | 411 | 08:10:00 INFO - PROCESS | 411 | 1470323400007 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] 08:12:13 INFO - PROCESS | 411 | Cycle 1(1): loaded http://localhost:58216/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58216/tests/dromaeo/cssquery-ext.html) 08:12:14 INFO - PROCESS | 411 | RSS: Main: 233361408 08:12:14 INFO - PROCESS | 411 | 08:15:16 INFO - PROCESS | 411 | Cycle 1(1): loaded http://localhost:58216/tests/dromaeo/cssquery-ext.html (next: http://localhost:58216/tests/dromaeo/cssquery-jquery.html) 08:15:17 INFO - PROCESS | 411 | RSS: Main: 243359744 08:15:17 INFO - PROCESS | 411 | 08:18:19 INFO - PROCESS | 411 | Cycle 1(1): loaded http://localhost:58216/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58216/tests/dromaeo/cssquery-mootools.html) 08:18:20 INFO - PROCESS | 411 | RSS: Main: 214380544 08:18:20 INFO - PROCESS | 411 | 08:21:22 INFO - PROCESS | 411 | Cycle 1(1): loaded http://localhost:58216/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58216/tests/dromaeo/cssquery-prototype.html) 08:21:23 INFO - PROCESS | 411 | RSS: Main: 188854272 08:21:23 INFO - PROCESS | 411 | 08:24:26 INFO - PROCESS | 411 | Cycle 1(1): loaded http://localhost:58216/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58216/tests/dromaeo/cssquery-yui.html) 08:24:26 INFO - PROCESS | 411 | RSS: Main: 188477440 08:24:26 INFO - PROCESS | 411 | 08:27:29 INFO - PROCESS | 411 | Cycle 1(1): loaded http://localhost:58216/tests/dromaeo/cssquery-yui.html (next: http://localhost:58216/tests/dromaeo/cssquery-dojo.html) 08:27:30 INFO - PROCESS | 411 | RSS: Main: 281047040 08:27:30 INFO - PROCESS | 411 | 08:27:30 INFO - PROCESS | 411 | __start_tp_report 08:27:30 INFO - PROCESS | 411 | _x_x_mozilla_page_load 08:27:30 INFO - PROCESS | 411 | _x_x_mozilla_page_load_details 08:27:30 INFO - PROCESS | 411 | |i|pagename|runs| 08:27:30 INFO - PROCESS | 411 | |0;dojo.html;2610.7911367090633;2641.2208398522434;2678.2634775436754;2700.797440191985;2700.9324766880827;4593.977030114853;4683.32091846682;4843.660943733936;4938.629602779793;4950.1337265978445;4720.881977950553;4750.76246187691;4764.118638051954;4827.396575428072;4841.636877234213;4280.892977675552;4296.613304802567;4316.20150272199;4345.804438800245;4400.955990440103;4382.276924307485;4417.22698527758;4520.593146616804;4559.544045595447;4561.384213131218;4478.305862591304;4519.457665080195;4522.0729750401415;4526.321051842234;4529.6376289896725;4184.539700632928;4220.620144187038;4320.783960801948;4353.346997950302;4371.868843934687;4383.276759334738;4406.206882761102;4408.801603927799;4410.42664453619;4438.223310920576;4918.139325618003;4926.531979461945;4950.752462376903;4952.67807592509;4957.256411538262;4934.827281045146;5135.589152867799;5141.254518094893;5199.792008319662;5260.789568417259;5243.528082472596;5263.921041184385;5283.735813209324;5287.365516138049;5305.071612467803;4933.136701077333;4934.654574179773;4935.851924442272;4935.950640493621;4944.208926571731;5135.948640513622;5198.506141916512;5204.505571970657;5243.4232234454175;5336;5026.698398096126;5058.089543882136;5062.594992400599;5107.821226257138;5125.179971204664;5132.230165475208;5134.974325128425;5144.71704056273;5171.68969861802;5181.766820493087;4806.49531799156;5005.74971251436;5058.645894787403;5081.085404627129;5134.332536770196;5078.97460512695;5084.059449001947;5089.05852417304;5122.667026643257;5135.460776618476;4307.39696442492;4312.89217769552;4316.115196384733;4355.60799528044;4357.019670574159;3693.1874987502706;3710.0539362462937;3749.5125633667994;3768.3028639701197;3795;4463.196624607602;4479.59683628475;4482.932756008662;4527.864164075083;4529.773511324421;5123.795048198031;5168.741562921914;5170.250313704491;5170.560502357342;5217.947820521822;4272.102858399709;4463.397441345377;4495.033567782943;4506.639468842551;4547.658925580595;4653.464851542116;4715.882102947385;4734.597559207506;4736.834210802605;4739.312799644033;4898.461169271449;4920.581750551171;4933.260010998379;4939.975300123477;4989.900201996013;5239.135542635422;5245.396779370421;5246.6065045121;5249.47505249472;5252.107141785829;4687.437507499122;4854.417469903493;4911.68074075184;4912.312276281395;4995.125852975787;5110.923336149886;5121.487851214849;5121.8463446096675;5123.28274041627;5174.120399532013;5196.714180720097;5214.165733482625;5215;5216.921746173886;5220.138677118233;4849.2726091086615;4951.405831300267;4986.252062190701;5003.699778013185;5082.542571168613;5005.799768009385;5015.3480047593575;5025.422076461254;5029.547340739351;5069.847904562722;4928.926066108939;4972.378452693413;5015.473375295542;5019.372578427697;5019.7741101651245;4796.952030479651;5065.645404821627;5118.641695081308;5120.103981803244;5184.118699820964;5024.623153263593;5035.244713293036;5038.269450929668;5044.192929131322;5084.313617661568 08:27:30 INFO - PROCESS | 411 | |1;ext.html;568.1704711121762;572.9885402291951;582.868854507736;587.0636335045601;589.1339730596025;28465.146045618614;39488.80255598722;40239.396409053814;40298.39552406713;43655;39452.60547394525;39891.60108398915;39948.80025599868;39962.800185999105;40004.59949405571;7702.845943081135;7841.960790196041;7843.882341764878;7845.176256493071;7848.68605255789;7676.577788221645;7752.496087754306;7757.5733334666575;7773.533587984711;7781.260780225898;7788.532688038707;7800.726974555863;7826.921730782705;7831.686732530692;7833.569153696573;7747.728829490969;7775.961120194419;7792.220777922219;7794.727184548542;7796.493227940223;7691.192424795372;7747.72882949094;7747.96126019372;7751.418643601696;7755.573443460607;37756;37938.43092353617;38101;38174;38218.808905955295;2837.6736675282195;2901.231173738961;2949.6607890092487;3029.5924120485015;3201.439748044106;28027;28192.577111343347;28330.575041374395;28450.146495605164;29000.12999609994;3265.0857759827286;3293.357795229931;3324.1357247115925;3342.5320455136302;3370.8483118259737;249633;251724;252335;252638;252669;48991.265131023065;49195.50804491981;49234.75382623064;49288;49289.50710492849;32581.348373032408;33249.3350132996;52498.73750631222;52645.47354526406;52677;13188.670283242804;13513.527026554024;13517.729645407037;13518.526851560346;13523.188608683511;9768.120869121813;9804.215662746963;9826.508674566387;9837.704868853945;9840.3603765755;17978.910105449388;18165.18256678426;18176.36382726598;18227.63544729098;18304.816951830577;6953.33943275388;6998.650067496605;7138.750143744944;7170.784876453715;7218.855622887513;764.7858599592123;798.6525861250375;840.5839109640767;846.9703560375357;883.2183517586982;24150;25200;25322.620160697603;25416.49167016649;25465;721.4661150748514;966.7389804752818;970.6117552978724;985.975350616226;986.1371300112402;14263.92868035674;15143.545693629208;15774.211289435483;15863.20683965797;16508.83491165097;374659;377295;377326;378231.3061216281;379362;48749.75625121852;49092.7545362278;49166;49230.99999999929;49277.75361123172;1109.073923274059;1180.468789044916;1210.5823490895627;1216.920900141488;1238.3127364312893;27057.45885082248;28112.43775124445;28152;28755;28823.85588072046;40422.79788601038;41152.38271425991;41165;41221.38167927424;41228.79385603053;314342;316043;317486;317561;424035;38032.429513556766;38274.2345153101;38312.80843595764;38433.4234986481;38949.8052509747;41421.79289103656;41640.583594164884;41860;42053;42290.788546057076;35692.28615427625;35813.82093089518;35891.64108358883;36442.63557364392;36601.45097823588;35503;35799.46300805438;35816.104597385274;36297.63702363048;36665.81667091647;35024.474632881036;35198.296034079685;35307.82346088253;35331.29337413289;35402.645973540966;30311.242218944702;31856.68143318537;31916.5212521817;32247.67752322447;32611.510827338083;24588.754112458646;24746.876265619278;24804.37989050288;24912.50174996526;25259.74740252574 08:27:30 INFO - PROCESS | 411 | |2;jquery.html;345.3300596842125;358.1654744445441;368.8524590163933;372.53805281451;392.5054431416414;12290.078244131691;15976.121313327762;16177.433789817373;17311.307547698078;17394.913025434857;14966.925165374185;15398.461053863117;15501.534953951372;15503.069815811059;15557.455489057886;4706.976465117669;4903.607711383099;5064.772085256172;5094.133997220481;5105;4915.459299477055;4967.031428871372;4977.203647416414;4978.278149668296;4988.775505102279;4937.086638971802;4947.50524947506;4949.010197960422;5160.7419629018395;5424.403315635277;5474.507294343508;5495.065838807413;5497.945020549783;5503.091989821694;5507.173923911405;5249.2126181073145;5296.92054619181;5347.54545863602;5399.2980912481125;5411.675299482044;19919.800801992085;20068;20415;20563.897180514152;20746.5850682987;1852;1854.7125195594704;1872.4382685194387;2104.736907886514;2283.8058765004994;8725.869111963326;8964.686235981775;9023.774405639846;9031.27749780016;9341.205997490153;1662.6159416695673;1713.811480737118;1720.0797573298225;1741.3556983915905;1774.5918438759159;66234.3376566233;67568.66215668939;67956.66021669909;68953.65523172352;69141;9685.17675997534;9813.852792208123;9917.603295868228;9941.254405919584;10198;12912.870871291354;12923;12937.676558085936;12938.417771200318;12943.546975855988;6672.266050734415;6876.17485901685;6956.826079347956;7022.08712867324;7277.745278915212;6397.584157029778;6421.678916054178;6448.9355106449275;6549.901751473732;6726.159230096238;4262.339337402707;4291.9785401072795;4300.935485967713;4371.693981421334;4475.127350166751;1803.9188236529387;1827.5602071234784;1832.853371730285;1847.5104097414196;1908.6182763447089;816.1348970091722;867.7266661001764;870.7910101575576;916.3722849847876;924.5146298193367;15414.152221627694;16444.424445144603;16516.256768445448;17125.14374281281;17330;839.3872473094675;855.6449073634496;859.8968123825056;875.369733791669;878.8198419324151;8604.956975215084;9302.90697093034;9349.626014959462;9421.90578094224;9669.70990870275;408242;414995.17526535725;415110;415545;415695;76675.61662191765;76786.6160669193;77339;79024;80625.59687201644;903.6656437118309;906.5014242166782;927.3276874266103;952.3381250031161;952.4333021851987;15321;15677.294521746777;15837.208139592743;15942.760858587362;16197.186610219564;36543.45184822177;37158.8142059288;37629.247415052094;38028.61971380251;39152.608473914894;52300.73849630728;52460.47539524556;53248;54929.1760623599;55400.16899746587;7166.964165179141;7225.096862892138;7479.252074792477;7661.310482056641;7850.489718168301;9739;11818.113641476752;11923.344216068199;12045.698857528632;12138.635840924786;9849.507524623883;9875.802483950425;9998.850017249893;10447.947760261453;10573.04842564173;10244.770627524447;10297.485125743533;10603.94698026505;10735.677929662123;10861;10282.948585257025;10387.117095047006;10484.318519296221;10596.947015264874;10671.199660025373;6422.871542569216;6510.511711621552;6640.169978752656;6944.548604340702;7593.354564862048;7640.656170472231;9904.900950990397;10004;10251.487425628839;10477.37135771856 08:27:30 INFO - PROCESS | 411 | |3;mootools.html;1147.8048731715608;1340.4772138865844;1396.7974643676666;1440.510226522982;1655.1145137351518;6274.968625156874;7195.424366050716;7449.366803821668;7475.439342049341;7605.505642133257;7425.1832298447125;7496.137944136426;7503.287187717158;7508.174100848916;7512.399008079355;2132.8720276783365;2155.568886222754;2159.9352019439443;2161.135545781684;2161.27597254919;2088.916443342272;2125.5961367340233;2125.7130287411155;2127.1385089038963;2129.58473097746;2079.6048750737314;2132.1364847236896;2142.2287976328507;2144.1209104267255;2144.7855214478504;2035.7964203579672;2037.3073155127329;2038.8878611676425;2041.6631255842767;2046.0588129460466;1985.682290833474;2044.6932960055963;2051.2615458434952;2051.712760213571;2054.9280775172797;7177.138743350779;7177.820554486128;7368.336849683555;7412.444066694966;7488.026556547614;4210.473690788652;4394.648428125743;4403.119376124788;4409.4488188976375;4416.514183439819;2633.2626864477975;2743.9725602744115;2779.6664400271893;2792.176307989148;2792.664880214367;896.332232486795;897.1477096758106;912.1334732004556;947.9194268487187;949.4113649537331;9910.702678919644;9954.701358959242;9982.051705088004;9992.550335234931;10007.64973225941;3647.6717095461004;3763.397856342972;3898.1813819098306;3900.356441187229;3925.666318362914;8029.116797152308;8036.959815200887;8046.678132874737;8058.758237252775;8063.556504392314;4282.993496528314;4285.100128972888;4287.399764033038;4295.892602684958;4300.376445415397;3461.273132642123;3750.5686846012513;3916.6083391661177;3974.2448934702315;3996.200759847984;3325.534425180477;3351.798892066484;3449.6550344965303;3454.9309013819584;3468.705160061423;968.1722127580957;969.2924165359327;975.6926568131016;987.1707765477033;994.6319861651235;774.2953911940108;776.4564804636777;778.1479280188184;787.4605894961969;807.3299161695778;4959.801607935714;4967.081089998362;5053.797848086109;5070.138076527;5305.310309659797;367.8712450642254;371.66550104905804;374.4177803515505;374.82383279858425;375.69756346141617;3404.914877128042;3451.378751824696;3498.3877821381157;3521.2957408517887;3700.6854417374825;8826.86759698605;9178.128077832594;9219.07809219086;9227.123423274777;9237.584308706124;9166.450012999241;9175.174234318943;9180.127887850644;9184;9208.26333893287;6944.513884028171;6980.546264492792;6992.580445173204;6992.615406152609;6994.5803251805055;4688.765561721969;4849.224124140262;4855.49017353187;4918.5573298403315;5070.898582028412;8340.374471914509;8485.066642669424;8507.95746021266;8588.098249683693;8589.269912057294;8439.915600844159;8554.31565474773;8588.871166932626;8617.69838055665;8646.178613031752;5557.360903495988;6082.543809214415;6207.503399727921;6265.185525881606;6269;7053.435725141873;7253.347198752138;7278.818029549304;7289.781306560812;7292.671829767567;6341.054760500214;6582.3746744059235;6583.604983700993;6686.53194276396;6697.09589205451;6428.292887782247;6455.903161452676;6484.092227088117;6512.055751915851;6536.1503004610995;6009.278886533644;6092.45167934888;6098.908516372169;6099.969500152471;6101.237345331833;4342.565743425632;4492.483364413004;4544.818207271672;4582.564656357641;4684.695494792828;4583.793729282123;4658.417697787777;4674.62602991753;4720.244760838249;4783.617310615212 08:27:30 INFO - PROCESS | 411 | |4;prototype.html;282.3238344165723;288.2347367738654;289.26238092863196;289.7927981493232;295.93637367965886;4899.461059283481;4917.704937703731;4918.8770280743;4923.876903077425;4933.1860243059855;4818.566329030386;4837.226043832988;4865.708057516552;4869.514797986612;4872.342233798436;3616.4936908832783;3686.6313368663054;3695.519582454277;3762.1911289072846;3783.1677031053123;3775.5469343678797;3777.471154038437;3779.4708740776314;3782.470454136423;3806.9809650951706;3757.304898593769;3765.585785563586;3767.60440153784;3770.1328694400304;3790.241951609675;3617.4212126059706;3643.799591022506;3735.916584190609;3765;3766.7551609145316;3321.634620191777;3324.484704870749;3331.6168640606397;3334.733221342287;3353.597568291796;4675.322078298627;4694.342792009122;4697.741624210667;4742.786574604151;4770;4183.435236243129;4281.293586558214;4310.038932285803;4358.934615980763;4367.061081867382;4964.503549645043;4965.975170124162;4973.502649735034;4996.92566098287;5002.349694539723;3638.308721342963;3642.581103173116;3644.1982763791925;3647.6717095461536;3654.6162652921594;5102;5216.791673121003;5222.21666749983;5310.92033619496;5320.707361095138;3679.6688298053305;3711.3690672585726;3711.406175012039;3716.442533619979;3721;3749.9062523437133;3770.5098337215986;3775.754575952554;3798.867039653599;3798.924021519554;4300.247456695129;4316.179925814148;4316.3093904975685;4327.76197309151;4342.348647702806;4851.248056551241;5011.7494125294315;5018.548330650259;5021.6735912165595;5069.112905241568;1292.8965682745359;1299.577637267873;1305.8106574546637;1307.47700919631;1314.723907979316;850.5832142250376;857.5883575883611;859.8108416148438;860.97543922733;895.2166854002747;4392.846250381285;4430.269005614037;4456.22016147173;4487.506374298824;4504.594586487232;5125.718085505333;5129.692218466829;5148.253503242009;5152.433232344439;5157.174852023658;4348.412964249849;4490.371348011281;4490.528494508095;4492.752898590609;4507.18870603288;2705.2830999785074;2707.7273681369725;2708.6885008223912;2724.7956403269436;2744.972550274512;4826.903461930741;4838.346823178826;4843.709377437365;4844.854654360375;4862.523295843489;4962.478939711351;5181.637285389987;5186.740662966837;5220.869478263074;5224.52979231871;4830.806767729322;4843.612510999112;4850.72576011191;4858.5384388483035;4870.391201099863;5093.745312734422;5097.235414687678;5108.131617625087;5109.770060347368;5112.846614601568;4834.419869615669;5021.698698078127;5024.4473107957365;5034;5074.5686616637995;4955.4053513577155;4973.204287314013;4975.179095449211;4975.303457516023;4981.903981124147;3687.764598859412;3710.3692372297314;3722.367197576473;3723.3298006359114;3728.683061939657;5017.222330538772;5228.085085110167;5260.44765299638;5268.367795864521;5270.104082306094;5019.472955339636;5020.648554601143;5022.372203474566;5037.471065538066;5055.368078990126;5026.673266237683;5028.245763135413;5052.837847295069;5066.9746651266505;5082.957993611227;4667.206574882211;4960.677555958851;5001.624878134082;5021.246812978083;5022.166909078233;4874.53691899269;4907.950920490749;5058.570021548209;5085.4406015337545;5092.337996060636;4899;4925.482824303396;4983.626228032839;4995.600351971906;5022.723750193628 08:27:30 INFO - PROCESS | 411 | |5;yui.html;584.4885724990634;610.4597431273322;632.784853149929;658.8451713847245;720.9726140250145;12010.399480025997;12913.354332283396;12985.48058077678;13009.089363744542;13025.934870325647;13040.608781736539;13197.868021319784;13226.603201903934;13251.271180085092;13268.734625307488;614.0451597765496;728.5118970289918;742.4913933955231;752.0449029732237;763.8090477380655;758.2076729817327;768.174212721324;768.4543973778624;768.757841279995;769.3537428560008;810.116972499975;811.0470197517923;811.7524155132683;811.8457493076326;811.9594020298991;647.2007071267028;782.2255966593088;800.1598321762126;802.3781569283793;803.895493585836;595.8629515211526;596.1385797522581;596.1832289763053;596.272547492059;596.4006173795308;11438.42807859612;11599.478023488964;11611.361375124448;11629.88370116305;11630.185886987914;12119.454624541917;12572.559960401433;12751.234925904475;13319.800202996963;13336;11780.99723047084;11931.659970563607;12143.696407589792;12283;12385.442655080453;4088.5093788745244;4118.155778065489;4122.896927576805;4126.442930204414;4176.4570605821355;65428;65888.3411165887;66013.66993165003;66202;66484.6675766623;10256.230782691327;10301.484925753683;10455.268131230892;10489.265751397328;10955.616553420592;17807.643847123243;18046.548836278937;18222.63554728898;18276.634467310578;18390.356337528123;6029.78895738647;6224.315325314212;6481.513886458534;6650.634215118215;6956.617386043715;3604.2070744436182;3609.5848977367414;3618.6972689832164;3619.4027985382118;3634.164142247245;2793.7764978801647;2927.1218634409593;2938.7502062324943;2940.1473572664117;3028.78798484104;545.9153831156177;552.2461839589013;556.5464146720491;558.4471373340444;564.6104188110273;497.1300224606938;537.4974398936928;538.090626840638;586.9442402971711;592.8873514032321;7656.502327348704;7917.208279172037;8339.332853371716;8397.832043359098;8843.646254149891;559.7732918168149;561.1806762127259;562.7664519224476;567.5062695454898;575.3900865083025;3928.52857657083;3975.383815508601;3985.342418500973;4017.3572228443895;4079.0249169188687;58612;75460.62269688616;78367.21632783713;78847;92751.53624231835;80663.59668201621;81847.590762047;82471;82741.58629206815;83788.16211837926;65356;70177;71436.64281678663;71984;74566;7951.920480795349;8449.915500844912;8555.700550480704;8574.09971952961;8742.56287185651;42276;43515.56484435115;43882.780586096866;45059;45195.32207016832;53737.46262537324;55139.448605515034;57173.71413142908;59027.11459328199;60362;10973.122150228122;11225.15811314171;11249.831252531383;11379.43102844871;11569.768604628029;12222.87777122253;12464.937675311565;12557.74884502323;12832.422540985492;13213.801792972921;11409.429528523706;11427.542898284308;11805.173637845268;12249.448774805333;12290.385480726107;10691.679249622524;10801.135909127093;11075.778484430428;11272.774544509228;11436.256643318158;11059.778804424028;11067.889321107008;11273.041791447818;11411;12537.686557836127;9538.14156725898;9712.465814380277;9817.410955342702;9977.650782222587;10144.239182061227;8676.575440135997;8808.163224493663;9157.358984870994;9324.160825525736;9465.148136667733 08:27:30 INFO - PROCESS | 411 | __end_tp_report 08:27:30 INFO - PROCESS | 411 | __start_cc_report 08:27:30 INFO - PROCESS | 411 | _x_x_mozilla_cycle_collect,1113 08:27:30 INFO - PROCESS | 411 | __end_cc_report 08:27:30 INFO - PROCESS | 411 | __startTimestamp1470324450073__endTimestamp 08:27:30 INFO - PROCESS | 411 | 08:27:30 INFO - PROCESS | 411 | ------- Summary: start ------- 08:27:30 INFO - PROCESS | 411 | Number of tests: 6 08:27:30 INFO - PROCESS | 411 | 08:27:30 INFO - PROCESS | 411 | [#0] dojo.html Cycles:165 Average:4774.24 Median:4939.98 stddev:518.03 (10.5%) stddev-sans-first:491.03 08:27:30 INFO - PROCESS | 411 | Values: 2610.8 2641.2 2678.3 2700.8 2700.9 4594.0 4683.3 4843.7 4938.6 4950.1 4720.9 4750.8 4764.1 4827.4 4841.6 4280.9 4296.6 4316.2 4345.8 4401.0 4382.3 4417.2 4520.6 4559.5 4561.4 4478.3 4519.5 4522.1 4526.3 4529.6 4184.5 4220.6 4320.8 4353.3 4371.9 4383.3 4406.2 4408.8 4410.4 4438.2 4918.1 4926.5 4950.8 4952.7 4957.3 4934.8 5135.6 5141.3 5199.8 5260.8 5243.5 5263.9 5283.7 5287.4 5305.1 4933.1 4934.7 4935.9 4936.0 4944.2 5135.9 5198.5 5204.5 5243.4 5336.0 5026.7 5058.1 5062.6 5107.8 5125.2 5132.2 5135.0 5144.7 5171.7 5181.8 4806.5 5005.7 5058.6 5081.1 5134.3 5079.0 5084.1 5089.1 5122.7 5135.5 4307.4 4312.9 4316.1 4355.6 4357.0 3693.2 3710.1 3749.5 3768.3 3795.0 4463.2 4479.6 4482.9 4527.9 4529.8 5123.8 5168.7 5170.3 5170.6 5217.9 4272.1 4463.4 4495.0 4506.6 4547.7 4653.5 4715.9 4734.6 4736.8 4739.3 4898.5 4920.6 4933.3 4940.0 4989.9 5239.1 5245.4 5246.6 5249.5 5252.1 4687.4 4854.4 4911.7 4912.3 4995.1 5110.9 5121.5 5121.8 5123.3 5174.1 5196.7 5214.2 5215.0 5216.9 5220.1 4849.3 4951.4 4986.3 5003.7 5082.5 5005.8 5015.3 5025.4 5029.5 5069.8 4928.9 4972.4 5015.5 5019.4 5019.8 4797.0 5065.6 5118.6 5120.1 5184.1 5024.6 5035.2 5038.3 5044.2 5084.3 08:27:30 INFO - PROCESS | 411 | 08:27:30 INFO - PROCESS | 411 | [#1] ext.html Cycles:180 Average:47394.06 Median:38137.50 stddev:86245.07 (226.1%) stddev-sans-first:86415.35 08:27:30 INFO - PROCESS | 411 | Values: 568.2 573.0 582.9 587.1 589.1 28465.1 39488.8 40239.4 40298.4 43655.0 39452.6 39891.6 39948.8 39962.8 40004.6 7702.8 7842.0 7843.9 7845.2 7848.7 7676.6 7752.5 7757.6 7773.5 7781.3 7788.5 7800.7 7826.9 7831.7 7833.6 7747.7 7776.0 7792.2 7794.7 7796.5 7691.2 7747.7 7748.0 7751.4 7755.6 37756.0 37938.4 38101.0 38174.0 38218.8 2837.7 2901.2 2949.7 3029.6 3201.4 28027.0 28192.6 28330.6 28450.1 29000.1 3265.1 3293.4 3324.1 3342.5 3370.8 249633.0 251724.0 252335.0 252638.0 252669.0 48991.3 49195.5 49234.8 49288.0 49289.5 32581.3 33249.3 52498.7 52645.5 52677.0 13188.7 13513.5 13517.7 13518.5 13523.2 9768.1 9804.2 9826.5 9837.7 9840.4 17978.9 18165.2 18176.4 18227.6 18304.8 6953.3 6998.7 7138.8 7170.8 7218.9 764.8 798.7 840.6 847.0 883.2 24150.0 25200.0 25322.6 25416.5 25465.0 721.5 966.7 970.6 986.0 986.1 14263.9 15143.5 15774.2 15863.2 16508.8 374659.0 377295.0 377326.0 378231.3 379362.0 48749.8 49092.8 49166.0 49231.0 49277.8 1109.1 1180.5 1210.6 1216.9 1238.3 27057.5 28112.4 28152.0 28755.0 28823.9 40422.8 41152.4 41165.0 41221.4 41228.8 314342.0 316043.0 317486.0 317561.0 424035.0 38032.4 38274.2 38312.8 38433.4 38949.8 41421.8 41640.6 41860.0 42053.0 42290.8 35692.3 35813.8 35891.6 36442.6 36601.5 35503.0 35799.5 35816.1 36297.6 36665.8 35024.5 35198.3 35307.8 35331.3 35402.6 30311.2 31856.7 31916.5 32247.7 32611.5 24588.8 24746.9 24804.4 24912.5 25259.7 08:27:30 INFO - PROCESS | 411 | 08:27:30 INFO - PROCESS | 411 | [#2] jquery.html Cycles:180 Average:24870.41 Median:4958.02 stddev:68272.36 (1377.0%) stddev-sans-first:68439.05 08:27:30 INFO - PROCESS | 411 | Values: 345.3 358.2 368.9 372.5 392.5 12290.1 15976.1 16177.4 17311.3 17394.9 14966.9 15398.5 15501.5 15503.1 15557.5 4707.0 4903.6 5064.8 5094.1 5105.0 4915.5 4967.0 4977.2 4978.3 4988.8 4937.1 4947.5 4949.0 5160.7 5424.4 5474.5 5495.1 5497.9 5503.1 5507.2 5249.2 5296.9 5347.5 5399.3 5411.7 19919.8 20068.0 20415.0 20563.9 20746.6 1852.0 1854.7 1872.4 2104.7 2283.8 8725.9 8964.7 9023.8 9031.3 9341.2 1662.6 1713.8 1720.1 1741.4 1774.6 66234.3 67568.7 67956.7 68953.7 69141.0 9685.2 9813.9 9917.6 9941.3 10198.0 12912.9 12923.0 12937.7 12938.4 12943.5 6672.3 6876.2 6956.8 7022.1 7277.7 6397.6 6421.7 6448.9 6549.9 6726.2 4262.3 4292.0 4300.9 4371.7 4475.1 1803.9 1827.6 1832.9 1847.5 1908.6 816.1 867.7 870.8 916.4 924.5 15414.2 16444.4 16516.3 17125.1 17330.0 839.4 855.6 859.9 875.4 878.8 8605.0 9302.9 9349.6 9421.9 9669.7 408242.0 414995.2 415110.0 415545.0 415695.0 76675.6 76786.6 77339.0 79024.0 80625.6 903.7 906.5 927.3 952.3 952.4 15321.0 15677.3 15837.2 15942.8 16197.2 36543.5 37158.8 37629.2 38028.6 39152.6 52300.7 52460.5 53248.0 54929.2 55400.2 7167.0 7225.1 7479.3 7661.3 7850.5 9739.0 11818.1 11923.3 12045.7 12138.6 9849.5 9875.8 9998.9 10447.9 10573.0 10244.8 10297.5 10603.9 10735.7 10861.0 10282.9 10387.1 10484.3 10596.9 10671.2 6422.9 6510.5 6640.2 6944.5 7593.4 7640.7 9904.9 10004.0 10251.5 10477.4 08:27:30 INFO - PROCESS | 411 | 08:27:30 INFO - PROCESS | 411 | [#3] mootools.html Cycles:180 Average:4859.10 Median:5431.34 stddev:2729.78 (50.3%) stddev-sans-first:2723.18 08:27:30 INFO - PROCESS | 411 | Values: 1147.8 1340.5 1396.8 1440.5 1655.1 6275.0 7195.4 7449.4 7475.4 7605.5 7425.2 7496.1 7503.3 7508.2 7512.4 2132.9 2155.6 2159.9 2161.1 2161.3 2088.9 2125.6 2125.7 2127.1 2129.6 2079.6 2132.1 2142.2 2144.1 2144.8 2035.8 2037.3 2038.9 2041.7 2046.1 1985.7 2044.7 2051.3 2051.7 2054.9 7177.1 7177.8 7368.3 7412.4 7488.0 4210.5 4394.6 4403.1 4409.4 4416.5 2633.3 2744.0 2779.7 2792.2 2792.7 896.3 897.1 912.1 947.9 949.4 9910.7 9954.7 9982.1 9992.6 10007.6 3647.7 3763.4 3898.2 3900.4 3925.7 8029.1 8037.0 8046.7 8058.8 8063.6 4283.0 4285.1 4287.4 4295.9 4300.4 3461.3 3750.6 3916.6 3974.2 3996.2 3325.5 3351.8 3449.7 3454.9 3468.7 968.2 969.3 975.7 987.2 994.6 774.3 776.5 778.1 787.5 807.3 4959.8 4967.1 5053.8 5070.1 5305.3 367.9 371.7 374.4 374.8 375.7 3404.9 3451.4 3498.4 3521.3 3700.7 8826.9 9178.1 9219.1 9227.1 9237.6 9166.5 9175.2 9180.1 9184.0 9208.3 6944.5 6980.5 6992.6 6992.6 6994.6 4688.8 4849.2 4855.5 4918.6 5070.9 8340.4 8485.1 8508.0 8588.1 8589.3 8439.9 8554.3 8588.9 8617.7 8646.2 5557.4 6082.5 6207.5 6265.2 6269.0 7053.4 7253.3 7278.8 7289.8 7292.7 6341.1 6582.4 6583.6 6686.5 6697.1 6428.3 6455.9 6484.1 6512.1 6536.2 6009.3 6092.5 6098.9 6100.0 6101.2 4342.6 4492.5 4544.8 4582.6 4684.7 4583.8 4658.4 4674.6 4720.2 4783.6 08:27:30 INFO - PROCESS | 411 | 08:27:30 INFO - PROCESS | 411 | [#4] prototype.html Cycles:180 Average:4189.58 Median:4837.79 stddev:1207.70 (25.0%) stddev-sans-first:1174.94 08:27:30 INFO - PROCESS | 411 | Values: 282.3 288.2 289.3 289.8 295.9 4899.5 4917.7 4918.9 4923.9 4933.2 4818.6 4837.2 4865.7 4869.5 4872.3 3616.5 3686.6 3695.5 3762.2 3783.2 3775.5 3777.5 3779.5 3782.5 3807.0 3757.3 3765.6 3767.6 3770.1 3790.2 3617.4 3643.8 3735.9 3765.0 3766.8 3321.6 3324.5 3331.6 3334.7 3353.6 4675.3 4694.3 4697.7 4742.8 4770.0 4183.4 4281.3 4310.0 4358.9 4367.1 4964.5 4966.0 4973.5 4996.9 5002.3 3638.3 3642.6 3644.2 3647.7 3654.6 5102.0 5216.8 5222.2 5310.9 5320.7 3679.7 3711.4 3711.4 3716.4 3721.0 3749.9 3770.5 3775.8 3798.9 3798.9 4300.2 4316.2 4316.3 4327.8 4342.3 4851.2 5011.7 5018.5 5021.7 5069.1 1292.9 1299.6 1305.8 1307.5 1314.7 850.6 857.6 859.8 861.0 895.2 4392.8 4430.3 4456.2 4487.5 4504.6 5125.7 5129.7 5148.3 5152.4 5157.2 4348.4 4490.4 4490.5 4492.8 4507.2 2705.3 2707.7 2708.7 2724.8 2745.0 4826.9 4838.3 4843.7 4844.9 4862.5 4962.5 5181.6 5186.7 5220.9 5224.5 4830.8 4843.6 4850.7 4858.5 4870.4 5093.7 5097.2 5108.1 5109.8 5112.8 4834.4 5021.7 5024.4 5034.0 5074.6 4955.4 4973.2 4975.2 4975.3 4981.9 3687.8 3710.4 3722.4 3723.3 3728.7 5017.2 5228.1 5260.4 5268.4 5270.1 5019.5 5020.6 5022.4 5037.5 5055.4 5026.7 5028.2 5052.8 5067.0 5083.0 4667.2 4960.7 5001.6 5021.2 5022.2 4874.5 4908.0 5058.6 5085.4 5092.3 4899.0 4925.5 4983.6 4995.6 5022.7 08:27:30 INFO - PROCESS | 411 | 08:27:30 INFO - PROCESS | 411 | [#5] yui.html Cycles:180 Average:16917.86 Median:27842.68 stddev:23266.25 (83.6%) stddev-sans-first:23299.19 08:27:30 INFO - PROCESS | 411 | Values: 584.5 610.5 632.8 658.8 721.0 12010.4 12913.4 12985.5 13009.1 13025.9 13040.6 13197.9 13226.6 13251.3 13268.7 614.0 728.5 742.5 752.0 763.8 758.2 768.2 768.5 768.8 769.4 810.1 811.0 811.8 811.8 812.0 647.2 782.2 800.2 802.4 803.9 595.9 596.1 596.2 596.3 596.4 11438.4 11599.5 11611.4 11629.9 11630.2 12119.5 12572.6 12751.2 13319.8 13336.0 11781.0 11931.7 12143.7 12283.0 12385.4 4088.5 4118.2 4122.9 4126.4 4176.5 65428.0 65888.3 66013.7 66202.0 66484.7 10256.2 10301.5 10455.3 10489.3 10955.6 17807.6 18046.5 18222.6 18276.6 18390.4 6029.8 6224.3 6481.5 6650.6 6956.6 3604.2 3609.6 3618.7 3619.4 3634.2 2793.8 2927.1 2938.8 2940.1 3028.8 545.9 552.2 556.5 558.4 564.6 497.1 537.5 538.1 586.9 592.9 7656.5 7917.2 8339.3 8397.8 8843.6 559.8 561.2 562.8 567.5 575.4 3928.5 3975.4 3985.3 4017.4 4079.0 58612.0 75460.6 78367.2 78847.0 92751.5 80663.6 81847.6 82471.0 82741.6 83788.2 65356.0 70177.0 71436.6 71984.0 74566.0 7951.9 8449.9 8555.7 8574.1 8742.6 42276.0 43515.6 43882.8 45059.0 45195.3 53737.5 55139.4 57173.7 59027.1 60362.0 10973.1 11225.2 11249.8 11379.4 11569.8 12222.9 12464.9 12557.7 12832.4 13213.8 11409.4 11427.5 11805.2 12249.4 12290.4 10691.7 10801.1 11075.8 11272.8 11436.3 11059.8 11067.9 11273.0 11411.0 12537.7 9538.1 9712.5 9817.4 9977.7 10144.2 8676.6 8808.2 9157.4 9324.2 9465.1 08:27:30 INFO - PROCESS | 411 | -------- Summary: end -------- 08:27:30 INFO - PROCESS | 411 | 08:27:30 INFO - TEST-INFO | 411: exit 0 08:27:30 INFO - TEST-OK | dromaeo_css | took 1119594ms 08:27:30 INFO - TEST-START | kraken 08:27:30 INFO - operating with platform_type : linux_ 08:27:30 INFO - Initialising browser for kraken test... 08:27:30 INFO - TEST-INFO | started process 603 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptPXSKC/profile http://localhost:58216/getInfo.html) 08:27:35 INFO - PROCESS | 603 | __metrics Screen width/height:1600/1200 08:27:35 INFO - PROCESS | 603 | colorDepth:24 08:27:35 INFO - PROCESS | 603 | Browser inner width/height: 1024/697 08:27:35 INFO - PROCESS | 603 | __metrics 08:27:35 INFO - PROCESS | 603 | 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" 08:27:35 INFO - PROCESS | 603 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:27:36 INFO - PROCESS | 603 | console.error: PushService: 08:27:36 INFO - PROCESS | 603 | stateChangeProcessEnqueue: Error transitioning state 08:27:36 INFO - PROCESS | 603 | UnknownError 08:27:36 INFO - TEST-INFO | 603: exit 0 08:27:36 INFO - Browser initialized. 08:27:36 INFO - Running cycle 1/1 for kraken test... 08:27:36 INFO - TEST-INFO | started process 682 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptPXSKC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:27:48 INFO - PROCESS | 682 | RSS: Main: 158330880 08:27:48 INFO - PROCESS | 682 | 08:27:51 INFO - PROCESS | 682 | Cycle 1(1): loaded http://localhost:58216/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58216/tests/kraken/driver.html?testName=audio-beat-detection) 08:27:52 INFO - PROCESS | 682 | RSS: Main: 214339584 08:27:52 INFO - PROCESS | 682 | 08:27:55 INFO - PROCESS | 682 | Cycle 1(1): loaded http://localhost:58216/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58216/tests/kraken/driver.html?testName=audio-dft) 08:27:55 INFO - PROCESS | 682 | RSS: Main: 191934464 08:27:55 INFO - PROCESS | 682 | 08:27:58 INFO - PROCESS | 682 | Cycle 1(1): loaded http://localhost:58216/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58216/tests/kraken/driver.html?testName=audio-fft) 08:27:59 INFO - PROCESS | 682 | RSS: Main: 270880768 08:27:59 INFO - PROCESS | 682 | 08:28:01 INFO - PROCESS | 682 | Cycle 1(1): loaded http://localhost:58216/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58216/tests/kraken/driver.html?testName=audio-oscillator) 08:28:02 INFO - PROCESS | 682 | RSS: Main: 181018624 08:28:02 INFO - PROCESS | 682 | 08:28:04 INFO - PROCESS | 682 | Cycle 1(1): loaded http://localhost:58216/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58216/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:28:05 INFO - PROCESS | 682 | RSS: Main: 185810944 08:28:05 INFO - PROCESS | 682 | 08:28:08 INFO - PROCESS | 682 | Cycle 1(1): loaded http://localhost:58216/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58216/tests/kraken/driver.html?testName=imaging-darkroom) 08:28:08 INFO - PROCESS | 682 | RSS: Main: 222044160 08:28:08 INFO - PROCESS | 682 | 08:28:12 INFO - PROCESS | 682 | Cycle 1(1): loaded http://localhost:58216/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58216/tests/kraken/driver.html?testName=imaging-desaturate) 08:28:13 INFO - PROCESS | 682 | RSS: Main: 215453696 08:28:13 INFO - PROCESS | 682 | 08:28:15 INFO - PROCESS | 682 | Cycle 1(1): loaded http://localhost:58216/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58216/tests/kraken/driver.html?testName=json-parse-financial) 08:28:16 INFO - PROCESS | 682 | RSS: Main: 218636288 08:28:16 INFO - PROCESS | 682 | 08:28:18 INFO - PROCESS | 682 | Cycle 1(1): loaded http://localhost:58216/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58216/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:28:18 INFO - PROCESS | 682 | RSS: Main: 184750080 08:28:18 INFO - PROCESS | 682 | 08:28:20 INFO - PROCESS | 682 | Cycle 1(1): loaded http://localhost:58216/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58216/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:28:21 INFO - PROCESS | 682 | RSS: Main: 190558208 08:28:21 INFO - PROCESS | 682 | 08:28:23 INFO - PROCESS | 682 | Cycle 1(1): loaded http://localhost:58216/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58216/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:28:24 INFO - PROCESS | 682 | RSS: Main: 194912256 08:28:24 INFO - PROCESS | 682 | 08:28:27 INFO - PROCESS | 682 | Cycle 1(1): loaded http://localhost:58216/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58216/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:28:27 INFO - PROCESS | 682 | RSS: Main: 190066688 08:28:27 INFO - PROCESS | 682 | 08:28:30 INFO - PROCESS | 682 | Cycle 1(1): loaded http://localhost:58216/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58216/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:28:31 INFO - PROCESS | 682 | RSS: Main: 193196032 08:28:31 INFO - PROCESS | 682 | 08:28:32 INFO - PROCESS | 682 | Cycle 1(1): loaded http://localhost:58216/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58216/tests/kraken/driver.html?testName=ai-astar) 08:28:33 INFO - PROCESS | 682 | RSS: Main: 243732480 08:28:33 INFO - PROCESS | 682 | 08:28:33 INFO - PROCESS | 682 | __start_tp_report 08:28:33 INFO - PROCESS | 682 | _x_x_mozilla_page_load 08:28:33 INFO - PROCESS | 682 | _x_x_mozilla_page_load_details 08:28:33 INFO - PROCESS | 682 | |i|pagename|runs| 08:28:33 INFO - PROCESS | 682 | |0;ai-astar;104;113;115;113;116;116;115;114;112;113 08:28:33 INFO - PROCESS | 682 | |1;audio-beat-detection;146;120;129;173;122;129;151;127;157;124 08:28:33 INFO - PROCESS | 682 | |2;audio-dft;162;161;161;160;161;161;162;163;160;161 08:28:33 INFO - PROCESS | 682 | |3;audio-fft;76;76;76;122;75;86;74;75;99;75 08:28:33 INFO - PROCESS | 682 | |4;audio-oscillator;84;86;108;86;85;85;124;84;86;129 08:28:33 INFO - PROCESS | 682 | |5;imaging-gaussian-blur;116;117;116;117;117;116;117;116;116;117 08:28:33 INFO - PROCESS | 682 | |6;imaging-darkroom;146;148;146;146;146;147;147;146;147;146 08:28:33 INFO - PROCESS | 682 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;95 08:28:33 INFO - PROCESS | 682 | |8;json-parse-financial;65;62;65;64;70;65;63;64;63;63 08:28:33 INFO - PROCESS | 682 | |9;json-stringify-tinderbox;65;67;64;65;65;64;65;66;65;65 08:28:33 INFO - PROCESS | 682 | |10;stanford-crypto-aes;90;79;79;79;80;79;80;88;84;78 08:28:33 INFO - PROCESS | 682 | |11;stanford-crypto-ccm;133;130;130;136;129;135;140;139;171;127 08:28:33 INFO - PROCESS | 682 | |12;stanford-crypto-pbkdf2;169;172;174;166;167;169;171;168;167;164 08:28:33 INFO - PROCESS | 682 | |13;stanford-crypto-sha256-iterative;66;67;67;67;67;66;67;66;67;69 08:28:33 INFO - PROCESS | 682 | __end_tp_report 08:28:33 INFO - PROCESS | 682 | __start_cc_report 08:28:33 INFO - PROCESS | 682 | _x_x_mozilla_cycle_collect,1928 08:28:33 INFO - PROCESS | 682 | __end_cc_report 08:28:33 INFO - PROCESS | 682 | __startTimestamp1470324513155__endTimestamp 08:28:33 INFO - PROCESS | 682 | 08:28:33 INFO - PROCESS | 682 | ------- Summary: start ------- 08:28:33 INFO - PROCESS | 682 | Number of tests: 14 08:28:33 INFO - PROCESS | 682 | 08:28:33 INFO - PROCESS | 682 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.50 stddev:3.48 (3.0%) stddev-sans-first:1.45 08:28:33 INFO - PROCESS | 682 | Values: 104.0 113.0 115.0 113.0 116.0 116.0 115.0 114.0 112.0 113.0 08:28:33 INFO - PROCESS | 682 | 08:28:33 INFO - PROCESS | 682 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:137.50 stddev:17.88 (13.0%) stddev-sans-first:18.72 08:28:33 INFO - PROCESS | 682 | Values: 146.0 120.0 129.0 173.0 122.0 129.0 151.0 127.0 157.0 124.0 08:28:33 INFO - PROCESS | 682 | 08:28:33 INFO - PROCESS | 682 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 08:28:33 INFO - PROCESS | 682 | Values: 162.0 161.0 161.0 160.0 161.0 161.0 162.0 163.0 160.0 161.0 08:28:33 INFO - PROCESS | 682 | 08:28:33 INFO - PROCESS | 682 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.00 stddev:15.65 (20.6%) stddev-sans-first:16.37 08:28:33 INFO - PROCESS | 682 | Values: 76.0 76.0 76.0 122.0 75.0 86.0 74.0 75.0 99.0 75.0 08:28:33 INFO - PROCESS | 682 | 08:28:33 INFO - PROCESS | 682 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:85.00 stddev:17.78 (20.9%) stddev-sans-first:18.35 08:28:33 INFO - PROCESS | 682 | Values: 84.0 86.0 108.0 86.0 85.0 85.0 124.0 84.0 86.0 129.0 08:28:33 INFO - PROCESS | 682 | 08:28:33 INFO - PROCESS | 682 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:28:33 INFO - PROCESS | 682 | Values: 116.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 08:28:33 INFO - PROCESS | 682 | 08:28:33 INFO - PROCESS | 682 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 08:28:33 INFO - PROCESS | 682 | Values: 146.0 148.0 146.0 146.0 146.0 147.0 147.0 146.0 147.0 146.0 08:28:33 INFO - PROCESS | 682 | 08:28:33 INFO - PROCESS | 682 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:28:33 INFO - PROCESS | 682 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 08:28:33 INFO - PROCESS | 682 | 08:28:33 INFO - PROCESS | 682 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.50 stddev:2.22 (3.4%) stddev-sans-first:2.35 08:28:33 INFO - PROCESS | 682 | Values: 65.0 62.0 65.0 64.0 70.0 65.0 63.0 64.0 63.0 63.0 08:28:33 INFO - PROCESS | 682 | 08:28:33 INFO - PROCESS | 682 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 08:28:33 INFO - PROCESS | 682 | Values: 65.0 67.0 64.0 65.0 65.0 64.0 65.0 66.0 65.0 65.0 08:28:33 INFO - PROCESS | 682 | 08:28:33 INFO - PROCESS | 682 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:80.00 stddev:4.25 (5.3%) stddev-sans-first:3.24 08:28:33 INFO - PROCESS | 682 | Values: 90.0 79.0 79.0 79.0 80.0 79.0 80.0 88.0 84.0 78.0 08:28:33 INFO - PROCESS | 682 | 08:28:33 INFO - PROCESS | 682 | [#11] stanford-crypto-ccm Cycles:10 Average:137.00 Median:135.50 stddev:12.70 (9.4%) stddev-sans-first:13.39 08:28:33 INFO - PROCESS | 682 | Values: 133.0 130.0 130.0 136.0 129.0 135.0 140.0 139.0 171.0 127.0 08:28:33 INFO - PROCESS | 682 | 08:28:33 INFO - PROCESS | 682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.70 Median:169.00 stddev:2.98 (1.8%) stddev-sans-first:3.16 08:28:33 INFO - PROCESS | 682 | Values: 169.0 172.0 174.0 166.0 167.0 169.0 171.0 168.0 167.0 164.0 08:28:33 INFO - PROCESS | 682 | 08:28:33 INFO - PROCESS | 682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 08:28:33 INFO - PROCESS | 682 | Values: 66.0 67.0 67.0 67.0 67.0 66.0 67.0 66.0 67.0 69.0 08:28:33 INFO - PROCESS | 682 | -------- Summary: end -------- 08:28:33 INFO - PROCESS | 682 | 08:28:34 INFO - TEST-INFO | 682: exit 0 08:28:34 INFO - TEST-OK | kraken | took 63270ms 08:28:34 INFO - SUITE-END | took 1182s 08:28:34 INFO - Completed test suite (00:19:42) 08:28:34 INFO - javascript benchmark 08:28:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2610.7911367090633, 2641.2208398522434, 2678.2634775436754, 2700.797440191985, 2700.9324766880827, 4593.977030114853, 4683.32091846682, 4843.660943733936, 4938.629602779793, 4950.1337265978445, 4720.881977950553, 4750.76246187691, 4764.118638051954, 4827.396575428072, 4841.636877234213, 4280.892977675552, 4296.613304802567, 4316.20150272199, 4345.804438800245, 4400.955990440103, 4382.276924307485, 4417.22698527758, 4520.593146616804, 4559.544045595447, 4561.384213131218, 4478.305862591304, 4519.457665080195, 4522.0729750401415, 4526.321051842234, 4529.6376289896725, 4184.539700632928, 4220.620144187038, 4320.783960801948, 4353.346997950302, 4371.868843934687, 4383.276759334738, 4406.206882761102, 4408.801603927799, 4410.42664453619, 4438.223310920576, 4918.139325618003, 4926.531979461945, 4950.752462376903, 4952.67807592509, 4957.256411538262, 4934.827281045146, 5135.589152867799, 5141.254518094893, 5199.792008319662, 5260.789568417259, 5243.528082472596, 5263.921041184385, 5283.735813209324, 5287.365516138049, 5305.071612467803, 4933.136701077333, 4934.654574179773, 4935.851924442272, 4935.950640493621, 4944.208926571731, 5135.948640513622, 5198.506141916512, 5204.505571970657, 5243.4232234454175, 5336.0, 5026.698398096126, 5058.089543882136, 5062.594992400599, 5107.821226257138, 5125.179971204664, 5132.230165475208, 5134.974325128425, 5144.71704056273, 5171.68969861802, 5181.766820493087, 4806.49531799156, 5005.74971251436, 5058.645894787403, 5081.085404627129, 5134.332536770196, 5078.97460512695, 5084.059449001947, 5089.05852417304, 5122.667026643257, 5135.460776618476, 4307.39696442492, 4312.89217769552, 4316.115196384733, 4355.60799528044, 4357.019670574159, 3693.1874987502706, 3710.0539362462937, 3749.5125633667994, 3768.3028639701197, 3795.0, 4463.196624607602, 4479.59683628475, 4482.932756008662, 4527.864164075083, 4529.773511324421, 5123.795048198031, 5168.741562921914, 5170.250313704491, 5170.560502357342, 5217.947820521822, 4272.102858399709, 4463.397441345377, 4495.033567782943, 4506.639468842551, 4547.658925580595, 4653.464851542116, 4715.882102947385, 4734.597559207506, 4736.834210802605, 4739.312799644033, 4898.461169271449, 4920.581750551171, 4933.260010998379, 4939.975300123477, 4989.900201996013, 5239.135542635422, 5245.396779370421, 5246.6065045121, 5249.47505249472, 5252.107141785829, 4687.437507499122, 4854.417469903493, 4911.68074075184, 4912.312276281395, 4995.125852975787, 5110.923336149886, 5121.487851214849, 5121.8463446096675, 5123.28274041627, 5174.120399532013, 5196.714180720097, 5214.165733482625, 5215.0, 5216.921746173886, 5220.138677118233, 4849.2726091086615, 4951.405831300267, 4986.252062190701, 5003.699778013185, 5082.542571168613, 5005.799768009385, 5015.3480047593575, 5025.422076461254, 5029.547340739351, 5069.847904562722, 4928.926066108939, 4972.378452693413, 5015.473375295542, 5019.372578427697, 5019.7741101651245, 4796.952030479651, 5065.645404821627, 5118.641695081308, 5120.103981803244, 5184.118699820964, 5024.623153263593, 5035.244713293036, 5038.269450929668, 5044.192929131322, 5084.313617661568], "value": 4740.066281516742, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.1704711121762, 572.9885402291951, 582.868854507736, 587.0636335045601, 589.1339730596025, 28465.146045618614, 39488.80255598722, 40239.396409053814, 40298.39552406713, 43655.0, 39452.60547394525, 39891.60108398915, 39948.80025599868, 39962.800185999105, 40004.59949405571, 7702.845943081135, 7841.960790196041, 7843.882341764878, 7845.176256493071, 7848.68605255789, 7676.577788221645, 7752.496087754306, 7757.5733334666575, 7773.533587984711, 7781.260780225898, 7788.532688038707, 7800.726974555863, 7826.921730782705, 7831.686732530692, 7833.569153696573, 7747.728829490969, 7775.961120194419, 7792.220777922219, 7794.727184548542, 7796.493227940223, 7691.192424795372, 7747.72882949094, 7747.96126019372, 7751.418643601696, 7755.573443460607, 37756.0, 37938.43092353617, 38101.0, 38174.0, 38218.808905955295, 2837.6736675282195, 2901.231173738961, 2949.6607890092487, 3029.5924120485015, 3201.439748044106, 28027.0, 28192.577111343347, 28330.575041374395, 28450.146495605164, 29000.12999609994, 3265.0857759827286, 3293.357795229931, 3324.1357247115925, 3342.5320455136302, 3370.8483118259737, 249633.0, 251724.0, 252335.0, 252638.0, 252669.0, 48991.265131023065, 49195.50804491981, 49234.75382623064, 49288.0, 49289.50710492849, 32581.348373032408, 33249.3350132996, 52498.73750631222, 52645.47354526406, 52677.0, 13188.670283242804, 13513.527026554024, 13517.729645407037, 13518.526851560346, 13523.188608683511, 9768.120869121813, 9804.215662746963, 9826.508674566387, 9837.704868853945, 9840.3603765755, 17978.910105449388, 18165.18256678426, 18176.36382726598, 18227.63544729098, 18304.816951830577, 6953.33943275388, 6998.650067496605, 7138.750143744944, 7170.784876453715, 7218.855622887513, 764.7858599592123, 798.6525861250375, 840.5839109640767, 846.9703560375357, 883.2183517586982, 24150.0, 25200.0, 25322.620160697603, 25416.49167016649, 25465.0, 721.4661150748514, 966.7389804752818, 970.6117552978724, 985.975350616226, 986.1371300112402, 14263.92868035674, 15143.545693629208, 15774.211289435483, 15863.20683965797, 16508.83491165097, 374659.0, 377295.0, 377326.0, 378231.3061216281, 379362.0, 48749.75625121852, 49092.7545362278, 49166.0, 49230.99999999929, 49277.75361123172, 1109.073923274059, 1180.468789044916, 1210.5823490895627, 1216.920900141488, 1238.3127364312893, 27057.45885082248, 28112.43775124445, 28152.0, 28755.0, 28823.85588072046, 40422.79788601038, 41152.38271425991, 41165.0, 41221.38167927424, 41228.79385603053, 314342.0, 316043.0, 317486.0, 317561.0, 424035.0, 38032.429513556766, 38274.2345153101, 38312.80843595764, 38433.4234986481, 38949.8052509747, 41421.79289103656, 41640.583594164884, 41860.0, 42053.0, 42290.788546057076, 35692.28615427625, 35813.82093089518, 35891.64108358883, 36442.63557364392, 36601.45097823588, 35503.0, 35799.46300805438, 35816.104597385274, 36297.63702363048, 36665.81667091647, 35024.474632881036, 35198.296034079685, 35307.82346088253, 35331.29337413289, 35402.645973540966, 30311.242218944702, 31856.68143318537, 31916.5212521817, 32247.67752322447, 32611.510827338083, 24588.754112458646, 24746.876265619278, 24804.37989050288, 24912.50174996526, 25259.74740252574], "value": 17317.034314392215, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.3300596842125, 358.1654744445441, 368.8524590163933, 372.53805281451, 392.5054431416414, 12290.078244131691, 15976.121313327762, 16177.433789817373, 17311.307547698078, 17394.913025434857, 14966.925165374185, 15398.461053863117, 15501.534953951372, 15503.069815811059, 15557.455489057886, 4706.976465117669, 4903.607711383099, 5064.772085256172, 5094.133997220481, 5105.0, 4915.459299477055, 4967.031428871372, 4977.203647416414, 4978.278149668296, 4988.775505102279, 4937.086638971802, 4947.50524947506, 4949.010197960422, 5160.7419629018395, 5424.403315635277, 5474.507294343508, 5495.065838807413, 5497.945020549783, 5503.091989821694, 5507.173923911405, 5249.2126181073145, 5296.92054619181, 5347.54545863602, 5399.2980912481125, 5411.675299482044, 19919.800801992085, 20068.0, 20415.0, 20563.897180514152, 20746.5850682987, 1852.0, 1854.7125195594704, 1872.4382685194387, 2104.736907886514, 2283.8058765004994, 8725.869111963326, 8964.686235981775, 9023.774405639846, 9031.27749780016, 9341.205997490153, 1662.6159416695673, 1713.811480737118, 1720.0797573298225, 1741.3556983915905, 1774.5918438759159, 66234.3376566233, 67568.66215668939, 67956.66021669909, 68953.65523172352, 69141.0, 9685.17675997534, 9813.852792208123, 9917.603295868228, 9941.254405919584, 10198.0, 12912.870871291354, 12923.0, 12937.676558085936, 12938.417771200318, 12943.546975855988, 6672.266050734415, 6876.17485901685, 6956.826079347956, 7022.08712867324, 7277.745278915212, 6397.584157029778, 6421.678916054178, 6448.9355106449275, 6549.901751473732, 6726.159230096238, 4262.339337402707, 4291.9785401072795, 4300.935485967713, 4371.693981421334, 4475.127350166751, 1803.9188236529387, 1827.5602071234784, 1832.853371730285, 1847.5104097414196, 1908.6182763447089, 816.1348970091722, 867.7266661001764, 870.7910101575576, 916.3722849847876, 924.5146298193367, 15414.152221627694, 16444.424445144603, 16516.256768445448, 17125.14374281281, 17330.0, 839.3872473094675, 855.6449073634496, 859.8968123825056, 875.369733791669, 878.8198419324151, 8604.956975215084, 9302.90697093034, 9349.626014959462, 9421.90578094224, 9669.70990870275, 408242.0, 414995.17526535725, 415110.0, 415545.0, 415695.0, 76675.61662191765, 76786.6160669193, 77339.0, 79024.0, 80625.59687201644, 903.6656437118309, 906.5014242166782, 927.3276874266103, 952.3381250031161, 952.4333021851987, 15321.0, 15677.294521746777, 15837.208139592743, 15942.760858587362, 16197.186610219564, 36543.45184822177, 37158.8142059288, 37629.247415052094, 38028.61971380251, 39152.608473914894, 52300.73849630728, 52460.47539524556, 53248.0, 54929.1760623599, 55400.16899746587, 7166.964165179141, 7225.096862892138, 7479.252074792477, 7661.310482056641, 7850.489718168301, 9739.0, 11818.113641476752, 11923.344216068199, 12045.698857528632, 12138.635840924786, 9849.507524623883, 9875.802483950425, 9998.850017249893, 10447.947760261453, 10573.04842564173, 10244.770627524447, 10297.485125743533, 10603.94698026505, 10735.677929662123, 10861.0, 10282.948585257025, 10387.117095047006, 10484.318519296221, 10596.947015264874, 10671.199660025373, 6422.871542569216, 6510.511711621552, 6640.169978752656, 6944.548604340702, 7593.354564862048, 7640.656170472231, 9904.900950990397, 10004.0, 10251.487425628839, 10477.37135771856], "value": 8082.732880397298, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1147.8048731715608, 1340.4772138865844, 1396.7974643676666, 1440.510226522982, 1655.1145137351518, 6274.968625156874, 7195.424366050716, 7449.366803821668, 7475.439342049341, 7605.505642133257, 7425.1832298447125, 7496.137944136426, 7503.287187717158, 7508.174100848916, 7512.399008079355, 2132.8720276783365, 2155.568886222754, 2159.9352019439443, 2161.135545781684, 2161.27597254919, 2088.916443342272, 2125.5961367340233, 2125.7130287411155, 2127.1385089038963, 2129.58473097746, 2079.6048750737314, 2132.1364847236896, 2142.2287976328507, 2144.1209104267255, 2144.7855214478504, 2035.7964203579672, 2037.3073155127329, 2038.8878611676425, 2041.6631255842767, 2046.0588129460466, 1985.682290833474, 2044.6932960055963, 2051.2615458434952, 2051.712760213571, 2054.9280775172797, 7177.138743350779, 7177.820554486128, 7368.336849683555, 7412.444066694966, 7488.026556547614, 4210.473690788652, 4394.648428125743, 4403.119376124788, 4409.4488188976375, 4416.514183439819, 2633.2626864477975, 2743.9725602744115, 2779.6664400271893, 2792.176307989148, 2792.664880214367, 896.332232486795, 897.1477096758106, 912.1334732004556, 947.9194268487187, 949.4113649537331, 9910.702678919644, 9954.701358959242, 9982.051705088004, 9992.550335234931, 10007.64973225941, 3647.6717095461004, 3763.397856342972, 3898.1813819098306, 3900.356441187229, 3925.666318362914, 8029.116797152308, 8036.959815200887, 8046.678132874737, 8058.758237252775, 8063.556504392314, 4282.993496528314, 4285.100128972888, 4287.399764033038, 4295.892602684958, 4300.376445415397, 3461.273132642123, 3750.5686846012513, 3916.6083391661177, 3974.2448934702315, 3996.200759847984, 3325.534425180477, 3351.798892066484, 3449.6550344965303, 3454.9309013819584, 3468.705160061423, 968.1722127580957, 969.2924165359327, 975.6926568131016, 987.1707765477033, 994.6319861651235, 774.2953911940108, 776.4564804636777, 778.1479280188184, 787.4605894961969, 807.3299161695778, 4959.801607935714, 4967.081089998362, 5053.797848086109, 5070.138076527, 5305.310309659797, 367.8712450642254, 371.66550104905804, 374.4177803515505, 374.82383279858425, 375.69756346141617, 3404.914877128042, 3451.378751824696, 3498.3877821381157, 3521.2957408517887, 3700.6854417374825, 8826.86759698605, 9178.128077832594, 9219.07809219086, 9227.123423274777, 9237.584308706124, 9166.450012999241, 9175.174234318943, 9180.127887850644, 9184.0, 9208.26333893287, 6944.513884028171, 6980.546264492792, 6992.580445173204, 6992.615406152609, 6994.5803251805055, 4688.765561721969, 4849.224124140262, 4855.49017353187, 4918.5573298403315, 5070.898582028412, 8340.374471914509, 8485.066642669424, 8507.95746021266, 8588.098249683693, 8589.269912057294, 8439.915600844159, 8554.31565474773, 8588.871166932626, 8617.69838055665, 8646.178613031752, 5557.360903495988, 6082.543809214415, 6207.503399727921, 6265.185525881606, 6269.0, 7053.435725141873, 7253.347198752138, 7278.818029549304, 7289.781306560812, 7292.671829767567, 6341.054760500214, 6582.3746744059235, 6583.604983700993, 6686.53194276396, 6697.09589205451, 6428.292887782247, 6455.903161452676, 6484.092227088117, 6512.055751915851, 6536.1503004610995, 6009.278886533644, 6092.45167934888, 6098.908516372169, 6099.969500152471, 6101.237345331833, 4342.565743425632, 4492.483364413004, 4544.818207271672, 4582.564656357641, 4684.695494792828, 4583.793729282123, 4658.417697787777, 4674.62602991753, 4720.244760838249, 4783.617310615212], "value": 3840.403333486598, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.3238344165723, 288.2347367738654, 289.26238092863196, 289.7927981493232, 295.93637367965886, 4899.461059283481, 4917.704937703731, 4918.8770280743, 4923.876903077425, 4933.1860243059855, 4818.566329030386, 4837.226043832988, 4865.708057516552, 4869.514797986612, 4872.342233798436, 3616.4936908832783, 3686.6313368663054, 3695.519582454277, 3762.1911289072846, 3783.1677031053123, 3775.5469343678797, 3777.471154038437, 3779.4708740776314, 3782.470454136423, 3806.9809650951706, 3757.304898593769, 3765.585785563586, 3767.60440153784, 3770.1328694400304, 3790.241951609675, 3617.4212126059706, 3643.799591022506, 3735.916584190609, 3765.0, 3766.7551609145316, 3321.634620191777, 3324.484704870749, 3331.6168640606397, 3334.733221342287, 3353.597568291796, 4675.322078298627, 4694.342792009122, 4697.741624210667, 4742.786574604151, 4770.0, 4183.435236243129, 4281.293586558214, 4310.038932285803, 4358.934615980763, 4367.061081867382, 4964.503549645043, 4965.975170124162, 4973.502649735034, 4996.92566098287, 5002.349694539723, 3638.308721342963, 3642.581103173116, 3644.1982763791925, 3647.6717095461536, 3654.6162652921594, 5102.0, 5216.791673121003, 5222.21666749983, 5310.92033619496, 5320.707361095138, 3679.6688298053305, 3711.3690672585726, 3711.406175012039, 3716.442533619979, 3721.0, 3749.9062523437133, 3770.5098337215986, 3775.754575952554, 3798.867039653599, 3798.924021519554, 4300.247456695129, 4316.179925814148, 4316.3093904975685, 4327.76197309151, 4342.348647702806, 4851.248056551241, 5011.7494125294315, 5018.548330650259, 5021.6735912165595, 5069.112905241568, 1292.8965682745359, 1299.577637267873, 1305.8106574546637, 1307.47700919631, 1314.723907979316, 850.5832142250376, 857.5883575883611, 859.8108416148438, 860.97543922733, 895.2166854002747, 4392.846250381285, 4430.269005614037, 4456.22016147173, 4487.506374298824, 4504.594586487232, 5125.718085505333, 5129.692218466829, 5148.253503242009, 5152.433232344439, 5157.174852023658, 4348.412964249849, 4490.371348011281, 4490.528494508095, 4492.752898590609, 4507.18870603288, 2705.2830999785074, 2707.7273681369725, 2708.6885008223912, 2724.7956403269436, 2744.972550274512, 4826.903461930741, 4838.346823178826, 4843.709377437365, 4844.854654360375, 4862.523295843489, 4962.478939711351, 5181.637285389987, 5186.740662966837, 5220.869478263074, 5224.52979231871, 4830.806767729322, 4843.612510999112, 4850.72576011191, 4858.5384388483035, 4870.391201099863, 5093.745312734422, 5097.235414687678, 5108.131617625087, 5109.770060347368, 5112.846614601568, 4834.419869615669, 5021.698698078127, 5024.4473107957365, 5034.0, 5074.5686616637995, 4955.4053513577155, 4973.204287314013, 4975.179095449211, 4975.303457516023, 4981.903981124147, 3687.764598859412, 3710.3692372297314, 3722.367197576473, 3723.3298006359114, 3728.683061939657, 5017.222330538772, 5228.085085110167, 5260.44765299638, 5268.367795864521, 5270.104082306094, 5019.472955339636, 5020.648554601143, 5022.372203474566, 5037.471065538066, 5055.368078990126, 5026.673266237683, 5028.245763135413, 5052.837847295069, 5066.9746651266505, 5082.957993611227, 4667.206574882211, 4960.677555958851, 5001.624878134082, 5021.246812978083, 5022.166909078233, 4874.53691899269, 4907.950920490749, 5058.570021548209, 5085.4406015337545, 5092.337996060636, 4899.0, 4925.482824303396, 4983.626228032839, 4995.600351971906, 5022.723750193628], "value": 3802.9431104158807, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.4885724990634, 610.4597431273322, 632.784853149929, 658.8451713847245, 720.9726140250145, 12010.399480025997, 12913.354332283396, 12985.48058077678, 13009.089363744542, 13025.934870325647, 13040.608781736539, 13197.868021319784, 13226.603201903934, 13251.271180085092, 13268.734625307488, 614.0451597765496, 728.5118970289918, 742.4913933955231, 752.0449029732237, 763.8090477380655, 758.2076729817327, 768.174212721324, 768.4543973778624, 768.757841279995, 769.3537428560008, 810.116972499975, 811.0470197517923, 811.7524155132683, 811.8457493076326, 811.9594020298991, 647.2007071267028, 782.2255966593088, 800.1598321762126, 802.3781569283793, 803.895493585836, 595.8629515211526, 596.1385797522581, 596.1832289763053, 596.272547492059, 596.4006173795308, 11438.42807859612, 11599.478023488964, 11611.361375124448, 11629.88370116305, 11630.185886987914, 12119.454624541917, 12572.559960401433, 12751.234925904475, 13319.800202996963, 13336.0, 11780.99723047084, 11931.659970563607, 12143.696407589792, 12283.0, 12385.442655080453, 4088.5093788745244, 4118.155778065489, 4122.896927576805, 4126.442930204414, 4176.4570605821355, 65428.0, 65888.3411165887, 66013.66993165003, 66202.0, 66484.6675766623, 10256.230782691327, 10301.484925753683, 10455.268131230892, 10489.265751397328, 10955.616553420592, 17807.643847123243, 18046.548836278937, 18222.63554728898, 18276.634467310578, 18390.356337528123, 6029.78895738647, 6224.315325314212, 6481.513886458534, 6650.634215118215, 6956.617386043715, 3604.2070744436182, 3609.5848977367414, 3618.6972689832164, 3619.4027985382118, 3634.164142247245, 2793.7764978801647, 2927.1218634409593, 2938.7502062324943, 2940.1473572664117, 3028.78798484104, 545.9153831156177, 552.2461839589013, 556.5464146720491, 558.4471373340444, 564.6104188110273, 497.1300224606938, 537.4974398936928, 538.090626840638, 586.9442402971711, 592.8873514032321, 7656.502327348704, 7917.208279172037, 8339.332853371716, 8397.832043359098, 8843.646254149891, 559.7732918168149, 561.1806762127259, 562.7664519224476, 567.5062695454898, 575.3900865083025, 3928.52857657083, 3975.383815508601, 3985.342418500973, 4017.3572228443895, 4079.0249169188687, 58612.0, 75460.62269688616, 78367.21632783713, 78847.0, 92751.53624231835, 80663.59668201621, 81847.590762047, 82471.0, 82741.58629206815, 83788.16211837926, 65356.0, 70177.0, 71436.64281678663, 71984.0, 74566.0, 7951.920480795349, 8449.915500844912, 8555.700550480704, 8574.09971952961, 8742.56287185651, 42276.0, 43515.56484435115, 43882.780586096866, 45059.0, 45195.32207016832, 53737.46262537324, 55139.448605515034, 57173.71413142908, 59027.11459328199, 60362.0, 10973.122150228122, 11225.15811314171, 11249.831252531383, 11379.43102844871, 11569.768604628029, 12222.87777122253, 12464.937675311565, 12557.74884502323, 12832.422540985492, 13213.801792972921, 11409.429528523706, 11427.542898284308, 11805.173637845268, 12249.448774805333, 12290.385480726107, 10691.679249622524, 10801.135909127093, 11075.778484430428, 11272.774544509228, 11436.256643318158, 11059.778804424028, 11067.889321107008, 11273.041791447818, 11411.0, 12537.686557836127, 9538.14156725898, 9712.465814380277, 9817.410955342702, 9977.650782222587, 10144.239182061227, 8676.575440135997, 8808.163224493663, 9157.358984870994, 9324.160825525736, 9465.148136667733], "value": 6460.74838020065, "unit": "score"}], "name": "dromaeo_css", "value": 6301.459888064785, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 115.0, 113.0, 116.0, 116.0, 115.0, 114.0, 112.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 120.0, 129.0, 173.0, 122.0, 129.0, 151.0, 127.0, 157.0, 124.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 160.0, 161.0, 161.0, 162.0, 163.0, 160.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 122.0, 75.0, 86.0, 74.0, 75.0, 99.0, 75.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 108.0, 86.0, 85.0, 85.0, 124.0, 84.0, 86.0, 129.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 146.0], "value": 146.5, "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, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 65.0, 64.0, 70.0, 65.0, 63.0, 64.0, 63.0, 63.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 64.0, 65.0, 65.0, 64.0, 65.0, 66.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 79.0, 79.0, 79.0, 80.0, 79.0, 80.0, 88.0, 84.0, 78.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 130.0, 136.0, 129.0, 135.0, 140.0, 139.0, 171.0, 127.0], "value": 137.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 174.0, 166.0, 167.0, 169.0, 171.0, 168.0, 167.0, 164.0], "value": 168.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 67.0, 69.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1533.0, "alertThreshold": 2.0}]} 08:28:34 INFO - Return code: 0 08:28:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:28:34 INFO - # TBPL SUCCESS # 08:28:34 INFO - Running post-action listener: _resource_record_post_action 08:28:34 INFO - [mozharness: 2016-08-04 15:28:34.471508Z] Finished run-tests step (success) 08:28:34 INFO - Running post-run listener: _resource_record_post_run 08:28:34 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 532447232; Read time: 12; Write time: 467348 08:28:34 INFO - TinderboxPrint: CPU usage
13.0% 08:28:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:28:34 INFO - TinderboxPrint: I/O write bytes / time
532,447,232 / 467,348 08:28:34 INFO - TinderboxPrint: CPU idle
8,326.8 (87.0%) 08:28:34 INFO - TinderboxPrint: CPU user
1,200.1 (12.5%) 08:28:34 INFO - TinderboxPrint: Swap in / out
0 / 0 08:28:34 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 247504896; Read time: 0; Write time: 235464 08:28:34 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 284700672; Read time: 0; Write time: 231860 08:28:35 INFO - Running post-run listener: _upload_blobber_files 08:28:35 INFO - Blob upload gear active. 08:28:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:28:35 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 08:28:35 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:28:35 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:28:35 INFO - (blobuploader) - INFO - Open directory for files ... 08:28:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:28:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:28:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:36 INFO - (blobuploader) - INFO - Done attempting. 08:28:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:28:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:28:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:40 INFO - (blobuploader) - INFO - Done attempting. 08:28:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:28:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:28:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:28:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:28:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:28:41 INFO - (blobuploader) - INFO - Done attempting. 08:28:41 INFO - (blobuploader) - INFO - Iteration through files over. 08:28:41 INFO - Return code: 0 08:28:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:28:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:28:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef618a027efccf7c2cb4b2f4cf9da3bdc3dced51b6780372c9ec1c9c1c726d829077dfb52b2ce7d36c6d9438cacc48cf56166b710b31c962da22a7582f1801c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4380eecef8c1e7170ebe785aeb65845ac60c419e98398f8c2cfb76f275928af7e69632592f02314c14f14125f5e5bb8b7a405d44a64506d0e364abd973222f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e19472d07d87dd8a53b34ff9128078f0201deae4b0744a70f7d2dc804569835b23bc2d0745f714b4986b4399592acef1a3c46023cb7681c9b95ecc03eac5cc2f"} 08:28:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:28:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:28:41 INFO - Contents: 08:28:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef618a027efccf7c2cb4b2f4cf9da3bdc3dced51b6780372c9ec1c9c1c726d829077dfb52b2ce7d36c6d9438cacc48cf56166b710b31c962da22a7582f1801c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4380eecef8c1e7170ebe785aeb65845ac60c419e98398f8c2cfb76f275928af7e69632592f02314c14f14125f5e5bb8b7a405d44a64506d0e364abd973222f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e19472d07d87dd8a53b34ff9128078f0201deae4b0744a70f7d2dc804569835b23bc2d0745f714b4986b4399592acef1a3c46023cb7681c9b95ecc03eac5cc2f"} 08:28:41 INFO - Running post-run listener: copy_logs_to_upload_dir 08:28:41 INFO - Copying logs to upload dir... 08:28:41 INFO - mkdir: /builds/slave/test/build/upload/logs 08:28:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.492072 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-04 08:28:40.823098) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 08:28:40.826789) ========= 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=ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef618a027efccf7c2cb4b2f4cf9da3bdc3dced51b6780372c9ec1c9c1c726d829077dfb52b2ce7d36c6d9438cacc48cf56166b710b31c962da22a7582f1801c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4380eecef8c1e7170ebe785aeb65845ac60c419e98398f8c2cfb76f275928af7e69632592f02314c14f14125f5e5bb8b7a405d44a64506d0e364abd973222f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e19472d07d87dd8a53b34ff9128078f0201deae4b0744a70f7d2dc804569835b23bc2d0745f714b4986b4399592acef1a3c46023cb7681c9b95ecc03eac5cc2f"} build_url:https://queue.taskcluster.net/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/f_rNauXjRWimj6gWa-NiQg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef618a027efccf7c2cb4b2f4cf9da3bdc3dced51b6780372c9ec1c9c1c726d829077dfb52b2ce7d36c6d9438cacc48cf56166b710b31c962da22a7582f1801c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4380eecef8c1e7170ebe785aeb65845ac60c419e98398f8c2cfb76f275928af7e69632592f02314c14f14125f5e5bb8b7a405d44a64506d0e364abd973222f4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e19472d07d87dd8a53b34ff9128078f0201deae4b0744a70f7d2dc804569835b23bc2d0745f714b4986b4399592acef1a3c46023cb7681c9b95ecc03eac5cc2f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 08:28:40.851578) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 08:28:40.851873) ========= 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=ed14279e38b05397cf4aa391000001a4-1470322648.921536-1754001673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 08:28:40.937850) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 08:28:40.938173) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 08:28:40.938450) ========= ========= Total master_lag: 0.18 =========