builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-069 starttime: 1469551026.53 results: success (0) buildid: 20160726081052 builduid: dd6a15a6c1a44834967a5f2b91d8cbe7 revision: ceb63dec9267e9bb62f5e5e1f4c9d32d3ac1fbac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 09:37:06.532560) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 09:37:06.533147) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 09:37:06.533561) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 09:37:06.553849) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 09:37:06.554395) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-26 09:37:06-- 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% 224M=0s 2016-07-26 09:37:06 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118731 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 09:37:06.688169) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 09:37:06.688516) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015774 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 09:37:06.742142) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 09:37:06.742731) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ceb63dec9267e9bb62f5e5e1f4c9d32d3ac1fbac --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 ceb63dec9267e9bb62f5e5e1f4c9d32d3ac1fbac --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=05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-26 09:37:06,861 truncating revision to first 12 chars 2016-07-26 09:37:06,861 Setting DEBUG logging. 2016-07-26 09:37:06,861 attempt 1/10 2016-07-26 09:37:06,862 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ceb63dec9267?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 09:37:07,176 unpacking tar archive at: fx-team-ceb63dec9267/testing/mozharness/ program finished with exit code 0 elapsedTime=0.668457 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 09:37:07.429774) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 09:37:07.430219) ========= script_repo_revision: ceb63dec9267e9bb62f5e5e1f4c9d32d3ac1fbac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 09:37:07.430936) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 09:37:07.431428) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 09:37:07.443449) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-26 09:37:07.444117) ========= /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=05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:37:07 INFO - MultiFileLogger online at 20160726 09:37:07 in /builds/slave/test 09:37:07 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 09:37:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:37:07 INFO - {'append_to_log': False, 09:37:07 INFO - 'base_work_dir': '/builds/slave/test', 09:37:07 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:37:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:37:07 INFO - 'branch': 'Fx-Team-Non-PGO', 09:37:07 INFO - 'buildbot_json_path': 'buildprops.json', 09:37:07 INFO - 'config_files': ('talos/linux_config.py',), 09:37:07 INFO - 'default_actions': ('clobber', 09:37:07 INFO - 'read-buildbot-config', 09:37:07 INFO - 'download-and-extract', 09:37:07 INFO - 'populate-webroot', 09:37:07 INFO - 'create-virtualenv', 09:37:07 INFO - 'install', 09:37:07 INFO - 'run-tests'), 09:37:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:37:07 INFO - 'download_minidump_stackwalk': True, 09:37:07 INFO - 'download_symbols': 'ondemand', 09:37:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:37:07 INFO - 'tooltool.py': '/tools/tooltool.py', 09:37:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:37:07 INFO - '/tools/misc-python/virtualenv.py')}, 09:37:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:37:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:37:07 INFO - 'installer_path': 'installer.exe', 09:37:07 INFO - 'log_level': 'info', 09:37:07 INFO - 'log_name': 'talos', 09:37:07 INFO - 'log_to_console': True, 09:37:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:37:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:37:07 INFO - 'opt_config_files': (), 09:37:07 INFO - 'pip_index': False, 09:37:07 INFO - 'sps_profile': False, 09:37:07 INFO - 'sps_profile_interval': 0, 09:37:07 INFO - 'suite': 'dromaeojs', 09:37:07 INFO - 'system_bits': '32', 09:37:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:37:07 INFO - 'title': 'talos-linux64-ix-069', 09:37:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:37:07 INFO - 'use_talos_json': True, 09:37:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:37:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:37:07 INFO - 'work_dir': 'build'} 09:37:07 INFO - [mozharness: 2016-07-26 16:37:07.678837Z] Running clobber step. 09:37:07 INFO - Running pre-action listener: _resource_record_pre_action 09:37:07 INFO - Running main action method: clobber 09:37:07 INFO - rmtree: /builds/slave/test/build 09:37:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:37:07 INFO - Running post-action listener: _resource_record_post_action 09:37:07 INFO - [mozharness: 2016-07-26 16:37:07.682354Z] Finished clobber step (success) 09:37:07 INFO - [mozharness: 2016-07-26 16:37:07.682450Z] Running read-buildbot-config step. 09:37:07 INFO - Running pre-action listener: _resource_record_pre_action 09:37:07 INFO - Running main action method: read_buildbot_config 09:37:07 INFO - Using buildbot properties: 09:37:07 INFO - { 09:37:07 INFO - "project": "", 09:37:07 INFO - "product": "firefox", 09:37:07 INFO - "script_repo_revision": "production", 09:37:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:37:07 INFO - "repository": "", 09:37:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:37:07 INFO - "buildid": "20160726081052", 09:37:07 INFO - "pgo_build": "False", 09:37:07 INFO - "basedir": "/builds/slave/test", 09:37:07 INFO - "buildnumber": 1827, 09:37:07 INFO - "slavename": "talos-linux64-ix-069", 09:37:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:37:07 INFO - "platform": "ubuntu64_hw", 09:37:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:37:07 INFO - "branch": "fx-team", 09:37:07 INFO - "repo_path": "integration/fx-team", 09:37:07 INFO - "revision": "ceb63dec9267e9bb62f5e5e1f4c9d32d3ac1fbac", 09:37:07 INFO - "stage_platform": "linux64", 09:37:07 INFO - "builduid": "dd6a15a6c1a44834967a5f2b91d8cbe7", 09:37:07 INFO - "slavebuilddir": "test" 09:37:07 INFO - } 09:37:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:37:07 INFO - Running post-action listener: _resource_record_post_action 09:37:07 INFO - [mozharness: 2016-07-26 16:37:07.684846Z] Finished read-buildbot-config step (success) 09:37:07 INFO - [mozharness: 2016-07-26 16:37:07.684934Z] Running download-and-extract step. 09:37:07 INFO - Running pre-action listener: _resource_record_pre_action 09:37:07 INFO - Running main action method: download_and_extract 09:37:07 INFO - mkdir: /builds/slave/test/build/tests 09:37:07 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')]} 09:37:07 INFO - https://queue.taskcluster.net/v1/task/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:37:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:37:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:37:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/do984iaDSVaEOiY6iGC4EQ/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 09:37:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/do984iaDSVaEOiY6iGC4EQ/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 09:37:08 INFO - Downloaded 1361 bytes. 09:37:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:37:08 INFO - Using the following test package requirements: 09:37:08 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:37:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:37:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:37:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:08 INFO - u'jsshell-linux-x86_64.zip'], 09:37:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:37:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:37:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:37:08 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:37:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:37:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:37:08 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:37:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:37:08 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')]} 09:37:08 INFO - https://queue.taskcluster.net/v1/task/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:37:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:37:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:37:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/do984iaDSVaEOiY6iGC4EQ/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 09:37:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/do984iaDSVaEOiY6iGC4EQ/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 09:37:09 INFO - Downloaded 22742092 bytes. 09:37:09 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'] 09:37:09 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 09:37:10 INFO - Return code: 0 09:37:10 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 09:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:10 INFO - https://queue.taskcluster.net/v1/task/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:37:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:37:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:37:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/do984iaDSVaEOiY6iGC4EQ/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 09:37:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/do984iaDSVaEOiY6iGC4EQ/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 09:37:11 INFO - Downloaded 22742092 bytes. 09:37:11 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'] 09:37:11 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 09:37:13 INFO - Return code: 0 09:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:13 INFO - https://queue.taskcluster.net/v1/task/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:37:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:37:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:37:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/do984iaDSVaEOiY6iGC4EQ/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 09:37:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/do984iaDSVaEOiY6iGC4EQ/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 09:37:14 INFO - Downloaded 14413725 bytes. 09:37:14 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'] 09:37:14 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 09:37:14 INFO - Return code: 0 09:37:14 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')]} 09:37:14 INFO - https://queue.taskcluster.net/v1/task/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:37:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:37:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:37:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/do984iaDSVaEOiY6iGC4EQ/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 09:37:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/do984iaDSVaEOiY6iGC4EQ/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 09:37:15 INFO - Downloaded 57165728 bytes. 09:37:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:37:15 INFO - mkdir: /builds/slave/test/properties 09:37:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:37:15 INFO - Writing to file /builds/slave/test/properties/build_url 09:37:15 INFO - Contents: 09:37:15 INFO - build_url:https://queue.taskcluster.net/v1/task/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:37:16 INFO - Running post-action listener: _resource_record_post_action 09:37:16 INFO - Running post-action listener: set_extra_try_arguments 09:37:16 INFO - [mozharness: 2016-07-26 16:37:16.456817Z] Finished download-and-extract step (success) 09:37:16 INFO - [mozharness: 2016-07-26 16:37:16.457056Z] Running populate-webroot step. 09:37:16 INFO - Running pre-action listener: _resource_record_pre_action 09:37:16 INFO - Running main action method: populate_webroot 09:37:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:37:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:37:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:37:16 INFO - '--tppagecycles', 09:37:16 INFO - '7'], 09:37:16 INFO - 'tests': ['tsvgm']}}, 09:37:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:37:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:37:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:37:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:37:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:37:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:37:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:16 INFO - 'talos_options': ['--disable-e10s'], 09:37:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:37:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:37:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:16 INFO - 'talos_options': ['--disable-e10s'], 09:37:16 INFO - 'tests': ['damp', 'tps']}, 09:37:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:16 INFO - 'tests': ['damp', 'tps']}, 09:37:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:37:16 INFO - 'tests': ['dromaeo_dom']}, 09:37:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:37:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:37:16 INFO - 'tests': ['basic_compositor_video']}, 09:37:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:37:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:37:16 INFO - 'tests': ['a11yr', 09:37:16 INFO - 'ts_paint', 09:37:16 INFO - 'tpaint', 09:37:16 INFO - 'sessionrestore', 09:37:16 INFO - 'sessionrestore_no_auto_restore', 09:37:16 INFO - 'tabpaint']}, 09:37:16 INFO - 'other-e10s': {'tests': ['a11yr', 09:37:16 INFO - 'ts_paint', 09:37:16 INFO - 'tpaint', 09:37:16 INFO - 'sessionrestore', 09:37:16 INFO - 'sessionrestore_no_auto_restore', 09:37:16 INFO - 'tabpaint']}, 09:37:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:37:16 INFO - 'ts_paint', 09:37:16 INFO - 'tpaint', 09:37:16 INFO - 'sessionrestore', 09:37:16 INFO - 'sessionrestore_no_auto_restore', 09:37:16 INFO - 'tabpaint']}, 09:37:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:37:16 INFO - 'ts_paint', 09:37:16 INFO - 'tpaint', 09:37:16 INFO - 'sessionrestore', 09:37:16 INFO - 'sessionrestore_no_auto_restore', 09:37:16 INFO - 'tabpaint']}, 09:37:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:37:16 INFO - 'tests': ['a11yr', 09:37:16 INFO - 'ts_paint', 09:37:16 INFO - 'tpaint', 09:37:16 INFO - 'sessionrestore', 09:37:16 INFO - 'sessionrestore_no_auto_restore', 09:37:16 INFO - 'tabpaint']}, 09:37:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:37:16 INFO - 'tests': ['a11yr', 09:37:16 INFO - 'ts_paint', 09:37:16 INFO - 'tpaint', 09:37:16 INFO - 'sessionrestore', 09:37:16 INFO - 'sessionrestore_no_auto_restore', 09:37:16 INFO - 'tabpaint']}, 09:37:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:37:16 INFO - 'tests': ['tsvgx', 09:37:16 INFO - 'tsvgr_opacity', 09:37:16 INFO - 'tart', 09:37:16 INFO - 'tscrollx', 09:37:16 INFO - 'cart']}, 09:37:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:37:16 INFO - 'tsvgr_opacity', 09:37:16 INFO - 'tart', 09:37:16 INFO - 'tscrollx', 09:37:16 INFO - 'cart']}, 09:37:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:16 INFO - 'talos_options': ['--disable-e10s'], 09:37:16 INFO - 'tests': ['tp5o']}, 09:37:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:16 INFO - 'tests': ['tp5o']}, 09:37:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:16 INFO - 'talos_options': ['--disable-e10s', 09:37:16 INFO - '--xperf_path', 09:37:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:37:16 INFO - 'tests': ['tp5n']}, 09:37:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:37:16 INFO - 'talos_options': ['--xperf_path', 09:37:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:37:16 INFO - 'tests': ['tp5n']}}, 09:37:16 INFO - 'talos.zip': {'path': '', 09:37:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:37:16 INFO - Running post-action listener: _resource_record_post_action 09:37:16 INFO - [mozharness: 2016-07-26 16:37:16.473452Z] Finished populate-webroot step (success) 09:37:16 INFO - [mozharness: 2016-07-26 16:37:16.473540Z] Running create-virtualenv step. 09:37:16 INFO - Running pre-action listener: _resource_record_pre_action 09:37:16 INFO - Running main action method: create_virtualenv 09:37:16 INFO - Creating virtualenv /builds/slave/test/build/venv 09:37:16 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 09:37:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:37:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:37:16 INFO - Using real prefix '/usr' 09:37:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:37:18 INFO - Installing distribute.............................................................................................................................................................................................done. 09:37:19 INFO - Installing pip.................done. 09:37:20 INFO - Return code: 0 09:37:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab03b0>, '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 0x2ab12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab1740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', '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 09:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:37:20 INFO - Using env: {'DISPLAY': ':0', 09:37:20 INFO - 'HOME': '/home/cltbld', 09:37:20 INFO - 'LANG': 'en_US.UTF-8', 09:37:20 INFO - 'LANGUAGE': 'en_US:en', 09:37:20 INFO - 'LOGNAME': 'cltbld', 09:37:20 INFO - 'MAIL': '/var/mail/cltbld', 09:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:20 INFO - 'MOZ_NO_REMOTE': '1', 09:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:20 INFO - 'NO_EM_RESTART': '1', 09:37:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:20 INFO - 'PWD': '/builds/slave/test', 09:37:20 INFO - 'SHELL': '/bin/bash', 09:37:20 INFO - 'SHLVL': '1', 09:37:20 INFO - 'TERM': 'linux', 09:37:20 INFO - 'TMOUT': '86400', 09:37:20 INFO - 'USER': 'cltbld', 09:37:20 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', 09:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:20 INFO - '_': '/tools/buildbot/bin/python'} 09:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:20 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 09:37:20 INFO - Cleaning up... 09:37:20 INFO - Return code: 0 09:37:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x27f1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab03b0>, '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 0x2ab12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab1740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', '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 09:37:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:37:20 INFO - Using env: {'DISPLAY': ':0', 09:37:20 INFO - 'HOME': '/home/cltbld', 09:37:20 INFO - 'LANG': 'en_US.UTF-8', 09:37:20 INFO - 'LANGUAGE': 'en_US:en', 09:37:20 INFO - 'LOGNAME': 'cltbld', 09:37:20 INFO - 'MAIL': '/var/mail/cltbld', 09:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:20 INFO - 'MOZ_NO_REMOTE': '1', 09:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:20 INFO - 'NO_EM_RESTART': '1', 09:37:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:20 INFO - 'PWD': '/builds/slave/test', 09:37:20 INFO - 'SHELL': '/bin/bash', 09:37:20 INFO - 'SHLVL': '1', 09:37:20 INFO - 'TERM': 'linux', 09:37:20 INFO - 'TMOUT': '86400', 09:37:20 INFO - 'USER': 'cltbld', 09:37:20 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', 09:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:20 INFO - '_': '/tools/buildbot/bin/python'} 09:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:20 INFO - Downloading/unpacking psutil>=3.1.1 09:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:37:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:22 INFO - Installing collected packages: psutil 09:37:22 INFO - Running setup.py install for psutil 09:37:22 INFO - building 'psutil._psutil_linux' extension 09:37:22 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 09:37:22 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 09:37:22 INFO - building 'psutil._psutil_posix' extension 09:37:22 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 09:37:22 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 09:37:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:37:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:37:24 INFO - Successfully installed psutil 09:37:24 INFO - Cleaning up... 09:37:24 INFO - Return code: 0 09:37:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:37:24 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')]} 09:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:24 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')]} 09:37:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:24 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 0x27f1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab03b0>, '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 0x2ab12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab1740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', '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 09:37:24 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 09:37:24 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 09:37:24 INFO - Using env: {'DISPLAY': ':0', 09:37:24 INFO - 'HOME': '/home/cltbld', 09:37:24 INFO - 'LANG': 'en_US.UTF-8', 09:37:24 INFO - 'LANGUAGE': 'en_US:en', 09:37:24 INFO - 'LOGNAME': 'cltbld', 09:37:24 INFO - 'MAIL': '/var/mail/cltbld', 09:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:24 INFO - 'MOZ_NO_REMOTE': '1', 09:37:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:24 INFO - 'NO_EM_RESTART': '1', 09:37:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:24 INFO - 'PWD': '/builds/slave/test', 09:37:24 INFO - 'SHELL': '/bin/bash', 09:37:24 INFO - 'SHLVL': '1', 09:37:24 INFO - 'TERM': 'linux', 09:37:24 INFO - 'TMOUT': '86400', 09:37:24 INFO - 'USER': 'cltbld', 09:37:24 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', 09:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:24 INFO - '_': '/tools/buildbot/bin/python'} 09:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:37:24 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 09:37:24 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 09:37:24 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 09:37:24 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 09:37:24 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 09:37:24 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 09:37:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:37:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:37:26 INFO - Installing collected packages: mozsystemmonitor 09:37:26 INFO - Running setup.py install for mozsystemmonitor 09:37:26 INFO - Successfully installed mozsystemmonitor 09:37:26 INFO - Cleaning up... 09:37:26 INFO - Return code: 0 09:37:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:26 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 0x27f1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab03b0>, '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 0x2ab12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab1740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', '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 09:37:26 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 09:37:26 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 09:37:26 INFO - Using env: {'DISPLAY': ':0', 09:37:26 INFO - 'HOME': '/home/cltbld', 09:37:26 INFO - 'LANG': 'en_US.UTF-8', 09:37:26 INFO - 'LANGUAGE': 'en_US:en', 09:37:26 INFO - 'LOGNAME': 'cltbld', 09:37:26 INFO - 'MAIL': '/var/mail/cltbld', 09:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:26 INFO - 'MOZ_NO_REMOTE': '1', 09:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:26 INFO - 'NO_EM_RESTART': '1', 09:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:26 INFO - 'PWD': '/builds/slave/test', 09:37:26 INFO - 'SHELL': '/bin/bash', 09:37:26 INFO - 'SHLVL': '1', 09:37:26 INFO - 'TERM': 'linux', 09:37:26 INFO - 'TMOUT': '86400', 09:37:26 INFO - 'USER': 'cltbld', 09:37:26 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', 09:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:26 INFO - '_': '/tools/buildbot/bin/python'} 09:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:26 INFO - Downloading/unpacking jsonschema==2.5.1 09:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:37:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:37:28 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 09:37:28 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 09:37:28 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 09:37:28 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 09:37:28 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 09:37:28 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 09:37:29 INFO - Downloading functools32-3.2.3-2.tar.gz 09:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:37:29 INFO - warning: no files found matching '*.txt' 09:37:29 INFO - no previously-included directories found matching 'build' 09:37:29 INFO - no previously-included directories found matching 'dist' 09:37:29 INFO - no previously-included directories found matching '.git*' 09:37:29 INFO - Installing collected packages: jsonschema, functools32 09:37:29 INFO - Running setup.py install for functools32 09:37:29 INFO - warning: no files found matching '*.txt' 09:37:29 INFO - no previously-included directories found matching 'build' 09:37:29 INFO - no previously-included directories found matching 'dist' 09:37:29 INFO - no previously-included directories found matching '.git*' 09:37:29 INFO - Successfully installed jsonschema functools32 09:37:29 INFO - Cleaning up... 09:37:29 INFO - Return code: 0 09:37:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:37: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')]} 09:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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')]} 09:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:29 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 0x27f1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab03b0>, '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 0x2ab12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab1740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', '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 09:37:29 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 09:37:29 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 09:37:29 INFO - Using env: {'DISPLAY': ':0', 09:37:29 INFO - 'HOME': '/home/cltbld', 09:37:29 INFO - 'LANG': 'en_US.UTF-8', 09:37:29 INFO - 'LANGUAGE': 'en_US:en', 09:37:29 INFO - 'LOGNAME': 'cltbld', 09:37:29 INFO - 'MAIL': '/var/mail/cltbld', 09:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:29 INFO - 'MOZ_NO_REMOTE': '1', 09:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:29 INFO - 'NO_EM_RESTART': '1', 09:37:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:29 INFO - 'PWD': '/builds/slave/test', 09:37:29 INFO - 'SHELL': '/bin/bash', 09:37:29 INFO - 'SHLVL': '1', 09:37:29 INFO - 'TERM': 'linux', 09:37:29 INFO - 'TMOUT': '86400', 09:37:29 INFO - 'USER': 'cltbld', 09:37:29 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', 09:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:29 INFO - '_': '/tools/buildbot/bin/python'} 09:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:37:29 INFO - Cleaning up... 09:37:29 INFO - Return code: 0 09:37:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:37: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')]} 09:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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')]} 09:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:29 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 0x27f1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab03b0>, '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 0x2ab12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab1740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', '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 09:37:29 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 09:37:29 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 09:37:29 INFO - Using env: {'DISPLAY': ':0', 09:37:29 INFO - 'HOME': '/home/cltbld', 09:37:29 INFO - 'LANG': 'en_US.UTF-8', 09:37:29 INFO - 'LANGUAGE': 'en_US:en', 09:37:29 INFO - 'LOGNAME': 'cltbld', 09:37:29 INFO - 'MAIL': '/var/mail/cltbld', 09:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:29 INFO - 'MOZ_NO_REMOTE': '1', 09:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:29 INFO - 'NO_EM_RESTART': '1', 09:37:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:29 INFO - 'PWD': '/builds/slave/test', 09:37:29 INFO - 'SHELL': '/bin/bash', 09:37:29 INFO - 'SHLVL': '1', 09:37:29 INFO - 'TERM': 'linux', 09:37:29 INFO - 'TMOUT': '86400', 09:37:29 INFO - 'USER': 'cltbld', 09:37:29 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', 09:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:29 INFO - '_': '/tools/buildbot/bin/python'} 09:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:29 INFO - Downloading/unpacking blobuploader==1.2.4 09:37:29 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 09:37:29 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 09:37:29 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 09:37:29 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 09:37:29 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 09:37:29 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 09:37:31 INFO - Downloading blobuploader-1.2.4.tar.gz 09:37:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:37:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:37:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:37:32 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 09:37:32 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 09:37:32 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 09:37:32 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 09:37:32 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 09:37:32 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 09:37:32 INFO - Downloading docopt-0.6.1.tar.gz 09:37:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:37:32 INFO - Installing collected packages: blobuploader, requests, docopt 09:37:32 INFO - Running setup.py install for blobuploader 09:37:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:37:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:37:32 INFO - Running setup.py install for requests 09:37:32 INFO - Running setup.py install for docopt 09:37:32 INFO - Successfully installed blobuploader requests docopt 09:37:32 INFO - Cleaning up... 09:37:33 INFO - Return code: 0 09:37:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:33 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 0x27f1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab03b0>, '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 0x2ab12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab1740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', '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 09:37:33 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 09:37:33 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 09:37:33 INFO - Using env: {'DISPLAY': ':0', 09:37:33 INFO - 'HOME': '/home/cltbld', 09:37:33 INFO - 'LANG': 'en_US.UTF-8', 09:37:33 INFO - 'LANGUAGE': 'en_US:en', 09:37:33 INFO - 'LOGNAME': 'cltbld', 09:37:33 INFO - 'MAIL': '/var/mail/cltbld', 09:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:33 INFO - 'MOZ_NO_REMOTE': '1', 09:37:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:33 INFO - 'NO_EM_RESTART': '1', 09:37:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:33 INFO - 'PWD': '/builds/slave/test', 09:37:33 INFO - 'SHELL': '/bin/bash', 09:37:33 INFO - 'SHLVL': '1', 09:37:33 INFO - 'TERM': 'linux', 09:37:33 INFO - 'TMOUT': '86400', 09:37:33 INFO - 'USER': 'cltbld', 09:37:33 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', 09:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:33 INFO - '_': '/tools/buildbot/bin/python'} 09:37:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:37:33 INFO - Running setup.py (path:/tmp/pip-J2QZOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:37:33 INFO - Running setup.py (path:/tmp/pip-qtUnZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:37:33 INFO - Running setup.py (path:/tmp/pip-v9BzWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:37:33 INFO - Running setup.py (path:/tmp/pip-gSalxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:37:33 INFO - Running setup.py (path:/tmp/pip-jsDYBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:37:33 INFO - Running setup.py (path:/tmp/pip-YYFWCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:37:33 INFO - Running setup.py (path:/tmp/pip-PsQ0ZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:37:33 INFO - Running setup.py (path:/tmp/pip-yaugbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:37:33 INFO - Running setup.py (path:/tmp/pip-sx6kMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:37:33 INFO - Running setup.py (path:/tmp/pip-RCheNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:37:33 INFO - Running setup.py (path:/tmp/pip-Cxiam5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:37:34 INFO - Running setup.py (path:/tmp/pip-Lptk8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:37:34 INFO - Running setup.py (path:/tmp/pip-2mm_uG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:37:34 INFO - Running setup.py (path:/tmp/pip-s7rq4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:34 INFO - Running setup.py (path:/tmp/pip-lC6hGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:37:34 INFO - Running setup.py (path:/tmp/pip-U_X67T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:37:34 INFO - Running setup.py (path:/tmp/pip-SUn80U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:37:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:37:34 INFO - Running setup.py install for manifestparser 09:37:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:37:34 INFO - Running setup.py install for mozcrash 09:37:34 INFO - Running setup.py install for mozdebug 09:37:34 INFO - Running setup.py install for mozdevice 09:37:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:37:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:37:34 INFO - Running setup.py install for mozfile 09:37:34 INFO - Running setup.py install for mozhttpd 09:37:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:37:35 INFO - Running setup.py install for mozinfo 09:37:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:37:35 INFO - Running setup.py install for mozInstall 09:37:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:37:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:37:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:37:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:37:35 INFO - Running setup.py install for mozleak 09:37:35 INFO - Running setup.py install for mozlog 09:37:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:37:35 INFO - Running setup.py install for moznetwork 09:37:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:37:35 INFO - Running setup.py install for mozprocess 09:37:35 INFO - Running setup.py install for mozprofile 09:37:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:37:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:37:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:37:35 INFO - Running setup.py install for mozrunner 09:37:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:37:35 INFO - Running setup.py install for mozscreenshot 09:37:36 INFO - Running setup.py install for moztest 09:37:36 INFO - Running setup.py install for mozversion 09:37:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:37:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:37:36 INFO - Cleaning up... 09:37:36 INFO - Return code: 0 09:37:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:37:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:36 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 0x27f1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab03b0>, '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 0x2ab12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab1740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', '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 09:37:36 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 09:37:36 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 09:37:36 INFO - Using env: {'DISPLAY': ':0', 09:37:36 INFO - 'HOME': '/home/cltbld', 09:37:36 INFO - 'LANG': 'en_US.UTF-8', 09:37:36 INFO - 'LANGUAGE': 'en_US:en', 09:37:36 INFO - 'LOGNAME': 'cltbld', 09:37:36 INFO - 'MAIL': '/var/mail/cltbld', 09:37:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:36 INFO - 'MOZ_NO_REMOTE': '1', 09:37:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:36 INFO - 'NO_EM_RESTART': '1', 09:37:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:36 INFO - 'PWD': '/builds/slave/test', 09:37:36 INFO - 'SHELL': '/bin/bash', 09:37:36 INFO - 'SHLVL': '1', 09:37:36 INFO - 'TERM': 'linux', 09:37:36 INFO - 'TMOUT': '86400', 09:37:36 INFO - 'USER': 'cltbld', 09:37:36 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', 09:37:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:36 INFO - '_': '/tools/buildbot/bin/python'} 09:37:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:37:36 INFO - Running setup.py (path:/tmp/pip-ClMpsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:37:36 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)) 09:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:37:36 INFO - Running setup.py (path:/tmp/pip-TkPtFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:37:36 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)) 09:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:37:36 INFO - Running setup.py (path:/tmp/pip-aeLkSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:37:36 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)) 09:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:37:36 INFO - Running setup.py (path:/tmp/pip-NIW_IB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:37:36 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)) 09:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:37:36 INFO - Running setup.py (path:/tmp/pip-tL68Zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:37:36 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)) 09:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:37:36 INFO - Running setup.py (path:/tmp/pip-fTpswK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:37:36 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)) 09:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:37:36 INFO - Running setup.py (path:/tmp/pip-SG7jOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:37:36 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)) 09:37:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:37:36 INFO - Running setup.py (path:/tmp/pip-GZP1UZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:37:37 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)) 09:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:37:37 INFO - Running setup.py (path:/tmp/pip-DT1pgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:37:37 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)) 09:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:37:37 INFO - Running setup.py (path:/tmp/pip-q3V9vU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:37:37 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)) 09:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:37:37 INFO - Running setup.py (path:/tmp/pip-zLO3Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:37:37 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)) 09:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:37:37 INFO - Running setup.py (path:/tmp/pip-hFoW1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:37:37 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)) 09:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:37:37 INFO - Running setup.py (path:/tmp/pip-scWPa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:37:37 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)) 09:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:37:37 INFO - Running setup.py (path:/tmp/pip-JLVprd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:37:37 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)) 09:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:37 INFO - Running setup.py (path:/tmp/pip-Y7hZwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:37:37 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)) 09:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:37:37 INFO - Running setup.py (path:/tmp/pip-ok0taZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:37:37 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)) 09:37:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:37:37 INFO - Running setup.py (path:/tmp/pip-9Ft9MY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:37:37 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)) 09:37:37 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)) 09:37:37 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)) 09:37:37 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)) 09:37:37 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)) 09:37:37 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)) 09:37:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:37:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:37:39 INFO - Downloading blessings-1.6.tar.gz 09:37:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:37:39 INFO - Installing collected packages: blessings 09:37:39 INFO - Running setup.py install for blessings 09:37:39 INFO - Successfully installed blessings 09:37:39 INFO - Cleaning up... 09:37:39 INFO - Return code: 0 09:37:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:37:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:37:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:37:40 INFO - Reading from file tmpfile_stdout 09:37:40 INFO - Current package versions: 09:37:40 INFO - argparse == 1.2.1 09:37:40 INFO - blessings == 1.6 09:37:40 INFO - blobuploader == 1.2.4 09:37:40 INFO - docopt == 0.6.1 09:37:40 INFO - functools32 == 3.2.3-2 09:37:40 INFO - jsonschema == 2.5.1 09:37:40 INFO - manifestparser == 1.1 09:37:40 INFO - mozInstall == 1.12 09:37:40 INFO - mozcrash == 0.17 09:37:40 INFO - mozdebug == 0.1 09:37:40 INFO - mozdevice == 0.48 09:37:40 INFO - mozfile == 1.2 09:37:40 INFO - mozhttpd == 0.7 09:37:40 INFO - mozinfo == 0.9 09:37:40 INFO - mozleak == 0.1 09:37:40 INFO - mozlog == 3.3 09:37:40 INFO - moznetwork == 0.27 09:37:40 INFO - mozprocess == 0.23 09:37:40 INFO - mozprofile == 0.28 09:37:40 INFO - mozrunner == 6.12 09:37:40 INFO - mozscreenshot == 0.1 09:37:40 INFO - mozsystemmonitor == 0.3 09:37:40 INFO - moztest == 0.7 09:37:40 INFO - mozversion == 1.4 09:37:40 INFO - psutil == 3.1.1 09:37:40 INFO - requests == 1.2.3 09:37:40 INFO - wsgiref == 0.1.2 09:37:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:37: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')]} 09:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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')]} 09:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37:40 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 0x27f1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab03b0>, '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 0x2ab12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab1740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', '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 09:37:40 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 09:37:40 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 09:37:40 INFO - Using env: {'DISPLAY': ':0', 09:37:40 INFO - 'HOME': '/home/cltbld', 09:37:40 INFO - 'LANG': 'en_US.UTF-8', 09:37:40 INFO - 'LANGUAGE': 'en_US:en', 09:37:40 INFO - 'LOGNAME': 'cltbld', 09:37:40 INFO - 'MAIL': '/var/mail/cltbld', 09:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:40 INFO - 'MOZ_NO_REMOTE': '1', 09:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:40 INFO - 'NO_EM_RESTART': '1', 09:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:40 INFO - 'PWD': '/builds/slave/test', 09:37:40 INFO - 'SHELL': '/bin/bash', 09:37:40 INFO - 'SHLVL': '1', 09:37:40 INFO - 'TERM': 'linux', 09:37:40 INFO - 'TMOUT': '86400', 09:37:40 INFO - 'USER': 'cltbld', 09:37:40 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', 09:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:40 INFO - '_': '/tools/buildbot/bin/python'} 09:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:40 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)) 09:37:40 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)) 09:37:40 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)) 09:37:40 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)) 09:37:40 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)) 09:37:40 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)) 09:37:40 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)) 09:37:40 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)) 09:37:40 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)) 09:37:40 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)) 09:37:40 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)) 09:37:40 INFO - Cleaning up... 09:37:40 INFO - Return code: 0 09:37:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:37: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')]} 09:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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')]} 09:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:37: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29548a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab03b0>, '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 0x2ab12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab1740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', '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 09:37: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', 'jsonschema'] in /builds/slave/test/build 09:37: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 jsonschema 09:37:40 INFO - Using env: {'DISPLAY': ':0', 09:37:40 INFO - 'HOME': '/home/cltbld', 09:37:40 INFO - 'LANG': 'en_US.UTF-8', 09:37:40 INFO - 'LANGUAGE': 'en_US:en', 09:37:40 INFO - 'LOGNAME': 'cltbld', 09:37:40 INFO - 'MAIL': '/var/mail/cltbld', 09:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:40 INFO - 'MOZ_NO_REMOTE': '1', 09:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:40 INFO - 'NO_EM_RESTART': '1', 09:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:40 INFO - 'PWD': '/builds/slave/test', 09:37:40 INFO - 'SHELL': '/bin/bash', 09:37:40 INFO - 'SHLVL': '1', 09:37:40 INFO - 'TERM': 'linux', 09:37:40 INFO - 'TMOUT': '86400', 09:37:40 INFO - 'USER': 'cltbld', 09:37:40 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', 09:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:40 INFO - '_': '/tools/buildbot/bin/python'} 09:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:37:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:37:40 INFO - Cleaning up... 09:37:40 INFO - Return code: 0 09:37:40 INFO - Running post-action listener: _resource_record_post_action 09:37:40 INFO - Running post-action listener: _start_resource_monitoring 09:37:40 INFO - Starting resource monitoring. 09:37:40 INFO - [mozharness: 2016-07-26 16:37:40.518262Z] Finished create-virtualenv step (success) 09:37:40 INFO - [mozharness: 2016-07-26 16:37:40.518690Z] Running install step. 09:37:40 INFO - Running pre-action listener: _resource_record_pre_action 09:37:40 INFO - Running main action method: install 09:37:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:37:40 INFO - Reading from file tmpfile_stdout 09:37:40 INFO - Detecting whether we're running mozinstall >=1.0... 09:37:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:37:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:37:40 INFO - Reading from file tmpfile_stdout 09:37:40 INFO - Output received: 09:37:40 INFO - Usage: mozinstall [options] installer 09:37:40 INFO - Options: 09:37:40 INFO - -h, --help show this help message and exit 09:37:40 INFO - -d DEST, --destination=DEST 09:37:40 INFO - Directory to install application into. [default: 09:37:40 INFO - "/builds/slave/test"] 09:37:40 INFO - --app=APP Application being installed. [default: firefox] 09:37:40 INFO - mkdir: /builds/slave/test/build/application 09:37:40 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'] 09:37:40 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 09:37:57 INFO - Reading from file tmpfile_stdout 09:37:57 INFO - Output received: 09:37:57 INFO - /builds/slave/test/build/application/firefox/firefox 09:37:57 INFO - Running post-action listener: _resource_record_post_action 09:37:57 INFO - [mozharness: 2016-07-26 16:37:57.184360Z] Finished install step (success) 09:37:57 INFO - [mozharness: 2016-07-26 16:37:57.184698Z] Running run-tests step. 09:37:57 INFO - Running pre-action listener: _resource_record_pre_action 09:37:57 INFO - Running main action method: run_tests 09:37:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:37:57 INFO - Python 2.7.3 09:37:57 INFO - Return code: 0 09:37:57 INFO - grabbing minidump binary from tooltool 09:37: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')]} 09:37:57 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 0x2ab03b0>, '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 0x2ab12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab1740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:37:57 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 09:37:57 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 09:37:57 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 09:37:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:37:57 INFO - Return code: 0 09:37:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:37:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:37:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:37:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:37:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:37:57 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/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 09:37:57 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/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 09:37:57 INFO - Using env: {'DISPLAY': ':0', 09:37:57 INFO - 'HOME': '/home/cltbld', 09:37:57 INFO - 'LANG': 'en_US.UTF-8', 09:37:57 INFO - 'LANGUAGE': 'en_US:en', 09:37:57 INFO - 'LOGNAME': 'cltbld', 09:37:57 INFO - 'MAIL': '/var/mail/cltbld', 09:37:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:37:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:57 INFO - 'MOZ_NO_REMOTE': '1', 09:37:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:37:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:37:57 INFO - 'NO_EM_RESTART': '1', 09:37:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:57 INFO - 'PWD': '/builds/slave/test', 09:37:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:37:57 INFO - 'SHELL': '/bin/bash', 09:37:57 INFO - 'SHLVL': '1', 09:37:57 INFO - 'TERM': 'linux', 09:37:57 INFO - 'TMOUT': '86400', 09:37:57 INFO - 'USER': 'cltbld', 09:37:57 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981', 09:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:57 INFO - '_': '/tools/buildbot/bin/python'} 09:37:57 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/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 09:37:57 INFO - mozversion application_buildid: 20160726081052 09:37:57 INFO - mozversion application_changeset: ceb63dec9267e9bb62f5e5e1f4c9d32d3ac1fbac 09:37:57 INFO - mozversion application_display_name: Nightly 09:37:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:37:57 INFO - mozversion application_name: Firefox 09:37:57 INFO - mozversion application_remotingname: firefox 09:37:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:37:57 INFO - mozversion application_vendor: Mozilla 09:37:57 INFO - mozversion application_version: 50.0a1 09:37:57 INFO - mozversion platform_buildid: 20160726081052 09:37:57 INFO - mozversion platform_changeset: ceb63dec9267e9bb62f5e5e1f4c9d32d3ac1fbac 09:37:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:37:57 INFO - mozversion platform_version: 50.0a1 09:37:57 INFO - using testdate: 1469551077 09:37:57 INFO - actual date: 1469551077 09:37:57 INFO - starting webserver on 'localhost:44112' 09:37:57 INFO - SUITE-START | Running 2 tests 09:37:57 INFO - TEST-START | dromaeo_css 09:37:57 INFO - operating with platform_type : linux_ 09:37:57 INFO - Initialising browser for dromaeo_css test... 09:37:57 INFO - TEST-INFO | started process 5545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOEF4hn/profile http://localhost:44112/getInfo.html) 09:38:01 INFO - PROCESS | 5545 | JavaScript error: , line 0: uncaught exception: undefined 09:38:01 INFO - PROCESS | 5545 | __metrics Screen width/height:1600/1200 09:38:01 INFO - PROCESS | 5545 | colorDepth:24 09:38:01 INFO - PROCESS | 5545 | Browser inner width/height: 1024/697 09:38:01 INFO - PROCESS | 5545 | __metrics 09:38:02 INFO - PROCESS | 5545 | 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" 09:38:02 INFO - PROCESS | 5545 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:38:03 INFO - PROCESS | 5545 | console.error: PushService: 09:38:03 INFO - PROCESS | 5545 | stateChangeProcessEnqueue: Error transitioning state 09:38:03 INFO - PROCESS | 5545 | UnknownError 09:38:03 INFO - TEST-INFO | 5545: exit 0 09:38:03 INFO - Browser initialized. 09:38:03 INFO - Running cycle 1/1 for dromaeo_css test... 09:38:03 INFO - TEST-INFO | started process 5625 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOEF4hn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:15 INFO - PROCESS | 5625 | RSS: Main: 159121408 09:38:15 INFO - PROCESS | 5625 | 09:39:06 INFO - PROCESS | 5625 | 1469551146522 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] 09:41:19 INFO - PROCESS | 5625 | Cycle 1(1): loaded http://localhost:44112/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44112/tests/dromaeo/cssquery-ext.html) 09:41:20 INFO - PROCESS | 5625 | RSS: Main: 243974144 09:41:20 INFO - PROCESS | 5625 | 09:44:23 INFO - PROCESS | 5625 | Cycle 1(1): loaded http://localhost:44112/tests/dromaeo/cssquery-ext.html (next: http://localhost:44112/tests/dromaeo/cssquery-jquery.html) 09:44:24 INFO - PROCESS | 5625 | RSS: Main: 245346304 09:44:24 INFO - PROCESS | 5625 | 09:47:26 INFO - PROCESS | 5625 | Cycle 1(1): loaded http://localhost:44112/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44112/tests/dromaeo/cssquery-mootools.html) 09:47:26 INFO - PROCESS | 5625 | RSS: Main: 190050304 09:47:26 INFO - PROCESS | 5625 | 09:50:29 INFO - PROCESS | 5625 | Cycle 1(1): loaded http://localhost:44112/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44112/tests/dromaeo/cssquery-prototype.html) 09:50:29 INFO - PROCESS | 5625 | RSS: Main: 193851392 09:50:29 INFO - PROCESS | 5625 | 09:53:32 INFO - PROCESS | 5625 | Cycle 1(1): loaded http://localhost:44112/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44112/tests/dromaeo/cssquery-yui.html) 09:53:33 INFO - PROCESS | 5625 | RSS: Main: 192061440 09:53:33 INFO - PROCESS | 5625 | 09:56:36 INFO - PROCESS | 5625 | Cycle 1(1): loaded http://localhost:44112/tests/dromaeo/cssquery-yui.html (next: http://localhost:44112/tests/dromaeo/cssquery-dojo.html) 09:56:36 INFO - PROCESS | 5625 | RSS: Main: 263917568 09:56:36 INFO - PROCESS | 5625 | 09:56:36 INFO - PROCESS | 5625 | __start_tp_report 09:56:36 INFO - PROCESS | 5625 | _x_x_mozilla_page_load 09:56:36 INFO - PROCESS | 5625 | _x_x_mozilla_page_load_details 09:56:36 INFO - PROCESS | 5625 | |i|pagename|runs| 09:56:36 INFO - PROCESS | 5625 | |0;dojo.html;2602.7787638050763;2623.8688065596716;2651.655284812974;2654.9070782522617;2659.6675415573054;4564.589186973171;4636.837710680127;4709.952900470998;4750.738709370983;4768.73771942543;4579.610733087691;4610.17016936952;4674.9766251168785;4686;4747.45404278509;4238.173556156551;4287.48550173978;4322.438083049199;4384.868453946387;4469.039156581334;4397.890052748691;4423.380726698265;4455.643548516127;4469.307257375112;4478.081993191388;4248.171606536726;4291.613754762056;4342.478902531717;4355.891102722426;4439.200943830109;4215.3044747616605;4244.299690551055;4291.034517233628;4351.956480435187;4369.978150109261;4223.767692776896;4277.422547956017;4286;4288.056627541936;4317.7193482423545;4534.501204867462;4695.3426520287185;4707.45864225615;4743.786529606176;4762.38089048425;4902.460729319772;4960.87597810054;4966.528179822911;4991.076650819574;5047.0915235257635;4969.155243608595;5010.4739002404585;5019.598432125421;5023.648344615878;5039.294498770175;4553.385292985471;4590.793414296365;4612.838550650745;4660.300954856731;4667.719936803803;5088.542031217208;5184.637075404761;5200.947990520122;5202.505761952609;5214.217867319932;4950.603951683856;5013.423456302499;5014.949850501521;5018.071656743514;5021.14640511114;4873.293372460973;4943.975280123648;5019.82430614934;5073.594112470993;5085.542301192911;4921.188003979375;4997.90004199914;5015.673981191211;5020.824271150492;5025.47232540578;4943.728094954812;4945.8021679132435;4949.851504454872;4955.603551715926;5011.323471331323;4273.059926816096;4277.91444171121;4285.314349704033;4295.742255464682;4331.761753103609;3688.3360995020616;3689.1699367642605;3715.9628403715615;3725.0501122213664;3767.7550959187565;4299.742015479082;4326.697131200785;4329.480462344539;4345.9348109778375;4348.826046958086;5026.84919452417;5031.798728050837;5032.295478632995;5032.924506132411;5076.771545280471;4230.915381692411;4283.550227226158;4311.956880431218;4326.956730432718;4345.869623911224;4587.266037433995;4595.816167353335;4611.377464042312;4630.629549636021;4659.2312268476;4777.163996300564;4805.783739731651;4806.062817750575;4851.393575803025;4865.489123641966;4804.855854324376;4933.4819843915875;4967.677100988424;5078.542931136216;5084.771185296744;4737.952620473751;4759.547842954914;4765.475797662185;4792.448868380181;4808.687435316833;4904.901901961869;4914.901701966012;4915.680480768739;4925.335079764329;4959.082569724613;4853.781579828987;4927.384076990376;4981.676191047571;5001.249812528004;5015.172496538176;4862.659613826998;4880.097182021337;4885.340479035285;4909.239067944474;4929.162042452864;4866.416030076413;4866.513348665105;4867.075255701406;4867.148249056472;4905.533974272438;4751.358566593465;4752.19212733843;4802.303665968345;4823.927641085316;4860.149473842134;4904.877378065434;4922.72924989129;4934.9753251233515;4955.8017679292425;4980.252962055576;4817.454313811396;4828.830990915301;4829.251466022772;4830.372051633406;4873.269009648581 09:56:36 INFO - PROCESS | 5625 | |1;ext.html;576.4984463516741;577.1083675721013;589.6255877517776;592.6325678079592;593.0363159865219;26804.731952680468;38495.80752096239;39617;39746.60253397465;43478.130437391235;39959.40060899089;40332.79833600835;40395;40396.798016009954;40434.19131617373;7566.772996810105;7702.152763196044;7703.653335599912;7707.30634242918;7708.075030996289;7531.2468753124795;7546.396288296951;7609.201033891445;7617.047869016373;7622.504537205064;7581.128170260408;7628.656710448043;7633.770986870375;7637.350825179867;7640.503367281109;7597.696092156307;7622.352100071501;7627.847443051163;7630.122535908386;7630.961845190766;7594.886076708854;7655.540667559964;7673.808154796119;7675.616219189074;7676.692932282702;36868;37344.43983340252;37344.626553734386;37366.62633373659;37368.25263494715;3002.549617557362;3045.193023848682;3097.674744151854;3161.5573819665265;3319.4191016572245;28323.85838070817;28651.426971460663;28837;28856;29135.271618209503;3085.2595377109556;3207.1982004498877;3235.433799085174;3282.720968717662;3283.885064022748;246821;246992.94545854462;247811;247872;249244;31264.531032034538;49174.262386064234;49588.50411495839;49630.75184624126;49661.50338496641;31802;33099;33446.498302525484;33459.49810752841;33462.832685836416;12819.487220511075;12943.805842912363;12958.092933494565;12958.28729419891;12966.611001669966;10306.896931030593;10328;10353.4305613192;10356.741081472872;10365.429901355497;7784.571848548271;7856.567888766059;7866.488678236011;7920.920790792134;7923.12845586985;3041.8783248669806;3061.4795484767196;3075.9551190184834;3113.081640915935;3126.5779119818535;815.4903185509057;864.2006144316482;908.4095338030334;947.5830634520789;1000.8098461292332;26884.462310753675;27413;27556.862215688794;27935;28404;954.174638937328;991.8940381474748;1006.964756233543;1033.4419413516616;1036.7667274863095;14131;14634.560963171121;14976.326065327086;15117.16855572932;15318.617034574225;120289.39855300667;120645.39677301557;120773.39613301877;387982;392239;48469.75765121152;49086.75456622765;49285.507144928095;49332.75333623381;49351.753241234284;1068.8931106889404;1135.2734250079955;1169.3568537304448;1202.723373624054;1217.3852204636603;27403.862980685768;28372.290692732848;29131.563026554195;29197.562036569892;29370.853145734134;46551;46806.53193468022;47061.52938470572;47505.299364076534;47590.76204618955;366363;369268;369984;372413;372914;32770;38152;39971.40042899301;41198.38202426906;41484.1703165941;37299.440508391854;40253.39619905762;40755.535779459075;40971.38542921799;41721.79139104285;34698.65301346954;35039.12402189965;35251.29497409986;35389.646103539664;35764.284714306086;35182;35278.17774578079;35484.46773298351;35584.82207588945;35753.82123089472;34018.31963360769;34022.65977340195;34285.31429371348;34593.30813383769;34910.65089349074;30260.84869575638;32689.836550817094;32798;32859.83570082134;32914.67085329116;24667.383315417257;24800.25599232026;24918.501629966937;25175.87412062928;25220 09:56:36 INFO - PROCESS | 5625 | |2;jquery.html;355.89323203039066;358.24946736586855;369.46427679864195;375.82524126281305;379.2377321583618;15920.283587238573;16752.246148923296;17186.054766987825;17308.221130049147;17325.393611223608;16456.506304810846;16597.83402165978;16770.161491925417;16924.23840927158;17052.23264953077;4881.414230292361;5127.615428842833;5127.820526281581;5131.871703207413;5133.666311689728;3828.406596977473;4018.4775979122674;5044.495550444963;5526.751296191681;5778.4799368056865;5932.495737862287;5934.554908381867;5940.584159108864;5941.405859414067;5941.792037278696;5669.9433005669825;5849.356570777211;5863.736131874076;5875.647461152302;5877.147813567051;4986.650934434591;5105.8723531912;5121.8463446096675;5127.53852153308;5130.358705161855;20593;20868.269610563708;20940.581188376298;20961.371158865106;21061.684074738892;1813.1931290575699;1815.137809540471;1872.5318670332417;1900.914458849355;2018.8485863560293;12763.680907977281;13221.272829994346;13325.400356983959;13341.799873001914;14196.077254978496;1736.3749050341867;1758.7361895715617;1786.8302511261409;1810.3211295764088;1846.4829847642682;65603;66776.66611666958;68001.97997030098;68054;68679.65660171717;8097.595120243965;8299.585020749058;9469.242460603135;9656.855147172799;9768.21854251658;12931.418086186144;12939.5471158509;12943.870561294454;12944.223346599234;12962.870371296167;7140.750073747394;7284.854302913912;7321.78034658961;7411.221821708751;7488.887666685004;7044.788656340318;7060.505764596532;7077;7242.96378518104;7317.853642927218;5933.376995415506;5940.732667029994;5980.880382392328;6003.129546215774;6075.422834830684;1534.1792141204403;1575.550967974145;1655.51989922921;1702.658844089377;1778.2086971297906;858.3819350979487;884.3323290915317;896.7668406214431;928.9953550232206;943.8678584998106;16936;17738.11309434523;17777.46667599974;18000.459986200436;18080.095995200187;870.6865528409768;872.5462759365095;879.1164879296266;886.8093359927647;907.6278725722422;9886;10373.118284945864;10431.426271555138;10434.37393756377;10532.894671053346;387507;394362;398215;398547;403241;78881.60559197167;81844;83423;84481;85554.57222713847;871.407442938795;888.3337496877342;894.5169608411385;914.07221670005;948.3977674176947;15159;15605.453809116627;15649;16119.355225790838;16586.75119873227;39550;39668.40497392484;40507.59492405156;40511;42214.366784498874;54783.726081369336;55412.72293638506;56413;56542;56795;6765.830854228684;6866.485013623898;6906.482013849082;6977.825554361181;7051.471139664443;11108.166887483309;11366.090712742794;11815.054795616503;11825;11899.643010709693;6766.458683305422;9893.109620134222;10032.046955539212;10188.694339169837;10736.946315268373;9129.315301352557;9387.389819661701;10214.489275536045;10307.793844123225;10853.511591978538;10230.795384092426;10255.07704306616;10308.948455257676;10700.197485188486;10773.89226107729;7035.718571257093;7105.82235444118;7305.671244793891;7520.962395188208;7555.508891922007;9701.417914925127;9788.85316720264;9861.556229969812;10052.346597471142;10607.734806629896 09:56:36 INFO - PROCESS | 5625 | |3;mootools.html;1362.1963041805336;1404.3961096728406;1434.297194374756;1635.6483356078456;1640.5898525368657;7737.806554836125;8278.461899976504;8284.668613255477;8289.58552072397;8299.211574900382;6869.141357330333;7639.579823109727;7886.250806173404;7910.920890791091;8116.3101136403475;1986.9304574339901;2006.2877678424168;2013.6073465674199;2015.7782643909159;2018.777934427212;2161.438026113214;2190.4195388222133;2213.1589995801655;2233.542123864604;2236.630955892276;1889.6787546117125;2064.194963964055;2133.0188113467825;2139.721836161297;2170.3597438755605;2196.033745152136;2207.404000919743;2222.0334154642783;2225.1989283857797;2232.586971410286;2143.3141394753684;2159.9568008639894;2163.448320678217;2164.177612507237;2169.6203164446315;8020;8038.557879316635;8042;8056.234657707509;8073.354131669511;4674.836380726692;4777.617790576745;4789.49710280419;4804.807807687688;4841.225403935388;2807.3402750353653;2831.5186418308936;2917.139443864065;2919.226405002676;2929.3555417808047;839.5508403004425;881.5944665453899;886.4769785826329;888.4891187567175;1724.672312260679;10487.685369438928;10907.83638245419;10918.617848375348;10927.83608245869;10964.122870170448;3901.122247494348;4113.465249517603;4158.043649960526;4170.311898536768;4273.059926816096;8575.1424857515;8576.656933722581;8577.656893724181;8580.957095214484;8585.957070214734;4791.041791641685;4793.760311984387;4794.4486384065585;4802.375691160127;4802.447718512346;4111.362738775495;4411.492678341968;4412.779361031936;4413.3159360299205;4417.734935903856;3394.3890099781784;3465.1337165708574;3541.769784963969;3541.8583256669444;3546.432570788713;1044.6239353832614;1052.2108418685987;1059.3485006720966;1061.867266591676;1065.227709910309;630.6405348951146;713.2403989751002;748.8689479341093;752.4807882561015;802.5545822068808;5023.494574525997;5165.1219292720325;5279.076161671769;5282.418933917266;5423.132298832247;888.3071204460531;911.7720569857536;923.3859483443434;951.4671783801093;951.7144856543009;3537.9469307960403;3618.222082252328;3647.2340808430527;3650.9817450912574;3707.536557930259;9812.852807207897;10017.39895606266;10111.3427627204;10141.898581014242;10145.391276523433;10033.247506436901;10041.297109202433;10044.698659040094;10045.296829221885;10050.899491005142;7490.550566966109;7510.549367037996;7634.618269086634;7667.463277570517;7667.923320766832;5184.637075404837;5306.097963346318;5336.919946200887;5363.115086010765;5381.919271210857;9071.183593476619;9248.583813728264;9341.252699784136;9418.152366287068;9545.856812147684;9313.767155821159;9452.338336316392;9525.857112143462;9550.808983820145;9667.468289243878;6562.245341785756;6635.0710900473005;6683.064370987969;6686.197656281277;6688.996650502463;7603.7338693145475;7633.1985141559335;7636.045494313211;7656.73201437947;7683.039620047494;6571.5399922005;6596.472282217315;6640.701168447335;6707.698153583198;6782.152230971129;6804.319568043354;6850.280720524473;6853.143357080365;6855.143107111611;6872.037914692047;6401.7119229633845;6525.738970441129;6530.510211734234;6530.608163510205;6537.1174891389055;4444.511103778517;4659.044895796286;4688.92966605508;4692.671512994058;4713.2223183175765;4541.250693635513;4562.749048802348;4629.467611224618;4690.085433340466;4859.805607775649 09:56:36 INFO - PROCESS | 5625 | |4;prototype.html;270.844264547885;282.6763999920652;290.17011347546014;296.19435136428905;301.19730917105915;4580.29005504147;4727.267273572593;4782;4783.30642056902;4808.326834243208;4754.548317909793;4756.334113224151;4762.880927976802;4776.90446191076;4777.04459108178;3569.375933950053;3651.726120540957;3658.213484100918;3668.926621467569;3706.0734816295926;3462.117160124165;3585.7310701697347;3644.362236608583;3673.4306182541613;3700.1859590889962;3634.5638523377233;3639.4168536686625;3644.107193737538;3644.4533320001947;3648.2885837261742;3643.180284435981;3643.908902277438;3645.908852278701;3656.1590834108306;3681.6069554789333;3199.104250809777;3208.9037328879936;3214;3218.855151518187;3231.2406584452633;4486;4573;4579.3131030345385;4579.381783459257;4597.195490789132;4118.75287482749;4121.237571049365;4123.505179378494;4133.0574629923885;4144.937825932613;4885.5358740919555;4893.510648935114;4898.044881248158;4901.779419926076;4968.279599458095;3264;3448.793072415638;3467.6532346765375;3482.8432720527635;3490.5985811631735;5120.667156634807;5130.4356520782685;5137.919142747156;5152.562032227265;5164.2770012198325;3506.7720598161036;3511.3504001759757;3518.1028837646236;3525.2244506208594;3529.347070791912;3560.1099725068734;3571.8928432147077;3584.301061293075;3593.1017245688577;3597.838097285576;4037.37420699792;4084.509858816961;4103.871435355301;4135.841964250015;4142.834286628561;4891.315215869781;4902.460729319772;4912.803487860517;4915.16442204826;4923.77842997066;1224.706070543081;1237.7648246833073;1246.052999720219;1246.2086575024925;1247.494764620312;746.914104877946;791.5567282321919;797.4617133434908;808.458332916947;814.6049166154411;3941.842326306973;3959.7228194026143;3981.442598036277;3988.641022308006;3995.180987897474;4477.6417886569;4531.844379683225;4556.2937744649635;4558.452985641744;4569.200389931749;3919.862804801818;3952.7430717003876;3955.7626542407547;3978.5026871641044;4012.398140278923;2299.9080036798673;2409.8554086754853;2415.6955244167953;2425.721042080148;2445.4131008558174;4325.858699943548;4338.240807858612;4352.303631418958;4378.452693413324;4386.649068074546;4670.392848929618;4677.906441871211;4709.67032307742;4717.5046620104395;4742.33607294979;4039.434479172918;4309.827606895752;4368.759718215529;4406.845760398371;4427.760227136342;4491.550844915482;4505.43682039745;4530.501644819134;4536.591706746409;4553.817847286072;4498.100379924093;4532.4901722786035;4559.863204103882;4721.220998535203;4759.619230461624;4740.146773580651;4796.561031690409;4828.203346447796;4853.126437241189;4864.683795553277;3533.858645654145;3543.911402214965;3545.6808887200277;3558.6619271169197;3568.4825700273836;4791.760411979457;5115.848933989822;5117.9508200818;5119.360079990001;5124.743762811919;4929.753512324298;4934.284528743384;4935.876603084952;4953.414907229652;4953.801847926043;4917.409910810726;4924.581410579997;4955.380577427822;5009.323741294878;5042.218456139304;4823.011282687111;4840.201366774443;4908.092002979461;4924.975375123101;4958.983408401341;4949.57928576075;4955.801767929387;4965.255211718271;4995.775190116381;5007.3240112584335;4883.487233840396;4896.290037944407;4904.6321525886415;4948.8762780930765;4950.4406112074585 09:56:36 INFO - PROCESS | 5625 | |5;yui.html;605.7758629307157;643.8937575300075;656.2289310060678;721.5273995532924;742.7957311739273;12218.144729868913;13234.139780914235;13297.800532992012;13307.06850520464;13354.999999999987;12289.20120192187;12430.751384972295;12450.564230251943;12495.750084998295;12519.061070419732;621.2762132116079;635.6916895305797;737.0639288104104;748.1097493982171;752.4131177681418;760.8744557148063;777.215012837033;777.2887807655987;777.5490215674895;778.0740918307197;794.7099308752292;795.5346122518333;796.3271035974622;796.5539297993142;796.6494742313392;640.078287266335;767.9923200768033;794.2057942057942;795.8487887301394;796.8725003999361;585.4906231578511;585.7071464267866;585.759838466231;585.8125399872042;586.2378907420336;13100.213987160801;13123.60629181126;13134.211947283098;13169.078164528486;13174.868251317555;12161.270323780602;12247.571335003322;12761.234325940473;12859.292738899358;12925.836674699322;10719.142468602493;10830.891691083067;10892.074173695246;11003.779924401468;11206;4079.571644977294;4142.2958097123565;4169.207850508424;4277.123189746095;4284.742915425085;59687.40312596905;60214.69892650552;60267.69866150685;60718;63951.360486395;10219.131373833308;10231.94884025575;10262.743431414125;10309.53607087683;10407;19176;19282;19315.51711207231;19317.61364772697;19318;6450.3549645036055;6464.127342808754;6504.414602685781;6507.837304067436;6521.02184672303;3653.6529029742132;3689.594144644087;3694.150345420568;3704.685101766326;3715.7956312402534;2685.9328516786845;2749.257700420875;2775.5697866830674;2775.736305051017;2782.38787466757;477.3245857112217;489.24167540313084;489.307629703972;497.9502049794992;503.0191127301776;524.4388504300438;524.9947500524946;542.6391449685915;545.1876703711441;564.2354609504063;7066.893996590055;7101.467389945775;7164.892526612105;7366.447516436288;7549.849003019909;458.6949678463851;505.6409948936296;513.2096571280186;514.2055524215097;538.3620409814382;3400.1499625093725;3406.540117084162;3412.215190506148;3456.861725531001;3471.7396195285455;90976.54511727531;93621;94096.05903940873;96401.51799240959;99931.50034249782;80456.5977170122;84631.57684211539;84909.57545212234;87359.56320218358;92137;73855.26144738591;76379.61810190913;76501.61749191218;76909.23090769132;78152.6092369546;6443.96778016107;6471;6492.253390859923;6617.43751781104;6701.0953521274005;32923.17692057718;40257.18842652146;44190;45375;46778.53221467878;39960.80019599883;48187.277190841465;58783.70608146932;62677.373226267155;63042.369576305486;11199.944000280273;11201.327920324806;11368.147388945697;11399.829002565135;11483.712907177387;11407.714807129889;11442.199046066695;11644.53421863116;11758;11894.286342819458;7810.531368117931;8316.584170791315;11240.831387529357;11300.434978251218;11409.144314176305;11180.329180249211;11208.607698730506;11401.429928503707;11539.365334906324;11761.353125578175;9014.2788576915;9216.769580760534;10757.515911784145;11052.226344156154;11702.648920532398;9193.27856982353;9415.482148481899;9629.374090684083;9835.16401105914;10226.6420675276;9063.456192628464;9410.57652405657;9443.527823608929;9466.905330946602;9617.086376794194 09:56:36 INFO - PROCESS | 5625 | __end_tp_report 09:56:36 INFO - PROCESS | 5625 | __start_cc_report 09:56:36 INFO - PROCESS | 5625 | _x_x_mozilla_cycle_collect,904 09:56:36 INFO - PROCESS | 5625 | __end_cc_report 09:56:36 INFO - PROCESS | 5625 | __startTimestamp1469552196328__endTimestamp 09:56:36 INFO - PROCESS | 5625 | 09:56:36 INFO - PROCESS | 5625 | ------- Summary: start ------- 09:56:36 INFO - PROCESS | 5625 | Number of tests: 6 09:56:36 INFO - PROCESS | 5625 | 09:56:36 INFO - PROCESS | 5625 | [#0] dojo.html Cycles:165 Average:4642.26 Median:4802.30 stddev:479.58 (10.0%) stddev-sans-first:453.58 09:56:36 INFO - PROCESS | 5625 | Values: 2602.8 2623.9 2651.7 2654.9 2659.7 4564.6 4636.8 4710.0 4750.7 4768.7 4579.6 4610.2 4675.0 4686.0 4747.5 4238.2 4287.5 4322.4 4384.9 4469.0 4397.9 4423.4 4455.6 4469.3 4478.1 4248.2 4291.6 4342.5 4355.9 4439.2 4215.3 4244.3 4291.0 4352.0 4370.0 4223.8 4277.4 4286.0 4288.1 4317.7 4534.5 4695.3 4707.5 4743.8 4762.4 4902.5 4960.9 4966.5 4991.1 5047.1 4969.2 5010.5 5019.6 5023.6 5039.3 4553.4 4590.8 4612.8 4660.3 4667.7 5088.5 5184.6 5200.9 5202.5 5214.2 4950.6 5013.4 5014.9 5018.1 5021.1 4873.3 4944.0 5019.8 5073.6 5085.5 4921.2 4997.9 5015.7 5020.8 5025.5 4943.7 4945.8 4949.9 4955.6 5011.3 4273.1 4277.9 4285.3 4295.7 4331.8 3688.3 3689.2 3716.0 3725.1 3767.8 4299.7 4326.7 4329.5 4345.9 4348.8 5026.8 5031.8 5032.3 5032.9 5076.8 4230.9 4283.6 4312.0 4327.0 4345.9 4587.3 4595.8 4611.4 4630.6 4659.2 4777.2 4805.8 4806.1 4851.4 4865.5 4804.9 4933.5 4967.7 5078.5 5084.8 4738.0 4759.5 4765.5 4792.4 4808.7 4904.9 4914.9 4915.7 4925.3 4959.1 4853.8 4927.4 4981.7 5001.2 5015.2 4862.7 4880.1 4885.3 4909.2 4929.2 4866.4 4866.5 4867.1 4867.1 4905.5 4751.4 4752.2 4802.3 4823.9 4860.1 4904.9 4922.7 4935.0 4955.8 4980.3 4817.5 4828.8 4829.3 4830.4 4873.3 09:56:36 INFO - PROCESS | 5625 | 09:56:36 INFO - PROCESS | 5625 | [#1] ext.html Cycles:180 Average:43338.54 Median:35437.06 stddev:79192.62 (223.5%) stddev-sans-first:79349.69 09:56:36 INFO - PROCESS | 5625 | Values: 576.5 577.1 589.6 592.6 593.0 26804.7 38495.8 39617.0 39746.6 43478.1 39959.4 40332.8 40395.0 40396.8 40434.2 7566.8 7702.2 7703.7 7707.3 7708.1 7531.2 7546.4 7609.2 7617.0 7622.5 7581.1 7628.7 7633.8 7637.4 7640.5 7597.7 7622.4 7627.8 7630.1 7631.0 7594.9 7655.5 7673.8 7675.6 7676.7 36868.0 37344.4 37344.6 37366.6 37368.3 3002.5 3045.2 3097.7 3161.6 3319.4 28323.9 28651.4 28837.0 28856.0 29135.3 3085.3 3207.2 3235.4 3282.7 3283.9 246821.0 246992.9 247811.0 247872.0 249244.0 31264.5 49174.3 49588.5 49630.8 49661.5 31802.0 33099.0 33446.5 33459.5 33462.8 12819.5 12943.8 12958.1 12958.3 12966.6 10306.9 10328.0 10353.4 10356.7 10365.4 7784.6 7856.6 7866.5 7920.9 7923.1 3041.9 3061.5 3076.0 3113.1 3126.6 815.5 864.2 908.4 947.6 1000.8 26884.5 27413.0 27556.9 27935.0 28404.0 954.2 991.9 1007.0 1033.4 1036.8 14131.0 14634.6 14976.3 15117.2 15318.6 120289.4 120645.4 120773.4 387982.0 392239.0 48469.8 49086.8 49285.5 49332.8 49351.8 1068.9 1135.3 1169.4 1202.7 1217.4 27403.9 28372.3 29131.6 29197.6 29370.9 46551.0 46806.5 47061.5 47505.3 47590.8 366363.0 369268.0 369984.0 372413.0 372914.0 32770.0 38152.0 39971.4 41198.4 41484.2 37299.4 40253.4 40755.5 40971.4 41721.8 34698.7 35039.1 35251.3 35389.6 35764.3 35182.0 35278.2 35484.5 35584.8 35753.8 34018.3 34022.7 34285.3 34593.3 34910.7 30260.8 32689.8 32798.0 32859.8 32914.7 24667.4 24800.3 24918.5 25175.9 25220.0 09:56:36 INFO - PROCESS | 5625 | 09:56:36 INFO - PROCESS | 5625 | [#2] jquery.html Cycles:180 Average:24952.59 Median:5015.57 stddev:65577.52 (1307.5%) stddev-sans-first:65735.47 09:56:36 INFO - PROCESS | 5625 | Values: 355.9 358.2 369.5 375.8 379.2 15920.3 16752.2 17186.1 17308.2 17325.4 16456.5 16597.8 16770.2 16924.2 17052.2 4881.4 5127.6 5127.8 5131.9 5133.7 3828.4 4018.5 5044.5 5526.8 5778.5 5932.5 5934.6 5940.6 5941.4 5941.8 5669.9 5849.4 5863.7 5875.6 5877.1 4986.7 5105.9 5121.8 5127.5 5130.4 20593.0 20868.3 20940.6 20961.4 21061.7 1813.2 1815.1 1872.5 1900.9 2018.8 12763.7 13221.3 13325.4 13341.8 14196.1 1736.4 1758.7 1786.8 1810.3 1846.5 65603.0 66776.7 68002.0 68054.0 68679.7 8097.6 8299.6 9469.2 9656.9 9768.2 12931.4 12939.5 12943.9 12944.2 12962.9 7140.8 7284.9 7321.8 7411.2 7488.9 7044.8 7060.5 7077.0 7243.0 7317.9 5933.4 5940.7 5980.9 6003.1 6075.4 1534.2 1575.6 1655.5 1702.7 1778.2 858.4 884.3 896.8 929.0 943.9 16936.0 17738.1 17777.5 18000.5 18080.1 870.7 872.5 879.1 886.8 907.6 9886.0 10373.1 10431.4 10434.4 10532.9 387507.0 394362.0 398215.0 398547.0 403241.0 78881.6 81844.0 83423.0 84481.0 85554.6 871.4 888.3 894.5 914.1 948.4 15159.0 15605.5 15649.0 16119.4 16586.8 39550.0 39668.4 40507.6 40511.0 42214.4 54783.7 55412.7 56413.0 56542.0 56795.0 6765.8 6866.5 6906.5 6977.8 7051.5 11108.2 11366.1 11815.1 11825.0 11899.6 6766.5 9893.1 10032.0 10188.7 10736.9 9129.3 9387.4 10214.5 10307.8 10853.5 10230.8 10255.1 10308.9 10700.2 10773.9 7035.7 7105.8 7305.7 7521.0 7555.5 9701.4 9788.9 9861.6 10052.3 10607.7 09:56:36 INFO - PROCESS | 5625 | 09:56:36 INFO - PROCESS | 5625 | [#3] mootools.html Cycles:180 Average:5221.52 Median:4802.41 stddev:2974.62 (61.9%) stddev-sans-first:2968.83 09:56:36 INFO - PROCESS | 5625 | Values: 1362.2 1404.4 1434.3 1635.6 1640.6 7737.8 8278.5 8284.7 8289.6 8299.2 6869.1 7639.6 7886.3 7910.9 8116.3 1986.9 2006.3 2013.6 2015.8 2018.8 2161.4 2190.4 2213.2 2233.5 2236.6 1889.7 2064.2 2133.0 2139.7 2170.4 2196.0 2207.4 2222.0 2225.2 2232.6 2143.3 2160.0 2163.4 2164.2 2169.6 8020.0 8038.6 8042.0 8056.2 8073.4 4674.8 4777.6 4789.5 4804.8 4841.2 2807.3 2831.5 2917.1 2919.2 2929.4 839.6 881.6 886.5 888.5 1724.7 10487.7 10907.8 10918.6 10927.8 10964.1 3901.1 4113.5 4158.0 4170.3 4273.1 8575.1 8576.7 8577.7 8581.0 8586.0 4791.0 4793.8 4794.4 4802.4 4802.4 4111.4 4411.5 4412.8 4413.3 4417.7 3394.4 3465.1 3541.8 3541.9 3546.4 1044.6 1052.2 1059.3 1061.9 1065.2 630.6 713.2 748.9 752.5 802.6 5023.5 5165.1 5279.1 5282.4 5423.1 888.3 911.8 923.4 951.5 951.7 3537.9 3618.2 3647.2 3651.0 3707.5 9812.9 10017.4 10111.3 10141.9 10145.4 10033.2 10041.3 10044.7 10045.3 10050.9 7490.6 7510.5 7634.6 7667.5 7667.9 5184.6 5306.1 5336.9 5363.1 5381.9 9071.2 9248.6 9341.3 9418.2 9545.9 9313.8 9452.3 9525.9 9550.8 9667.5 6562.2 6635.1 6683.1 6686.2 6689.0 7603.7 7633.2 7636.0 7656.7 7683.0 6571.5 6596.5 6640.7 6707.7 6782.2 6804.3 6850.3 6853.1 6855.1 6872.0 6401.7 6525.7 6530.5 6530.6 6537.1 4444.5 4659.0 4688.9 4692.7 4713.2 4541.3 4562.7 4629.5 4690.1 4859.8 09:56:36 INFO - PROCESS | 5625 | 09:56:36 INFO - PROCESS | 5625 | [#4] prototype.html Cycles:180 Average:3982.70 Median:4481.82 stddev:1166.06 (26.0%) stddev-sans-first:1135.56 09:56:36 INFO - PROCESS | 5625 | Values: 270.8 282.7 290.2 296.2 301.2 4580.3 4727.3 4782.0 4783.3 4808.3 4754.5 4756.3 4762.9 4776.9 4777.0 3569.4 3651.7 3658.2 3668.9 3706.1 3462.1 3585.7 3644.4 3673.4 3700.2 3634.6 3639.4 3644.1 3644.5 3648.3 3643.2 3643.9 3645.9 3656.2 3681.6 3199.1 3208.9 3214.0 3218.9 3231.2 4486.0 4573.0 4579.3 4579.4 4597.2 4118.8 4121.2 4123.5 4133.1 4144.9 4885.5 4893.5 4898.0 4901.8 4968.3 3264.0 3448.8 3467.7 3482.8 3490.6 5120.7 5130.4 5137.9 5152.6 5164.3 3506.8 3511.4 3518.1 3525.2 3529.3 3560.1 3571.9 3584.3 3593.1 3597.8 4037.4 4084.5 4103.9 4135.8 4142.8 4891.3 4902.5 4912.8 4915.2 4923.8 1224.7 1237.8 1246.1 1246.2 1247.5 746.9 791.6 797.5 808.5 814.6 3941.8 3959.7 3981.4 3988.6 3995.2 4477.6 4531.8 4556.3 4558.5 4569.2 3919.9 3952.7 3955.8 3978.5 4012.4 2299.9 2409.9 2415.7 2425.7 2445.4 4325.9 4338.2 4352.3 4378.5 4386.6 4670.4 4677.9 4709.7 4717.5 4742.3 4039.4 4309.8 4368.8 4406.8 4427.8 4491.6 4505.4 4530.5 4536.6 4553.8 4498.1 4532.5 4559.9 4721.2 4759.6 4740.1 4796.6 4828.2 4853.1 4864.7 3533.9 3543.9 3545.7 3558.7 3568.5 4791.8 5115.8 5118.0 5119.4 5124.7 4929.8 4934.3 4935.9 4953.4 4953.8 4917.4 4924.6 4955.4 5009.3 5042.2 4823.0 4840.2 4908.1 4925.0 4959.0 4949.6 4955.8 4965.3 4995.8 5007.3 4883.5 4896.3 4904.6 4948.9 4950.4 09:56:36 INFO - PROCESS | 5625 | 09:56:36 INFO - PROCESS | 5625 | [#5] yui.html Cycles:180 Average:17233.17 Median:509.43 stddev:24991.00 (4905.7%) stddev-sans-first:25029.92 09:56:36 INFO - PROCESS | 5625 | Values: 605.8 643.9 656.2 721.5 742.8 12218.1 13234.1 13297.8 13307.1 13355.0 12289.2 12430.8 12450.6 12495.8 12519.1 621.3 635.7 737.1 748.1 752.4 760.9 777.2 777.3 777.5 778.1 794.7 795.5 796.3 796.6 796.6 640.1 768.0 794.2 795.8 796.9 585.5 585.7 585.8 585.8 586.2 13100.2 13123.6 13134.2 13169.1 13174.9 12161.3 12247.6 12761.2 12859.3 12925.8 10719.1 10830.9 10892.1 11003.8 11206.0 4079.6 4142.3 4169.2 4277.1 4284.7 59687.4 60214.7 60267.7 60718.0 63951.4 10219.1 10231.9 10262.7 10309.5 10407.0 19176.0 19282.0 19315.5 19317.6 19318.0 6450.4 6464.1 6504.4 6507.8 6521.0 3653.7 3689.6 3694.2 3704.7 3715.8 2685.9 2749.3 2775.6 2775.7 2782.4 477.3 489.2 489.3 498.0 503.0 524.4 525.0 542.6 545.2 564.2 7066.9 7101.5 7164.9 7366.4 7549.8 458.7 505.6 513.2 514.2 538.4 3400.1 3406.5 3412.2 3456.9 3471.7 90976.5 93621.0 94096.1 96401.5 99931.5 80456.6 84631.6 84909.6 87359.6 92137.0 73855.3 76379.6 76501.6 76909.2 78152.6 6444.0 6471.0 6492.3 6617.4 6701.1 32923.2 40257.2 44190.0 45375.0 46778.5 39960.8 48187.3 58783.7 62677.4 63042.4 11199.9 11201.3 11368.1 11399.8 11483.7 11407.7 11442.2 11644.5 11758.0 11894.3 7810.5 8316.6 11240.8 11300.4 11409.1 11180.3 11208.6 11401.4 11539.4 11761.4 9014.3 9216.8 10757.5 11052.2 11702.6 9193.3 9415.5 9629.4 9835.2 10226.6 9063.5 9410.6 9443.5 9466.9 9617.1 09:56:36 INFO - PROCESS | 5625 | -------- Summary: end -------- 09:56:36 INFO - PROCESS | 5625 | 09:56:37 INFO - TEST-INFO | 5625: exit 0 09:56:37 INFO - TEST-OK | dromaeo_css | took 1119656ms 09:56:37 INFO - TEST-START | kraken 09:56:37 INFO - operating with platform_type : linux_ 09:56:37 INFO - Initialising browser for kraken test... 09:56:37 INFO - TEST-INFO | started process 5814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpujCH3S/profile http://localhost:44112/getInfo.html) 09:56:40 INFO - PROCESS | 5814 | JavaScript error: , line 0: uncaught exception: undefined 09:56:41 INFO - PROCESS | 5814 | __metrics Screen width/height:1600/1200 09:56:41 INFO - PROCESS | 5814 | colorDepth:24 09:56:41 INFO - PROCESS | 5814 | Browser inner width/height: 1024/697 09:56:41 INFO - PROCESS | 5814 | __metrics 09:56:42 INFO - PROCESS | 5814 | 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" 09:56:42 INFO - PROCESS | 5814 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:56:43 INFO - TEST-INFO | 5814: exit 0 09:56:43 INFO - Browser initialized. 09:56:43 INFO - Running cycle 1/1 for kraken test... 09:56:43 INFO - TEST-INFO | started process 5891 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpujCH3S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:56:55 INFO - PROCESS | 5891 | RSS: Main: 159735808 09:56:55 INFO - PROCESS | 5891 | 09:56:58 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:44112/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44112/tests/kraken/driver.html?testName=audio-beat-detection) 09:56:58 INFO - PROCESS | 5891 | RSS: Main: 215207936 09:56:58 INFO - PROCESS | 5891 | 09:57:01 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:44112/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44112/tests/kraken/driver.html?testName=audio-dft) 09:57:02 INFO - PROCESS | 5891 | RSS: Main: 193110016 09:57:02 INFO - PROCESS | 5891 | 09:57:05 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:44112/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44112/tests/kraken/driver.html?testName=audio-fft) 09:57:06 INFO - PROCESS | 5891 | RSS: Main: 272064512 09:57:06 INFO - PROCESS | 5891 | 09:57:08 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:44112/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44112/tests/kraken/driver.html?testName=audio-oscillator) 09:57:08 INFO - PROCESS | 5891 | RSS: Main: 182489088 09:57:08 INFO - PROCESS | 5891 | 09:57:11 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:44112/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44112/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:57:11 INFO - PROCESS | 5891 | RSS: Main: 186695680 09:57:11 INFO - PROCESS | 5891 | 09:57:14 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:44112/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44112/tests/kraken/driver.html?testName=imaging-darkroom) 09:57:15 INFO - PROCESS | 5891 | RSS: Main: 222605312 09:57:15 INFO - PROCESS | 5891 | 09:57:19 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:44112/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44112/tests/kraken/driver.html?testName=imaging-desaturate) 09:57:19 INFO - PROCESS | 5891 | RSS: Main: 222101504 09:57:19 INFO - PROCESS | 5891 | 09:57:22 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:44112/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44112/tests/kraken/driver.html?testName=json-parse-financial) 09:57:23 INFO - PROCESS | 5891 | RSS: Main: 222109696 09:57:23 INFO - PROCESS | 5891 | 09:57:24 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:44112/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44112/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:57:25 INFO - PROCESS | 5891 | RSS: Main: 186806272 09:57:25 INFO - PROCESS | 5891 | 09:57:27 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:44112/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44112/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:57:28 INFO - PROCESS | 5891 | RSS: Main: 193622016 09:57:28 INFO - PROCESS | 5891 | 09:57:30 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:44112/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44112/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:57:30 INFO - PROCESS | 5891 | RSS: Main: 195932160 09:57:30 INFO - PROCESS | 5891 | 09:57:33 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:44112/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44112/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:57:34 INFO - PROCESS | 5891 | RSS: Main: 191565824 09:57:34 INFO - PROCESS | 5891 | 09:57:37 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:44112/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44112/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:57:37 INFO - PROCESS | 5891 | RSS: Main: 194048000 09:57:37 INFO - PROCESS | 5891 | 09:57:39 INFO - PROCESS | 5891 | Cycle 1(1): loaded http://localhost:44112/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44112/tests/kraken/driver.html?testName=ai-astar) 09:57:39 INFO - PROCESS | 5891 | RSS: Main: 245219328 09:57:39 INFO - PROCESS | 5891 | 09:57:39 INFO - PROCESS | 5891 | __start_tp_report 09:57:39 INFO - PROCESS | 5891 | _x_x_mozilla_page_load 09:57:39 INFO - PROCESS | 5891 | _x_x_mozilla_page_load_details 09:57:39 INFO - PROCESS | 5891 | |i|pagename|runs| 09:57:39 INFO - PROCESS | 5891 | |0;ai-astar;107;114;114;114;115;115;113;116;115;113 09:57:39 INFO - PROCESS | 5891 | |1;audio-beat-detection;148;124;128;177;124;123;151;121;159;122 09:57:39 INFO - PROCESS | 5891 | |2;audio-dft;162;162;162;162;160;162;162;160;160;159 09:57:39 INFO - PROCESS | 5891 | |3;audio-fft;76;79;76;113;75;75;76;77;105;75 09:57:39 INFO - PROCESS | 5891 | |4;audio-oscillator;85;86;123;85;85;85;127;85;85;133 09:57:39 INFO - PROCESS | 5891 | |5;imaging-gaussian-blur;117;117;116;118;117;117;117;117;119;117 09:57:39 INFO - PROCESS | 5891 | |6;imaging-darkroom;147;148;147;146;147;146;147;148;148;147 09:57:39 INFO - PROCESS | 5891 | |7;imaging-desaturate;95;95;95;96;96;96;96;95;95;95 09:57:39 INFO - PROCESS | 5891 | |8;json-parse-financial;61;61;61;62;63;62;62;62;61;61 09:57:39 INFO - PROCESS | 5891 | |9;json-stringify-tinderbox;65;65;65;65;65;65;65;64;66;66 09:57:39 INFO - PROCESS | 5891 | |10;stanford-crypto-aes;82;79;81;84;79;79;78;79;80;80 09:57:39 INFO - PROCESS | 5891 | |11;stanford-crypto-ccm;129;129;127;129;127;137;127;126;180;137 09:57:39 INFO - PROCESS | 5891 | |12;stanford-crypto-pbkdf2;170;171;171;164;165;166;170;163;163;166 09:57:39 INFO - PROCESS | 5891 | |13;stanford-crypto-sha256-iterative;68;67;67;67;71;66;72;66;65;66 09:57:39 INFO - PROCESS | 5891 | __end_tp_report 09:57:39 INFO - PROCESS | 5891 | __start_cc_report 09:57:39 INFO - PROCESS | 5891 | _x_x_mozilla_cycle_collect,1956 09:57:39 INFO - PROCESS | 5891 | __end_cc_report 09:57:39 INFO - PROCESS | 5891 | __startTimestamp1469552259746__endTimestamp 09:57:39 INFO - PROCESS | 5891 | 09:57:39 INFO - PROCESS | 5891 | ------- Summary: start ------- 09:57:39 INFO - PROCESS | 5891 | Number of tests: 14 09:57:39 INFO - PROCESS | 5891 | 09:57:39 INFO - PROCESS | 5891 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.50 stddev:2.50 (2.2%) stddev-sans-first:1.00 09:57:39 INFO - PROCESS | 5891 | Values: 107.0 114.0 114.0 114.0 115.0 115.0 113.0 116.0 115.0 113.0 09:57:39 INFO - PROCESS | 5891 | 09:57:39 INFO - PROCESS | 5891 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:138.00 stddev:19.70 (14.3%) stddev-sans-first:20.54 09:57:39 INFO - PROCESS | 5891 | Values: 148.0 124.0 128.0 177.0 124.0 123.0 151.0 121.0 159.0 122.0 09:57:39 INFO - PROCESS | 5891 | 09:57:39 INFO - PROCESS | 5891 | [#2] audio-dft Cycles:10 Average:161.10 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.22 09:57:39 INFO - PROCESS | 5891 | Values: 162.0 162.0 162.0 162.0 160.0 162.0 162.0 160.0 160.0 159.0 09:57:39 INFO - PROCESS | 5891 | 09:57:39 INFO - PROCESS | 5891 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:14.04 (18.5%) stddev-sans-first:14.68 09:57:39 INFO - PROCESS | 5891 | Values: 76.0 79.0 76.0 113.0 75.0 75.0 76.0 77.0 105.0 75.0 09:57:39 INFO - PROCESS | 5891 | 09:57:39 INFO - PROCESS | 5891 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:85.00 stddev:20.68 (24.3%) stddev-sans-first:21.40 09:57:39 INFO - PROCESS | 5891 | Values: 85.0 86.0 123.0 85.0 85.0 85.0 127.0 85.0 85.0 133.0 09:57:39 INFO - PROCESS | 5891 | 09:57:39 INFO - PROCESS | 5891 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 09:57:39 INFO - PROCESS | 5891 | Values: 117.0 117.0 116.0 118.0 117.0 117.0 117.0 117.0 119.0 117.0 09:57:39 INFO - PROCESS | 5891 | 09:57:39 INFO - PROCESS | 5891 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 09:57:39 INFO - PROCESS | 5891 | Values: 147.0 148.0 147.0 146.0 147.0 146.0 147.0 148.0 148.0 147.0 09:57:39 INFO - PROCESS | 5891 | 09:57:39 INFO - PROCESS | 5891 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:57:39 INFO - PROCESS | 5891 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 09:57:39 INFO - PROCESS | 5891 | 09:57:39 INFO - PROCESS | 5891 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:62.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 09:57:39 INFO - PROCESS | 5891 | Values: 61.0 61.0 61.0 62.0 63.0 62.0 62.0 62.0 61.0 61.0 09:57:39 INFO - PROCESS | 5891 | 09:57:39 INFO - PROCESS | 5891 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 09:57:39 INFO - PROCESS | 5891 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 65.0 64.0 66.0 66.0 09:57:39 INFO - PROCESS | 5891 | 09:57:39 INFO - PROCESS | 5891 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:1.79 (2.2%) stddev-sans-first:1.76 09:57:39 INFO - PROCESS | 5891 | Values: 82.0 79.0 81.0 84.0 79.0 79.0 78.0 79.0 80.0 80.0 09:57:39 INFO - PROCESS | 5891 | 09:57:39 INFO - PROCESS | 5891 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:129.00 stddev:16.38 (12.7%) stddev-sans-first:17.23 09:57:39 INFO - PROCESS | 5891 | Values: 129.0 129.0 127.0 129.0 127.0 137.0 127.0 126.0 180.0 137.0 09:57:39 INFO - PROCESS | 5891 | 09:57:39 INFO - PROCESS | 5891 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:168.00 stddev:3.28 (2.0%) stddev-sans-first:3.28 09:57:39 INFO - PROCESS | 5891 | Values: 170.0 171.0 171.0 164.0 165.0 166.0 170.0 163.0 163.0 166.0 09:57:39 INFO - PROCESS | 5891 | 09:57:39 INFO - PROCESS | 5891 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.00 stddev:2.27 (3.4%) stddev-sans-first:2.40 09:57:39 INFO - PROCESS | 5891 | Values: 68.0 67.0 67.0 67.0 71.0 66.0 72.0 66.0 65.0 66.0 09:57:39 INFO - PROCESS | 5891 | -------- Summary: end -------- 09:57:39 INFO - PROCESS | 5891 | 09:57:40 INFO - TEST-INFO | 5891: exit 0 09:57:40 INFO - TEST-OK | kraken | took 63757ms 09:57:40 INFO - SUITE-END | took 1183s 09:57:40 INFO - Completed test suite (00:19:43) 09:57:40 INFO - javascript benchmark 09:57:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2602.7787638050763, 2623.8688065596716, 2651.655284812974, 2654.9070782522617, 2659.6675415573054, 4564.589186973171, 4636.837710680127, 4709.952900470998, 4750.738709370983, 4768.73771942543, 4579.610733087691, 4610.17016936952, 4674.9766251168785, 4686.0, 4747.45404278509, 4238.173556156551, 4287.48550173978, 4322.438083049199, 4384.868453946387, 4469.039156581334, 4397.890052748691, 4423.380726698265, 4455.643548516127, 4469.307257375112, 4478.081993191388, 4248.171606536726, 4291.613754762056, 4342.478902531717, 4355.891102722426, 4439.200943830109, 4215.3044747616605, 4244.299690551055, 4291.034517233628, 4351.956480435187, 4369.978150109261, 4223.767692776896, 4277.422547956017, 4286.0, 4288.056627541936, 4317.7193482423545, 4534.501204867462, 4695.3426520287185, 4707.45864225615, 4743.786529606176, 4762.38089048425, 4902.460729319772, 4960.87597810054, 4966.528179822911, 4991.076650819574, 5047.0915235257635, 4969.155243608595, 5010.4739002404585, 5019.598432125421, 5023.648344615878, 5039.294498770175, 4553.385292985471, 4590.793414296365, 4612.838550650745, 4660.300954856731, 4667.719936803803, 5088.542031217208, 5184.637075404761, 5200.947990520122, 5202.505761952609, 5214.217867319932, 4950.603951683856, 5013.423456302499, 5014.949850501521, 5018.071656743514, 5021.14640511114, 4873.293372460973, 4943.975280123648, 5019.82430614934, 5073.594112470993, 5085.542301192911, 4921.188003979375, 4997.90004199914, 5015.673981191211, 5020.824271150492, 5025.47232540578, 4943.728094954812, 4945.8021679132435, 4949.851504454872, 4955.603551715926, 5011.323471331323, 4273.059926816096, 4277.91444171121, 4285.314349704033, 4295.742255464682, 4331.761753103609, 3688.3360995020616, 3689.1699367642605, 3715.9628403715615, 3725.0501122213664, 3767.7550959187565, 4299.742015479082, 4326.697131200785, 4329.480462344539, 4345.9348109778375, 4348.826046958086, 5026.84919452417, 5031.798728050837, 5032.295478632995, 5032.924506132411, 5076.771545280471, 4230.915381692411, 4283.550227226158, 4311.956880431218, 4326.956730432718, 4345.869623911224, 4587.266037433995, 4595.816167353335, 4611.377464042312, 4630.629549636021, 4659.2312268476, 4777.163996300564, 4805.783739731651, 4806.062817750575, 4851.393575803025, 4865.489123641966, 4804.855854324376, 4933.4819843915875, 4967.677100988424, 5078.542931136216, 5084.771185296744, 4737.952620473751, 4759.547842954914, 4765.475797662185, 4792.448868380181, 4808.687435316833, 4904.901901961869, 4914.901701966012, 4915.680480768739, 4925.335079764329, 4959.082569724613, 4853.781579828987, 4927.384076990376, 4981.676191047571, 5001.249812528004, 5015.172496538176, 4862.659613826998, 4880.097182021337, 4885.340479035285, 4909.239067944474, 4929.162042452864, 4866.416030076413, 4866.513348665105, 4867.075255701406, 4867.148249056472, 4905.533974272438, 4751.358566593465, 4752.19212733843, 4802.303665968345, 4823.927641085316, 4860.149473842134, 4904.877378065434, 4922.72924989129, 4934.9753251233515, 4955.8017679292425, 4980.252962055576, 4817.454313811396, 4828.830990915301, 4829.251466022772, 4830.372051633406, 4873.269009648581], "value": 4612.038459816055, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.4984463516741, 577.1083675721013, 589.6255877517776, 592.6325678079592, 593.0363159865219, 26804.731952680468, 38495.80752096239, 39617.0, 39746.60253397465, 43478.130437391235, 39959.40060899089, 40332.79833600835, 40395.0, 40396.798016009954, 40434.19131617373, 7566.772996810105, 7702.152763196044, 7703.653335599912, 7707.30634242918, 7708.075030996289, 7531.2468753124795, 7546.396288296951, 7609.201033891445, 7617.047869016373, 7622.504537205064, 7581.128170260408, 7628.656710448043, 7633.770986870375, 7637.350825179867, 7640.503367281109, 7597.696092156307, 7622.352100071501, 7627.847443051163, 7630.122535908386, 7630.961845190766, 7594.886076708854, 7655.540667559964, 7673.808154796119, 7675.616219189074, 7676.692932282702, 36868.0, 37344.43983340252, 37344.626553734386, 37366.62633373659, 37368.25263494715, 3002.549617557362, 3045.193023848682, 3097.674744151854, 3161.5573819665265, 3319.4191016572245, 28323.85838070817, 28651.426971460663, 28837.0, 28856.0, 29135.271618209503, 3085.2595377109556, 3207.1982004498877, 3235.433799085174, 3282.720968717662, 3283.885064022748, 246821.0, 246992.94545854462, 247811.0, 247872.0, 249244.0, 31264.531032034538, 49174.262386064234, 49588.50411495839, 49630.75184624126, 49661.50338496641, 31802.0, 33099.0, 33446.498302525484, 33459.49810752841, 33462.832685836416, 12819.487220511075, 12943.805842912363, 12958.092933494565, 12958.28729419891, 12966.611001669966, 10306.896931030593, 10328.0, 10353.4305613192, 10356.741081472872, 10365.429901355497, 7784.571848548271, 7856.567888766059, 7866.488678236011, 7920.920790792134, 7923.12845586985, 3041.8783248669806, 3061.4795484767196, 3075.9551190184834, 3113.081640915935, 3126.5779119818535, 815.4903185509057, 864.2006144316482, 908.4095338030334, 947.5830634520789, 1000.8098461292332, 26884.462310753675, 27413.0, 27556.862215688794, 27935.0, 28404.0, 954.174638937328, 991.8940381474748, 1006.964756233543, 1033.4419413516616, 1036.7667274863095, 14131.0, 14634.560963171121, 14976.326065327086, 15117.16855572932, 15318.617034574225, 120289.39855300667, 120645.39677301557, 120773.39613301877, 387982.0, 392239.0, 48469.75765121152, 49086.75456622765, 49285.507144928095, 49332.75333623381, 49351.753241234284, 1068.8931106889404, 1135.2734250079955, 1169.3568537304448, 1202.723373624054, 1217.3852204636603, 27403.862980685768, 28372.290692732848, 29131.563026554195, 29197.562036569892, 29370.853145734134, 46551.0, 46806.53193468022, 47061.52938470572, 47505.299364076534, 47590.76204618955, 366363.0, 369268.0, 369984.0, 372413.0, 372914.0, 32770.0, 38152.0, 39971.40042899301, 41198.38202426906, 41484.1703165941, 37299.440508391854, 40253.39619905762, 40755.535779459075, 40971.38542921799, 41721.79139104285, 34698.65301346954, 35039.12402189965, 35251.29497409986, 35389.646103539664, 35764.284714306086, 35182.0, 35278.17774578079, 35484.46773298351, 35584.82207588945, 35753.82123089472, 34018.31963360769, 34022.65977340195, 34285.31429371348, 34593.30813383769, 34910.65089349074, 30260.84869575638, 32689.836550817094, 32798.0, 32859.83570082134, 32914.67085329116, 24667.383315417257, 24800.25599232026, 24918.501629966937, 25175.87412062928, 25220.0], "value": 16259.294176034078, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.89323203039066, 358.24946736586855, 369.46427679864195, 375.82524126281305, 379.2377321583618, 15920.283587238573, 16752.246148923296, 17186.054766987825, 17308.221130049147, 17325.393611223608, 16456.506304810846, 16597.83402165978, 16770.161491925417, 16924.23840927158, 17052.23264953077, 4881.414230292361, 5127.615428842833, 5127.820526281581, 5131.871703207413, 5133.666311689728, 3828.406596977473, 4018.4775979122674, 5044.495550444963, 5526.751296191681, 5778.4799368056865, 5932.495737862287, 5934.554908381867, 5940.584159108864, 5941.405859414067, 5941.792037278696, 5669.9433005669825, 5849.356570777211, 5863.736131874076, 5875.647461152302, 5877.147813567051, 4986.650934434591, 5105.8723531912, 5121.8463446096675, 5127.53852153308, 5130.358705161855, 20593.0, 20868.269610563708, 20940.581188376298, 20961.371158865106, 21061.684074738892, 1813.1931290575699, 1815.137809540471, 1872.5318670332417, 1900.914458849355, 2018.8485863560293, 12763.680907977281, 13221.272829994346, 13325.400356983959, 13341.799873001914, 14196.077254978496, 1736.3749050341867, 1758.7361895715617, 1786.8302511261409, 1810.3211295764088, 1846.4829847642682, 65603.0, 66776.66611666958, 68001.97997030098, 68054.0, 68679.65660171717, 8097.595120243965, 8299.585020749058, 9469.242460603135, 9656.855147172799, 9768.21854251658, 12931.418086186144, 12939.5471158509, 12943.870561294454, 12944.223346599234, 12962.870371296167, 7140.750073747394, 7284.854302913912, 7321.78034658961, 7411.221821708751, 7488.887666685004, 7044.788656340318, 7060.505764596532, 7077.0, 7242.96378518104, 7317.853642927218, 5933.376995415506, 5940.732667029994, 5980.880382392328, 6003.129546215774, 6075.422834830684, 1534.1792141204403, 1575.550967974145, 1655.51989922921, 1702.658844089377, 1778.2086971297906, 858.3819350979487, 884.3323290915317, 896.7668406214431, 928.9953550232206, 943.8678584998106, 16936.0, 17738.11309434523, 17777.46667599974, 18000.459986200436, 18080.095995200187, 870.6865528409768, 872.5462759365095, 879.1164879296266, 886.8093359927647, 907.6278725722422, 9886.0, 10373.118284945864, 10431.426271555138, 10434.37393756377, 10532.894671053346, 387507.0, 394362.0, 398215.0, 398547.0, 403241.0, 78881.60559197167, 81844.0, 83423.0, 84481.0, 85554.57222713847, 871.407442938795, 888.3337496877342, 894.5169608411385, 914.07221670005, 948.3977674176947, 15159.0, 15605.453809116627, 15649.0, 16119.355225790838, 16586.75119873227, 39550.0, 39668.40497392484, 40507.59492405156, 40511.0, 42214.366784498874, 54783.726081369336, 55412.72293638506, 56413.0, 56542.0, 56795.0, 6765.830854228684, 6866.485013623898, 6906.482013849082, 6977.825554361181, 7051.471139664443, 11108.166887483309, 11366.090712742794, 11815.054795616503, 11825.0, 11899.643010709693, 6766.458683305422, 9893.109620134222, 10032.046955539212, 10188.694339169837, 10736.946315268373, 9129.315301352557, 9387.389819661701, 10214.489275536045, 10307.793844123225, 10853.511591978538, 10230.795384092426, 10255.07704306616, 10308.948455257676, 10700.197485188486, 10773.89226107729, 7035.718571257093, 7105.82235444118, 7305.671244793891, 7520.962395188208, 7555.508891922007, 9701.417914925127, 9788.85316720264, 9861.556229969812, 10052.346597471142, 10607.734806629896], "value": 8359.39731334222, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.1963041805336, 1404.3961096728406, 1434.297194374756, 1635.6483356078456, 1640.5898525368657, 7737.806554836125, 8278.461899976504, 8284.668613255477, 8289.58552072397, 8299.211574900382, 6869.141357330333, 7639.579823109727, 7886.250806173404, 7910.920890791091, 8116.3101136403475, 1986.9304574339901, 2006.2877678424168, 2013.6073465674199, 2015.7782643909159, 2018.777934427212, 2161.438026113214, 2190.4195388222133, 2213.1589995801655, 2233.542123864604, 2236.630955892276, 1889.6787546117125, 2064.194963964055, 2133.0188113467825, 2139.721836161297, 2170.3597438755605, 2196.033745152136, 2207.404000919743, 2222.0334154642783, 2225.1989283857797, 2232.586971410286, 2143.3141394753684, 2159.9568008639894, 2163.448320678217, 2164.177612507237, 2169.6203164446315, 8020.0, 8038.557879316635, 8042.0, 8056.234657707509, 8073.354131669511, 4674.836380726692, 4777.617790576745, 4789.49710280419, 4804.807807687688, 4841.225403935388, 2807.3402750353653, 2831.5186418308936, 2917.139443864065, 2919.226405002676, 2929.3555417808047, 839.5508403004425, 881.5944665453899, 886.4769785826329, 888.4891187567175, 1724.672312260679, 10487.685369438928, 10907.83638245419, 10918.617848375348, 10927.83608245869, 10964.122870170448, 3901.122247494348, 4113.465249517603, 4158.043649960526, 4170.311898536768, 4273.059926816096, 8575.1424857515, 8576.656933722581, 8577.656893724181, 8580.957095214484, 8585.957070214734, 4791.041791641685, 4793.760311984387, 4794.4486384065585, 4802.375691160127, 4802.447718512346, 4111.362738775495, 4411.492678341968, 4412.779361031936, 4413.3159360299205, 4417.734935903856, 3394.3890099781784, 3465.1337165708574, 3541.769784963969, 3541.8583256669444, 3546.432570788713, 1044.6239353832614, 1052.2108418685987, 1059.3485006720966, 1061.867266591676, 1065.227709910309, 630.6405348951146, 713.2403989751002, 748.8689479341093, 752.4807882561015, 802.5545822068808, 5023.494574525997, 5165.1219292720325, 5279.076161671769, 5282.418933917266, 5423.132298832247, 888.3071204460531, 911.7720569857536, 923.3859483443434, 951.4671783801093, 951.7144856543009, 3537.9469307960403, 3618.222082252328, 3647.2340808430527, 3650.9817450912574, 3707.536557930259, 9812.852807207897, 10017.39895606266, 10111.3427627204, 10141.898581014242, 10145.391276523433, 10033.247506436901, 10041.297109202433, 10044.698659040094, 10045.296829221885, 10050.899491005142, 7490.550566966109, 7510.549367037996, 7634.618269086634, 7667.463277570517, 7667.923320766832, 5184.637075404837, 5306.097963346318, 5336.919946200887, 5363.115086010765, 5381.919271210857, 9071.183593476619, 9248.583813728264, 9341.252699784136, 9418.152366287068, 9545.856812147684, 9313.767155821159, 9452.338336316392, 9525.857112143462, 9550.808983820145, 9667.468289243878, 6562.245341785756, 6635.0710900473005, 6683.064370987969, 6686.197656281277, 6688.996650502463, 7603.7338693145475, 7633.1985141559335, 7636.045494313211, 7656.73201437947, 7683.039620047494, 6571.5399922005, 6596.472282217315, 6640.701168447335, 6707.698153583198, 6782.152230971129, 6804.319568043354, 6850.280720524473, 6853.143357080365, 6855.143107111611, 6872.037914692047, 6401.7119229633845, 6525.738970441129, 6530.510211734234, 6530.608163510205, 6537.1174891389055, 4444.511103778517, 4659.044895796286, 4688.92966605508, 4692.671512994058, 4713.2223183175765, 4541.250693635513, 4562.749048802348, 4629.467611224618, 4690.085433340466, 4859.805607775649], "value": 4171.930105648095, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.844264547885, 282.6763999920652, 290.17011347546014, 296.19435136428905, 301.19730917105915, 4580.29005504147, 4727.267273572593, 4782.0, 4783.30642056902, 4808.326834243208, 4754.548317909793, 4756.334113224151, 4762.880927976802, 4776.90446191076, 4777.04459108178, 3569.375933950053, 3651.726120540957, 3658.213484100918, 3668.926621467569, 3706.0734816295926, 3462.117160124165, 3585.7310701697347, 3644.362236608583, 3673.4306182541613, 3700.1859590889962, 3634.5638523377233, 3639.4168536686625, 3644.107193737538, 3644.4533320001947, 3648.2885837261742, 3643.180284435981, 3643.908902277438, 3645.908852278701, 3656.1590834108306, 3681.6069554789333, 3199.104250809777, 3208.9037328879936, 3214.0, 3218.855151518187, 3231.2406584452633, 4486.0, 4573.0, 4579.3131030345385, 4579.381783459257, 4597.195490789132, 4118.75287482749, 4121.237571049365, 4123.505179378494, 4133.0574629923885, 4144.937825932613, 4885.5358740919555, 4893.510648935114, 4898.044881248158, 4901.779419926076, 4968.279599458095, 3264.0, 3448.793072415638, 3467.6532346765375, 3482.8432720527635, 3490.5985811631735, 5120.667156634807, 5130.4356520782685, 5137.919142747156, 5152.562032227265, 5164.2770012198325, 3506.7720598161036, 3511.3504001759757, 3518.1028837646236, 3525.2244506208594, 3529.347070791912, 3560.1099725068734, 3571.8928432147077, 3584.301061293075, 3593.1017245688577, 3597.838097285576, 4037.37420699792, 4084.509858816961, 4103.871435355301, 4135.841964250015, 4142.834286628561, 4891.315215869781, 4902.460729319772, 4912.803487860517, 4915.16442204826, 4923.77842997066, 1224.706070543081, 1237.7648246833073, 1246.052999720219, 1246.2086575024925, 1247.494764620312, 746.914104877946, 791.5567282321919, 797.4617133434908, 808.458332916947, 814.6049166154411, 3941.842326306973, 3959.7228194026143, 3981.442598036277, 3988.641022308006, 3995.180987897474, 4477.6417886569, 4531.844379683225, 4556.2937744649635, 4558.452985641744, 4569.200389931749, 3919.862804801818, 3952.7430717003876, 3955.7626542407547, 3978.5026871641044, 4012.398140278923, 2299.9080036798673, 2409.8554086754853, 2415.6955244167953, 2425.721042080148, 2445.4131008558174, 4325.858699943548, 4338.240807858612, 4352.303631418958, 4378.452693413324, 4386.649068074546, 4670.392848929618, 4677.906441871211, 4709.67032307742, 4717.5046620104395, 4742.33607294979, 4039.434479172918, 4309.827606895752, 4368.759718215529, 4406.845760398371, 4427.760227136342, 4491.550844915482, 4505.43682039745, 4530.501644819134, 4536.591706746409, 4553.817847286072, 4498.100379924093, 4532.4901722786035, 4559.863204103882, 4721.220998535203, 4759.619230461624, 4740.146773580651, 4796.561031690409, 4828.203346447796, 4853.126437241189, 4864.683795553277, 3533.858645654145, 3543.911402214965, 3545.6808887200277, 3558.6619271169197, 3568.4825700273836, 4791.760411979457, 5115.848933989822, 5117.9508200818, 5119.360079990001, 5124.743762811919, 4929.753512324298, 4934.284528743384, 4935.876603084952, 4953.414907229652, 4953.801847926043, 4917.409910810726, 4924.581410579997, 4955.380577427822, 5009.323741294878, 5042.218456139304, 4823.011282687111, 4840.201366774443, 4908.092002979461, 4924.975375123101, 4958.983408401341, 4949.57928576075, 4955.801767929387, 4965.255211718271, 4995.775190116381, 5007.3240112584335, 4883.487233840396, 4896.290037944407, 4904.6321525886415, 4948.8762780930765, 4950.4406112074585], "value": 3612.221332286553, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.7758629307157, 643.8937575300075, 656.2289310060678, 721.5273995532924, 742.7957311739273, 12218.144729868913, 13234.139780914235, 13297.800532992012, 13307.06850520464, 13354.999999999987, 12289.20120192187, 12430.751384972295, 12450.564230251943, 12495.750084998295, 12519.061070419732, 621.2762132116079, 635.6916895305797, 737.0639288104104, 748.1097493982171, 752.4131177681418, 760.8744557148063, 777.215012837033, 777.2887807655987, 777.5490215674895, 778.0740918307197, 794.7099308752292, 795.5346122518333, 796.3271035974622, 796.5539297993142, 796.6494742313392, 640.078287266335, 767.9923200768033, 794.2057942057942, 795.8487887301394, 796.8725003999361, 585.4906231578511, 585.7071464267866, 585.759838466231, 585.8125399872042, 586.2378907420336, 13100.213987160801, 13123.60629181126, 13134.211947283098, 13169.078164528486, 13174.868251317555, 12161.270323780602, 12247.571335003322, 12761.234325940473, 12859.292738899358, 12925.836674699322, 10719.142468602493, 10830.891691083067, 10892.074173695246, 11003.779924401468, 11206.0, 4079.571644977294, 4142.2958097123565, 4169.207850508424, 4277.123189746095, 4284.742915425085, 59687.40312596905, 60214.69892650552, 60267.69866150685, 60718.0, 63951.360486395, 10219.131373833308, 10231.94884025575, 10262.743431414125, 10309.53607087683, 10407.0, 19176.0, 19282.0, 19315.51711207231, 19317.61364772697, 19318.0, 6450.3549645036055, 6464.127342808754, 6504.414602685781, 6507.837304067436, 6521.02184672303, 3653.6529029742132, 3689.594144644087, 3694.150345420568, 3704.685101766326, 3715.7956312402534, 2685.9328516786845, 2749.257700420875, 2775.5697866830674, 2775.736305051017, 2782.38787466757, 477.3245857112217, 489.24167540313084, 489.307629703972, 497.9502049794992, 503.0191127301776, 524.4388504300438, 524.9947500524946, 542.6391449685915, 545.1876703711441, 564.2354609504063, 7066.893996590055, 7101.467389945775, 7164.892526612105, 7366.447516436288, 7549.849003019909, 458.6949678463851, 505.6409948936296, 513.2096571280186, 514.2055524215097, 538.3620409814382, 3400.1499625093725, 3406.540117084162, 3412.215190506148, 3456.861725531001, 3471.7396195285455, 90976.54511727531, 93621.0, 94096.05903940873, 96401.51799240959, 99931.50034249782, 80456.5977170122, 84631.57684211539, 84909.57545212234, 87359.56320218358, 92137.0, 73855.26144738591, 76379.61810190913, 76501.61749191218, 76909.23090769132, 78152.6092369546, 6443.96778016107, 6471.0, 6492.253390859923, 6617.43751781104, 6701.0953521274005, 32923.17692057718, 40257.18842652146, 44190.0, 45375.0, 46778.53221467878, 39960.80019599883, 48187.277190841465, 58783.70608146932, 62677.373226267155, 63042.369576305486, 11199.944000280273, 11201.327920324806, 11368.147388945697, 11399.829002565135, 11483.712907177387, 11407.714807129889, 11442.199046066695, 11644.53421863116, 11758.0, 11894.286342819458, 7810.531368117931, 8316.584170791315, 11240.831387529357, 11300.434978251218, 11409.144314176305, 11180.329180249211, 11208.607698730506, 11401.429928503707, 11539.365334906324, 11761.353125578175, 9014.2788576915, 9216.769580760534, 10757.515911784145, 11052.226344156154, 11702.648920532398, 9193.27856982353, 9415.482148481899, 9629.374090684083, 9835.16401105914, 10226.6420675276, 9063.456192628464, 9410.57652405657, 9443.527823608929, 9466.905330946602, 9617.086376794194], "value": 6290.62421045654, "unit": "score"}], "name": "dromaeo_css", "value": 6246.987332211757, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 114.0, 114.0, 114.0, 115.0, 115.0, 113.0, 116.0, 115.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 124.0, 128.0, 177.0, 124.0, 123.0, 151.0, 121.0, 159.0, 122.0], "value": 137.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 162.0, 160.0, 162.0, 162.0, 160.0, 160.0, 159.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 76.0, 113.0, 75.0, 75.0, 76.0, 77.0, 105.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 123.0, 85.0, 85.0, 85.0, 127.0, 85.0, 85.0, 133.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 118.0, 117.0, 117.0, 117.0, 117.0, 119.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 147.0, 146.0, 147.0, 148.0, 148.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 63.0, 62.0, 62.0, 62.0, 61.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 66.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 81.0, 84.0, 79.0, 79.0, 78.0, 79.0, 80.0, 80.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 129.0, 127.0, 129.0, 127.0, 137.0, 127.0, 126.0, 180.0, 137.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 171.0, 164.0, 165.0, 166.0, 170.0, 163.0, 163.0, 166.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 71.0, 66.0, 72.0, 66.0, 65.0, 66.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1528.7, "alertThreshold": 2.0}]} 09:57:41 INFO - Return code: 0 09:57:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:57:41 INFO - # TBPL SUCCESS # 09:57:41 INFO - Running post-action listener: _resource_record_post_action 09:57:41 INFO - [mozharness: 2016-07-26 16:57:41.073643Z] Finished run-tests step (success) 09:57:41 INFO - Running post-run listener: _resource_record_post_run 09:57:41 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 552960; Write bytes: 298700800; Read time: 76; Write time: 272260 09:57:41 INFO - TinderboxPrint: CPU usage
13.0% 09:57:41 INFO - TinderboxPrint: I/O read bytes / time
552,960 / 76 09:57:41 INFO - TinderboxPrint: I/O write bytes / time
298,700,800 / 272,260 09:57:41 INFO - TinderboxPrint: CPU idle
8,329.6 (87.0%) 09:57:41 INFO - TinderboxPrint: CPU user
1,203.4 (12.6%) 09:57:41 INFO - TinderboxPrint: Swap in / out
0 / 0 09:57:41 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13946880; Read time: 0; Write time: 2252 09:57:41 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 548864; Write bytes: 284753920; Read time: 68; Write time: 270008 09:57:41 INFO - Running post-run listener: _upload_blobber_files 09:57:41 INFO - Blob upload gear active. 09:57:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:57:41 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 09:57:41 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'] 09:57:41 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 09:57:42 INFO - (blobuploader) - INFO - Open directory for files ... 09:57:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:57:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:57:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:57:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:42 INFO - (blobuploader) - INFO - Done attempting. 09:57:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:57:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:57:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:57:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:46 INFO - (blobuploader) - INFO - Done attempting. 09:57:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:57:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:57:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:57:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:57:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:57:47 INFO - (blobuploader) - INFO - Done attempting. 09:57:47 INFO - (blobuploader) - INFO - Iteration through files over. 09:57:47 INFO - Return code: 0 09:57:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:57:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:57:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a289e5ded3bb4d7a861c3c04d4f8deff95813010a953d7f5f7785855998079739a8bbb3181dbed9bfe1b3048ec3c5cc5688d397caeec4f81ae30ab50b099d55b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9307af9a624b0451011d8db7d5e3aab9c04963049467abfac5c7ca5317dfa50aaf64cb16e6ceac93e919b8be2779c7ade7f1264fa16a0135033ecce3eeb76cb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/719ef63f20706af6354c2154333899d9b1e7982ead3c70460c70ef49830183bb578e04eaecd5fcd9f9d96afaea0f1f523d816fda35fb6f973a2086b8bbddcff5"} 09:57:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:57:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:57:47 INFO - Contents: 09:57:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a289e5ded3bb4d7a861c3c04d4f8deff95813010a953d7f5f7785855998079739a8bbb3181dbed9bfe1b3048ec3c5cc5688d397caeec4f81ae30ab50b099d55b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9307af9a624b0451011d8db7d5e3aab9c04963049467abfac5c7ca5317dfa50aaf64cb16e6ceac93e919b8be2779c7ade7f1264fa16a0135033ecce3eeb76cb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/719ef63f20706af6354c2154333899d9b1e7982ead3c70460c70ef49830183bb578e04eaecd5fcd9f9d96afaea0f1f523d816fda35fb6f973a2086b8bbddcff5"} 09:57:47 INFO - Running post-run listener: copy_logs_to_upload_dir 09:57:47 INFO - Copying logs to upload dir... 09:57:47 INFO - mkdir: /builds/slave/test/build/upload/logs 09:57:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.353229 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-07-26 09:57:47.820976) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 09:57:47.824691) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981 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/a289e5ded3bb4d7a861c3c04d4f8deff95813010a953d7f5f7785855998079739a8bbb3181dbed9bfe1b3048ec3c5cc5688d397caeec4f81ae30ab50b099d55b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9307af9a624b0451011d8db7d5e3aab9c04963049467abfac5c7ca5317dfa50aaf64cb16e6ceac93e919b8be2779c7ade7f1264fa16a0135033ecce3eeb76cb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/719ef63f20706af6354c2154333899d9b1e7982ead3c70460c70ef49830183bb578e04eaecd5fcd9f9d96afaea0f1f523d816fda35fb6f973a2086b8bbddcff5"} build_url:https://queue.taskcluster.net/v1/task/do984iaDSVaEOiY6iGC4EQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011199 build_url: 'https://queue.taskcluster.net/v1/task/do984iaDSVaEOiY6iGC4EQ/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/a289e5ded3bb4d7a861c3c04d4f8deff95813010a953d7f5f7785855998079739a8bbb3181dbed9bfe1b3048ec3c5cc5688d397caeec4f81ae30ab50b099d55b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9307af9a624b0451011d8db7d5e3aab9c04963049467abfac5c7ca5317dfa50aaf64cb16e6ceac93e919b8be2779c7ade7f1264fa16a0135033ecce3eeb76cb4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/719ef63f20706af6354c2154333899d9b1e7982ead3c70460c70ef49830183bb578e04eaecd5fcd9f9d96afaea0f1f523d816fda35fb6f973a2086b8bbddcff5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 09:57:47.850827) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 09:57:47.851211) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1469551022.458221-18662981 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 09:57:47.933895) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 09:57:47.934226) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 09:57:47.934563) ========= ========= Total master_lag: 0.19 =========