builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1469535685.42 results: success (0) buildid: 20160726042502 builduid: cb1e78a3d0424af5a3cbb6837476d90f revision: ccbf505eff5113af886ca4e3738d476bd0a83ca9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 05:21:25.419722) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 05:21:25.420302) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 05:21:25.420611) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 05:21:25.545220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 05:21:25.545637) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-26 05:21:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-07-26 05:21:25 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125301 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 05:21:25.699410) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 05:21:25.699724) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.130210 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 05:21:25.843198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 05:21:25.843844) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ccbf505eff5113af886ca4e3738d476bd0a83ca9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev ccbf505eff5113af886ca4e3738d476bd0a83ca9 --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=56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-26 05:21:26,129 truncating revision to first 12 chars 2016-07-26 05:21:26,130 Setting DEBUG logging. 2016-07-26 05:21:26,130 attempt 1/10 2016-07-26 05:21:26,130 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ccbf505eff51?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 05:21:26,443 unpacking tar archive at: fx-team-ccbf505eff51/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643274 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 05:21:26.502372) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 05:21:26.502797) ========= script_repo_revision: ccbf505eff5113af886ca4e3738d476bd0a83ca9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 05:21:26.503232) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 05:21:26.503501) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 05:21:26.514986) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-26 05:21:26.515385) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:21:26 INFO - MultiFileLogger online at 20160726 05:21:26 in /builds/slave/test 05:21:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:21:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:21:26 INFO - {'append_to_log': False, 05:21:26 INFO - 'base_work_dir': '/builds/slave/test', 05:21:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:21:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:21:26 INFO - 'branch': 'Fx-Team-Non-PGO', 05:21:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:21:26 INFO - 'config_files': ('talos/linux_config.py',), 05:21:26 INFO - 'default_actions': ('clobber', 05:21:26 INFO - 'read-buildbot-config', 05:21:26 INFO - 'download-and-extract', 05:21:26 INFO - 'populate-webroot', 05:21:26 INFO - 'create-virtualenv', 05:21:26 INFO - 'install', 05:21:26 INFO - 'run-tests'), 05:21:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:21:26 INFO - 'download_minidump_stackwalk': True, 05:21:26 INFO - 'download_symbols': 'ondemand', 05:21:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:21:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:21:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:21:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:21:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:21:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:21:26 INFO - 'installer_path': 'installer.exe', 05:21:26 INFO - 'log_level': 'info', 05:21:26 INFO - 'log_name': 'talos', 05:21:26 INFO - 'log_to_console': True, 05:21:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:21:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:21:26 INFO - 'opt_config_files': (), 05:21:26 INFO - 'pip_index': False, 05:21:26 INFO - 'sps_profile': False, 05:21:26 INFO - 'sps_profile_interval': 0, 05:21:26 INFO - 'suite': 'dromaeojs', 05:21:26 INFO - 'system_bits': '32', 05:21:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:21:26 INFO - 'title': 'talos-linux64-ix-037', 05:21:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:21:26 INFO - 'use_talos_json': True, 05:21:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:21:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:21:26 INFO - 'work_dir': 'build'} 05:21:26 INFO - [mozharness: 2016-07-26 12:21:26.988529Z] Running clobber step. 05:21:26 INFO - Running pre-action listener: _resource_record_pre_action 05:21:26 INFO - Running main action method: clobber 05:21:26 INFO - rmtree: /builds/slave/test/build 05:21:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:21:29 INFO - Running post-action listener: _resource_record_post_action 05:21:29 INFO - [mozharness: 2016-07-26 12:21:29.174470Z] Finished clobber step (success) 05:21:29 INFO - [mozharness: 2016-07-26 12:21:29.174651Z] Running read-buildbot-config step. 05:21:29 INFO - Running pre-action listener: _resource_record_pre_action 05:21:29 INFO - Running main action method: read_buildbot_config 05:21:29 INFO - Using buildbot properties: 05:21:29 INFO - { 05:21:29 INFO - "project": "", 05:21:29 INFO - "product": "firefox", 05:21:29 INFO - "script_repo_revision": "production", 05:21:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:21:29 INFO - "repository": "", 05:21:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:21:29 INFO - "buildid": "20160726042502", 05:21:29 INFO - "pgo_build": "False", 05:21:29 INFO - "basedir": "/builds/slave/test", 05:21:29 INFO - "buildnumber": 1825, 05:21:29 INFO - "slavename": "talos-linux64-ix-037", 05:21:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:21:29 INFO - "platform": "ubuntu64_hw", 05:21:29 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:21:29 INFO - "branch": "fx-team", 05:21:29 INFO - "repo_path": "integration/fx-team", 05:21:29 INFO - "revision": "ccbf505eff5113af886ca4e3738d476bd0a83ca9", 05:21:29 INFO - "stage_platform": "linux64", 05:21:29 INFO - "builduid": "cb1e78a3d0424af5a3cbb6837476d90f", 05:21:29 INFO - "slavebuilddir": "test" 05:21:29 INFO - } 05:21:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:21:29 INFO - Running post-action listener: _resource_record_post_action 05:21:29 INFO - [mozharness: 2016-07-26 12:21:29.178837Z] Finished read-buildbot-config step (success) 05:21:29 INFO - [mozharness: 2016-07-26 12:21:29.178985Z] Running download-and-extract step. 05:21:29 INFO - Running pre-action listener: _resource_record_pre_action 05:21:29 INFO - Running main action method: download_and_extract 05:21:29 INFO - mkdir: /builds/slave/test/build/tests 05:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:29 INFO - https://queue.taskcluster.net/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:21:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:21:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:21:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:21:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:21:29 INFO - Downloaded 1361 bytes. 05:21:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:21:29 INFO - Using the following test package requirements: 05:21:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:21:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:21:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:21:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:29 INFO - u'jsshell-linux-x86_64.zip'], 05:21:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:21:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:21:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:21:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:21:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:21:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:21:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:29 INFO - https://queue.taskcluster.net/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:21:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:21:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:21:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:21:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:21:30 INFO - Downloaded 22741588 bytes. 05:21:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:21:32 INFO - Return code: 0 05:21:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:32 INFO - https://queue.taskcluster.net/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:21:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:21:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:21:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:21:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:21:33 INFO - Downloaded 22741588 bytes. 05:21:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:21:34 INFO - Return code: 0 05:21: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')]} 05:21:34 INFO - https://queue.taskcluster.net/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:21:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:21:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:21:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:21:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:21:35 INFO - Downloaded 14413725 bytes. 05:21:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:21:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:21:35 INFO - Return code: 0 05:21:35 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')]} 05:21:35 INFO - https://queue.taskcluster.net/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:21:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:21:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:21:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:21:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:21:37 INFO - Downloaded 57169072 bytes. 05:21:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:21:37 INFO - mkdir: /builds/slave/test/properties 05:21:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:21:37 INFO - Writing to file /builds/slave/test/properties/build_url 05:21:37 INFO - Contents: 05:21:37 INFO - build_url:https://queue.taskcluster.net/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:21:37 INFO - Running post-action listener: _resource_record_post_action 05:21:37 INFO - Running post-action listener: set_extra_try_arguments 05:21:37 INFO - [mozharness: 2016-07-26 12:21:37.972462Z] Finished download-and-extract step (success) 05:21:37 INFO - [mozharness: 2016-07-26 12:21:37.972694Z] Running populate-webroot step. 05:21:37 INFO - Running pre-action listener: _resource_record_pre_action 05:21:37 INFO - Running main action method: populate_webroot 05:21:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:21:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:21:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:21:37 INFO - '--tppagecycles', 05:21:37 INFO - '7'], 05:21:37 INFO - 'tests': ['tsvgm']}}, 05:21:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:21:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:21:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:21:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:21:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:21:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:21:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:37 INFO - 'talos_options': ['--disable-e10s'], 05:21:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:37 INFO - 'talos_options': ['--disable-e10s'], 05:21:37 INFO - 'tests': ['damp', 'tps']}, 05:21:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:37 INFO - 'tests': ['damp', 'tps']}, 05:21:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:21:37 INFO - 'tests': ['dromaeo_dom']}, 05:21:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:21:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:21:37 INFO - 'tests': ['basic_compositor_video']}, 05:21:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:21:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:21:37 INFO - 'tests': ['a11yr', 05:21:37 INFO - 'ts_paint', 05:21:37 INFO - 'tpaint', 05:21:37 INFO - 'sessionrestore', 05:21:37 INFO - 'sessionrestore_no_auto_restore', 05:21:37 INFO - 'tabpaint']}, 05:21:37 INFO - 'other-e10s': {'tests': ['a11yr', 05:21:37 INFO - 'ts_paint', 05:21:37 INFO - 'tpaint', 05:21:37 INFO - 'sessionrestore', 05:21:37 INFO - 'sessionrestore_no_auto_restore', 05:21:37 INFO - 'tabpaint']}, 05:21:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:21:37 INFO - 'ts_paint', 05:21:37 INFO - 'tpaint', 05:21:37 INFO - 'sessionrestore', 05:21:37 INFO - 'sessionrestore_no_auto_restore', 05:21:37 INFO - 'tabpaint']}, 05:21:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:21:37 INFO - 'ts_paint', 05:21:37 INFO - 'tpaint', 05:21:37 INFO - 'sessionrestore', 05:21:37 INFO - 'sessionrestore_no_auto_restore', 05:21:37 INFO - 'tabpaint']}, 05:21:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:21:37 INFO - 'tests': ['a11yr', 05:21:37 INFO - 'ts_paint', 05:21:37 INFO - 'tpaint', 05:21:37 INFO - 'sessionrestore', 05:21:37 INFO - 'sessionrestore_no_auto_restore', 05:21:37 INFO - 'tabpaint']}, 05:21:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:21:37 INFO - 'tests': ['a11yr', 05:21:37 INFO - 'ts_paint', 05:21:37 INFO - 'tpaint', 05:21:37 INFO - 'sessionrestore', 05:21:37 INFO - 'sessionrestore_no_auto_restore', 05:21:37 INFO - 'tabpaint']}, 05:21:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:21:37 INFO - 'tests': ['tsvgx', 05:21:37 INFO - 'tsvgr_opacity', 05:21:37 INFO - 'tart', 05:21:37 INFO - 'tscrollx', 05:21:37 INFO - 'cart']}, 05:21:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:21:37 INFO - 'tsvgr_opacity', 05:21:37 INFO - 'tart', 05:21:37 INFO - 'tscrollx', 05:21:37 INFO - 'cart']}, 05:21:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:37 INFO - 'talos_options': ['--disable-e10s'], 05:21:37 INFO - 'tests': ['tp5o']}, 05:21:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:37 INFO - 'tests': ['tp5o']}, 05:21:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:37 INFO - 'talos_options': ['--disable-e10s', 05:21:37 INFO - '--xperf_path', 05:21:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:37 INFO - 'tests': ['tp5n']}, 05:21:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:37 INFO - 'talos_options': ['--xperf_path', 05:21:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:37 INFO - 'tests': ['tp5n']}}, 05:21:37 INFO - 'talos.zip': {'path': '', 05:21:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:21:37 INFO - Running post-action listener: _resource_record_post_action 05:21:37 INFO - [mozharness: 2016-07-26 12:21:37.988924Z] Finished populate-webroot step (success) 05:21:37 INFO - [mozharness: 2016-07-26 12:21:37.989013Z] Running create-virtualenv step. 05:21:37 INFO - Running pre-action listener: _resource_record_pre_action 05:21:37 INFO - Running main action method: create_virtualenv 05:21:37 INFO - Creating virtualenv /builds/slave/test/build/venv 05:21:37 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 05:21:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:21:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:21:38 INFO - Using real prefix '/usr' 05:21:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:21:38 INFO - Installing distribute.............................................................................................................................................................................................done. 05:21:40 INFO - Installing pip.................done. 05:21:40 INFO - Return code: 0 05:21:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26663b0>, '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 0x26672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', '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 05:21:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:21:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:21:40 INFO - Using env: {'DISPLAY': ':0', 05:21:40 INFO - 'HOME': '/home/cltbld', 05:21:40 INFO - 'LANG': 'en_US.UTF-8', 05:21:40 INFO - 'LANGUAGE': 'en_US:en', 05:21:40 INFO - 'LOGNAME': 'cltbld', 05:21:40 INFO - 'MAIL': '/var/mail/cltbld', 05:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:40 INFO - 'MOZ_NO_REMOTE': '1', 05:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:40 INFO - 'NO_EM_RESTART': '1', 05:21:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:40 INFO - 'PWD': '/builds/slave/test', 05:21:40 INFO - 'SHELL': '/bin/bash', 05:21:40 INFO - 'SHLVL': '1', 05:21:40 INFO - 'TERM': 'linux', 05:21:40 INFO - 'TMOUT': '86400', 05:21:40 INFO - 'USER': 'cltbld', 05:21:40 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', 05:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:40 INFO - '_': '/tools/buildbot/bin/python'} 05:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:41 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 05:21:41 INFO - Cleaning up... 05:21:41 INFO - Return code: 0 05:21:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23a7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26663b0>, '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 0x26672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', '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 05:21:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:21:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:21:41 INFO - Using env: {'DISPLAY': ':0', 05:21:41 INFO - 'HOME': '/home/cltbld', 05:21:41 INFO - 'LANG': 'en_US.UTF-8', 05:21:41 INFO - 'LANGUAGE': 'en_US:en', 05:21:41 INFO - 'LOGNAME': 'cltbld', 05:21:41 INFO - 'MAIL': '/var/mail/cltbld', 05:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:41 INFO - 'MOZ_NO_REMOTE': '1', 05:21:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:41 INFO - 'NO_EM_RESTART': '1', 05:21:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:41 INFO - 'PWD': '/builds/slave/test', 05:21:41 INFO - 'SHELL': '/bin/bash', 05:21:41 INFO - 'SHLVL': '1', 05:21:41 INFO - 'TERM': 'linux', 05:21:41 INFO - 'TMOUT': '86400', 05:21:41 INFO - 'USER': 'cltbld', 05:21:41 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', 05:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:41 INFO - '_': '/tools/buildbot/bin/python'} 05:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:41 INFO - Downloading/unpacking psutil>=3.1.1 05:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:21:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:43 INFO - Installing collected packages: psutil 05:21:43 INFO - Running setup.py install for psutil 05:21:43 INFO - building 'psutil._psutil_linux' extension 05:21:43 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 05:21:44 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 05:21:44 INFO - building 'psutil._psutil_posix' extension 05:21:44 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 05:21:45 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 05:21:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:45 INFO - Successfully installed psutil 05:21:45 INFO - Cleaning up... 05:21:45 INFO - Return code: 0 05:21:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26663b0>, '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 0x26672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', '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 05:21:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:21:45 INFO - Using env: {'DISPLAY': ':0', 05:21:45 INFO - 'HOME': '/home/cltbld', 05:21:45 INFO - 'LANG': 'en_US.UTF-8', 05:21:45 INFO - 'LANGUAGE': 'en_US:en', 05:21:45 INFO - 'LOGNAME': 'cltbld', 05:21:45 INFO - 'MAIL': '/var/mail/cltbld', 05:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:45 INFO - 'MOZ_NO_REMOTE': '1', 05:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:45 INFO - 'NO_EM_RESTART': '1', 05:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:45 INFO - 'PWD': '/builds/slave/test', 05:21:45 INFO - 'SHELL': '/bin/bash', 05:21:45 INFO - 'SHLVL': '1', 05:21:45 INFO - 'TERM': 'linux', 05:21:45 INFO - 'TMOUT': '86400', 05:21:45 INFO - 'USER': 'cltbld', 05:21:45 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', 05:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:45 INFO - '_': '/tools/buildbot/bin/python'} 05:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:21:47 INFO - Installing collected packages: mozsystemmonitor 05:21:47 INFO - Running setup.py install for mozsystemmonitor 05:21:47 INFO - Successfully installed mozsystemmonitor 05:21:47 INFO - Cleaning up... 05:21:47 INFO - Return code: 0 05:21:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:21:47 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')]} 05:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:47 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')]} 05:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:47 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 0x23a7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26663b0>, '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 0x26672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', '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 05:21:47 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 05:21:47 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 05:21:47 INFO - Using env: {'DISPLAY': ':0', 05:21:47 INFO - 'HOME': '/home/cltbld', 05:21:47 INFO - 'LANG': 'en_US.UTF-8', 05:21:47 INFO - 'LANGUAGE': 'en_US:en', 05:21:47 INFO - 'LOGNAME': 'cltbld', 05:21:47 INFO - 'MAIL': '/var/mail/cltbld', 05:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:47 INFO - 'MOZ_NO_REMOTE': '1', 05:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:47 INFO - 'NO_EM_RESTART': '1', 05:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:47 INFO - 'PWD': '/builds/slave/test', 05:21:47 INFO - 'SHELL': '/bin/bash', 05:21:47 INFO - 'SHLVL': '1', 05:21:47 INFO - 'TERM': 'linux', 05:21:47 INFO - 'TMOUT': '86400', 05:21:47 INFO - 'USER': 'cltbld', 05:21:47 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', 05:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:47 INFO - '_': '/tools/buildbot/bin/python'} 05:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:47 INFO - Downloading/unpacking jsonschema==2.5.1 05:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:21:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:49 INFO - Downloading functools32-3.2.3-2.tar.gz 05:21:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:21:49 INFO - warning: no files found matching '*.txt' 05:21:49 INFO - no previously-included directories found matching 'build' 05:21:50 INFO - no previously-included directories found matching 'dist' 05:21:50 INFO - no previously-included directories found matching '.git*' 05:21:50 INFO - Installing collected packages: jsonschema, functools32 05:21:50 INFO - Running setup.py install for functools32 05:21:50 INFO - warning: no files found matching '*.txt' 05:21:50 INFO - no previously-included directories found matching 'build' 05:21:50 INFO - no previously-included directories found matching 'dist' 05:21:50 INFO - no previously-included directories found matching '.git*' 05:21:50 INFO - Successfully installed jsonschema functools32 05:21:50 INFO - Cleaning up... 05:21:50 INFO - Return code: 0 05:21:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:21:50 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')]} 05:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:50 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')]} 05:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:50 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 0x23a7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26663b0>, '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 0x26672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', '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 05:21:50 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 05:21:50 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 05:21:50 INFO - Using env: {'DISPLAY': ':0', 05:21:50 INFO - 'HOME': '/home/cltbld', 05:21:50 INFO - 'LANG': 'en_US.UTF-8', 05:21:50 INFO - 'LANGUAGE': 'en_US:en', 05:21:50 INFO - 'LOGNAME': 'cltbld', 05:21:50 INFO - 'MAIL': '/var/mail/cltbld', 05:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:50 INFO - 'MOZ_NO_REMOTE': '1', 05:21:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:50 INFO - 'NO_EM_RESTART': '1', 05:21:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:50 INFO - 'PWD': '/builds/slave/test', 05:21:50 INFO - 'SHELL': '/bin/bash', 05:21:50 INFO - 'SHLVL': '1', 05:21:50 INFO - 'TERM': 'linux', 05:21:50 INFO - 'TMOUT': '86400', 05:21:50 INFO - 'USER': 'cltbld', 05:21:50 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', 05:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:50 INFO - '_': '/tools/buildbot/bin/python'} 05:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:21:50 INFO - Cleaning up... 05:21:50 INFO - Return code: 0 05:21:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:21:50 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')]} 05:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:50 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')]} 05:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:50 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 0x23a7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26663b0>, '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 0x26672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', '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 05:21:50 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 05:21:50 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 05:21:50 INFO - Using env: {'DISPLAY': ':0', 05:21:50 INFO - 'HOME': '/home/cltbld', 05:21:50 INFO - 'LANG': 'en_US.UTF-8', 05:21:50 INFO - 'LANGUAGE': 'en_US:en', 05:21:50 INFO - 'LOGNAME': 'cltbld', 05:21:50 INFO - 'MAIL': '/var/mail/cltbld', 05:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:50 INFO - 'MOZ_NO_REMOTE': '1', 05:21:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:50 INFO - 'NO_EM_RESTART': '1', 05:21:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:50 INFO - 'PWD': '/builds/slave/test', 05:21:50 INFO - 'SHELL': '/bin/bash', 05:21:50 INFO - 'SHLVL': '1', 05:21:50 INFO - 'TERM': 'linux', 05:21:50 INFO - 'TMOUT': '86400', 05:21:50 INFO - 'USER': 'cltbld', 05:21:50 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', 05:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:50 INFO - '_': '/tools/buildbot/bin/python'} 05:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:50 INFO - Downloading/unpacking blobuploader==1.2.4 05:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:52 INFO - Downloading blobuploader-1.2.4.tar.gz 05:21:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:21:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:21:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:53 INFO - Downloading docopt-0.6.1.tar.gz 05:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:21:53 INFO - Installing collected packages: blobuploader, requests, docopt 05:21:53 INFO - Running setup.py install for blobuploader 05:21:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:21:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:21:53 INFO - Running setup.py install for requests 05:21:53 INFO - Running setup.py install for docopt 05:21:54 INFO - Successfully installed blobuploader requests docopt 05:21:54 INFO - Cleaning up... 05:21:54 INFO - Return code: 0 05:21:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:54 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 0x23a7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26663b0>, '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 0x26672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', '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 05:21:54 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 05:21:54 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 05:21:54 INFO - Using env: {'DISPLAY': ':0', 05:21:54 INFO - 'HOME': '/home/cltbld', 05:21:54 INFO - 'LANG': 'en_US.UTF-8', 05:21:54 INFO - 'LANGUAGE': 'en_US:en', 05:21:54 INFO - 'LOGNAME': 'cltbld', 05:21:54 INFO - 'MAIL': '/var/mail/cltbld', 05:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:54 INFO - 'MOZ_NO_REMOTE': '1', 05:21:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:54 INFO - 'NO_EM_RESTART': '1', 05:21:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:54 INFO - 'PWD': '/builds/slave/test', 05:21:54 INFO - 'SHELL': '/bin/bash', 05:21:54 INFO - 'SHLVL': '1', 05:21:54 INFO - 'TERM': 'linux', 05:21:54 INFO - 'TMOUT': '86400', 05:21:54 INFO - 'USER': 'cltbld', 05:21:54 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', 05:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:54 INFO - '_': '/tools/buildbot/bin/python'} 05:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:54 INFO - Running setup.py (path:/tmp/pip-R2RBd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:54 INFO - Running setup.py (path:/tmp/pip-iCbUNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:54 INFO - Running setup.py (path:/tmp/pip-YHH0RS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:54 INFO - Running setup.py (path:/tmp/pip-FgiOZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:54 INFO - Running setup.py (path:/tmp/pip-ajTbu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:54 INFO - Running setup.py (path:/tmp/pip-9Sx1Df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:54 INFO - Running setup.py (path:/tmp/pip-qbJVWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:54 INFO - Running setup.py (path:/tmp/pip-lswX3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:54 INFO - Running setup.py (path:/tmp/pip-6lHY9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:54 INFO - Running setup.py (path:/tmp/pip-s29FnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:55 INFO - Running setup.py (path:/tmp/pip-M4VXLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:55 INFO - Running setup.py (path:/tmp/pip-NIrqOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:55 INFO - Running setup.py (path:/tmp/pip-VqunaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:55 INFO - Running setup.py (path:/tmp/pip-BNITYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:55 INFO - Running setup.py (path:/tmp/pip-J7lTpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:55 INFO - Running setup.py (path:/tmp/pip-sTKOZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:55 INFO - Running setup.py (path:/tmp/pip-AvuLdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:21:55 INFO - Running setup.py install for manifestparser 05:21:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:21:55 INFO - Running setup.py install for mozcrash 05:21:55 INFO - Running setup.py install for mozdebug 05:21:55 INFO - Running setup.py install for mozdevice 05:21:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:21:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:21:55 INFO - Running setup.py install for mozfile 05:21:56 INFO - Running setup.py install for mozhttpd 05:21:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:21:56 INFO - Running setup.py install for mozinfo 05:21:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:21:56 INFO - Running setup.py install for mozInstall 05:21:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:21:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:21:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:21:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:21:56 INFO - Running setup.py install for mozleak 05:21:56 INFO - Running setup.py install for mozlog 05:21:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:21:56 INFO - Running setup.py install for moznetwork 05:21:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:21:56 INFO - Running setup.py install for mozprocess 05:21:56 INFO - Running setup.py install for mozprofile 05:21:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:21:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:21:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:21:56 INFO - Running setup.py install for mozrunner 05:21:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:21:57 INFO - Running setup.py install for mozscreenshot 05:21:57 INFO - Running setup.py install for moztest 05:21:57 INFO - Running setup.py install for mozversion 05:21:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:21:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:21:57 INFO - Cleaning up... 05:21:57 INFO - Return code: 0 05:21:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:57 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')]} 05:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:57 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')]} 05:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:57 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 0x23a7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26663b0>, '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 0x26672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', '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 05:21:57 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 05:21:57 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 05:21:57 INFO - Using env: {'DISPLAY': ':0', 05:21:57 INFO - 'HOME': '/home/cltbld', 05:21:57 INFO - 'LANG': 'en_US.UTF-8', 05:21:57 INFO - 'LANGUAGE': 'en_US:en', 05:21:57 INFO - 'LOGNAME': 'cltbld', 05:21:57 INFO - 'MAIL': '/var/mail/cltbld', 05:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:57 INFO - 'MOZ_NO_REMOTE': '1', 05:21:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:57 INFO - 'NO_EM_RESTART': '1', 05:21:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:57 INFO - 'PWD': '/builds/slave/test', 05:21:57 INFO - 'SHELL': '/bin/bash', 05:21:57 INFO - 'SHLVL': '1', 05:21:57 INFO - 'TERM': 'linux', 05:21:57 INFO - 'TMOUT': '86400', 05:21:57 INFO - 'USER': 'cltbld', 05:21:57 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', 05:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:57 INFO - '_': '/tools/buildbot/bin/python'} 05:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:57 INFO - Running setup.py (path:/tmp/pip-CrBhkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:57 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)) 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:57 INFO - Running setup.py (path:/tmp/pip-fGQTBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:57 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)) 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:57 INFO - Running setup.py (path:/tmp/pip-At1Ckj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:57 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)) 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:57 INFO - Running setup.py (path:/tmp/pip-nCFq97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:57 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)) 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:57 INFO - Running setup.py (path:/tmp/pip-emsyC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:57 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)) 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:57 INFO - Running setup.py (path:/tmp/pip-V1Rqxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:58 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)) 05:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:58 INFO - Running setup.py (path:/tmp/pip-c2S1mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:58 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)) 05:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:58 INFO - Running setup.py (path:/tmp/pip-zm8NaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:58 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)) 05:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:58 INFO - Running setup.py (path:/tmp/pip-Ixixcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:58 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)) 05:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:58 INFO - Running setup.py (path:/tmp/pip-NaEgl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:58 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)) 05:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:58 INFO - Running setup.py (path:/tmp/pip-njGWi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:58 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)) 05:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:58 INFO - Running setup.py (path:/tmp/pip-uVPqcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:58 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)) 05:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:58 INFO - Running setup.py (path:/tmp/pip-93Fn8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:58 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)) 05:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:58 INFO - Running setup.py (path:/tmp/pip-0YyLSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:58 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)) 05:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:58 INFO - Running setup.py (path:/tmp/pip-kg2_Y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:58 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)) 05:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:58 INFO - Running setup.py (path:/tmp/pip-43rib3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:58 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)) 05:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:58 INFO - Running setup.py (path:/tmp/pip-srRuzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:58 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)) 05:21:58 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)) 05:21:58 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)) 05:21:58 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)) 05:21:58 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)) 05:21:58 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)) 05:21:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21:58 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 05:21:58 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 05:21:58 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 05:21:58 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 05:21:58 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 05:21:58 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 05:22:00 INFO - Downloading blessings-1.6.tar.gz 05:22:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:22:00 INFO - Installing collected packages: blessings 05:22:00 INFO - Running setup.py install for blessings 05:22:00 INFO - Successfully installed blessings 05:22:00 INFO - Cleaning up... 05:22:01 INFO - Return code: 0 05:22:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:22:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:22:01 INFO - Reading from file tmpfile_stdout 05:22:01 INFO - Current package versions: 05:22:01 INFO - argparse == 1.2.1 05:22:01 INFO - blessings == 1.6 05:22:01 INFO - blobuploader == 1.2.4 05:22:01 INFO - docopt == 0.6.1 05:22:01 INFO - functools32 == 3.2.3-2 05:22:01 INFO - jsonschema == 2.5.1 05:22:01 INFO - manifestparser == 1.1 05:22:01 INFO - mozInstall == 1.12 05:22:01 INFO - mozcrash == 0.17 05:22:01 INFO - mozdebug == 0.1 05:22:01 INFO - mozdevice == 0.48 05:22:01 INFO - mozfile == 1.2 05:22:01 INFO - mozhttpd == 0.7 05:22:01 INFO - mozinfo == 0.9 05:22:01 INFO - mozleak == 0.1 05:22:01 INFO - mozlog == 3.3 05:22:01 INFO - moznetwork == 0.27 05:22:01 INFO - mozprocess == 0.23 05:22:01 INFO - mozprofile == 0.28 05:22:01 INFO - mozrunner == 6.12 05:22:01 INFO - mozscreenshot == 0.1 05:22:01 INFO - mozsystemmonitor == 0.3 05:22:01 INFO - moztest == 0.7 05:22:01 INFO - mozversion == 1.4 05:22:01 INFO - psutil == 3.1.1 05:22:01 INFO - requests == 1.2.3 05:22:01 INFO - wsgiref == 0.1.2 05:22:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:22:01 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')]} 05:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:01 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')]} 05:22:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:01 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 0x23a7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26663b0>, '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 0x26672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', '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 05:22:01 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 05:22:01 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 05:22:01 INFO - Using env: {'DISPLAY': ':0', 05:22:01 INFO - 'HOME': '/home/cltbld', 05:22:01 INFO - 'LANG': 'en_US.UTF-8', 05:22:01 INFO - 'LANGUAGE': 'en_US:en', 05:22:01 INFO - 'LOGNAME': 'cltbld', 05:22:01 INFO - 'MAIL': '/var/mail/cltbld', 05:22:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:01 INFO - 'MOZ_NO_REMOTE': '1', 05:22:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:01 INFO - 'NO_EM_RESTART': '1', 05:22:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:01 INFO - 'PWD': '/builds/slave/test', 05:22:01 INFO - 'SHELL': '/bin/bash', 05:22:01 INFO - 'SHLVL': '1', 05:22:01 INFO - 'TERM': 'linux', 05:22:01 INFO - 'TMOUT': '86400', 05:22:01 INFO - 'USER': 'cltbld', 05:22:01 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', 05:22:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:01 INFO - '_': '/tools/buildbot/bin/python'} 05:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:01 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)) 05:22:01 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)) 05:22:01 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)) 05:22:01 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)) 05:22:01 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)) 05:22:01 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)) 05:22:01 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)) 05:22:01 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)) 05:22:01 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)) 05:22:01 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)) 05:22:01 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)) 05:22:01 INFO - Cleaning up... 05:22:01 INFO - Return code: 0 05:22:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:22:01 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')]} 05:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:01 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')]} 05:22:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:01 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 0x23a7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x250a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2668180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26663b0>, '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 0x26672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', '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 05:22:01 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 05:22:01 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 05:22:01 INFO - Using env: {'DISPLAY': ':0', 05:22:01 INFO - 'HOME': '/home/cltbld', 05:22:01 INFO - 'LANG': 'en_US.UTF-8', 05:22:01 INFO - 'LANGUAGE': 'en_US:en', 05:22:01 INFO - 'LOGNAME': 'cltbld', 05:22:01 INFO - 'MAIL': '/var/mail/cltbld', 05:22:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:01 INFO - 'MOZ_NO_REMOTE': '1', 05:22:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:01 INFO - 'NO_EM_RESTART': '1', 05:22:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:01 INFO - 'PWD': '/builds/slave/test', 05:22:01 INFO - 'SHELL': '/bin/bash', 05:22:01 INFO - 'SHLVL': '1', 05:22:01 INFO - 'TERM': 'linux', 05:22:01 INFO - 'TMOUT': '86400', 05:22:01 INFO - 'USER': 'cltbld', 05:22:01 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', 05:22:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:01 INFO - '_': '/tools/buildbot/bin/python'} 05:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:22:01 INFO - Cleaning up... 05:22:01 INFO - Return code: 0 05:22:01 INFO - Running post-action listener: _resource_record_post_action 05:22:01 INFO - Running post-action listener: _start_resource_monitoring 05:22:01 INFO - Starting resource monitoring. 05:22:01 INFO - [mozharness: 2016-07-26 12:22:01.708334Z] Finished create-virtualenv step (success) 05:22:01 INFO - [mozharness: 2016-07-26 12:22:01.709330Z] Running install step. 05:22:01 INFO - Running pre-action listener: _resource_record_pre_action 05:22:01 INFO - Running main action method: install 05:22:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:22:01 INFO - Reading from file tmpfile_stdout 05:22:01 INFO - Detecting whether we're running mozinstall >=1.0... 05:22:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:22:01 INFO - Reading from file tmpfile_stdout 05:22:01 INFO - Output received: 05:22:01 INFO - Usage: mozinstall [options] installer 05:22:01 INFO - Options: 05:22:01 INFO - -h, --help show this help message and exit 05:22:01 INFO - -d DEST, --destination=DEST 05:22:01 INFO - Directory to install application into. [default: 05:22:01 INFO - "/builds/slave/test"] 05:22:01 INFO - --app=APP Application being installed. [default: firefox] 05:22:01 INFO - mkdir: /builds/slave/test/build/application 05:22:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:22:18 INFO - Reading from file tmpfile_stdout 05:22:18 INFO - Output received: 05:22:18 INFO - /builds/slave/test/build/application/firefox/firefox 05:22:18 INFO - Running post-action listener: _resource_record_post_action 05:22:18 INFO - [mozharness: 2016-07-26 12:22:18.385736Z] Finished install step (success) 05:22:18 INFO - [mozharness: 2016-07-26 12:22:18.386009Z] Running run-tests step. 05:22:18 INFO - Running pre-action listener: _resource_record_pre_action 05:22:18 INFO - Running main action method: run_tests 05:22:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:22:18 INFO - Python 2.7.3 05:22:18 INFO - Return code: 0 05:22:18 INFO - grabbing minidump binary from tooltool 05:22: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')]} 05:22:18 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 0x26663b0>, '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 0x26672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2667740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:22:18 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 05:22:18 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 05:22:18 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 05:22:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:22:18 INFO - Return code: 0 05:22:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:22:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:22:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:22:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:22:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:22:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 05:22:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 05:22:18 INFO - Using env: {'DISPLAY': ':0', 05:22:18 INFO - 'HOME': '/home/cltbld', 05:22:18 INFO - 'LANG': 'en_US.UTF-8', 05:22:18 INFO - 'LANGUAGE': 'en_US:en', 05:22:18 INFO - 'LOGNAME': 'cltbld', 05:22:18 INFO - 'MAIL': '/var/mail/cltbld', 05:22:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:22:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:22:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:18 INFO - 'MOZ_NO_REMOTE': '1', 05:22:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:22:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:18 INFO - 'NO_EM_RESTART': '1', 05:22:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:18 INFO - 'PWD': '/builds/slave/test', 05:22:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:22:18 INFO - 'SHELL': '/bin/bash', 05:22:18 INFO - 'SHLVL': '1', 05:22:18 INFO - 'TERM': 'linux', 05:22:18 INFO - 'TMOUT': '86400', 05:22:18 INFO - 'USER': 'cltbld', 05:22:18 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712', 05:22:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:18 INFO - '_': '/tools/buildbot/bin/python'} 05:22:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 05:22:18 INFO - mozversion application_buildid: 20160726042502 05:22:18 INFO - mozversion application_changeset: ccbf505eff5113af886ca4e3738d476bd0a83ca9 05:22:18 INFO - mozversion application_display_name: Nightly 05:22:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:22:18 INFO - mozversion application_name: Firefox 05:22:18 INFO - mozversion application_remotingname: firefox 05:22:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:22:18 INFO - mozversion application_vendor: Mozilla 05:22:18 INFO - mozversion application_version: 50.0a1 05:22:18 INFO - mozversion platform_buildid: 20160726042502 05:22:18 INFO - mozversion platform_changeset: ccbf505eff5113af886ca4e3738d476bd0a83ca9 05:22:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:22:18 INFO - mozversion platform_version: 50.0a1 05:22:18 INFO - using testdate: 1469535738 05:22:18 INFO - actual date: 1469535738 05:22:18 INFO - starting webserver on 'localhost:35931' 05:22:18 INFO - SUITE-START | Running 2 tests 05:22:18 INFO - TEST-START | dromaeo_css 05:22:18 INFO - operating with platform_type : linux_ 05:22:18 INFO - Initialising browser for dromaeo_css test... 05:22:18 INFO - TEST-INFO | started process 3296 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptEI0Xv/profile http://localhost:35931/getInfo.html) 05:22:23 INFO - PROCESS | 3296 | JavaScript error: , line 0: uncaught exception: undefined 05:22:24 INFO - PROCESS | 3296 | __metrics Screen width/height:1600/1200 05:22:24 INFO - PROCESS | 3296 | colorDepth:24 05:22:24 INFO - PROCESS | 3296 | Browser inner width/height: 1024/697 05:22:24 INFO - PROCESS | 3296 | __metrics 05:22:25 INFO - PROCESS | 3296 | 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" 05:22:25 INFO - PROCESS | 3296 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:22:26 INFO - TEST-INFO | 3296: exit 0 05:22:26 INFO - Browser initialized. 05:22:26 INFO - Running cycle 1/1 for dromaeo_css test... 05:22:26 INFO - TEST-INFO | started process 3375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptEI0Xv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:22:38 INFO - PROCESS | 3375 | RSS: Main: 158846976 05:22:38 INFO - PROCESS | 3375 | 05:23:30 INFO - PROCESS | 3375 | 1469535810148 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] 05:25:43 INFO - PROCESS | 3375 | Cycle 1(1): loaded http://localhost:35931/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35931/tests/dromaeo/cssquery-ext.html) 05:25:44 INFO - PROCESS | 3375 | RSS: Main: 272084992 05:25:44 INFO - PROCESS | 3375 | 05:28:47 INFO - PROCESS | 3375 | Cycle 1(1): loaded http://localhost:35931/tests/dromaeo/cssquery-ext.html (next: http://localhost:35931/tests/dromaeo/cssquery-jquery.html) 05:28:47 INFO - PROCESS | 3375 | RSS: Main: 247578624 05:28:47 INFO - PROCESS | 3375 | 05:31:49 INFO - PROCESS | 3375 | Cycle 1(1): loaded http://localhost:35931/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35931/tests/dromaeo/cssquery-mootools.html) 05:31:50 INFO - PROCESS | 3375 | RSS: Main: 189333504 05:31:50 INFO - PROCESS | 3375 | 05:34:52 INFO - PROCESS | 3375 | Cycle 1(1): loaded http://localhost:35931/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35931/tests/dromaeo/cssquery-prototype.html) 05:34:53 INFO - PROCESS | 3375 | RSS: Main: 242450432 05:34:53 INFO - PROCESS | 3375 | 05:37:56 INFO - PROCESS | 3375 | Cycle 1(1): loaded http://localhost:35931/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35931/tests/dromaeo/cssquery-yui.html) 05:37:56 INFO - PROCESS | 3375 | RSS: Main: 191602688 05:37:56 INFO - PROCESS | 3375 | 05:41:00 INFO - PROCESS | 3375 | Cycle 1(1): loaded http://localhost:35931/tests/dromaeo/cssquery-yui.html (next: http://localhost:35931/tests/dromaeo/cssquery-dojo.html) 05:41:00 INFO - PROCESS | 3375 | RSS: Main: 282812416 05:41:00 INFO - PROCESS | 3375 | 05:41:00 INFO - PROCESS | 3375 | __start_tp_report 05:41:00 INFO - PROCESS | 3375 | _x_x_mozilla_page_load 05:41:00 INFO - PROCESS | 3375 | _x_x_mozilla_page_load_details 05:41:00 INFO - PROCESS | 3375 | |i|pagename|runs| 05:41:00 INFO - PROCESS | 3375 | |0;dojo.html;2645.563482025466;2665.640138581291;2689.744474274943;2695.272276485349;2704.824186427882;4672.5327467253255;4789.401324834395;4844.055409195208;4868.707877527347;4886.242632391981;4751.786169622366;4786.904261914751;4810.06203790261;4814.037192561493;4882.951170488294;4403.955960440387;4405.625521830648;4428.512863585003;4435.4899186593475;4616.2613981762925;4573.519780423041;4578.702384345007;4578.908421831578;4587.610053145487;4600;4323.697341186118;4385.758783266919;4392.912141757147;4393.6045755881805;4395.912081758347;4445.777711114463;4450.043240703232;4458.509563947963;4458.910821783546;4465.062336909253;4287.142571485684;4325.718828276152;4351.760653164075;4431.7784110794655;4435.401220835211;4690.554397332282;4755.619550435957;4781.593564546983;4797.328374027639;4844.958333958216;5174.818881339173;5175.508326708994;5178.0679477694;5178.818741344035;5181.093308670967;4947.529984651453;5082.288479612857;5152.639315247934;5166.61250406221;5198.142306519419;4820.71075735457;4852.053849499349;4853.417589889165;4857.222844344888;4858.732769697701;5330.866728331745;5332.200169974535;5334.493223143795;5345.893082138336;5356.571474282048;4873.829415970424;4959.603231741524;4978.502149784992;5005.849824505271;5111.284420181178;5078.542931136216;5141.2545180948555;5150.819721309736;5170.560502357342;5171.560417364566;5052.418971818288;5066.594672426197;5071.8985620287385;5073.594112470993;5121.180611102206;4967.180415231519;5015.724135172601;5064.49355064498;5103.489651034867;5106.974465127725;4064.1871625674394;4064.7154699170774;4089.7546147230664;4101.733387329814;4101.958980410217;3575.535180426528;3591.2637909228547;3600.867245496435;3623.8188090595363;3626.456031595229;4298.09739954613;4348;4406.801693923781;4460.50934397216;4463.598276155161;5165.328507294028;5194.662346947436;5208.713520756319;5237.580993520509;5246.23929530216;4450.354698568754;4466.464024317038;4468.594217347956;4478.664100192498;4516.751578663205;4494.617957473652;4590.793414296298;4683.859484215479;4690.929636055462;4727.905441891212;4846.079244943449;4871.63462740303;4883.536064073907;4918.409790825124;4932.235503496964;5175.223716442564;5187.740612969261;5189.247559103985;5192.117340052125;5235.528802407802;4682.648801339845;4749.168895443215;4822;4860.562549370574;4870.057338595492;4982.526659967298;5028.773705183203;5052.418971818141;5082.847514574569;5130;5102.285680004728;5130.615203859651;5140.56305214046;5148.073346797462;5196.064708352382;4881.877953051202;5001.7749201285305;5018.121828679893;5018.573421259234;5023.572996295356;4904.435989861212;4990.50094990498;4992.675476094042;4993.950060499348;5045.8738531537;4930.753462326941;4939.333190019302;4949.925751113664;4970.726610036482;4979.875503112451;4853.247746599282;5025.597952163745;5031.496850314939;5032.144535428913;5034.244863270539;4932.53140951609;4964.875878102932;4985.4266759323145;5004.099262132851;5010 05:41:00 INFO - PROCESS | 3375 | |1;ext.html;585.2070444547638;586.557149352239;587.5828162004976;589.7051474262869;594.982150535484;26178.86910565447;36865;38272;38519.229615407676;41948.161036779326;39899.40150897732;40299;40299.79850100753;40315.59684403155;40330.59669403305;7681.270279323456;7812.375009999187;7824.960875195616;7826.256505631955;7833.9608301958415;7132.108486439195;9802.117809397152;10061.949690251538;10063.446510441923;10419.791604167913;10125.24060695447;10209.183265338756;10217.897821021807;10222.591096356136;10235.795284094314;10070.395776253412;10133.442660653662;10134.23993200513;10134.493275336241;10135.189184865194;9861.112499875046;9930.255230857714;9944.303898727092;9947.253955953332;9952;37660.623393765985;37934.43098353527;37937;37941.43087853684;37959.8102009491;3129.264622813637;3217.678232176787;3300.818454984975;3414.6926776589976;3422.4866270059442;28711.13866584006;28762.424751505063;29120.41759164805;29633.555496667566;29863.701362986525;3282.8383100381175;3366.764326497146;3368.6126095499085;3395.6264810870784;3447.9310413791836;265361;267021;267650;267722;268393;54067.45932540703;54550.727246363516;54593;54628;54632;29488.557671634942;29763.404731905674;29949.700502994692;30011.549826752616;57816.421835781104;14471.131732096108;14510.91168162371;14552.126872387691;14578.489752858599;14615.488457903923;10585.894141058645;10884.836727449094;11684.824727629093;11757.353345565905;11831.17181797266;17091.230894609773;17699;17945.7308140378;17962;18299.63400731978;6755.695993680296;6787.423069039089;6798.864022719518;6944.965275173693;7133.429325653935;771.7298945369188;860.475110182788;900.3247564326755;918.9386258871015;988.1551273661061;26939.865300673373;27111;27826.860865695948;27835.443291134063;27889.721102789117;935.9251259899328;953.9809203816023;966.1932286540817;1007.7883644434604;1018.256672628985;15035.624109397133;15686.76469852953;15688.686226275411;16305.429309974332;16429.342826286815;422662;424873;425586;425721;426611;48791.5120848787;49397.25904111441;49405.75297123563;49567.50432495629;49752.75123624431;1093.50245638236;1127.2841745491671;1166.7608140331042;1187.0978056676815;1205.3852535206931;24083;26754.866225668746;26930.59604105901;27069.353457716545;27481;39347.409788852616;39636.80181599074;39639.40540891831;39640.2071958565;39794.40308395434;323014;324237;325724;325796;325919;24360;24864.50270994606;25377.111801086874;25521.234362969142;26786.59820102739;39814.80092599519;40003.599963999986;40203.79898100491;40596;41080.794596026826;34729.82635086808;34745.30509389748;34818.129546761535;35668.643313566536;35698.28603427865;34988.30023399569;35209;35380.82309588538;35451.29097418089;35534.82232588924;34017.58364164344;34263.82868085644;34917;35218.64781352256;35304.823475882455;29602;32089.839550802095;32092.67907320897;32398.056116633077;32434.837825811665;24077.157299494433;24475.26574202777;24498.51002979895;24904.252872413857;25143.119990800235 05:41:00 INFO - PROCESS | 3375 | |2;jquery.html;343.1350609437708;363.3949474125581;364.855881926639;365.1747051663242;379.84046700385835;12871.871281287184;16258;16851.241694123764;18020.999999999967;18238;17037.233324500397;17379.217935192915;17476.912615436937;17601.295948162056;17741.112944352764;5006.574441172495;5246.501582349671;5488.4785945335125;5521.4478552144665;5601.635893666919;3512.1570823002553;5086.516780905827;5482.451754824506;5519.862003449925;5522.420145884685;5416.891662166754;5434.8913021739545;5440.727963601824;5441.156620723775;5449.64577302476;5259.263703081533;5436.21174929637;5439.048166570854;5457.808976685837;5492.368377636543;5326.786928522854;5327.946720532784;5329.040772660919;5332.68003919766;5337.466253374631;11618;17667.73498397525;20391.898040509852;20888.89555552228;21053.263135790326;1850.3523766681687;1956.7358406615067;1962.107241205248;2156.816670583002;2237.127520267097;8487.363447741443;8951.776205594848;9261.073892610684;9431.056894310583;9436.669716559956;1702.1659386900453;1762.97355539667;1767.4785938148277;1778.919948602316;1812.392848395789;67552.3244767551;69044.30955690429;69125.65437172832;70491.64754176248;71680.64159679221;9533.904660953302;9620.71137865865;10034.548445319979;10071.295009349275;10210.285280030326;13906.165630062027;13906.930465347608;13913.30433478322;13915.30423478822;13927.512537061155;7121.643917804089;7125.287471252833;7226.674799634029;7242.529235599774;7600.315971562586;6650.46796256308;6676.866462670817;6746.561473504206;6856.211535673362;6887.20797108339;4187.560306167869;4194.266003449445;4346.326319420495;4393.494748103945;4477.507474177838;1744.891993584058;1816.5731053202487;1840.4110684580805;1868.9813101869079;1869.643989039677;743.687651186503;757.7007082202499;791.3945831438954;812.8983877015373;824.0552296580066;16591.170441477876;17457;17721.29114835392;17814.287428502714;17904.731429028576;849.3375167369462;851.6806197675871;855.9471849624872;858.0647094666843;913.5204017890528;9363.063693630582;9792.55933482995;9858.359206651545;9919.057689519484;10006.399616023062;367894;368655;372783;374378;381761;76926.61536692281;78567.60716196382;79389;79980.60009700031;80674;892.7455675132557;900.8783814185132;927.174814415171;929.080210591523;931.8276118918022;15088.471903483765;15316.234188290764;15631.921840390725;15760.842391575938;15954.840451595335;37962.24075518419;38499;39588.40617390799;39748.83265175509;39777.80111099426;52243.47756522386;52730.73634631802;53868;57796;58243;7279.1265048194555;7393.186749457663;7605.125410577633;7609.809754755954;7740.806479838049;10267.229957753048;12010.63968080959;12046.75906481883;12088.576899808464;12115.939420302842;9754.341761900352;9772.657956971472;9797.804043919225;9859.654912078044;9877.901220987698;10519.94740026295;10567.365958042234;10590.735231619272;10683.465826708478;11094.611688590861;9723.611055557698;9742.610295588098;9801.31390802637;9973.102420782165;10178.389296642225;7392.630368481662;7402;7629.771106866803;7755.146933837161;7826.334761545332;8123.6750529978135;9484.099010593982;9717.465539395118;9902.504874756378;10092.293539452168 05:41:00 INFO - PROCESS | 3375 | |3;mootools.html;1268.5116230251363;1354.6342487528364;1404.5786264120761;1466.2375564706347;1662.3683000459823;6435.163428754261;7568.772936811897;7827.960860195691;7834.608269586519;8081.838363232732;7862.410319226066;7907.288344049034;7923.524588524692;7927.643256053477;7929.801754956129;2194.6378847490146;2221.911123555056;2222.211115054157;2225.3657707553352;2228.1198926424054;2132.1791110422523;2171.771963943787;2185.9562808743817;2187.157944191482;2195.7584665686763;2164.729408823897;2168.1544197762805;2170.89145542723;2171.6959625652344;2217.7116974793335;2169.240765731997;2174.282486779367;2174.967375489369;2175.0647221694667;2175.7389113306344;2126.0857831132607;2171.619966505871;2176.662617294322;2177.3467959612053;2179.0194412514434;7718.459707820399;7843.764687059397;7850.725224617168;7874.448788584801;7892.131865494791;4343.6959412841115;4473.9552604473865;4492.3710680504755;4502.527234640381;4551.453825540923;2804.0466241477793;2900;2941.9264518387;2942.337973955864;2963.8073525220793;867.2324992381724;877.3113106211657;881.1056777370974;882.0297672560132;885.424474091839;10469.31949423285;10560.735981600445;10570.841437378445;10604.628837990633;10607.469626518643;3892.8637497687446;4061.3095773718537;4088.0597462583773;4191.308434108399;4194.077302993336;8393.412461127784;8406.075331713506;8410.957945210235;8414.074451810297;8415.831683366298;4536.705114167635;4560.543945605413;4562.224421848294;4563.0873825235085;4571.2000399929875;3681.1349332906743;3859.864904728377;4021.135455876942;4241.257779888507;4262.914741705148;3405.9659403406145;3409.62494125646;3522.383582872987;3526.858925642997;3538.8938331850086;1009.9899001009895;1011.0546638892658;1016.3089099412323;1021.7292417509366;1022.2384323678758;831.3930830493773;862.4178679391385;868.1015149320423;897.1387468030764;898.8067565473455;5303.681779093266;5435.7825686972865;5480.534154596824;5484.067708489566;5683.5737319700365;880.4673172730534;896.1397058823472;900.1583519409373;904.2088172848757;909.2907532124954;3662.08447888028;3753.7560058596105;3795.1081495848453;3890.844366225376;3902.0635047588376;9534.713958581253;10026.949865250774;10043.397396156108;10045.19638428924;10071.5467803949;9919.603215871428;9943;9953.850692239623;9964.701058968243;9972.950135249423;6947.444204463631;7259.274072592699;7299.744508942162;7391.039164908528;7435.776926692208;5569.66582005081;5624.74688639004;5624.887502250014;5653.293338332708;5787.8553036174435;8653.39426240157;8748.956255218684;8780.209781119729;8800.38397312182;8851.46891186531;8772.736817895473;8879.778005549913;8946.910530894867;9080.40977336471;9098.181163695035;6130.080487926846;6393.073004414427;6882.655867206719;7062.223155452793;7070.540414873017;7376.852462950818;7634;7643.694252229849;7646.464747467624;7649.502782319131;6529.7388104475285;6642.966785166043;6673.466122710269;6774.085498457645;6813.114295141798;6484.221893372825;6710.396064354036;6766.492513061442;6812.557183783038;6831.863362732618;6337;6427.068075129174;6427.967860160669;6434.485241180788;6436.645984470899;4640.907181856412;4705.294205869147;4768.046390721939;4788.018456216398;4856.732879691651;4594.655400845017;4630.259158534618;4747.646920627604;4831.855044348676;4860.198067318853 05:41:00 INFO - PROCESS | 3375 | |4;prototype.html;269.1736369346107;276.14670667637;280.23216387099353;284.9259192609921;285.5174754664617;4864.367632207813;4865.951340486594;4900.705957642544;4908.190148625477;4914.017196560684;4501.482329532105;4569.954300456994;4621.722696638196;4677.74272415017;4873.415190177184;3763.2849758545926;3764.849406023756;3766.303233901723;3780.7164462665273;3786.8863934082024;3762.4168253920684;3783;3788.583255841869;3802.714796390268;3814.19901820618;3571.3035957988204;3656.4880916671686;3736.0099573613015;3752.718546109039;3772.6038765929457;3749.4188400797784;3756.793376364299;3757.9436308455397;3776.622337766229;3782.205736795276;3330.150811543065;3330.81680507572;3341.04780137662;3341.2816244507303;3352.0949343677316;4701.712112235692;4747.430308362984;4762.071396077767;4785.880352991168;4790.161721698689;4252.085801552681;4277.294246449332;4297.699161058727;4303.91392172158;4345.739255644671;5054.7472626368535;5073.568746656539;5080.13637681595;5086.287919691246;5121.261479120263;3635.8909232723063;3640.1445660269815;3661.6887564557046;3663.981680091609;3667.523221981152;5224.63427560071;5300.681959082467;5322.76047577856;5336.733163341817;5386.434424385461;3680.2271522980473;3684.9447258291148;3686.4286035664513;3690.409534474471;3704.3517384457614;3742.36379815432;3764.284785890672;3765.86819461323;3766.303233901737;3771.4719939208535;4126.731762435432;4282.850100246476;4303.33298338758;4305.74165550068;4306.892327691833;5035.949640503548;5041.1769409131;5043.823466178666;5050.444451110375;5097.362829646294;1276.0493432392927;1284.441268048402;1287.9098463107493;1301.466398776516;1306.941377484222;776.1423626892316;820.6102101501739;825.2449009156675;830.4021104804531;835.8465317861312;4078.938815917764;4114.847842604016;4118.732282401635;4134.656236723077;4148;4608.133705849136;4640.419947506562;4669.486356500782;4677.555632214934;4692.389989301369;4065.6747460203114;4104.220198162339;4105.050101201905;4143.440635514227;4143.585641435892;2509.3475696319088;2616.476704659076;2816.9295767605972;2818.309514169042;2842.374677570931;4959.70241785494;4962.851114466572;4963.404391472975;4970.950290497049;4996.750162491933;5128;5396.757145928443;5404.216388623628;5431.207701458509;5437.238786569884;4768.880777980509;4799.328094066834;4922.33548470959;4931.9753401232765;4941.728204948834;5196.32447781786;5226.817061402985;5241.318628578413;5271.630985830955;5275.841724748264;4943.9505604944925;5150.4592017837585;5181;5181.55956743666;5199.194124910645;4944.406671199479;4952.232403977389;4959.181735013683;4960.603151747924;4963;3621.583517895476;3634.6547078027547;3656.1225305925855;3671.320805650963;3672.265546890579;5141.485851414828;5264.630916087699;5333.466653334635;5336.9466305338;5337.332833395825;5092.185250359925;5100.617453691062;5107.719075450737;5111.361079865017;5134.820281290137;5086.338775959101;5090.338256026693;5117.8720531987;5159.896802064013;5165.985265746437;4852.417709874697;5055.266986287042;5077;5095.439501654889;5104.438511763778;5160.142348754521;5172.844814655567;5190.377154741455;5203.479652034766;5205.6616319939085;5066.873328166678;5079.476157152913;5094.337736094284;5094.337736094432;5113 05:41:00 INFO - PROCESS | 3375 | |5;yui.html;633.9175907132072;648.3516483516484;683.0914883205337;723.3598265535003;726.1358982810456;12314.630561083159;13032;13083.869161308385;13103.08278420511;13165.473381064758;13037.934810325958;13110.278934658614;13124.212547247173;13127.737445251089;13132.868671313285;611.9265688117432;628.8270725550465;746.3916907720218;750.6021808441535;767.3784234769854;766.2108028730416;776.0648418655506;776.216021817965;777.4480119115435;778.1945686214768;819.5779173725537;820.4134044158426;820.9425340226187;821.2157389692859;821.4414198345123;666.7466362782112;801.2628381888618;813.7029984055836;814.3241109878786;825.4015838517087;596.6241268001131;596.9373215812363;596.9850753731191;597.035787203663;597.4085655201363;13004.934975325063;13019.349032548334;13040.543580974716;13051.804222936664;13057.804132938014;12059.397030148457;12249.203801752858;12454.75090498194;12709.555165569162;12945.551711417076;11156.442177891073;11246.718832029264;11283.548658053667;11794.941025294904;11977.760444791142;3344.3812894614575;3355.7818741781707;3371.039253812676;3462.9307413851834;3482.7736197147105;62896.371036289966;63476.047859282146;64467.3553264466;64904.35095649077;65773.34226657767;10349.664213317503;10686.893131068746;10923.508442120125;10973.890261097447;11308.943455282835;19940.90325032137;20537;20545.69181462279;20567.4858128545;20589.176432942815;6868.450523958071;6918.688659010357;6990.720371185197;7015.123109611299;7086.645667716697;3590.515280437108;3723.106454450912;3748.3253014457114;3809.504764380613;3843.2121415109837;2937.9853100734786;3007.263220510989;3017.6227971503563;3035.4991426414836;3037.9848100759355;492.2984746735887;555.611072249427;573.8249833800647;588.358689028952;590.9320428150818;464.45194670289385;526.6734624532814;565.197419664078;578.1097110449944;581.8370856160282;8388.748337549883;8548.102449242864;8553.44402613828;8587.355948303903;8647.697330593399;527.9049771041173;539.5036566358959;545.6616897523561;547.3049227481076;551.5339538090308;3611.8735844245325;3671.706263498967;3810.8856734298015;3868.5357757069332;3969.523657161159;59467;59954.700226498586;60190.39809601848;68075;109981;84536.57731711425;96718.51640741892;96877.2185946977;98210.5089474548;98446.5077674607;83673;83761;84221.57889210638;87069.5646521776;89172.5541372289;7134.081169901302;7244;7295.635218239173;7429.962850185714;7653.57905315213;40320.596794031684;47581.28628070651;47811.5218847821;49864.75067624639;50296.74851625718;67927.66036169787;71031.28968710247;72862.63568682123;74223.62888185524;75753.62123189348;10205.795884082128;10279.074883260542;10294.330868493524;10453.68638940833;10757.354558726502;11517.53929842797;11562.884371156517;11572.250530997426;11619.321299927255;12033.578824741442;9787.46168960714;10007.399556026661;10257.846132307872;10327.948360258151;10538.89461105379;10418.583256669952;10578.788424231627;11050.778984420105;11330.830037549607;11811.822822657496;11283.605073822377;12025.4588543514;12396.628101156979;12712.046596505485;12726.618201453972;10582;10595.682129535819;10676.306040107369;10890.29213101146;11238.157138214503;9529.237660987243;9807.85288220663;9925.702228933143;9978;10092.192624589869 05:41:00 INFO - PROCESS | 3375 | __end_tp_report 05:41:00 INFO - PROCESS | 3375 | __start_cc_report 05:41:00 INFO - PROCESS | 3375 | _x_x_mozilla_cycle_collect,1136 05:41:00 INFO - PROCESS | 3375 | __end_cc_report 05:41:00 INFO - PROCESS | 3375 | __startTimestamp1469536860251__endTimestamp 05:41:00 INFO - PROCESS | 3375 | 05:41:00 INFO - PROCESS | 3375 | ------- Summary: start ------- 05:41:00 INFO - PROCESS | 3375 | Number of tests: 6 05:41:00 INFO - PROCESS | 3375 | 05:41:00 INFO - PROCESS | 3375 | [#0] dojo.html Cycles:165 Average:4740.70 Median:4881.88 stddev:519.28 (10.6%) stddev-sans-first:494.18 05:41:00 INFO - PROCESS | 3375 | Values: 2645.6 2665.6 2689.7 2695.3 2704.8 4672.5 4789.4 4844.1 4868.7 4886.2 4751.8 4786.9 4810.1 4814.0 4883.0 4404.0 4405.6 4428.5 4435.5 4616.3 4573.5 4578.7 4578.9 4587.6 4600.0 4323.7 4385.8 4392.9 4393.6 4395.9 4445.8 4450.0 4458.5 4458.9 4465.1 4287.1 4325.7 4351.8 4431.8 4435.4 4690.6 4755.6 4781.6 4797.3 4845.0 5174.8 5175.5 5178.1 5178.8 5181.1 4947.5 5082.3 5152.6 5166.6 5198.1 4820.7 4852.1 4853.4 4857.2 4858.7 5330.9 5332.2 5334.5 5345.9 5356.6 4873.8 4959.6 4978.5 5005.8 5111.3 5078.5 5141.3 5150.8 5170.6 5171.6 5052.4 5066.6 5071.9 5073.6 5121.2 4967.2 5015.7 5064.5 5103.5 5107.0 4064.2 4064.7 4089.8 4101.7 4102.0 3575.5 3591.3 3600.9 3623.8 3626.5 4298.1 4348.0 4406.8 4460.5 4463.6 5165.3 5194.7 5208.7 5237.6 5246.2 4450.4 4466.5 4468.6 4478.7 4516.8 4494.6 4590.8 4683.9 4690.9 4727.9 4846.1 4871.6 4883.5 4918.4 4932.2 5175.2 5187.7 5189.2 5192.1 5235.5 4682.6 4749.2 4822.0 4860.6 4870.1 4982.5 5028.8 5052.4 5082.8 5130.0 5102.3 5130.6 5140.6 5148.1 5196.1 4881.9 5001.8 5018.1 5018.6 5023.6 4904.4 4990.5 4992.7 4994.0 5045.9 4930.8 4939.3 4949.9 4970.7 4979.9 4853.2 5025.6 5031.5 5032.1 5034.2 4932.5 4964.9 4985.4 5004.1 5010.0 05:41:00 INFO - PROCESS | 3375 | 05:41:00 INFO - PROCESS | 3375 | [#1] ext.html Cycles:180 Average:48480.82 Median:3382.12 stddev:91109.98 (2693.9%) stddev-sans-first:91294.59 05:41:00 INFO - PROCESS | 3375 | Values: 585.2 586.6 587.6 589.7 595.0 26178.9 36865.0 38272.0 38519.2 41948.2 39899.4 40299.0 40299.8 40315.6 40330.6 7681.3 7812.4 7825.0 7826.3 7834.0 7132.1 9802.1 10061.9 10063.4 10419.8 10125.2 10209.2 10217.9 10222.6 10235.8 10070.4 10133.4 10134.2 10134.5 10135.2 9861.1 9930.3 9944.3 9947.3 9952.0 37660.6 37934.4 37937.0 37941.4 37959.8 3129.3 3217.7 3300.8 3414.7 3422.5 28711.1 28762.4 29120.4 29633.6 29863.7 3282.8 3366.8 3368.6 3395.6 3447.9 265361.0 267021.0 267650.0 267722.0 268393.0 54067.5 54550.7 54593.0 54628.0 54632.0 29488.6 29763.4 29949.7 30011.5 57816.4 14471.1 14510.9 14552.1 14578.5 14615.5 10585.9 10884.8 11684.8 11757.4 11831.2 17091.2 17699.0 17945.7 17962.0 18299.6 6755.7 6787.4 6798.9 6945.0 7133.4 771.7 860.5 900.3 918.9 988.2 26939.9 27111.0 27826.9 27835.4 27889.7 935.9 954.0 966.2 1007.8 1018.3 15035.6 15686.8 15688.7 16305.4 16429.3 422662.0 424873.0 425586.0 425721.0 426611.0 48791.5 49397.3 49405.8 49567.5 49752.8 1093.5 1127.3 1166.8 1187.1 1205.4 24083.0 26754.9 26930.6 27069.4 27481.0 39347.4 39636.8 39639.4 39640.2 39794.4 323014.0 324237.0 325724.0 325796.0 325919.0 24360.0 24864.5 25377.1 25521.2 26786.6 39814.8 40003.6 40203.8 40596.0 41080.8 34729.8 34745.3 34818.1 35668.6 35698.3 34988.3 35209.0 35380.8 35451.3 35534.8 34017.6 34263.8 34917.0 35218.6 35304.8 29602.0 32089.8 32092.7 32398.1 32434.8 24077.2 24475.3 24498.5 24904.3 25143.1 05:41:00 INFO - PROCESS | 3375 | 05:41:00 INFO - PROCESS | 3375 | [#2] jquery.html Cycles:180 Average:24000.51 Median:5330.86 stddev:61865.38 (1160.5%) stddev-sans-first:62013.43 05:41:00 INFO - PROCESS | 3375 | Values: 343.1 363.4 364.9 365.2 379.8 12871.9 16258.0 16851.2 18021.0 18238.0 17037.2 17379.2 17476.9 17601.3 17741.1 5006.6 5246.5 5488.5 5521.4 5601.6 3512.2 5086.5 5482.5 5519.9 5522.4 5416.9 5434.9 5440.7 5441.2 5449.6 5259.3 5436.2 5439.0 5457.8 5492.4 5326.8 5327.9 5329.0 5332.7 5337.5 11618.0 17667.7 20391.9 20888.9 21053.3 1850.4 1956.7 1962.1 2156.8 2237.1 8487.4 8951.8 9261.1 9431.1 9436.7 1702.2 1763.0 1767.5 1778.9 1812.4 67552.3 69044.3 69125.7 70491.6 71680.6 9533.9 9620.7 10034.5 10071.3 10210.3 13906.2 13906.9 13913.3 13915.3 13927.5 7121.6 7125.3 7226.7 7242.5 7600.3 6650.5 6676.9 6746.6 6856.2 6887.2 4187.6 4194.3 4346.3 4393.5 4477.5 1744.9 1816.6 1840.4 1869.0 1869.6 743.7 757.7 791.4 812.9 824.1 16591.2 17457.0 17721.3 17814.3 17904.7 849.3 851.7 855.9 858.1 913.5 9363.1 9792.6 9858.4 9919.1 10006.4 367894.0 368655.0 372783.0 374378.0 381761.0 76926.6 78567.6 79389.0 79980.6 80674.0 892.7 900.9 927.2 929.1 931.8 15088.5 15316.2 15631.9 15760.8 15954.8 37962.2 38499.0 39588.4 39748.8 39777.8 52243.5 52730.7 53868.0 57796.0 58243.0 7279.1 7393.2 7605.1 7609.8 7740.8 10267.2 12010.6 12046.8 12088.6 12115.9 9754.3 9772.7 9797.8 9859.7 9877.9 10519.9 10567.4 10590.7 10683.5 11094.6 9723.6 9742.6 9801.3 9973.1 10178.4 7392.6 7402.0 7629.8 7755.1 7826.3 8123.7 9484.1 9717.5 9902.5 10092.3 05:41:00 INFO - PROCESS | 3375 | 05:41:00 INFO - PROCESS | 3375 | [#3] mootools.html Cycles:180 Average:5144.81 Median:5458.16 stddev:2881.60 (52.8%) stddev-sans-first:2874.96 05:41:00 INFO - PROCESS | 3375 | Values: 1268.5 1354.6 1404.6 1466.2 1662.4 6435.2 7568.8 7828.0 7834.6 8081.8 7862.4 7907.3 7923.5 7927.6 7929.8 2194.6 2221.9 2222.2 2225.4 2228.1 2132.2 2171.8 2186.0 2187.2 2195.8 2164.7 2168.2 2170.9 2171.7 2217.7 2169.2 2174.3 2175.0 2175.1 2175.7 2126.1 2171.6 2176.7 2177.3 2179.0 7718.5 7843.8 7850.7 7874.4 7892.1 4343.7 4474.0 4492.4 4502.5 4551.5 2804.0 2900.0 2941.9 2942.3 2963.8 867.2 877.3 881.1 882.0 885.4 10469.3 10560.7 10570.8 10604.6 10607.5 3892.9 4061.3 4088.1 4191.3 4194.1 8393.4 8406.1 8411.0 8414.1 8415.8 4536.7 4560.5 4562.2 4563.1 4571.2 3681.1 3859.9 4021.1 4241.3 4262.9 3406.0 3409.6 3522.4 3526.9 3538.9 1010.0 1011.1 1016.3 1021.7 1022.2 831.4 862.4 868.1 897.1 898.8 5303.7 5435.8 5480.5 5484.1 5683.6 880.5 896.1 900.2 904.2 909.3 3662.1 3753.8 3795.1 3890.8 3902.1 9534.7 10026.9 10043.4 10045.2 10071.5 9919.6 9943.0 9953.9 9964.7 9973.0 6947.4 7259.3 7299.7 7391.0 7435.8 5569.7 5624.7 5624.9 5653.3 5787.9 8653.4 8749.0 8780.2 8800.4 8851.5 8772.7 8879.8 8946.9 9080.4 9098.2 6130.1 6393.1 6882.7 7062.2 7070.5 7376.9 7634.0 7643.7 7646.5 7649.5 6529.7 6643.0 6673.5 6774.1 6813.1 6484.2 6710.4 6766.5 6812.6 6831.9 6337.0 6427.1 6428.0 6434.5 6436.6 4640.9 4705.3 4768.0 4788.0 4856.7 4594.7 4630.3 4747.6 4831.9 4860.2 05:41:00 INFO - PROCESS | 3375 | 05:41:00 INFO - PROCESS | 3375 | [#4] prototype.html Cycles:180 Average:4188.58 Median:4754.75 stddev:1232.18 (25.9%) stddev-sans-first:1200.01 05:41:00 INFO - PROCESS | 3375 | Values: 269.2 276.1 280.2 284.9 285.5 4864.4 4866.0 4900.7 4908.2 4914.0 4501.5 4570.0 4621.7 4677.7 4873.4 3763.3 3764.8 3766.3 3780.7 3786.9 3762.4 3783.0 3788.6 3802.7 3814.2 3571.3 3656.5 3736.0 3752.7 3772.6 3749.4 3756.8 3757.9 3776.6 3782.2 3330.2 3330.8 3341.0 3341.3 3352.1 4701.7 4747.4 4762.1 4785.9 4790.2 4252.1 4277.3 4297.7 4303.9 4345.7 5054.7 5073.6 5080.1 5086.3 5121.3 3635.9 3640.1 3661.7 3664.0 3667.5 5224.6 5300.7 5322.8 5336.7 5386.4 3680.2 3684.9 3686.4 3690.4 3704.4 3742.4 3764.3 3765.9 3766.3 3771.5 4126.7 4282.9 4303.3 4305.7 4306.9 5035.9 5041.2 5043.8 5050.4 5097.4 1276.0 1284.4 1287.9 1301.5 1306.9 776.1 820.6 825.2 830.4 835.8 4078.9 4114.8 4118.7 4134.7 4148.0 4608.1 4640.4 4669.5 4677.6 4692.4 4065.7 4104.2 4105.1 4143.4 4143.6 2509.3 2616.5 2816.9 2818.3 2842.4 4959.7 4962.9 4963.4 4971.0 4996.8 5128.0 5396.8 5404.2 5431.2 5437.2 4768.9 4799.3 4922.3 4932.0 4941.7 5196.3 5226.8 5241.3 5271.6 5275.8 4944.0 5150.5 5181.0 5181.6 5199.2 4944.4 4952.2 4959.2 4960.6 4963.0 3621.6 3634.7 3656.1 3671.3 3672.3 5141.5 5264.6 5333.5 5336.9 5337.3 5092.2 5100.6 5107.7 5111.4 5134.8 5086.3 5090.3 5117.9 5159.9 5166.0 4852.4 5055.3 5077.0 5095.4 5104.4 5160.1 5172.8 5190.4 5203.5 5205.7 5066.9 5079.5 5094.3 5094.3 5113.0 05:41:00 INFO - PROCESS | 3375 | 05:41:00 INFO - PROCESS | 3375 | [#5] yui.html Cycles:180 Average:18034.53 Median:25178.52 stddev:25985.86 (103.2%) stddev-sans-first:26025.91 05:41:00 INFO - PROCESS | 3375 | Values: 633.9 648.4 683.1 723.4 726.1 12314.6 13032.0 13083.9 13103.1 13165.5 13037.9 13110.3 13124.2 13127.7 13132.9 611.9 628.8 746.4 750.6 767.4 766.2 776.1 776.2 777.4 778.2 819.6 820.4 820.9 821.2 821.4 666.7 801.3 813.7 814.3 825.4 596.6 596.9 597.0 597.0 597.4 13004.9 13019.3 13040.5 13051.8 13057.8 12059.4 12249.2 12454.8 12709.6 12945.6 11156.4 11246.7 11283.5 11794.9 11977.8 3344.4 3355.8 3371.0 3462.9 3482.8 62896.4 63476.0 64467.4 64904.4 65773.3 10349.7 10686.9 10923.5 10973.9 11308.9 19940.9 20537.0 20545.7 20567.5 20589.2 6868.5 6918.7 6990.7 7015.1 7086.6 3590.5 3723.1 3748.3 3809.5 3843.2 2938.0 3007.3 3017.6 3035.5 3038.0 492.3 555.6 573.8 588.4 590.9 464.5 526.7 565.2 578.1 581.8 8388.7 8548.1 8553.4 8587.4 8647.7 527.9 539.5 545.7 547.3 551.5 3611.9 3671.7 3810.9 3868.5 3969.5 59467.0 59954.7 60190.4 68075.0 109981.0 84536.6 96718.5 96877.2 98210.5 98446.5 83673.0 83761.0 84221.6 87069.6 89172.6 7134.1 7244.0 7295.6 7430.0 7653.6 40320.6 47581.3 47811.5 49864.8 50296.7 67927.7 71031.3 72862.6 74223.6 75753.6 10205.8 10279.1 10294.3 10453.7 10757.4 11517.5 11562.9 11572.3 11619.3 12033.6 9787.5 10007.4 10257.8 10327.9 10538.9 10418.6 10578.8 11050.8 11330.8 11811.8 11283.6 12025.5 12396.6 12712.0 12726.6 10582.0 10595.7 10676.3 10890.3 11238.2 9529.2 9807.9 9925.7 9978.0 10092.2 05:41:00 INFO - PROCESS | 3375 | -------- Summary: end -------- 05:41:00 INFO - PROCESS | 3375 | 05:41:01 INFO - TEST-INFO | 3375: exit 0 05:41:01 INFO - TEST-OK | dromaeo_css | took 1122375ms 05:41:01 INFO - TEST-START | kraken 05:41:01 INFO - operating with platform_type : linux_ 05:41:01 INFO - Initialising browser for kraken test... 05:41:01 INFO - TEST-INFO | started process 3560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEWr_0y/profile http://localhost:35931/getInfo.html) 05:41:05 INFO - PROCESS | 3560 | JavaScript error: , line 0: uncaught exception: undefined 05:41:05 INFO - PROCESS | 3560 | __metrics Screen width/height:1600/1200 05:41:05 INFO - PROCESS | 3560 | colorDepth:24 05:41:05 INFO - PROCESS | 3560 | Browser inner width/height: 1024/697 05:41:05 INFO - PROCESS | 3560 | __metrics 05:41:06 INFO - PROCESS | 3560 | 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" 05:41:06 INFO - PROCESS | 3560 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:41:07 INFO - TEST-INFO | 3560: exit 0 05:41:07 INFO - Browser initialized. 05:41:07 INFO - Running cycle 1/1 for kraken test... 05:41:07 INFO - TEST-INFO | started process 3637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEWr_0y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:19 INFO - PROCESS | 3637 | RSS: Main: 159084544 05:41:19 INFO - PROCESS | 3637 | 05:41:22 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:35931/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35931/tests/kraken/driver.html?testName=audio-beat-detection) 05:41:23 INFO - PROCESS | 3637 | RSS: Main: 215048192 05:41:23 INFO - PROCESS | 3637 | 05:41:26 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:35931/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35931/tests/kraken/driver.html?testName=audio-dft) 05:41:26 INFO - PROCESS | 3637 | RSS: Main: 192806912 05:41:26 INFO - PROCESS | 3637 | 05:41:30 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:35931/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35931/tests/kraken/driver.html?testName=audio-fft) 05:41:30 INFO - PROCESS | 3637 | RSS: Main: 273293312 05:41:30 INFO - PROCESS | 3637 | 05:41:32 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:35931/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35931/tests/kraken/driver.html?testName=audio-oscillator) 05:41:33 INFO - PROCESS | 3637 | RSS: Main: 181239808 05:41:33 INFO - PROCESS | 3637 | 05:41:35 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:35931/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35931/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:41:36 INFO - PROCESS | 3637 | RSS: Main: 186372096 05:41:36 INFO - PROCESS | 3637 | 05:41:39 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:35931/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35931/tests/kraken/driver.html?testName=imaging-darkroom) 05:41:40 INFO - PROCESS | 3637 | RSS: Main: 222658560 05:41:40 INFO - PROCESS | 3637 | 05:41:43 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:35931/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35931/tests/kraken/driver.html?testName=imaging-desaturate) 05:41:44 INFO - PROCESS | 3637 | RSS: Main: 222310400 05:41:44 INFO - PROCESS | 3637 | 05:41:47 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:35931/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35931/tests/kraken/driver.html?testName=json-parse-financial) 05:41:47 INFO - PROCESS | 3637 | RSS: Main: 221143040 05:41:47 INFO - PROCESS | 3637 | 05:41:49 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:35931/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35931/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:41:49 INFO - PROCESS | 3637 | RSS: Main: 186810368 05:41:49 INFO - PROCESS | 3637 | 05:41:51 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:35931/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35931/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:41:52 INFO - PROCESS | 3637 | RSS: Main: 193441792 05:41:52 INFO - PROCESS | 3637 | 05:41:54 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:35931/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35931/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:41:55 INFO - PROCESS | 3637 | RSS: Main: 196186112 05:41:55 INFO - PROCESS | 3637 | 05:41:58 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:35931/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:41:59 INFO - PROCESS | 3637 | RSS: Main: 190078976 05:41:59 INFO - PROCESS | 3637 | 05:42:01 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:35931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:42:02 INFO - PROCESS | 3637 | RSS: Main: 194486272 05:42:02 INFO - PROCESS | 3637 | 05:42:04 INFO - PROCESS | 3637 | Cycle 1(1): loaded http://localhost:35931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35931/tests/kraken/driver.html?testName=ai-astar) 05:42:04 INFO - PROCESS | 3637 | RSS: Main: 244891648 05:42:04 INFO - PROCESS | 3637 | 05:42:04 INFO - PROCESS | 3637 | __start_tp_report 05:42:04 INFO - PROCESS | 3637 | _x_x_mozilla_page_load 05:42:04 INFO - PROCESS | 3637 | _x_x_mozilla_page_load_details 05:42:04 INFO - PROCESS | 3637 | |i|pagename|runs| 05:42:04 INFO - PROCESS | 3637 | |0;ai-astar;104;114;115;114;114;114;114;112;113;113 05:42:04 INFO - PROCESS | 3637 | |1;audio-beat-detection;154;131;124;180;131;123;160;123;179;133 05:42:04 INFO - PROCESS | 3637 | |2;audio-dft;164;161;161;163;161;163;162;162;162;161 05:42:04 INFO - PROCESS | 3637 | |3;audio-fft;75;75;75;116;75;77;74;75;106;76 05:42:04 INFO - PROCESS | 3637 | |4;audio-oscillator;86;85;122;85;85;85;129;85;85;127 05:42:04 INFO - PROCESS | 3637 | |5;imaging-gaussian-blur;117;117;117;117;123;116;117;116;117;116 05:42:04 INFO - PROCESS | 3637 | |6;imaging-darkroom;146;145;146;147;147;147;146;146;145;146 05:42:04 INFO - PROCESS | 3637 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 05:42:04 INFO - PROCESS | 3637 | |8;json-parse-financial;62;61;61;60;69;61;60;60;60;59 05:42:04 INFO - PROCESS | 3637 | |9;json-stringify-tinderbox;65;66;65;65;66;65;65;65;66;66 05:42:04 INFO - PROCESS | 3637 | |10;stanford-crypto-aes;78;79;79;78;79;79;85;80;78;82 05:42:04 INFO - PROCESS | 3637 | |11;stanford-crypto-ccm;156;127;139;126;128;130;136;139;206;140 05:42:04 INFO - PROCESS | 3637 | |12;stanford-crypto-pbkdf2;162;162;162;161;162;165;161;162;161;163 05:42:04 INFO - PROCESS | 3637 | |13;stanford-crypto-sha256-iterative;67;67;68;70;67;67;70;67;67;67 05:42:04 INFO - PROCESS | 3637 | __end_tp_report 05:42:04 INFO - PROCESS | 3637 | __start_cc_report 05:42:04 INFO - PROCESS | 3637 | _x_x_mozilla_cycle_collect,1939 05:42:04 INFO - PROCESS | 3637 | __end_cc_report 05:42:04 INFO - PROCESS | 3637 | __startTimestamp1469536924620__endTimestamp 05:42:04 INFO - PROCESS | 3637 | 05:42:04 INFO - PROCESS | 3637 | ------- Summary: start ------- 05:42:04 INFO - PROCESS | 3637 | Number of tests: 14 05:42:04 INFO - PROCESS | 3637 | 05:42:04 INFO - PROCESS | 3637 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:3.16 (2.8%) stddev-sans-first:0.87 05:42:04 INFO - PROCESS | 3637 | Values: 104.0 114.0 115.0 114.0 114.0 114.0 114.0 112.0 113.0 113.0 05:42:04 INFO - PROCESS | 3637 | 05:42:04 INFO - PROCESS | 3637 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:143.50 stddev:22.65 (15.8%) stddev-sans-first:23.72 05:42:04 INFO - PROCESS | 3637 | Values: 154.0 131.0 124.0 180.0 131.0 123.0 160.0 123.0 179.0 133.0 05:42:04 INFO - PROCESS | 3637 | 05:42:04 INFO - PROCESS | 3637 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.05 (0.7%) stddev-sans-first:0.83 05:42:04 INFO - PROCESS | 3637 | Values: 164.0 161.0 161.0 163.0 161.0 163.0 162.0 162.0 162.0 161.0 05:42:04 INFO - PROCESS | 3637 | 05:42:04 INFO - PROCESS | 3637 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:15.28 (20.4%) stddev-sans-first:15.97 05:42:04 INFO - PROCESS | 3637 | Values: 75.0 75.0 75.0 116.0 75.0 77.0 74.0 75.0 106.0 76.0 05:42:04 INFO - PROCESS | 3637 | 05:42:04 INFO - PROCESS | 3637 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:85.00 stddev:19.81 (23.3%) stddev-sans-first:20.58 05:42:04 INFO - PROCESS | 3637 | Values: 86.0 85.0 122.0 85.0 85.0 85.0 129.0 85.0 85.0 127.0 05:42:04 INFO - PROCESS | 3637 | 05:42:04 INFO - PROCESS | 3637 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:2.06 (1.8%) stddev-sans-first:2.18 05:42:04 INFO - PROCESS | 3637 | Values: 117.0 117.0 117.0 117.0 123.0 116.0 117.0 116.0 117.0 116.0 05:42:04 INFO - PROCESS | 3637 | 05:42:04 INFO - PROCESS | 3637 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 05:42:04 INFO - PROCESS | 3637 | Values: 146.0 145.0 146.0 147.0 147.0 147.0 146.0 146.0 145.0 146.0 05:42:04 INFO - PROCESS | 3637 | 05:42:04 INFO - PROCESS | 3637 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:42:04 INFO - PROCESS | 3637 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:42:04 INFO - PROCESS | 3637 | 05:42:04 INFO - PROCESS | 3637 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:61.00 stddev:2.83 (4.6%) stddev-sans-first:2.99 05:42:04 INFO - PROCESS | 3637 | Values: 62.0 61.0 61.0 60.0 69.0 61.0 60.0 60.0 60.0 59.0 05:42:04 INFO - PROCESS | 3637 | 05:42:04 INFO - PROCESS | 3637 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 05:42:04 INFO - PROCESS | 3637 | Values: 65.0 66.0 65.0 65.0 66.0 65.0 65.0 65.0 66.0 66.0 05:42:04 INFO - PROCESS | 3637 | 05:42:04 INFO - PROCESS | 3637 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.00 stddev:2.21 (2.8%) stddev-sans-first:2.26 05:42:04 INFO - PROCESS | 3637 | Values: 78.0 79.0 79.0 78.0 79.0 79.0 85.0 80.0 78.0 82.0 05:42:04 INFO - PROCESS | 3637 | 05:42:04 INFO - PROCESS | 3637 | [#11] stanford-crypto-ccm Cycles:10 Average:142.70 Median:139.00 stddev:23.96 (17.2%) stddev-sans-first:24.92 05:42:04 INFO - PROCESS | 3637 | Values: 156.0 127.0 139.0 126.0 128.0 130.0 136.0 139.0 206.0 140.0 05:42:04 INFO - PROCESS | 3637 | 05:42:04 INFO - PROCESS | 3637 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 05:42:04 INFO - PROCESS | 3637 | Values: 162.0 162.0 162.0 161.0 162.0 165.0 161.0 162.0 161.0 163.0 05:42:04 INFO - PROCESS | 3637 | 05:42:04 INFO - PROCESS | 3637 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.00 stddev:1.25 (1.9%) stddev-sans-first:1.30 05:42:04 INFO - PROCESS | 3637 | Values: 67.0 67.0 68.0 70.0 67.0 67.0 70.0 67.0 67.0 67.0 05:42:04 INFO - PROCESS | 3637 | -------- Summary: end -------- 05:42:04 INFO - PROCESS | 3637 | 05:42:05 INFO - TEST-INFO | 3637: exit 0 05:42:05 INFO - TEST-OK | kraken | took 64671ms 05:42:05 INFO - SUITE-END | took 1187s 05:42:06 INFO - Completed test suite (00:19:47) 05:42:06 INFO - javascript benchmark 05:42:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2645.563482025466, 2665.640138581291, 2689.744474274943, 2695.272276485349, 2704.824186427882, 4672.5327467253255, 4789.401324834395, 4844.055409195208, 4868.707877527347, 4886.242632391981, 4751.786169622366, 4786.904261914751, 4810.06203790261, 4814.037192561493, 4882.951170488294, 4403.955960440387, 4405.625521830648, 4428.512863585003, 4435.4899186593475, 4616.2613981762925, 4573.519780423041, 4578.702384345007, 4578.908421831578, 4587.610053145487, 4600.0, 4323.697341186118, 4385.758783266919, 4392.912141757147, 4393.6045755881805, 4395.912081758347, 4445.777711114463, 4450.043240703232, 4458.509563947963, 4458.910821783546, 4465.062336909253, 4287.142571485684, 4325.718828276152, 4351.760653164075, 4431.7784110794655, 4435.401220835211, 4690.554397332282, 4755.619550435957, 4781.593564546983, 4797.328374027639, 4844.958333958216, 5174.818881339173, 5175.508326708994, 5178.0679477694, 5178.818741344035, 5181.093308670967, 4947.529984651453, 5082.288479612857, 5152.639315247934, 5166.61250406221, 5198.142306519419, 4820.71075735457, 4852.053849499349, 4853.417589889165, 4857.222844344888, 4858.732769697701, 5330.866728331745, 5332.200169974535, 5334.493223143795, 5345.893082138336, 5356.571474282048, 4873.829415970424, 4959.603231741524, 4978.502149784992, 5005.849824505271, 5111.284420181178, 5078.542931136216, 5141.2545180948555, 5150.819721309736, 5170.560502357342, 5171.560417364566, 5052.418971818288, 5066.594672426197, 5071.8985620287385, 5073.594112470993, 5121.180611102206, 4967.180415231519, 5015.724135172601, 5064.49355064498, 5103.489651034867, 5106.974465127725, 4064.1871625674394, 4064.7154699170774, 4089.7546147230664, 4101.733387329814, 4101.958980410217, 3575.535180426528, 3591.2637909228547, 3600.867245496435, 3623.8188090595363, 3626.456031595229, 4298.09739954613, 4348.0, 4406.801693923781, 4460.50934397216, 4463.598276155161, 5165.328507294028, 5194.662346947436, 5208.713520756319, 5237.580993520509, 5246.23929530216, 4450.354698568754, 4466.464024317038, 4468.594217347956, 4478.664100192498, 4516.751578663205, 4494.617957473652, 4590.793414296298, 4683.859484215479, 4690.929636055462, 4727.905441891212, 4846.079244943449, 4871.63462740303, 4883.536064073907, 4918.409790825124, 4932.235503496964, 5175.223716442564, 5187.740612969261, 5189.247559103985, 5192.117340052125, 5235.528802407802, 4682.648801339845, 4749.168895443215, 4822.0, 4860.562549370574, 4870.057338595492, 4982.526659967298, 5028.773705183203, 5052.418971818141, 5082.847514574569, 5130.0, 5102.285680004728, 5130.615203859651, 5140.56305214046, 5148.073346797462, 5196.064708352382, 4881.877953051202, 5001.7749201285305, 5018.121828679893, 5018.573421259234, 5023.572996295356, 4904.435989861212, 4990.50094990498, 4992.675476094042, 4993.950060499348, 5045.8738531537, 4930.753462326941, 4939.333190019302, 4949.925751113664, 4970.726610036482, 4979.875503112451, 4853.247746599282, 5025.597952163745, 5031.496850314939, 5032.144535428913, 5034.244863270539, 4932.53140951609, 4964.875878102932, 4985.4266759323145, 5004.099262132851, 5010.0], "value": 4706.206383788477, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.2070444547638, 586.557149352239, 587.5828162004976, 589.7051474262869, 594.982150535484, 26178.86910565447, 36865.0, 38272.0, 38519.229615407676, 41948.161036779326, 39899.40150897732, 40299.0, 40299.79850100753, 40315.59684403155, 40330.59669403305, 7681.270279323456, 7812.375009999187, 7824.960875195616, 7826.256505631955, 7833.9608301958415, 7132.108486439195, 9802.117809397152, 10061.949690251538, 10063.446510441923, 10419.791604167913, 10125.24060695447, 10209.183265338756, 10217.897821021807, 10222.591096356136, 10235.795284094314, 10070.395776253412, 10133.442660653662, 10134.23993200513, 10134.493275336241, 10135.189184865194, 9861.112499875046, 9930.255230857714, 9944.303898727092, 9947.253955953332, 9952.0, 37660.623393765985, 37934.43098353527, 37937.0, 37941.43087853684, 37959.8102009491, 3129.264622813637, 3217.678232176787, 3300.818454984975, 3414.6926776589976, 3422.4866270059442, 28711.13866584006, 28762.424751505063, 29120.41759164805, 29633.555496667566, 29863.701362986525, 3282.8383100381175, 3366.764326497146, 3368.6126095499085, 3395.6264810870784, 3447.9310413791836, 265361.0, 267021.0, 267650.0, 267722.0, 268393.0, 54067.45932540703, 54550.727246363516, 54593.0, 54628.0, 54632.0, 29488.557671634942, 29763.404731905674, 29949.700502994692, 30011.549826752616, 57816.421835781104, 14471.131732096108, 14510.91168162371, 14552.126872387691, 14578.489752858599, 14615.488457903923, 10585.894141058645, 10884.836727449094, 11684.824727629093, 11757.353345565905, 11831.17181797266, 17091.230894609773, 17699.0, 17945.7308140378, 17962.0, 18299.63400731978, 6755.695993680296, 6787.423069039089, 6798.864022719518, 6944.965275173693, 7133.429325653935, 771.7298945369188, 860.475110182788, 900.3247564326755, 918.9386258871015, 988.1551273661061, 26939.865300673373, 27111.0, 27826.860865695948, 27835.443291134063, 27889.721102789117, 935.9251259899328, 953.9809203816023, 966.1932286540817, 1007.7883644434604, 1018.256672628985, 15035.624109397133, 15686.76469852953, 15688.686226275411, 16305.429309974332, 16429.342826286815, 422662.0, 424873.0, 425586.0, 425721.0, 426611.0, 48791.5120848787, 49397.25904111441, 49405.75297123563, 49567.50432495629, 49752.75123624431, 1093.50245638236, 1127.2841745491671, 1166.7608140331042, 1187.0978056676815, 1205.3852535206931, 24083.0, 26754.866225668746, 26930.59604105901, 27069.353457716545, 27481.0, 39347.409788852616, 39636.80181599074, 39639.40540891831, 39640.2071958565, 39794.40308395434, 323014.0, 324237.0, 325724.0, 325796.0, 325919.0, 24360.0, 24864.50270994606, 25377.111801086874, 25521.234362969142, 26786.59820102739, 39814.80092599519, 40003.599963999986, 40203.79898100491, 40596.0, 41080.794596026826, 34729.82635086808, 34745.30509389748, 34818.129546761535, 35668.643313566536, 35698.28603427865, 34988.30023399569, 35209.0, 35380.82309588538, 35451.29097418089, 35534.82232588924, 34017.58364164344, 34263.82868085644, 34917.0, 35218.64781352256, 35304.823475882455, 29602.0, 32089.839550802095, 32092.67907320897, 32398.056116633077, 32434.837825811665, 24077.157299494433, 24475.26574202777, 24498.51002979895, 24904.252872413857, 25143.119990800235], "value": 17734.64597262683, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.1350609437708, 363.3949474125581, 364.855881926639, 365.1747051663242, 379.84046700385835, 12871.871281287184, 16258.0, 16851.241694123764, 18020.999999999967, 18238.0, 17037.233324500397, 17379.217935192915, 17476.912615436937, 17601.295948162056, 17741.112944352764, 5006.574441172495, 5246.501582349671, 5488.4785945335125, 5521.4478552144665, 5601.635893666919, 3512.1570823002553, 5086.516780905827, 5482.451754824506, 5519.862003449925, 5522.420145884685, 5416.891662166754, 5434.8913021739545, 5440.727963601824, 5441.156620723775, 5449.64577302476, 5259.263703081533, 5436.21174929637, 5439.048166570854, 5457.808976685837, 5492.368377636543, 5326.786928522854, 5327.946720532784, 5329.040772660919, 5332.68003919766, 5337.466253374631, 11618.0, 17667.73498397525, 20391.898040509852, 20888.89555552228, 21053.263135790326, 1850.3523766681687, 1956.7358406615067, 1962.107241205248, 2156.816670583002, 2237.127520267097, 8487.363447741443, 8951.776205594848, 9261.073892610684, 9431.056894310583, 9436.669716559956, 1702.1659386900453, 1762.97355539667, 1767.4785938148277, 1778.919948602316, 1812.392848395789, 67552.3244767551, 69044.30955690429, 69125.65437172832, 70491.64754176248, 71680.64159679221, 9533.904660953302, 9620.71137865865, 10034.548445319979, 10071.295009349275, 10210.285280030326, 13906.165630062027, 13906.930465347608, 13913.30433478322, 13915.30423478822, 13927.512537061155, 7121.643917804089, 7125.287471252833, 7226.674799634029, 7242.529235599774, 7600.315971562586, 6650.46796256308, 6676.866462670817, 6746.561473504206, 6856.211535673362, 6887.20797108339, 4187.560306167869, 4194.266003449445, 4346.326319420495, 4393.494748103945, 4477.507474177838, 1744.891993584058, 1816.5731053202487, 1840.4110684580805, 1868.9813101869079, 1869.643989039677, 743.687651186503, 757.7007082202499, 791.3945831438954, 812.8983877015373, 824.0552296580066, 16591.170441477876, 17457.0, 17721.29114835392, 17814.287428502714, 17904.731429028576, 849.3375167369462, 851.6806197675871, 855.9471849624872, 858.0647094666843, 913.5204017890528, 9363.063693630582, 9792.55933482995, 9858.359206651545, 9919.057689519484, 10006.399616023062, 367894.0, 368655.0, 372783.0, 374378.0, 381761.0, 76926.61536692281, 78567.60716196382, 79389.0, 79980.60009700031, 80674.0, 892.7455675132557, 900.8783814185132, 927.174814415171, 929.080210591523, 931.8276118918022, 15088.471903483765, 15316.234188290764, 15631.921840390725, 15760.842391575938, 15954.840451595335, 37962.24075518419, 38499.0, 39588.40617390799, 39748.83265175509, 39777.80111099426, 52243.47756522386, 52730.73634631802, 53868.0, 57796.0, 58243.0, 7279.1265048194555, 7393.186749457663, 7605.125410577633, 7609.809754755954, 7740.806479838049, 10267.229957753048, 12010.63968080959, 12046.75906481883, 12088.576899808464, 12115.939420302842, 9754.341761900352, 9772.657956971472, 9797.804043919225, 9859.654912078044, 9877.901220987698, 10519.94740026295, 10567.365958042234, 10590.735231619272, 10683.465826708478, 11094.611688590861, 9723.611055557698, 9742.610295588098, 9801.31390802637, 9973.102420782165, 10178.389296642225, 7392.630368481662, 7402.0, 7629.771106866803, 7755.146933837161, 7826.334761545332, 8123.6750529978135, 9484.099010593982, 9717.465539395118, 9902.504874756378, 10092.293539452168], "value": 8167.925267168187, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1268.5116230251363, 1354.6342487528364, 1404.5786264120761, 1466.2375564706347, 1662.3683000459823, 6435.163428754261, 7568.772936811897, 7827.960860195691, 7834.608269586519, 8081.838363232732, 7862.410319226066, 7907.288344049034, 7923.524588524692, 7927.643256053477, 7929.801754956129, 2194.6378847490146, 2221.911123555056, 2222.211115054157, 2225.3657707553352, 2228.1198926424054, 2132.1791110422523, 2171.771963943787, 2185.9562808743817, 2187.157944191482, 2195.7584665686763, 2164.729408823897, 2168.1544197762805, 2170.89145542723, 2171.6959625652344, 2217.7116974793335, 2169.240765731997, 2174.282486779367, 2174.967375489369, 2175.0647221694667, 2175.7389113306344, 2126.0857831132607, 2171.619966505871, 2176.662617294322, 2177.3467959612053, 2179.0194412514434, 7718.459707820399, 7843.764687059397, 7850.725224617168, 7874.448788584801, 7892.131865494791, 4343.6959412841115, 4473.9552604473865, 4492.3710680504755, 4502.527234640381, 4551.453825540923, 2804.0466241477793, 2900.0, 2941.9264518387, 2942.337973955864, 2963.8073525220793, 867.2324992381724, 877.3113106211657, 881.1056777370974, 882.0297672560132, 885.424474091839, 10469.31949423285, 10560.735981600445, 10570.841437378445, 10604.628837990633, 10607.469626518643, 3892.8637497687446, 4061.3095773718537, 4088.0597462583773, 4191.308434108399, 4194.077302993336, 8393.412461127784, 8406.075331713506, 8410.957945210235, 8414.074451810297, 8415.831683366298, 4536.705114167635, 4560.543945605413, 4562.224421848294, 4563.0873825235085, 4571.2000399929875, 3681.1349332906743, 3859.864904728377, 4021.135455876942, 4241.257779888507, 4262.914741705148, 3405.9659403406145, 3409.62494125646, 3522.383582872987, 3526.858925642997, 3538.8938331850086, 1009.9899001009895, 1011.0546638892658, 1016.3089099412323, 1021.7292417509366, 1022.2384323678758, 831.3930830493773, 862.4178679391385, 868.1015149320423, 897.1387468030764, 898.8067565473455, 5303.681779093266, 5435.7825686972865, 5480.534154596824, 5484.067708489566, 5683.5737319700365, 880.4673172730534, 896.1397058823472, 900.1583519409373, 904.2088172848757, 909.2907532124954, 3662.08447888028, 3753.7560058596105, 3795.1081495848453, 3890.844366225376, 3902.0635047588376, 9534.713958581253, 10026.949865250774, 10043.397396156108, 10045.19638428924, 10071.5467803949, 9919.603215871428, 9943.0, 9953.850692239623, 9964.701058968243, 9972.950135249423, 6947.444204463631, 7259.274072592699, 7299.744508942162, 7391.039164908528, 7435.776926692208, 5569.66582005081, 5624.74688639004, 5624.887502250014, 5653.293338332708, 5787.8553036174435, 8653.39426240157, 8748.956255218684, 8780.209781119729, 8800.38397312182, 8851.46891186531, 8772.736817895473, 8879.778005549913, 8946.910530894867, 9080.40977336471, 9098.181163695035, 6130.080487926846, 6393.073004414427, 6882.655867206719, 7062.223155452793, 7070.540414873017, 7376.852462950818, 7634.0, 7643.694252229849, 7646.464747467624, 7649.502782319131, 6529.7388104475285, 6642.966785166043, 6673.466122710269, 6774.085498457645, 6813.114295141798, 6484.221893372825, 6710.396064354036, 6766.492513061442, 6812.557183783038, 6831.863362732618, 6337.0, 6427.068075129174, 6427.967860160669, 6434.485241180788, 6436.645984470899, 4640.907181856412, 4705.294205869147, 4768.046390721939, 4788.018456216398, 4856.732879691651, 4594.655400845017, 4630.259158534618, 4747.646920627604, 4831.855044348676, 4860.198067318853], "value": 4132.9530647602505, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [269.1736369346107, 276.14670667637, 280.23216387099353, 284.9259192609921, 285.5174754664617, 4864.367632207813, 4865.951340486594, 4900.705957642544, 4908.190148625477, 4914.017196560684, 4501.482329532105, 4569.954300456994, 4621.722696638196, 4677.74272415017, 4873.415190177184, 3763.2849758545926, 3764.849406023756, 3766.303233901723, 3780.7164462665273, 3786.8863934082024, 3762.4168253920684, 3783.0, 3788.583255841869, 3802.714796390268, 3814.19901820618, 3571.3035957988204, 3656.4880916671686, 3736.0099573613015, 3752.718546109039, 3772.6038765929457, 3749.4188400797784, 3756.793376364299, 3757.9436308455397, 3776.622337766229, 3782.205736795276, 3330.150811543065, 3330.81680507572, 3341.04780137662, 3341.2816244507303, 3352.0949343677316, 4701.712112235692, 4747.430308362984, 4762.071396077767, 4785.880352991168, 4790.161721698689, 4252.085801552681, 4277.294246449332, 4297.699161058727, 4303.91392172158, 4345.739255644671, 5054.7472626368535, 5073.568746656539, 5080.13637681595, 5086.287919691246, 5121.261479120263, 3635.8909232723063, 3640.1445660269815, 3661.6887564557046, 3663.981680091609, 3667.523221981152, 5224.63427560071, 5300.681959082467, 5322.76047577856, 5336.733163341817, 5386.434424385461, 3680.2271522980473, 3684.9447258291148, 3686.4286035664513, 3690.409534474471, 3704.3517384457614, 3742.36379815432, 3764.284785890672, 3765.86819461323, 3766.303233901737, 3771.4719939208535, 4126.731762435432, 4282.850100246476, 4303.33298338758, 4305.74165550068, 4306.892327691833, 5035.949640503548, 5041.1769409131, 5043.823466178666, 5050.444451110375, 5097.362829646294, 1276.0493432392927, 1284.441268048402, 1287.9098463107493, 1301.466398776516, 1306.941377484222, 776.1423626892316, 820.6102101501739, 825.2449009156675, 830.4021104804531, 835.8465317861312, 4078.938815917764, 4114.847842604016, 4118.732282401635, 4134.656236723077, 4148.0, 4608.133705849136, 4640.419947506562, 4669.486356500782, 4677.555632214934, 4692.389989301369, 4065.6747460203114, 4104.220198162339, 4105.050101201905, 4143.440635514227, 4143.585641435892, 2509.3475696319088, 2616.476704659076, 2816.9295767605972, 2818.309514169042, 2842.374677570931, 4959.70241785494, 4962.851114466572, 4963.404391472975, 4970.950290497049, 4996.750162491933, 5128.0, 5396.757145928443, 5404.216388623628, 5431.207701458509, 5437.238786569884, 4768.880777980509, 4799.328094066834, 4922.33548470959, 4931.9753401232765, 4941.728204948834, 5196.32447781786, 5226.817061402985, 5241.318628578413, 5271.630985830955, 5275.841724748264, 4943.9505604944925, 5150.4592017837585, 5181.0, 5181.55956743666, 5199.194124910645, 4944.406671199479, 4952.232403977389, 4959.181735013683, 4960.603151747924, 4963.0, 3621.583517895476, 3634.6547078027547, 3656.1225305925855, 3671.320805650963, 3672.265546890579, 5141.485851414828, 5264.630916087699, 5333.466653334635, 5336.9466305338, 5337.332833395825, 5092.185250359925, 5100.617453691062, 5107.719075450737, 5111.361079865017, 5134.820281290137, 5086.338775959101, 5090.338256026693, 5117.8720531987, 5159.896802064013, 5165.985265746437, 4852.417709874697, 5055.266986287042, 5077.0, 5095.439501654889, 5104.438511763778, 5160.142348754521, 5172.844814655567, 5190.377154741455, 5203.479652034766, 5205.6616319939085, 5066.873328166678, 5079.476157152913, 5094.337736094284, 5094.337736094432, 5113.0], "value": 3789.2518373231464, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.9175907132072, 648.3516483516484, 683.0914883205337, 723.3598265535003, 726.1358982810456, 12314.630561083159, 13032.0, 13083.869161308385, 13103.08278420511, 13165.473381064758, 13037.934810325958, 13110.278934658614, 13124.212547247173, 13127.737445251089, 13132.868671313285, 611.9265688117432, 628.8270725550465, 746.3916907720218, 750.6021808441535, 767.3784234769854, 766.2108028730416, 776.0648418655506, 776.216021817965, 777.4480119115435, 778.1945686214768, 819.5779173725537, 820.4134044158426, 820.9425340226187, 821.2157389692859, 821.4414198345123, 666.7466362782112, 801.2628381888618, 813.7029984055836, 814.3241109878786, 825.4015838517087, 596.6241268001131, 596.9373215812363, 596.9850753731191, 597.035787203663, 597.4085655201363, 13004.934975325063, 13019.349032548334, 13040.543580974716, 13051.804222936664, 13057.804132938014, 12059.397030148457, 12249.203801752858, 12454.75090498194, 12709.555165569162, 12945.551711417076, 11156.442177891073, 11246.718832029264, 11283.548658053667, 11794.941025294904, 11977.760444791142, 3344.3812894614575, 3355.7818741781707, 3371.039253812676, 3462.9307413851834, 3482.7736197147105, 62896.371036289966, 63476.047859282146, 64467.3553264466, 64904.35095649077, 65773.34226657767, 10349.664213317503, 10686.893131068746, 10923.508442120125, 10973.890261097447, 11308.943455282835, 19940.90325032137, 20537.0, 20545.69181462279, 20567.4858128545, 20589.176432942815, 6868.450523958071, 6918.688659010357, 6990.720371185197, 7015.123109611299, 7086.645667716697, 3590.515280437108, 3723.106454450912, 3748.3253014457114, 3809.504764380613, 3843.2121415109837, 2937.9853100734786, 3007.263220510989, 3017.6227971503563, 3035.4991426414836, 3037.9848100759355, 492.2984746735887, 555.611072249427, 573.8249833800647, 588.358689028952, 590.9320428150818, 464.45194670289385, 526.6734624532814, 565.197419664078, 578.1097110449944, 581.8370856160282, 8388.748337549883, 8548.102449242864, 8553.44402613828, 8587.355948303903, 8647.697330593399, 527.9049771041173, 539.5036566358959, 545.6616897523561, 547.3049227481076, 551.5339538090308, 3611.8735844245325, 3671.706263498967, 3810.8856734298015, 3868.5357757069332, 3969.523657161159, 59467.0, 59954.700226498586, 60190.39809601848, 68075.0, 109981.0, 84536.57731711425, 96718.51640741892, 96877.2185946977, 98210.5089474548, 98446.5077674607, 83673.0, 83761.0, 84221.57889210638, 87069.5646521776, 89172.5541372289, 7134.081169901302, 7244.0, 7295.635218239173, 7429.962850185714, 7653.57905315213, 40320.596794031684, 47581.28628070651, 47811.5218847821, 49864.75067624639, 50296.74851625718, 67927.66036169787, 71031.28968710247, 72862.63568682123, 74223.62888185524, 75753.62123189348, 10205.795884082128, 10279.074883260542, 10294.330868493524, 10453.68638940833, 10757.354558726502, 11517.53929842797, 11562.884371156517, 11572.250530997426, 11619.321299927255, 12033.578824741442, 9787.46168960714, 10007.399556026661, 10257.846132307872, 10327.948360258151, 10538.89461105379, 10418.583256669952, 10578.788424231627, 11050.778984420105, 11330.830037549607, 11811.822822657496, 11283.605073822377, 12025.4588543514, 12396.628101156979, 12712.046596505485, 12726.618201453972, 10582.0, 10595.682129535819, 10676.306040107369, 10890.29213101146, 11238.157138214503, 9529.237660987243, 9807.85288220663, 9925.702228933143, 9978.0, 10092.192624589869], "value": 6548.842197902177, "unit": "score"}], "name": "dromaeo_css", "value": 6418.579820916814, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 112.0, 113.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 131.0, 124.0, 180.0, 131.0, 123.0, 160.0, 123.0, 179.0, 133.0], "value": 143.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 161.0, 163.0, 161.0, 163.0, 162.0, 162.0, 162.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 116.0, 75.0, 77.0, 74.0, 75.0, 106.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 122.0, 85.0, 85.0, 85.0, 129.0, 85.0, 85.0, 127.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 123.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 60.0, 69.0, 61.0, 60.0, 60.0, 60.0, 59.0], "value": 61.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 66.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 79.0, 78.0, 79.0, 79.0, 85.0, 80.0, 78.0, 82.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 139.0, 126.0, 128.0, 130.0, 136.0, 139.0, 206.0, 140.0], "value": 142.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 162.0, 165.0, 161.0, 162.0, 161.0, 163.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 70.0, 67.0, 67.0, 70.0, 67.0, 67.0, 67.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1535.6, "alertThreshold": 2.0}]} 05:42:06 INFO - Return code: 0 05:42:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:42:06 INFO - # TBPL SUCCESS # 05:42:06 INFO - Running post-action listener: _resource_record_post_action 05:42:06 INFO - [mozharness: 2016-07-26 12:42:06.406702Z] Finished run-tests step (success) 05:42:06 INFO - Running post-run listener: _resource_record_post_run 05:42:06 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 7786496; Write bytes: 420839424; Read time: 1808; Write time: 330324 05:42:06 INFO - TinderboxPrint: CPU usage
13.0% 05:42:06 INFO - TinderboxPrint: I/O read bytes / time
7,786,496 / 1,808 05:42:06 INFO - TinderboxPrint: I/O write bytes / time
420,839,424 / 330,324 05:42:06 INFO - TinderboxPrint: CPU idle
8,359.3 (87.0%) 05:42:06 INFO - TinderboxPrint: CPU user
1,202.1 (12.5%) 05:42:06 INFO - TinderboxPrint: Swap in / out
0 / 0 05:42:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 97484800; Read time: 0; Write time: 62544 05:42:06 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 5632000; Write bytes: 323354624; Read time: 1708; Write time: 267780 05:42:07 INFO - Running post-run listener: _upload_blobber_files 05:42:07 INFO - Blob upload gear active. 05:42:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:42:07 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 05:42:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:42:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:42:07 INFO - (blobuploader) - INFO - Open directory for files ... 05:42:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:42:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:42:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:08 INFO - (blobuploader) - INFO - Done attempting. 05:42:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:42:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:42:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:09 INFO - (blobuploader) - INFO - Done attempting. 05:42:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:42:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:42:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:30 INFO - (blobuploader) - INFO - Done attempting. 05:42:30 INFO - (blobuploader) - INFO - Iteration through files over. 05:42:30 INFO - Return code: 0 05:42:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:42:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:42:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff52a5b7ffc3669648a2e1ba8c213fa3c584352fe66f1f4eb17393928211a2d66d6877ba15017377bffaf1af7012ae216c37560acde834039ff4ca4264236d20", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/01781896d8c798e266b3ecd62eb08d37d5ed82b09ddc544211ee688bfa047bff179285d081788de7d8366d102e4da4bcdc37f32db29ebd88b8a50000b6cce67c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1a1adbbdffeb4176cae934a78ee76985fdc60547c3e50b654fb1abf65943fb8e6874a4a000f19971f852c925cc2d5931666e3bb26a450753ee9191a69e5a24ad"} 05:42:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:42:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:42:30 INFO - Contents: 05:42:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff52a5b7ffc3669648a2e1ba8c213fa3c584352fe66f1f4eb17393928211a2d66d6877ba15017377bffaf1af7012ae216c37560acde834039ff4ca4264236d20", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/01781896d8c798e266b3ecd62eb08d37d5ed82b09ddc544211ee688bfa047bff179285d081788de7d8366d102e4da4bcdc37f32db29ebd88b8a50000b6cce67c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1a1adbbdffeb4176cae934a78ee76985fdc60547c3e50b654fb1abf65943fb8e6874a4a000f19971f852c925cc2d5931666e3bb26a450753ee9191a69e5a24ad"} 05:42:30 INFO - Running post-run listener: copy_logs_to_upload_dir 05:42:30 INFO - Copying logs to upload dir... 05:42:30 INFO - mkdir: /builds/slave/test/build/upload/logs 05:42:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.020461 ========= master_lag: 0.31 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-26 05:42:30.842871) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 05:42:30.846334) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff52a5b7ffc3669648a2e1ba8c213fa3c584352fe66f1f4eb17393928211a2d66d6877ba15017377bffaf1af7012ae216c37560acde834039ff4ca4264236d20", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/01781896d8c798e266b3ecd62eb08d37d5ed82b09ddc544211ee688bfa047bff179285d081788de7d8366d102e4da4bcdc37f32db29ebd88b8a50000b6cce67c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1a1adbbdffeb4176cae934a78ee76985fdc60547c3e50b654fb1abf65943fb8e6874a4a000f19971f852c925cc2d5931666e3bb26a450753ee9191a69e5a24ad"} build_url:https://queue.taskcluster.net/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011242 build_url: 'https://queue.taskcluster.net/v1/task/L3feiZunTXqy5cRLLm11NQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ff52a5b7ffc3669648a2e1ba8c213fa3c584352fe66f1f4eb17393928211a2d66d6877ba15017377bffaf1af7012ae216c37560acde834039ff4ca4264236d20", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/01781896d8c798e266b3ecd62eb08d37d5ed82b09ddc544211ee688bfa047bff179285d081788de7d8366d102e4da4bcdc37f32db29ebd88b8a50000b6cce67c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1a1adbbdffeb4176cae934a78ee76985fdc60547c3e50b654fb1abf65943fb8e6874a4a000f19971f852c925cc2d5931666e3bb26a450753ee9191a69e5a24ad"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 05:42:30.871315) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 05:42:30.871631) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1469535683.824969-59778712 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 05:42:30.954716) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 05:42:30.955044) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 05:42:30.955349) ========= ========= Total master_lag: 0.46 =========