builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-062 starttime: 1459843666.47 results: success (0) buildid: 20160404235505 builduid: 1c0147a6cabd47fba5304dd16f551aa4 revision: 55fb4cbbdfaecc090c2d7ca13c022f933b445d6d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 01:07:46.474948) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 01:07:46.475393) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 01:07:46.475699) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006348 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 01:07:46.515640) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 01:07:46.515921) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 01:07:46.570505) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:07:46.570757) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:07:46.623326) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 01:07:46.623596) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 01:07:46.623949) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:07:46.624235) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-05 01:07:46-- 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% 229M=0s 2016-04-05 01:07:46 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176411 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:07:46.814059) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:07:46.814366) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013254 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:07:46.863850) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:07:46.864185) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 55fb4cbbdfaecc090c2d7ca13c022f933b445d6d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 55fb4cbbdfaecc090c2d7ca13c022f933b445d6d --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=a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-05 01:07:47,034 truncating revision to first 12 chars 2016-04-05 01:07:47,034 Setting DEBUG logging. 2016-04-05 01:07:47,034 attempt 1/10 2016-04-05 01:07:47,034 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/55fb4cbbdfae?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 01:07:47,307 unpacking tar archive at: mozilla-central-55fb4cbbdfae/testing/mozharness/ program finished with exit code 0 elapsedTime=0.560671 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:07:47.437277) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 01:07:47.437626) ========= echo 55fb4cbbdfaecc090c2d7ca13c022f933b445d6d in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'55fb4cbbdfaecc090c2d7ca13c022f933b445d6d'] 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=a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 55fb4cbbdfaecc090c2d7ca13c022f933b445d6d program finished with exit code 0 elapsedTime=0.003778 script_repo_revision: '55fb4cbbdfaecc090c2d7ca13c022f933b445d6d' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 01:07:47.487420) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 01:07:47.487723) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 01:07:47.501662) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2016-04-05 01:07:47.502125) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:07:47 INFO - MultiFileLogger online at 20160405 01:07:47 in /builds/slave/test 01:07:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 01:07:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:07:47 INFO - {'append_to_log': False, 01:07:47 INFO - 'base_work_dir': '/builds/slave/test', 01:07:47 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 01:07:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:07:47 INFO - 'branch': 'Firefox-Non-PGO', 01:07:47 INFO - 'buildbot_json_path': 'buildprops.json', 01:07:47 INFO - 'config_files': ('talos/linux_config.py',), 01:07:47 INFO - 'default_actions': ('clobber', 01:07:47 INFO - 'read-buildbot-config', 01:07:47 INFO - 'download-and-extract', 01:07:47 INFO - 'populate-webroot', 01:07:47 INFO - 'create-virtualenv', 01:07:47 INFO - 'install', 01:07:47 INFO - 'run-tests'), 01:07:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:07:47 INFO - 'download_minidump_stackwalk': True, 01:07:47 INFO - 'download_symbols': 'ondemand', 01:07:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:07:47 INFO - 'tooltool.py': '/tools/tooltool.py', 01:07:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:07:47 INFO - '/tools/misc-python/virtualenv.py')}, 01:07:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:07:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:07:47 INFO - 'installer_path': 'installer.exe', 01:07:47 INFO - 'log_level': 'info', 01:07:47 INFO - 'log_name': 'talos', 01:07:47 INFO - 'log_to_console': True, 01:07:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:07:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:07:47 INFO - 'opt_config_files': (), 01:07:47 INFO - 'pip_index': False, 01:07:47 INFO - 'sps_profile': False, 01:07:47 INFO - 'sps_profile_interval': 0, 01:07:47 INFO - 'suite': 'dromaeojs', 01:07:47 INFO - 'system_bits': '32', 01:07:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:07:47 INFO - 'title': 'talos-linux64-ix-062', 01:07:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:07:47 INFO - 'use_talos_json': True, 01:07:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:07:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:07:47 INFO - 'work_dir': 'build'} 01:07:47 INFO - ##### 01:07:47 INFO - ##### Running clobber step. 01:07:47 INFO - ##### 01:07:47 INFO - Running pre-action listener: _resource_record_pre_action 01:07:47 INFO - Running main action method: clobber 01:07:47 INFO - rmtree: /builds/slave/test/build 01:07:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:07:48 INFO - Running post-action listener: _resource_record_post_action 01:07:48 INFO - ##### 01:07:48 INFO - ##### Running read-buildbot-config step. 01:07:48 INFO - ##### 01:07:48 INFO - Running pre-action listener: _resource_record_pre_action 01:07:48 INFO - Running main action method: read_buildbot_config 01:07:48 INFO - Using buildbot properties: 01:07:48 INFO - { 01:07:48 INFO - "project": "", 01:07:48 INFO - "product": "firefox", 01:07:48 INFO - "script_repo_revision": "production", 01:07:48 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 01:07:48 INFO - "repository": "", 01:07:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 01:07:48 INFO - "buildid": "20160404235505", 01:07:48 INFO - "pgo_build": "False", 01:07:48 INFO - "basedir": "/builds/slave/test", 01:07:48 INFO - "buildnumber": 463, 01:07:48 INFO - "slavename": "talos-linux64-ix-062", 01:07:48 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:07:48 INFO - "platform": "ubuntu64_hw", 01:07:48 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 01:07:48 INFO - "branch": "mozilla-central", 01:07:48 INFO - "repo_path": "mozilla-central", 01:07:48 INFO - "revision": "55fb4cbbdfaecc090c2d7ca13c022f933b445d6d", 01:07:48 INFO - "stage_platform": "linux64", 01:07:48 INFO - "builduid": "1c0147a6cabd47fba5304dd16f551aa4", 01:07:48 INFO - "slavebuilddir": "test" 01:07:48 INFO - } 01:07:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 01:07:48 INFO - Running post-action listener: _resource_record_post_action 01:07:48 INFO - ##### 01:07:48 INFO - ##### Running download-and-extract step. 01:07:48 INFO - ##### 01:07:48 INFO - Running pre-action listener: _resource_record_pre_action 01:07:48 INFO - Running main action method: download_and_extract 01:07:48 INFO - mkdir: /builds/slave/test/build/tests 01:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:48 INFO - https://queue.taskcluster.net/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:07:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:07:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:07:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:07:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:07:49 INFO - Downloaded 1361 bytes. 01:07:49 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 01:07:49 INFO - Using the following test package requirements: 01:07:49 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 01:07:49 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:07:49 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:07:49 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:49 INFO - u'jsshell-linux-x86_64.zip'], 01:07:49 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:07:49 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 01:07:49 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:07:49 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:07:49 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:07:49 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 01:07:49 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:07:49 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:07:49 INFO - https://queue.taskcluster.net/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:07:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:07:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:07:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:07:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:07:52 INFO - Downloaded 22125242 bytes. 01:07:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:07:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:07:53 INFO - Return code: 0 01:07:53 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:07:53 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')]} 01:07:53 INFO - https://queue.taskcluster.net/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:07:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:07:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:07:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 01:07:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:08:38 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip: The read operation timed out 01:08:38 INFO - retry: attempt #1 caught exception: The read operation timed out 01:08:38 INFO - retry: Failed, sleeping 30 seconds before retrying 01:09:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #2 01:09:11 INFO - Downloaded 22125242 bytes. 01:09:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:09:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:09:12 INFO - Return code: 0 01:09:12 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')]} 01:09:12 INFO - https://queue.taskcluster.net/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:09:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:09:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:09:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 01:09:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:09:13 INFO - Downloaded 10847584 bytes. 01:09:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:09:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:09:14 INFO - Return code: 0 01:09: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')]} 01:09:14 INFO - https://queue.taskcluster.net/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:09:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:09:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:09:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:09:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:09:17 INFO - Downloaded 54090750 bytes. 01:09:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:09:17 INFO - mkdir: /builds/slave/test/properties 01:09:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:09:17 INFO - Writing to file /builds/slave/test/properties/build_url 01:09:17 INFO - Contents: 01:09:17 INFO - build_url:https://queue.taskcluster.net/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 01:09:18 INFO - Running post-action listener: _resource_record_post_action 01:09:18 INFO - Running post-action listener: set_extra_try_arguments 01:09:18 INFO - ##### 01:09:18 INFO - ##### Running populate-webroot step. 01:09:18 INFO - ##### 01:09:18 INFO - Running pre-action listener: _resource_record_pre_action 01:09:18 INFO - Running main action method: populate_webroot 01:09:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:09:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:09:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:09:18 INFO - '--tppagecycles', 01:09:18 INFO - '7'], 01:09:18 INFO - 'tests': ['tsvgm']}}, 01:09:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:09:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:09:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:09:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:09:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:09:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:09:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:09:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:18 INFO - 'talos_options': ['--e10s'], 01:09:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:09:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:18 INFO - 'tests': ['damp', 'tps']}, 01:09:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:18 INFO - 'talos_options': ['--e10s'], 01:09:18 INFO - 'tests': ['damp', 'tps']}, 01:09:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:09:18 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 01:09:18 INFO - 'tests': ['dromaeo_dom']}, 01:09:18 INFO - 'other': {'tests': ['a11yr', 01:09:18 INFO - 'ts_paint', 01:09:18 INFO - 'tpaint', 01:09:18 INFO - 'sessionrestore', 01:09:18 INFO - 'sessionrestore_no_auto_restore', 01:09:18 INFO - 'tabpaint']}, 01:09:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:09:18 INFO - 'tests': ['a11yr', 01:09:18 INFO - 'ts_paint', 01:09:18 INFO - 'tpaint', 01:09:18 INFO - 'sessionrestore', 01:09:18 INFO - 'sessionrestore_no_auto_restore', 01:09:18 INFO - 'tabpaint']}, 01:09:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:09:18 INFO - 'tests': ['a11yr', 01:09:18 INFO - 'ts_paint', 01:09:18 INFO - 'tpaint', 01:09:18 INFO - 'sessionrestore', 01:09:18 INFO - 'sessionrestore_no_auto_restore', 01:09:18 INFO - 'tabpaint']}, 01:09:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:09:18 INFO - 'tests': ['a11yr', 01:09:18 INFO - 'ts_paint', 01:09:18 INFO - 'tpaint', 01:09:18 INFO - 'sessionrestore', 01:09:18 INFO - 'sessionrestore_no_auto_restore', 01:09:18 INFO - 'tabpaint']}, 01:09:18 INFO - 'other_l64': {'tests': ['a11yr', 01:09:18 INFO - 'ts_paint', 01:09:18 INFO - 'tpaint', 01:09:18 INFO - 'sessionrestore', 01:09:18 INFO - 'sessionrestore_no_auto_restore', 01:09:18 INFO - 'tabpaint']}, 01:09:18 INFO - 'other_nol64': {'tests': ['a11yr', 01:09:18 INFO - 'ts_paint', 01:09:18 INFO - 'tpaint', 01:09:18 INFO - 'sessionrestore', 01:09:18 INFO - 'sessionrestore_no_auto_restore', 01:09:18 INFO - 'tabpaint']}, 01:09:18 INFO - 'svgr': {'tests': ['tsvgx', 01:09:18 INFO - 'tsvgr_opacity', 01:09:18 INFO - 'tart', 01:09:18 INFO - 'tscrollx', 01:09:18 INFO - 'cart']}, 01:09:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:09:18 INFO - 'tests': ['tsvgx', 01:09:18 INFO - 'tsvgr_opacity', 01:09:18 INFO - 'tart', 01:09:18 INFO - 'tscrollx', 01:09:18 INFO - 'cart']}, 01:09:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:18 INFO - 'tests': ['tp5o']}, 01:09:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:18 INFO - 'talos_options': ['--e10s'], 01:09:18 INFO - 'tests': ['tp5o']}, 01:09:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:18 INFO - 'talos_options': ['--xperf_path', 01:09:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:09:18 INFO - 'tests': ['tp5n']}, 01:09:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:09:18 INFO - 'talos_options': ['--e10s', 01:09:18 INFO - '--xperf_path', 01:09:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:09:18 INFO - 'tests': ['tp5n']}}, 01:09:18 INFO - 'talos.zip': {'path': '', 01:09:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:09:18 INFO - Running post-action listener: _resource_record_post_action 01:09:18 INFO - ##### 01:09:18 INFO - ##### Running create-virtualenv step. 01:09:18 INFO - ##### 01:09:18 INFO - Running pre-action listener: _resource_record_pre_action 01:09:18 INFO - Running main action method: create_virtualenv 01:09:18 INFO - Creating virtualenv /builds/slave/test/build/venv 01:09:18 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 01:09:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:09:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:09:19 INFO - Using real prefix '/usr' 01:09:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:09:19 INFO - Installing distribute.............................................................................................................................................................................................done. 01:09:21 INFO - Installing pip.................done. 01:09:21 INFO - Return code: 0 01:09:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:21 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 0x7f37908ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2170410>, '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 0x2171310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21717a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734', '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 01:09:21 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 01:09:21 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 01:09:21 INFO - Using env: {'DISPLAY': ':0', 01:09:21 INFO - 'HOME': '/home/cltbld', 01:09:21 INFO - 'LANG': 'en_US.UTF-8', 01:09:21 INFO - 'LANGUAGE': 'en_US:en', 01:09:21 INFO - 'LOGNAME': 'cltbld', 01:09:21 INFO - 'MAIL': '/var/mail/cltbld', 01:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:21 INFO - 'MOZ_NO_REMOTE': '1', 01:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:21 INFO - 'NO_EM_RESTART': '1', 01:09:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:21 INFO - 'PWD': '/builds/slave/test', 01:09:21 INFO - 'SHELL': '/bin/bash', 01:09:21 INFO - 'SHLVL': '1', 01:09:21 INFO - 'TERM': 'linux', 01:09:21 INFO - 'TMOUT': '86400', 01:09:21 INFO - 'USER': 'cltbld', 01:09:21 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734', 01:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:21 INFO - '_': '/tools/buildbot/bin/python'} 01:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:21 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 01:09:21 INFO - Cleaning up... 01:09:21 INFO - Return code: 0 01:09:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:21 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f37908ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2170410>, '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 0x2171310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21717a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734', '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 01:09:21 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>=0.7.1'] in /builds/slave/test/build 01:09:21 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>=0.7.1 01:09:21 INFO - Using env: {'DISPLAY': ':0', 01:09:21 INFO - 'HOME': '/home/cltbld', 01:09:21 INFO - 'LANG': 'en_US.UTF-8', 01:09:21 INFO - 'LANGUAGE': 'en_US:en', 01:09:21 INFO - 'LOGNAME': 'cltbld', 01:09:21 INFO - 'MAIL': '/var/mail/cltbld', 01:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:21 INFO - 'MOZ_NO_REMOTE': '1', 01:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:21 INFO - 'NO_EM_RESTART': '1', 01:09:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:21 INFO - 'PWD': '/builds/slave/test', 01:09:21 INFO - 'SHELL': '/bin/bash', 01:09:21 INFO - 'SHLVL': '1', 01:09:21 INFO - 'TERM': 'linux', 01:09:21 INFO - 'TMOUT': '86400', 01:09:21 INFO - 'USER': 'cltbld', 01:09:21 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734', 01:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:21 INFO - '_': '/tools/buildbot/bin/python'} 01:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:21 INFO - Downloading/unpacking psutil>=0.7.1 01:09:21 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 01:09:21 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 01:09:21 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 01:09:21 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 01:09:21 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 01:09:21 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 01:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:09:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:09:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:09:24 INFO - Installing collected packages: psutil 01:09:24 INFO - Running setup.py install for psutil 01:09:24 INFO - building 'psutil._psutil_linux' extension 01:09:24 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 01:09:24 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 01:09:24 INFO - building 'psutil._psutil_posix' extension 01:09:24 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 01:09:24 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 01:09:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:09:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:09:24 INFO - Successfully installed psutil 01:09:24 INFO - Cleaning up... 01:09:25 INFO - Return code: 0 01:09:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:09:25 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')]} 01:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:25 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')]} 01:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:25 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f37908ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2170410>, '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 0x2171310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21717a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734', '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 01:09:25 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.0.0'] in /builds/slave/test/build 01:09:25 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.0.0 01:09:25 INFO - Using env: {'DISPLAY': ':0', 01:09:25 INFO - 'HOME': '/home/cltbld', 01:09:25 INFO - 'LANG': 'en_US.UTF-8', 01:09:25 INFO - 'LANGUAGE': 'en_US:en', 01:09:25 INFO - 'LOGNAME': 'cltbld', 01:09:25 INFO - 'MAIL': '/var/mail/cltbld', 01:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:25 INFO - 'MOZ_NO_REMOTE': '1', 01:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:25 INFO - 'NO_EM_RESTART': '1', 01:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:25 INFO - 'PWD': '/builds/slave/test', 01:09:25 INFO - 'SHELL': '/bin/bash', 01:09:25 INFO - 'SHLVL': '1', 01:09:25 INFO - 'TERM': 'linux', 01:09:25 INFO - 'TMOUT': '86400', 01:09:25 INFO - 'USER': 'cltbld', 01:09:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734', 01:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:25 INFO - '_': '/tools/buildbot/bin/python'} 01:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:09:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:09:27 INFO - Installing collected packages: mozsystemmonitor 01:09:27 INFO - Running setup.py install for mozsystemmonitor 01:09:27 INFO - Successfully installed mozsystemmonitor 01:09:27 INFO - Cleaning up... 01:09:27 INFO - Return code: 0 01:09:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:27 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 0x7f37908ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2170410>, '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 0x2171310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21717a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734', '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 01:09:27 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 01:09:27 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 01:09:27 INFO - Using env: {'DISPLAY': ':0', 01:09:27 INFO - 'HOME': '/home/cltbld', 01:09:27 INFO - 'LANG': 'en_US.UTF-8', 01:09:27 INFO - 'LANGUAGE': 'en_US:en', 01:09:27 INFO - 'LOGNAME': 'cltbld', 01:09:27 INFO - 'MAIL': '/var/mail/cltbld', 01:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:27 INFO - 'MOZ_NO_REMOTE': '1', 01:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:27 INFO - 'NO_EM_RESTART': '1', 01:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:27 INFO - 'PWD': '/builds/slave/test', 01:09:27 INFO - 'SHELL': '/bin/bash', 01:09:27 INFO - 'SHLVL': '1', 01:09:27 INFO - 'TERM': 'linux', 01:09:27 INFO - 'TMOUT': '86400', 01:09:27 INFO - 'USER': 'cltbld', 01:09:27 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734', 01:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:27 INFO - '_': '/tools/buildbot/bin/python'} 01:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:28 INFO - Downloading/unpacking blobuploader==1.2.4 01:09: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 01:09: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 01:09: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 01:09: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 01:09: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 01:09: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 01:09:30 INFO - Downloading blobuploader-1.2.4.tar.gz 01:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:09:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:09:30 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 01:09:30 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 01:09:30 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 01:09:30 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 01:09:30 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 01:09:30 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 01:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:09:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:09:30 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 01:09:30 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 01:09:30 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 01:09:30 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 01:09:30 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 01:09:30 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 01:09:31 INFO - Downloading docopt-0.6.1.tar.gz 01:09:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:09:31 INFO - Installing collected packages: blobuploader, requests, docopt 01:09:31 INFO - Running setup.py install for blobuploader 01:09:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:09:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:09:31 INFO - Running setup.py install for requests 01:09:31 INFO - Running setup.py install for docopt 01:09:31 INFO - Successfully installed blobuploader requests docopt 01:09:31 INFO - Cleaning up... 01:09:31 INFO - Return code: 0 01:09:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:31 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 0x7f37908ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2170410>, '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 0x2171310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21717a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734', '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 01:09:31 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 01:09:31 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 01:09:31 INFO - Using env: {'DISPLAY': ':0', 01:09:31 INFO - 'HOME': '/home/cltbld', 01:09:31 INFO - 'LANG': 'en_US.UTF-8', 01:09:31 INFO - 'LANGUAGE': 'en_US:en', 01:09:31 INFO - 'LOGNAME': 'cltbld', 01:09:31 INFO - 'MAIL': '/var/mail/cltbld', 01:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:31 INFO - 'MOZ_NO_REMOTE': '1', 01:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:31 INFO - 'NO_EM_RESTART': '1', 01:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:31 INFO - 'PWD': '/builds/slave/test', 01:09:31 INFO - 'SHELL': '/bin/bash', 01:09:31 INFO - 'SHLVL': '1', 01:09:31 INFO - 'TERM': 'linux', 01:09:31 INFO - 'TMOUT': '86400', 01:09:31 INFO - 'USER': 'cltbld', 01:09:31 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734', 01:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:31 INFO - '_': '/tools/buildbot/bin/python'} 01:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:09:31 INFO - Running setup.py (path:/tmp/pip-1mvBTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:09:32 INFO - Running setup.py (path:/tmp/pip-ZAAzry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:09:32 INFO - Running setup.py (path:/tmp/pip-ao_UpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:09:32 INFO - Running setup.py (path:/tmp/pip-1Hvs_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:09:32 INFO - Running setup.py (path:/tmp/pip-b4wgBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:09:32 INFO - Running setup.py (path:/tmp/pip-JcbFPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:09:32 INFO - Running setup.py (path:/tmp/pip-uGol_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:09:32 INFO - Running setup.py (path:/tmp/pip-gGnqEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:09:32 INFO - Running setup.py (path:/tmp/pip-YymitG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:09:32 INFO - Running setup.py (path:/tmp/pip-TrnHuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:09:32 INFO - Running setup.py (path:/tmp/pip-O43_8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:09:32 INFO - Running setup.py (path:/tmp/pip-aeZdzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:09:32 INFO - Running setup.py (path:/tmp/pip-l41wrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:09:32 INFO - Running setup.py (path:/tmp/pip-fGaUY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:09:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:33 INFO - Running setup.py (path:/tmp/pip-80t7GC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:09:33 INFO - Running setup.py (path:/tmp/pip-Ec6bzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:09:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:09:33 INFO - Running setup.py (path:/tmp/pip-GEWMbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:09:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:09:33 INFO - Running setup.py install for manifestparser 01:09:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:09:33 INFO - Running setup.py install for mozcrash 01:09:33 INFO - Running setup.py install for mozdebug 01:09:33 INFO - Running setup.py install for mozdevice 01:09:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:09:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:09:33 INFO - Running setup.py install for mozfile 01:09:33 INFO - Running setup.py install for mozhttpd 01:09:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:09:33 INFO - Running setup.py install for mozinfo 01:09:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:09:33 INFO - Running setup.py install for mozInstall 01:09:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:09:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:09:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:09:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:09:33 INFO - Running setup.py install for mozleak 01:09:34 INFO - Running setup.py install for mozlog 01:09:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:09:34 INFO - Running setup.py install for moznetwork 01:09:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:09:34 INFO - Running setup.py install for mozprocess 01:09:34 INFO - Running setup.py install for mozprofile 01:09:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:09:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:09:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:09:34 INFO - Running setup.py install for mozrunner 01:09:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:09:34 INFO - Running setup.py install for mozscreenshot 01:09:34 INFO - Running setup.py install for moztest 01:09:34 INFO - Running setup.py install for mozversion 01:09:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:09:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:09:34 INFO - Cleaning up... 01:09:34 INFO - Return code: 0 01:09:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:34 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 0x7f37908ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2170410>, '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 0x2171310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21717a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734', '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 01:09:34 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 01:09:34 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 01:09:34 INFO - Using env: {'DISPLAY': ':0', 01:09:34 INFO - 'HOME': '/home/cltbld', 01:09:34 INFO - 'LANG': 'en_US.UTF-8', 01:09:34 INFO - 'LANGUAGE': 'en_US:en', 01:09:34 INFO - 'LOGNAME': 'cltbld', 01:09:34 INFO - 'MAIL': '/var/mail/cltbld', 01:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:34 INFO - 'MOZ_NO_REMOTE': '1', 01:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:34 INFO - 'NO_EM_RESTART': '1', 01:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:34 INFO - 'PWD': '/builds/slave/test', 01:09:34 INFO - 'SHELL': '/bin/bash', 01:09:34 INFO - 'SHLVL': '1', 01:09:34 INFO - 'TERM': 'linux', 01:09:34 INFO - 'TMOUT': '86400', 01:09:34 INFO - 'USER': 'cltbld', 01:09:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734', 01:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:34 INFO - '_': '/tools/buildbot/bin/python'} 01:09:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:09:35 INFO - Running setup.py (path:/tmp/pip-a97Lbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:09:35 INFO - Running setup.py (path:/tmp/pip-19kFf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:09:35 INFO - Running setup.py (path:/tmp/pip-pxrXWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:09:35 INFO - Running setup.py (path:/tmp/pip-ht36Me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:09:35 INFO - Running setup.py (path:/tmp/pip-KBgFo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:09:35 INFO - Running setup.py (path:/tmp/pip-fMSdvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:09:35 INFO - Running setup.py (path:/tmp/pip-U_gceL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:09:35 INFO - Running setup.py (path:/tmp/pip-qfkOYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:09:35 INFO - Running setup.py (path:/tmp/pip-iRjt0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:09:35 INFO - Running setup.py (path:/tmp/pip-Bpcj7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:09:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:09:35 INFO - Running setup.py (path:/tmp/pip-ibJuI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:09:35 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)) 01:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:09:36 INFO - Running setup.py (path:/tmp/pip-Puouys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:09:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 01:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:09:36 INFO - Running setup.py (path:/tmp/pip-9lDWvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:09:36 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)) 01:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:09:36 INFO - Running setup.py (path:/tmp/pip-YxafUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:09:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 01:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:36 INFO - Running setup.py (path:/tmp/pip-QtqywF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:09:36 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)) 01:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:09:36 INFO - Running setup.py (path:/tmp/pip-akj6cB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:09:36 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)) 01:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:09:36 INFO - Running setup.py (path:/tmp/pip-VmRC3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:09:36 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)) 01:09:36 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)) 01:09:36 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)) 01:09:36 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)) 01:09:36 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)) 01:09:36 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)) 01:09:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:09:36 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 01:09:36 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 01:09:36 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 01:09:36 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 01:09:36 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 01:09:36 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 01:09:38 INFO - Downloading blessings-1.6.tar.gz 01:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:09:38 INFO - Installing collected packages: blessings 01:09:38 INFO - Running setup.py install for blessings 01:09:38 INFO - Successfully installed blessings 01:09:38 INFO - Cleaning up... 01:09:38 INFO - Return code: 0 01:09:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:09:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:09:38 INFO - Reading from file tmpfile_stdout 01:09:38 INFO - Current package versions: 01:09:38 INFO - argparse == 1.2.1 01:09:38 INFO - blessings == 1.6 01:09:38 INFO - blobuploader == 1.2.4 01:09:38 INFO - docopt == 0.6.1 01:09:38 INFO - manifestparser == 1.1 01:09:38 INFO - mozInstall == 1.12 01:09:38 INFO - mozcrash == 0.17 01:09:38 INFO - mozdebug == 0.1 01:09:38 INFO - mozdevice == 0.48 01:09:38 INFO - mozfile == 1.2 01:09:38 INFO - mozhttpd == 0.7 01:09:38 INFO - mozinfo == 0.9 01:09:38 INFO - mozleak == 0.1 01:09:38 INFO - mozlog == 3.1 01:09:38 INFO - moznetwork == 0.27 01:09:38 INFO - mozprocess == 0.22 01:09:38 INFO - mozprofile == 0.28 01:09:38 INFO - mozrunner == 6.11 01:09:38 INFO - mozscreenshot == 0.1 01:09:38 INFO - mozsystemmonitor == 0.0 01:09:38 INFO - moztest == 0.7 01:09:38 INFO - mozversion == 1.4 01:09:38 INFO - psutil == 3.1.1 01:09:38 INFO - requests == 1.2.3 01:09:38 INFO - wsgiref == 0.1.2 01:09:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:09:38 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')]} 01:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:38 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')]} 01:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:38 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 0x7f37908ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2170410>, '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 0x2171310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21717a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734', '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 01:09:38 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 01:09:38 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 01:09:38 INFO - Using env: {'DISPLAY': ':0', 01:09:38 INFO - 'HOME': '/home/cltbld', 01:09:38 INFO - 'LANG': 'en_US.UTF-8', 01:09:38 INFO - 'LANGUAGE': 'en_US:en', 01:09:38 INFO - 'LOGNAME': 'cltbld', 01:09:38 INFO - 'MAIL': '/var/mail/cltbld', 01:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:38 INFO - 'MOZ_NO_REMOTE': '1', 01:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:38 INFO - 'NO_EM_RESTART': '1', 01:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:38 INFO - 'PWD': '/builds/slave/test', 01:09:38 INFO - 'SHELL': '/bin/bash', 01:09:38 INFO - 'SHLVL': '1', 01:09:38 INFO - 'TERM': 'linux', 01:09:38 INFO - 'TMOUT': '86400', 01:09:38 INFO - 'USER': 'cltbld', 01:09:38 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734', 01:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:38 INFO - '_': '/tools/buildbot/bin/python'} 01:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:38 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)) 01:09:38 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)) 01:09:38 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)) 01:09:38 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)) 01:09:38 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)) 01:09:38 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)) 01:09:38 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)) 01:09:38 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)) 01:09:38 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)) 01:09:38 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)) 01:09:38 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)) 01:09:38 INFO - Cleaning up... 01:09:39 INFO - Return code: 0 01:09:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f37908ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2170410>, '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 0x2171310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21717a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734', '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 01:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:09:39 INFO - Using env: {'DISPLAY': ':0', 01:09:39 INFO - 'HOME': '/home/cltbld', 01:09:39 INFO - 'LANG': 'en_US.UTF-8', 01:09:39 INFO - 'LANGUAGE': 'en_US:en', 01:09:39 INFO - 'LOGNAME': 'cltbld', 01:09:39 INFO - 'MAIL': '/var/mail/cltbld', 01:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:39 INFO - 'MOZ_NO_REMOTE': '1', 01:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:39 INFO - 'NO_EM_RESTART': '1', 01:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:39 INFO - 'PWD': '/builds/slave/test', 01:09:39 INFO - 'SHELL': '/bin/bash', 01:09:39 INFO - 'SHLVL': '1', 01:09:39 INFO - 'TERM': 'linux', 01:09:39 INFO - 'TMOUT': '86400', 01:09:39 INFO - 'USER': 'cltbld', 01:09:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734', 01:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:39 INFO - '_': '/tools/buildbot/bin/python'} 01:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:39 INFO - Downloading/unpacking jsonschema 01:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:09:41 INFO - Downloading/unpacking functools32 (from jsonschema) 01:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:41 INFO - Downloading functools32-3.2.3-2.tar.gz 01:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:09:41 INFO - warning: no files found matching '*.txt' 01:09:41 INFO - no previously-included directories found matching 'build' 01:09:41 INFO - no previously-included directories found matching 'dist' 01:09:41 INFO - no previously-included directories found matching '.git*' 01:09:41 INFO - Installing collected packages: jsonschema, functools32 01:09:41 INFO - Running setup.py install for functools32 01:09:41 INFO - warning: no files found matching '*.txt' 01:09:41 INFO - no previously-included directories found matching 'build' 01:09:41 INFO - no previously-included directories found matching 'dist' 01:09:41 INFO - no previously-included directories found matching '.git*' 01:09:41 INFO - Successfully installed jsonschema functools32 01:09:41 INFO - Cleaning up... 01:09:41 INFO - Return code: 0 01:09:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:09:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f37908ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e15a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2170410>, '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 0x2171310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21717a0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734', '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 01:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:09:41 INFO - Using env: {'DISPLAY': ':0', 01:09:41 INFO - 'HOME': '/home/cltbld', 01:09:41 INFO - 'LANG': 'en_US.UTF-8', 01:09:41 INFO - 'LANGUAGE': 'en_US:en', 01:09:41 INFO - 'LOGNAME': 'cltbld', 01:09:41 INFO - 'MAIL': '/var/mail/cltbld', 01:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:09:41 INFO - 'MOZ_NO_REMOTE': '1', 01:09:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:09:41 INFO - 'NO_EM_RESTART': '1', 01:09:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:09:41 INFO - 'PWD': '/builds/slave/test', 01:09:41 INFO - 'SHELL': '/bin/bash', 01:09:41 INFO - 'SHLVL': '1', 01:09:41 INFO - 'TERM': 'linux', 01:09:41 INFO - 'TMOUT': '86400', 01:09:41 INFO - 'USER': 'cltbld', 01:09:41 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734', 01:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:09:41 INFO - '_': '/tools/buildbot/bin/python'} 01:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:09:41 INFO - Downloading/unpacking flake8 01:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:09:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:09:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:09:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:09:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:09:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:09:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:09:44 INFO - no previously-included directories found matching 'docs/_build' 01:09:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:09:44 INFO - Running setup.py install for pep8 01:09:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:09:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:09:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:09:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:09:44 INFO - no previously-included directories found matching 'docs/_build' 01:09:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:09:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:09:44 INFO - Cleaning up... 01:09:44 INFO - Return code: 0 01:09:44 INFO - Running post-action listener: _resource_record_post_action 01:09:44 INFO - Running post-action listener: _start_resource_monitoring 01:09:44 INFO - Starting resource monitoring. 01:09:44 INFO - ##### 01:09:44 INFO - ##### Running install step. 01:09:44 INFO - ##### 01:09:44 INFO - Running pre-action listener: _resource_record_pre_action 01:09:44 INFO - Running main action method: install 01:09:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:09:44 INFO - Reading from file tmpfile_stdout 01:09:44 INFO - Detecting whether we're running mozinstall >=1.0... 01:09:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:09:44 INFO - Reading from file tmpfile_stdout 01:09:44 INFO - Output received: 01:09:44 INFO - Usage: mozinstall [options] installer 01:09:44 INFO - Options: 01:09:44 INFO - -h, --help show this help message and exit 01:09:44 INFO - -d DEST, --destination=DEST 01:09:44 INFO - Directory to install application into. [default: 01:09:44 INFO - "/builds/slave/test"] 01:09:44 INFO - --app=APP Application being installed. [default: firefox] 01:09:44 INFO - mkdir: /builds/slave/test/build/application 01:09:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:10:00 INFO - Reading from file tmpfile_stdout 01:10:00 INFO - Output received: 01:10:00 INFO - /builds/slave/test/build/application/firefox/firefox 01:10:00 INFO - Running post-action listener: _resource_record_post_action 01:10:00 INFO - ##### 01:10:00 INFO - ##### Running run-tests step. 01:10:00 INFO - ##### 01:10:00 INFO - Running pre-action listener: _resource_record_pre_action 01:10:00 INFO - Running main action method: run_tests 01:10:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:10:00 INFO - Python 2.7.3 01:10:00 INFO - Return code: 0 01:10:00 INFO - grabbing minidump binary from tooltool 01:10:00 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')]} 01:10:00 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2170410>, '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 0x2171310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21717a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:10:00 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 01:10:00 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 01:10:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:10:00 INFO - Return code: 0 01:10:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:10:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:10:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:10:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:10:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:10:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:10:01 INFO - Return code: 0 01:10:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 01:10:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 01:10:01 INFO - Using env: {'DISPLAY': ':0', 01:10:01 INFO - 'HOME': '/home/cltbld', 01:10:01 INFO - 'LANG': 'en_US.UTF-8', 01:10:01 INFO - 'LANGUAGE': 'en_US:en', 01:10:01 INFO - 'LOGNAME': 'cltbld', 01:10:01 INFO - 'MAIL': '/var/mail/cltbld', 01:10:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:10:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:01 INFO - 'MOZ_NO_REMOTE': '1', 01:10:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:10:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:10:01 INFO - 'NO_EM_RESTART': '1', 01:10:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:01 INFO - 'PWD': '/builds/slave/test', 01:10:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:10:01 INFO - 'SHELL': '/bin/bash', 01:10:01 INFO - 'SHLVL': '1', 01:10:01 INFO - 'TERM': 'linux', 01:10:01 INFO - 'TMOUT': '86400', 01:10:01 INFO - 'USER': 'cltbld', 01:10:01 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734', 01:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:01 INFO - '_': '/tools/buildbot/bin/python'} 01:10:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 01:10:01 INFO - mozversion application_buildid: 20160404235505 01:10:01 INFO - mozversion application_changeset: 55fb4cbbdfaecc090c2d7ca13c022f933b445d6d 01:10:01 INFO - mozversion application_display_name: Nightly 01:10:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:10:01 INFO - mozversion application_name: Firefox 01:10:01 INFO - mozversion application_remotingname: firefox 01:10:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:10:01 INFO - mozversion application_vendor: Mozilla 01:10:01 INFO - mozversion application_version: 48.0a1 01:10:01 INFO - mozversion platform_buildid: 20160404235505 01:10:01 INFO - mozversion platform_changeset: 55fb4cbbdfaecc090c2d7ca13c022f933b445d6d 01:10:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:10:01 INFO - mozversion platform_version: 48.0a1 01:10:01 INFO - using testdate: 1459843801 01:10:01 INFO - actual date: 1459843801 01:10:01 INFO - starting webserver on 'localhost:34892' 01:10:01 INFO - SUITE-START | Running 2 tests 01:10:01 INFO - TEST-START | dromaeo_css 01:10:01 INFO - operating with platform_type : linux_ 01:10:01 INFO - Initialising browser for dromaeo_css test... 01:10:01 INFO - TEST-INFO | started process 4756 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH3S4eC/profile http://localhost:34892/getInfo.html) 01:10:05 INFO - PROCESS | 4756 | __metrics Screen width/height:1600/1200 01:10:05 INFO - PROCESS | 4756 | colorDepth:24 01:10:05 INFO - PROCESS | 4756 | Browser inner width/height: 1024/697 01:10:05 INFO - PROCESS | 4756 | __metrics 01:10:07 ERROR - PROCESS | 4756 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:10:07 INFO - TEST-INFO | 4756: exit 0 01:10:07 INFO - Browser initialized. 01:10:07 INFO - Running cycle 1/1 for dromaeo_css test... 01:10:07 INFO - TEST-INFO | started process 4838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH3S4eC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:10:19 INFO - PROCESS | 4838 | RSS: Main: 154402816 01:10:19 INFO - PROCESS | 4838 | 01:11:11 INFO - PROCESS | 4838 | 1459843871531 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] 01:13:21 INFO - PROCESS | 4838 | Cycle 1(1): loaded http://localhost:34892/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34892/tests/dromaeo/cssquery-ext.html) 01:13:22 INFO - PROCESS | 4838 | RSS: Main: 228388864 01:13:22 INFO - PROCESS | 4838 | 01:16:25 INFO - PROCESS | 4838 | Cycle 1(1): loaded http://localhost:34892/tests/dromaeo/cssquery-ext.html (next: http://localhost:34892/tests/dromaeo/cssquery-jquery.html) 01:16:25 INFO - PROCESS | 4838 | RSS: Main: 235319296 01:16:25 INFO - PROCESS | 4838 | 01:19:27 INFO - PROCESS | 4838 | Cycle 1(1): loaded http://localhost:34892/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34892/tests/dromaeo/cssquery-mootools.html) 01:19:28 INFO - PROCESS | 4838 | RSS: Main: 228847616 01:19:28 INFO - PROCESS | 4838 | 01:22:30 INFO - PROCESS | 4838 | Cycle 1(1): loaded http://localhost:34892/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34892/tests/dromaeo/cssquery-prototype.html) 01:22:30 INFO - PROCESS | 4838 | RSS: Main: 216113152 01:22:30 INFO - PROCESS | 4838 | 01:25:33 INFO - PROCESS | 4838 | Cycle 1(1): loaded http://localhost:34892/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34892/tests/dromaeo/cssquery-yui.html) 01:25:34 INFO - PROCESS | 4838 | RSS: Main: 197722112 01:25:34 INFO - PROCESS | 4838 | 01:28:36 INFO - PROCESS | 4838 | Cycle 1(1): loaded http://localhost:34892/tests/dromaeo/cssquery-yui.html (next: http://localhost:34892/tests/dromaeo/cssquery-dojo.html) 01:28:36 INFO - PROCESS | 4838 | RSS: Main: 300085248 01:28:36 INFO - PROCESS | 4838 | 01:28:36 INFO - PROCESS | 4838 | __start_tp_report 01:28:36 INFO - PROCESS | 4838 | _x_x_mozilla_page_load 01:28:36 INFO - PROCESS | 4838 | _x_x_mozilla_page_load_details 01:28:36 INFO - PROCESS | 4838 | |i|pagename|runs| 01:28:36 INFO - PROCESS | 4838 | |0;dojo.html;2597.0780372967597;2639.1158961747815;2667.4665066986595;2674.211107723222;2677.290518012726;4455.841481214883;4543.681942264043;4602.4707158676765;4641.535846415361;4698.107359601673;4526.411566496351;4599.885002874921;4665.440147182335;4674.719516828993;4674.929876051853;4195.538490766014;4209.557996410379;4211.452511173543;4259;4355.869323920271;4308.138372325532;4311.116221174651;4314.288142456491;4347.456567929009;4366.628836548881;4153.314703073989;4228.9154216915795;4231.87304380869;4254.829806807724;4265.7440553566885;4146.212219678282;4149.83400663973;4150.792460376999;4156.334986402161;4161.4382058422025;4110.383442483651;4129.463169787939;4131.132462182945;4132.2561938850995;4135.8966025849295;4405.251107311765;4414.4040554525045;4484.686071974963;4523.185826551219;4548.295014272793;4839.927401088987;4842.757862106881;4844.612431005511;4868.683535570177;4885.951140488585;4826.203676393391;4850.393700787402;4880.072786170652;4880.194767863299;4915.041566894457;4587.42657167854;4645.790939407735;4648.2562789953445;4669.32294817253;4693.037927224911;4931.630127740434;4975.950240497548;4991.5258050485145;4998.975005124951;5049.697018178921;4577.885552861205;4789.30555069513;4795.832145874878;4812.109759694467;4857.392825896763;4887.657863949489;4901.632377571696;4923.040007198562;4945.901081978341;4956.182229932093;4851.054044461367;4875.658703890765;4880;4886.193778026657;4911.901761964741;4756.9524304756505;4855.902881942341;4863.9513604864205;4865.829695960695;4916.778744956486;4116.0327323079055;4140.109876376593;4164.541900390955;4178.12259425518;4178.185253875465;3620.728445366608;3644.0707619556842;3651.774397972123;3666.395044817575;3671.1005803578296;4121.608447197512;4198.87403377893;4237.809298581571;4239.915201695949;4286.871393858127;4893.363862697826;4932.778024988884;4943.975280123648;4970.826021089317;4986.650934434555;4188.225178342016;4228.429162063144;4242.384854196124;4243.787810609457;4278.187144442546;4307.3754305626135;4399.054203346296;4402.3836662867225;4404.66964977628;4428.490723566831;4656.278276867091;4668.183067963025;4685.5782979532005;4698.95301046992;4728.550787675165;4929.285253638274;4929.6549241554185;4935.358403407534;4937.987712518997;4978.751062446936;4510.391097201967;4573.634109271184;4644.39622849041;4662;4696.553827386393;4774.737389443614;4801.663883528259;4814.494478079891;4843.539863712942;4852.078105160008;4860.878478038077;4864.537868902448;4870.220764677634;4876.634252431011;4911.042346742351;4648.86053418398;4698;4716.056788642217;4774.665773395829;4807;4708.058388322281;4730.1958667027375;4738.336632871332;4751.501092385388;4802.207635740064;4670.673052886265;4672.065586882705;4678.766061696833;4681.602063824613;4718.032803275251;4684.5549672781035;4743.0988112258565;4783.402074740658;4824;4839.782209800497;4641.883952901205;4655.674102812906;4656.487786343432;4672.065586882569;4705.894114883068 01:28:36 INFO - PROCESS | 4838 | |1;ext.html;517.6997341541904;517.8529557031176;518.0648928683725;525.921111833225;539.2558269587968;26750.5987410189;34083;34445;34447.48328775067;34451;36729.265414691756;37230;37281;37297.62702372976;37306.626933730724;7625.656845441955;7793.649285782153;7794.922050779504;7808.414368922326;7810.9609451952665;7632.771016869503;7757.5345479271145;7761.223877612222;7766.805829854271;7941.483803552751;7907.565083920411;7989.800254993614;7996.480228785111;7997.480163789364;7998.400119990994;7867.6459559319965;7911.446198766089;7924.167962363956;7924.366050715929;7928.841423171504;7809.531428114275;7874.685012599489;7898.210178982114;7942.205779422069;7948.682052717884;35437.64562354369;35744.10639734028;35806.82096589526;35874;35888.64111358879;3252.5771649685626;3264.8857289994976;3368.989303209052;3646.252518233756;3728.5898551159353;28849.278768030967;28864;29033.854830725923;29551.40897182044;30387.240318991982;3502.320635267685;3505.4917037029486;3510.227749895019;3669.5963444021136;3706.22169344438;240032;240417;241835;242484.78757606275;242566;47996.520034799905;54126.18810717842;55046.44953550413;55073;55085.72457137769;59709.402905971256;60682.08976865262;60696.696516517135;60783;60860.39139608636;12999.415026323839;13056.1513501624;13088.60734177957;13090.476380944847;13100.541481048118;10328.535215915303;11166.106711463064;11214.215004949576;11240.606578769868;11287.435628218556;17685.55786105332;17904.9104754478;17923.551911202325;17957.371491997717;18474.168662410222;7206.927930720731;7273.6726847292;7345.88981165283;7424.473375146762;7481.214472480311;837.7151768398774;888.1118881118881;922.6908985489802;940.9811803763887;1039.5529922133403;26015.73984260171;26584.734152658613;26926.461470770475;26933.86533067322;27047.459050819267;970.3062310448064;999.9200063994863;1029.5212726082407;1060.7931453366518;1077.65515035188;13896.305184740924;13961.162330260015;14330.713385732435;14406.927965360106;14434.278286085864;287914;292017;293443;293719;294955;46297.76851115723;46611.53388466072;46666.30000549994;46677.533224668;46784.2982355265;1174.4362705901215;1181.480148734554;1228.0912125027414;1244.9377531123407;1246.6010876519426;24572.6314105285;26157.869210654586;26617.600735988588;26625;26644.467110658064;34939.82530087333;35126.29747404986;35326;35361.46957795584;35400.29199415946;170296;172672;173207.1339643344;179491.10254448644;181219;30010;31405;32292.515612266303;32410.51384229191;32435.675643243267;38974;39244;39771.60228397679;39896.80051599723;40179.39730903981;32750;32885.83557082199;33169.336613267114;33392;33465.33069338648;32403.35193296168;32671;32879.506807398386;33321.66678333186;33363.33273334471;33565.32869342648;33897.15257118493;34000;34301.65698342985;34625.13437164091;24771.504569908142;27018.324541885824;27344.863275683496;27601.171964841087;27749.722502774715;22335.44161395978;22456;22756.20353287627;22816.657750134094;22834.771652283263 01:28:36 INFO - PROCESS | 4838 | |2;jquery.html;353.27402188502623;356.1861147278471;358.20835952544877;363.60730411155936;367.3864646041111;15533.301001454933;15912.212615690441;16049.11729854859;16533.66932661346;16548.83451165488;16203.108829014429;16581.253843577037;16586.917065414655;16631.66736665266;16678.249478773454;4860.829870954517;4905.288733133693;5044.772985215655;5046;5068.695878247298;4892.68197567157;4946.530079642428;4973.950260497385;4983.950160498385;4987.027529631723;4904.215325547913;4925.236588328797;4935.9753201234125;4937.901241975158;4940.2342636891335;4880.487548807378;4961.9751901240625;4989.800407983676;5008.924866127011;5015.473375295578;4413.757243351614;4459.955400445986;4460.063386688799;4464.843730469451;4470.977645111753;18969.24123035077;19545.80454195454;19702.80297197024;19754.604907901907;19777.703334449994;1975.3975037613523;1982.831459325959;2205.8235341172667;2587.9870600647064;2603.5834266517268;12450.626481205578;12498.562550310786;12841.486340546368;13045.282509461977;13342.13276137048;1641.8193998660138;1647.3575305630814;1707.3853412771393;1730.2905808618532;1748.8513476354526;58637.41362586362;59032.40967590312;59294.70352648209;59958.700206499125;60044.699776501715;9081.364304498753;9272.30457715674;9456.966752148184;9457.574409151466;9597.184239339595;12581.056420768478;12708.110432269652;12710.682232944066;12713.364331783374;12716.618501444971;7265.963670181615;7299.635018249172;7408.555486670817;7508.361789247866;7548.094228692592;7234.529755565872;7249.528780629243;7281.308275713799;7352.154502232205;7363.447741419415;5674.26234589509;5758.74085666146;5775.191473193756;5787.247657804459;5823.126531020296;1647.8712082223476;1715.9571010724833;1726.8743574130863;1752.1852338662584;1759.1380223690555;398.9301872172416;403.2861834552884;421.3910898751336;845.4631309118754;878.6748902905965;10149.34029288094;10199.38803671782;10288.845667314996;10596.417197054236;10777.515011824487;417.48023710480646;420.34845988717365;423.2508460025737;433.425710933015;435.8104224662282;9229.492377919145;9536.28477864163;9586.568604412818;9682.95158524217;9965.352252103736;375574;409825;412022;415420;416892;50991.490085098674;72304.63847680727;73382.63308683422;73993.63003185057;76060.61969690227;956.6077908057663;960.4285450157146;990.7424069741919;993.1260490768078;998.5855869814092;14871.40514379456;15043.849561504245;15116.168610726516;15322.61693457628;15381.615459613598;33002;33127.503087453224;33350.66649333476;33563.83218083894;34221.14447138841;41654;45372.31941520946;45856;46316.30525542187;46358;7407.925920740724;7556.788364944767;7657.310842024244;7810.843783124192;7846.372290216883;9287;11475;11663.88336116662;11992;12305.815412768636;10258.384496930208;10455.634052808115;10470.162387009173;10498.527566259383;10588.576456941637;10051.648192313527;10110.090091891765;10167.288289819642;10315.17478601725;10475.476226188812;10248.64129755455;10534.578616855546;10870.184736144978;10897.237193396386;10972.23194376386;7446.069241344832;7577.734779282699;7595.848083038419;7647.231320546635;7656.617169141632;7791.727289544839;9059;10252.58989640406;10285.53715082838;10442.843357349493 01:28:36 INFO - PROCESS | 4838 | |3;mootools.html;1391.4851504943172;1411.4495346814745;1516.2721893491123;1695.7965044194698;1749.3789704654848;7193.892091618623;7312.96343518283;7373.041504604401;7373.778786636396;7378.926210737898;6403.071554624588;6984.266652001543;7136.464765142609;7173.784786456415;7254.383377412926;2143.967840482394;2170.8806015669134;2171.0989939175224;2173.0330003148606;2176.1621775616345;2116.8306535477127;2142.3787101740477;2197.2748992832326;2208.4920468292303;2210.5689390568846;1895.7725072991261;1930.4884205685435;1942.8154325339142;2172.0768673313855;2231.241377931503;2133.5519540896353;2140.2616097446357;2148.334016454904;2154.3213887625348;2157;2106.820920221783;2171.0447403142725;2174.1194816099505;2175.8259339252822;2182.650775875868;7156.785296441115;7224.422046236341;7240.167380751228;7242.6378681065735;7243.311885370934;4468.2850743881145;4573.382593349888;4575.908481830378;4592.9665825189395;4603.976980115078;2882.553204253344;2924.400497897947;2983.194537474891;3004.354063876277;3004.6094007779066;913.9588718507683;940.3981451870808;947.0766003146946;1785.1788177438264;1858.6654402207732;9600.567974441166;9674.56464459101;9683.951580242125;9699.70900872975;9717.222622190207;3851.0372406898277;4021.778802165909;4041.2927737645796;4059.0867054913;4078.021274894004;7800.726974555863;7843.72546960865;7866.685332586632;7867.331276841418;7875.251851074138;4500.639948804088;4550.590446859798;4578.748168850745;4584.106099310669;4585.426821647294;4200.075983283673;4202.159568086395;4205.3481710334945;4224.1129362834145;4230.788460576959;3168.1921110116773;3305.0910999475336;3341.0478013766447;3423.6747508987105;3431.7769344992994;1016.1312078173056;1018.7809620931536;1023.3859684189575;1027.2860362048305;1029.5881647341123;944.0842382888587;959.8800149981253;1015.9136473399844;1016.4612755239734;1178.5109179690503;6636.203655561363;6679.532432729759;6724.66376681164;6732;6734.764283250062;599.3048064245454;605.8031139879469;608.7260732670316;621.7077973352517;746.0040845471248;5114.174882502918;5179.974100129475;5327.893442131136;5336.092864213093;5426.8371948841595;8578.227959483676;8849.247813935759;8920.197182253629;8954.2836573074;8994.910050899538;8638.611262493203;8805.635126555266;8840.8673869892;8953.686620968365;8967.820643587092;6817.863642727118;6902.309769023058;6913.89629155563;6928.064711264015;6950.930490695028;6565.179352580927;6654.76708315226;6691.631960242234;6710.396064354231;6838.247792742894;7558.9244107558225;7673.923260767321;7716.691332346868;7741.651625676971;7760.728374506865;7704.614769261627;7842.960785196037;7892.6053697313755;7987.960060199662;8017.759467215993;7047.224805271519;7147.82130446743;7180.210176880643;7194.388476979515;7204.207537171012;6949.2008419030435;6977.2673869243;7013.509054366145;7052.541584796972;7054.858902822018;6232.470240029648;6291.716872740829;6353.523485738496;6425.5502114851515;6550.574212676161;6380.840478988062;6395.5203359747275;6458.903116453163;6459.095726598374;6463.7737679181;6351.237851457855;6610.735570577123;6634.734610615521;6666.766663166766;6677;6060.424259695498;6070.575059745775;6077.665728384804;6078.7264573093435;6130.141780150871;5982.4017598239825;6120.357362477054;6134.938650613437;6138.815835524942;6139 01:28:36 INFO - PROCESS | 4838 | |4;prototype.html;315.3535252731899;316.8289123873109;320.038284953714;320.3864599292357;322.17844496533843;5281.313429254196;5482.5339846113075;5486.835394938148;5519.31008623922;5521.089020311644;5300.946990530094;5398.082326004579;5402.540784033352;5410.188471729242;5417.891642167155;3951.269015232177;4058.6144316289906;4167.583241675823;4187.72779769314;4189.853355132571;4155.39746736723;4172.561881002496;4174.457320548325;4175.290200665879;4176.770277634729;4129.442525259082;4132.855350062749;4135.17296540693;4136.731112477694;4143.02638879863;3914.17802261524;4055.0673345130785;4057.9391309130388;4069.1658210066867;4129.194807012634;3503.386907291214;3584.0860580552053;3589.2821435712963;3598.0285322962914;3603.4594810778594;5131.076406246874;5134.897302053975;5154.252633368178;5166.509181627739;5169.586433085382;4747.240441529373;4750.667453278272;4750.857474275743;4755.667103302771;4760.976195119002;5591.496765291144;5612.971935140298;5620;5633.436656334334;5638.887222255573;3970.8411663533425;3972.8609498667697;3978.104926391539;3978.76127432355;3981.124152686404;5688.800891968803;5832.387599302097;5878.706064696791;5905.143754155666;5912.40875912414;3993.1414745829206;4004.759714417144;4008.7795171265275;4024.1750441159493;4050.1292222172374;4073.1242782801246;4099.754014759124;4105.67154627629;4109.137081212979;4114.629683328515;4725.054989002213;4729.337892695025;4729.55069268419;4730.266808644666;4732.905341893143;5645.745941432645;5649.096144616841;5652.830415087554;5655.066913959233;5659.688717120598;1425.308725268244;1449.1956963885145;1451.905626134319;1452.5206681795194;1455.8180227471566;947.280067148958;951.6193522591019;966.6906589891167;972.1833659725722;974.5858010345717;4753.738544380092;4844;4889.242167464049;4927.039227350632;4928.334674818925;5866.911996320058;5883.676397798162;5890.204822349014;5890.2342695449315;5905.055191169392;4958.082754690322;4965.726885021359;4970.975145124251;4971.254311853251;4972.254161875748;3124.9218769530944;3153.858076386568;3157.463231250647;3159.810411375279;3164.4620414529586;5530.087535556588;5533.750981205855;5544.805931792368;5544.944550554524;5548.944510554843;5803.129530570448;6019.2175017248355;6022.427869352405;6030.758769649253;6056.545759068087;5497.752601132958;5520.420355862577;5522.30971128617;5525.419830917776;5538.501534861882;5852.297724273115;5855.414458554111;5860.677662728591;5864.384239654945;5866.6186697864505;5693.946619875336;5722.256106706268;5736.6558006519745;5750.453706897838;5773.24947756789;5517.531009864207;5529.281193444987;5532.6680399176175;5536.141898005815;5539.7784088636;3902.3561112416132;4032.9395059074723;4038.495188101487;4058.45210896537;4064.1262128642484;5807.593468457168;5812.622179558484;5839.386864379179;5843.912341314799;5851.034579294369;5611.747471363717;5614.831555053355;5617.634853734494;5624.578156638187;5624.915626265528;5529.364123125892;5560.694161821139;5582.469665381782;5586.888262234651;5589.133684278943;5528.032594296063;5532.585056120887;5534.564791491731;5540.861478463071;5550.888982220414;5455.208994695826;5627.43725627434;5630.02948967858;5653.378128405954;5657.236273103078;5489.286392768914;5506.889862202654;5507.476789704971;5511.58663100261;5512.724363781875 01:28:36 INFO - PROCESS | 4838 | |5;yui.html;687.6492988575826;712.33040941515;766.6013672890095;774.4385320642535;794.6543253684644;11808.468618912148;11884.405779711002;11938.224015438991;11960.820587691182;11972.102092343088;11882.702932426671;11893.464794084266;11897.464614092365;11907.880921190785;11949.522019119226;624.8906441372753;794.7019867549669;818;818.5947955761876;818.7011740714626;794.8648729715933;809.2312303311847;809.2352726673296;813.3127507256388;817.8568750468673;668.0346898731311;837.7151768398774;839.3033781960988;844.4595458906305;845.4589062999685;822.3832125905541;838.4382463749272;840.7645859159445;841.5876220651897;842.7935155886786;617.2654541096126;620.6152185644884;621.6083867163703;622.9159063526412;623.8440389902524;11925.463354148997;12021.398930053463;12039.63881083569;12115.091368147336;12156.696082598006;11453.942730286295;11947.462364193632;12247.448864801105;12291.815622765665;12406.503739850485;9919.355241909325;10060.295779295453;10061.446620435872;10204.540795664212;10544.841827372595;3252.1869532616847;3265.314284000339;3278.246003419227;3371.662833716633;3396.3207358528393;43214.78392608048;43615.78192109051;43626;43684.56315436868;44644.77677611591;9853.852192217122;9929.851052234222;9975.551100200508;10043.899561004442;10070.345427547187;16608.418705345495;16687.249073791707;16713.582160446087;16736.748948765777;16813.15934203285;6606;6880;6924.826879328057;7061.046758687614;7229.819254518679;3844.7885366304563;3846.942295865564;3883.1457079442475;3946.506686664167;3962.128331767007;2686.7044625091225;2709.647745793034;2723.4553089382202;2736.2885649730815;2736.521108805951;501.19307914258013;516.4422423782306;517.6402400331733;518.9922151167735;526.4524894110083;497.5522030172801;518.6732358614049;550.529297450682;641.4771960851891;656.2420404432887;7510.037156180688;7594.202608726115;7772.883406748903;7789.922100779033;8020.5588692621295;602.8726281852963;606.7330374635146;611.5718996702326;618.245740196959;627.5513008199068;3679.8344074516713;3722.683571896365;3769.378052621342;3812.1232116612778;3870.825812838429;41715.582844171775;42582.36126458106;51172.48827511752;51249.23126153111;51270.487295127314;44972.77513612411;45536;45898.311525327146;46613;46796.5320346799;40239.39640905389;40537.79731101326;40598.39102413407;40730.38904416436;41311.58688413138;6960.3735663788475;7339.266073392618;7353;7362.263773622595;7487.8876816846705;30074.849625751733;30525;31057.534136988415;31607.367852643278;31617.683823161475;37573.06067348338;37665.2466950665;38064.42903356507;40158.79920600378;40266.396004060545;9319.673811416567;9471.905280947103;9879.753006174904;9972.351797133164;10603.840942385716;10721.892781072089;11019.889801101886;11034.889651103385;11415.143864210051;11706.063514918957;10839.620613278497;11054.944725276322;11083.113350932068;11093.889061109285;11193.832092518456;9137.543122843697;9582.47296398677;9617;11049.28179668319;11586.594469193538;10102.09081182697;10242.334248273839;10434.21743369235;10649.89350106489;10851.511681974172;8632;8763.474191548528;8918.598663060047;9045.502497362708;9290.303227257848;8961.417507861968;9243.630254789734;9350.364530851672;9488.905110949077;9520.52397380142 01:28:36 INFO - PROCESS | 4838 | __end_tp_report 01:28:36 INFO - PROCESS | 4838 | __start_cc_report 01:28:36 INFO - PROCESS | 4838 | _x_x_mozilla_cycle_collect,1006 01:28:36 INFO - PROCESS | 4838 | __end_cc_report 01:28:36 INFO - PROCESS | 4838 | __startTimestamp1459844916897__endTimestamp 01:28:36 INFO - PROCESS | 4838 | 01:28:36 INFO - PROCESS | 4838 | ------- Summary: start ------- 01:28:36 INFO - PROCESS | 4838 | Number of tests: 6 01:28:36 INFO - PROCESS | 4838 | 01:28:36 INFO - PROCESS | 4838 | [#0] dojo.html Cycles:165 Average:4525.72 Median:4670.67 stddev:458.35 (9.8%) stddev-sans-first:434.07 01:28:36 INFO - PROCESS | 4838 | Values: 2597.1 2639.1 2667.5 2674.2 2677.3 4455.8 4543.7 4602.5 4641.5 4698.1 4526.4 4599.9 4665.4 4674.7 4674.9 4195.5 4209.6 4211.5 4259.0 4355.9 4308.1 4311.1 4314.3 4347.5 4366.6 4153.3 4228.9 4231.9 4254.8 4265.7 4146.2 4149.8 4150.8 4156.3 4161.4 4110.4 4129.5 4131.1 4132.3 4135.9 4405.3 4414.4 4484.7 4523.2 4548.3 4839.9 4842.8 4844.6 4868.7 4886.0 4826.2 4850.4 4880.1 4880.2 4915.0 4587.4 4645.8 4648.3 4669.3 4693.0 4931.6 4976.0 4991.5 4999.0 5049.7 4577.9 4789.3 4795.8 4812.1 4857.4 4887.7 4901.6 4923.0 4945.9 4956.2 4851.1 4875.7 4880.0 4886.2 4911.9 4757.0 4855.9 4864.0 4865.8 4916.8 4116.0 4140.1 4164.5 4178.1 4178.2 3620.7 3644.1 3651.8 3666.4 3671.1 4121.6 4198.9 4237.8 4239.9 4286.9 4893.4 4932.8 4944.0 4970.8 4986.7 4188.2 4228.4 4242.4 4243.8 4278.2 4307.4 4399.1 4402.4 4404.7 4428.5 4656.3 4668.2 4685.6 4699.0 4728.6 4929.3 4929.7 4935.4 4938.0 4978.8 4510.4 4573.6 4644.4 4662.0 4696.6 4774.7 4801.7 4814.5 4843.5 4852.1 4860.9 4864.5 4870.2 4876.6 4911.0 4648.9 4698.0 4716.1 4774.7 4807.0 4708.1 4730.2 4738.3 4751.5 4802.2 4670.7 4672.1 4678.8 4681.6 4718.0 4684.6 4743.1 4783.4 4824.0 4839.8 4641.9 4655.7 4656.5 4672.1 4705.9 01:28:36 INFO - PROCESS | 4838 | 01:28:36 INFO - PROCESS | 4838 | [#1] ext.html Cycles:180 Average:39658.93 Median:34041.50 stddev:63043.54 (185.2%) stddev-sans-first:63151.89 01:28:36 INFO - PROCESS | 4838 | Values: 517.7 517.9 518.1 525.9 539.3 26750.6 34083.0 34445.0 34447.5 34451.0 36729.3 37230.0 37281.0 37297.6 37306.6 7625.7 7793.6 7794.9 7808.4 7811.0 7632.8 7757.5 7761.2 7766.8 7941.5 7907.6 7989.8 7996.5 7997.5 7998.4 7867.6 7911.4 7924.2 7924.4 7928.8 7809.5 7874.7 7898.2 7942.2 7948.7 35437.6 35744.1 35806.8 35874.0 35888.6 3252.6 3264.9 3369.0 3646.3 3728.6 28849.3 28864.0 29033.9 29551.4 30387.2 3502.3 3505.5 3510.2 3669.6 3706.2 240032.0 240417.0 241835.0 242484.8 242566.0 47996.5 54126.2 55046.4 55073.0 55085.7 59709.4 60682.1 60696.7 60783.0 60860.4 12999.4 13056.2 13088.6 13090.5 13100.5 10328.5 11166.1 11214.2 11240.6 11287.4 17685.6 17904.9 17923.6 17957.4 18474.2 7206.9 7273.7 7345.9 7424.5 7481.2 837.7 888.1 922.7 941.0 1039.6 26015.7 26584.7 26926.5 26933.9 27047.5 970.3 999.9 1029.5 1060.8 1077.7 13896.3 13961.2 14330.7 14406.9 14434.3 287914.0 292017.0 293443.0 293719.0 294955.0 46297.8 46611.5 46666.3 46677.5 46784.3 1174.4 1181.5 1228.1 1244.9 1246.6 24572.6 26157.9 26617.6 26625.0 26644.5 34939.8 35126.3 35326.0 35361.5 35400.3 170296.0 172672.0 173207.1 179491.1 181219.0 30010.0 31405.0 32292.5 32410.5 32435.7 38974.0 39244.0 39771.6 39896.8 40179.4 32750.0 32885.8 33169.3 33392.0 33465.3 32403.4 32671.0 32879.5 33321.7 33363.3 33565.3 33897.2 34000.0 34301.7 34625.1 24771.5 27018.3 27344.9 27601.2 27749.7 22335.4 22456.0 22756.2 22816.7 22834.8 01:28:36 INFO - PROCESS | 4838 | 01:28:36 INFO - PROCESS | 4838 | [#2] jquery.html Cycles:180 Average:23773.20 Median:418.91 stddev:66635.46 (15906.7%) stddev-sans-first:66799.19 01:28:36 INFO - PROCESS | 4838 | Values: 353.3 356.2 358.2 363.6 367.4 15533.3 15912.2 16049.1 16533.7 16548.8 16203.1 16581.3 16586.9 16631.7 16678.2 4860.8 4905.3 5044.8 5046.0 5068.7 4892.7 4946.5 4974.0 4984.0 4987.0 4904.2 4925.2 4936.0 4937.9 4940.2 4880.5 4962.0 4989.8 5008.9 5015.5 4413.8 4460.0 4460.1 4464.8 4471.0 18969.2 19545.8 19702.8 19754.6 19777.7 1975.4 1982.8 2205.8 2588.0 2603.6 12450.6 12498.6 12841.5 13045.3 13342.1 1641.8 1647.4 1707.4 1730.3 1748.9 58637.4 59032.4 59294.7 59958.7 60044.7 9081.4 9272.3 9457.0 9457.6 9597.2 12581.1 12708.1 12710.7 12713.4 12716.6 7266.0 7299.6 7408.6 7508.4 7548.1 7234.5 7249.5 7281.3 7352.2 7363.4 5674.3 5758.7 5775.2 5787.2 5823.1 1647.9 1716.0 1726.9 1752.2 1759.1 398.9 403.3 421.4 845.5 878.7 10149.3 10199.4 10288.8 10596.4 10777.5 417.5 420.3 423.3 433.4 435.8 9229.5 9536.3 9586.6 9683.0 9965.4 375574.0 409825.0 412022.0 415420.0 416892.0 50991.5 72304.6 73382.6 73993.6 76060.6 956.6 960.4 990.7 993.1 998.6 14871.4 15043.8 15116.2 15322.6 15381.6 33002.0 33127.5 33350.7 33563.8 34221.1 41654.0 45372.3 45856.0 46316.3 46358.0 7407.9 7556.8 7657.3 7810.8 7846.4 9287.0 11475.0 11663.9 11992.0 12305.8 10258.4 10455.6 10470.2 10498.5 10588.6 10051.6 10110.1 10167.3 10315.2 10475.5 10248.6 10534.6 10870.2 10897.2 10972.2 7446.1 7577.7 7595.8 7647.2 7656.6 7791.7 9059.0 10252.6 10285.5 10442.8 01:28:36 INFO - PROCESS | 4838 | 01:28:36 INFO - PROCESS | 4838 | [#3] mootools.html Cycles:180 Average:5097.44 Median:6321.48 stddev:2604.75 (41.2%) stddev-sans-first:2597.16 01:28:36 INFO - PROCESS | 4838 | Values: 1391.5 1411.4 1516.3 1695.8 1749.4 7193.9 7313.0 7373.0 7373.8 7378.9 6403.1 6984.3 7136.5 7173.8 7254.4 2144.0 2170.9 2171.1 2173.0 2176.2 2116.8 2142.4 2197.3 2208.5 2210.6 1895.8 1930.5 1942.8 2172.1 2231.2 2133.6 2140.3 2148.3 2154.3 2157.0 2106.8 2171.0 2174.1 2175.8 2182.7 7156.8 7224.4 7240.2 7242.6 7243.3 4468.3 4573.4 4575.9 4593.0 4604.0 2882.6 2924.4 2983.2 3004.4 3004.6 914.0 940.4 947.1 1785.2 1858.7 9600.6 9674.6 9684.0 9699.7 9717.2 3851.0 4021.8 4041.3 4059.1 4078.0 7800.7 7843.7 7866.7 7867.3 7875.3 4500.6 4550.6 4578.7 4584.1 4585.4 4200.1 4202.2 4205.3 4224.1 4230.8 3168.2 3305.1 3341.0 3423.7 3431.8 1016.1 1018.8 1023.4 1027.3 1029.6 944.1 959.9 1015.9 1016.5 1178.5 6636.2 6679.5 6724.7 6732.0 6734.8 599.3 605.8 608.7 621.7 746.0 5114.2 5180.0 5327.9 5336.1 5426.8 8578.2 8849.2 8920.2 8954.3 8994.9 8638.6 8805.6 8840.9 8953.7 8967.8 6817.9 6902.3 6913.9 6928.1 6950.9 6565.2 6654.8 6691.6 6710.4 6838.2 7558.9 7673.9 7716.7 7741.7 7760.7 7704.6 7843.0 7892.6 7988.0 8017.8 7047.2 7147.8 7180.2 7194.4 7204.2 6949.2 6977.3 7013.5 7052.5 7054.9 6232.5 6291.7 6353.5 6425.6 6550.6 6380.8 6395.5 6458.9 6459.1 6463.8 6351.2 6610.7 6634.7 6666.8 6677.0 6060.4 6070.6 6077.7 6078.7 6130.1 5982.4 6120.4 6134.9 6138.8 6139.0 01:28:36 INFO - PROCESS | 4838 | 01:28:36 INFO - PROCESS | 4838 | [#4] prototype.html Cycles:180 Average:4671.90 Median:5436.55 stddev:1374.51 (25.3%) stddev-sans-first:1338.91 01:28:36 INFO - PROCESS | 4838 | Values: 315.4 316.8 320.0 320.4 322.2 5281.3 5482.5 5486.8 5519.3 5521.1 5300.9 5398.1 5402.5 5410.2 5417.9 3951.3 4058.6 4167.6 4187.7 4189.9 4155.4 4172.6 4174.5 4175.3 4176.8 4129.4 4132.9 4135.2 4136.7 4143.0 3914.2 4055.1 4057.9 4069.2 4129.2 3503.4 3584.1 3589.3 3598.0 3603.5 5131.1 5134.9 5154.3 5166.5 5169.6 4747.2 4750.7 4750.9 4755.7 4761.0 5591.5 5613.0 5620.0 5633.4 5638.9 3970.8 3972.9 3978.1 3978.8 3981.1 5688.8 5832.4 5878.7 5905.1 5912.4 3993.1 4004.8 4008.8 4024.2 4050.1 4073.1 4099.8 4105.7 4109.1 4114.6 4725.1 4729.3 4729.6 4730.3 4732.9 5645.7 5649.1 5652.8 5655.1 5659.7 1425.3 1449.2 1451.9 1452.5 1455.8 947.3 951.6 966.7 972.2 974.6 4753.7 4844.0 4889.2 4927.0 4928.3 5866.9 5883.7 5890.2 5890.2 5905.1 4958.1 4965.7 4971.0 4971.3 4972.3 3124.9 3153.9 3157.5 3159.8 3164.5 5530.1 5533.8 5544.8 5544.9 5548.9 5803.1 6019.2 6022.4 6030.8 6056.5 5497.8 5520.4 5522.3 5525.4 5538.5 5852.3 5855.4 5860.7 5864.4 5866.6 5693.9 5722.3 5736.7 5750.5 5773.2 5517.5 5529.3 5532.7 5536.1 5539.8 3902.4 4032.9 4038.5 4058.5 4064.1 5807.6 5812.6 5839.4 5843.9 5851.0 5611.7 5614.8 5617.6 5624.6 5624.9 5529.4 5560.7 5582.5 5586.9 5589.1 5528.0 5532.6 5534.6 5540.9 5550.9 5455.2 5627.4 5630.0 5653.4 5657.2 5489.3 5506.9 5507.5 5511.6 5512.7 01:28:36 INFO - PROCESS | 4838 | 01:28:36 INFO - PROCESS | 4838 | [#5] yui.html Cycles:180 Average:12373.91 Median:44808.78 stddev:13898.08 (31.0%) stddev-sans-first:13909.36 01:28:36 INFO - PROCESS | 4838 | Values: 687.6 712.3 766.6 774.4 794.7 11808.5 11884.4 11938.2 11960.8 11972.1 11882.7 11893.5 11897.5 11907.9 11949.5 624.9 794.7 818.0 818.6 818.7 794.9 809.2 809.2 813.3 817.9 668.0 837.7 839.3 844.5 845.5 822.4 838.4 840.8 841.6 842.8 617.3 620.6 621.6 622.9 623.8 11925.5 12021.4 12039.6 12115.1 12156.7 11453.9 11947.5 12247.4 12291.8 12406.5 9919.4 10060.3 10061.4 10204.5 10544.8 3252.2 3265.3 3278.2 3371.7 3396.3 43214.8 43615.8 43626.0 43684.6 44644.8 9853.9 9929.9 9975.6 10043.9 10070.3 16608.4 16687.2 16713.6 16736.7 16813.2 6606.0 6880.0 6924.8 7061.0 7229.8 3844.8 3846.9 3883.1 3946.5 3962.1 2686.7 2709.6 2723.5 2736.3 2736.5 501.2 516.4 517.6 519.0 526.5 497.6 518.7 550.5 641.5 656.2 7510.0 7594.2 7772.9 7789.9 8020.6 602.9 606.7 611.6 618.2 627.6 3679.8 3722.7 3769.4 3812.1 3870.8 41715.6 42582.4 51172.5 51249.2 51270.5 44972.8 45536.0 45898.3 46613.0 46796.5 40239.4 40537.8 40598.4 40730.4 41311.6 6960.4 7339.3 7353.0 7362.3 7487.9 30074.8 30525.0 31057.5 31607.4 31617.7 37573.1 37665.2 38064.4 40158.8 40266.4 9319.7 9471.9 9879.8 9972.4 10603.8 10721.9 11019.9 11034.9 11415.1 11706.1 10839.6 11054.9 11083.1 11093.9 11193.8 9137.5 9582.5 9617.0 11049.3 11586.6 10102.1 10242.3 10434.2 10649.9 10851.5 8632.0 8763.5 8918.6 9045.5 9290.3 8961.4 9243.6 9350.4 9488.9 9520.5 01:28:36 INFO - PROCESS | 4838 | -------- Summary: end -------- 01:28:36 INFO - PROCESS | 4838 | 01:28:37 INFO - TEST-INFO | 4838: exit 0 01:28:37 INFO - TEST-OK | dromaeo_css | took 1115732ms 01:28:37 INFO - TEST-START | kraken 01:28:37 INFO - operating with platform_type : linux_ 01:28:37 INFO - Initialising browser for kraken test... 01:28:37 INFO - TEST-INFO | started process 5014 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptcHY5L/profile http://localhost:34892/getInfo.html) 01:28:41 INFO - PROCESS | 5014 | __metrics Screen width/height:1600/1200 01:28:41 INFO - PROCESS | 5014 | colorDepth:24 01:28:41 INFO - PROCESS | 5014 | Browser inner width/height: 1024/697 01:28:41 INFO - PROCESS | 5014 | __metrics 01:28:42 ERROR - PROCESS | 5014 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:28:43 INFO - TEST-INFO | 5014: exit 0 01:28:43 INFO - Browser initialized. 01:28:43 INFO - Running cycle 1/1 for kraken test... 01:28:43 INFO - TEST-INFO | started process 5096 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptcHY5L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:28:55 INFO - PROCESS | 5096 | RSS: Main: 154304512 01:28:55 INFO - PROCESS | 5096 | 01:28:58 INFO - PROCESS | 5096 | Cycle 1(1): loaded http://localhost:34892/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34892/tests/kraken/driver.html?testName=audio-beat-detection) 01:28:58 INFO - PROCESS | 5096 | RSS: Main: 195469312 01:28:58 INFO - PROCESS | 5096 | 01:29:01 INFO - PROCESS | 5096 | Cycle 1(1): loaded http://localhost:34892/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34892/tests/kraken/driver.html?testName=audio-dft) 01:29:02 INFO - PROCESS | 5096 | RSS: Main: 185475072 01:29:02 INFO - PROCESS | 5096 | 01:29:05 INFO - PROCESS | 5096 | Cycle 1(1): loaded http://localhost:34892/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34892/tests/kraken/driver.html?testName=audio-fft) 01:29:05 INFO - PROCESS | 5096 | RSS: Main: 173150208 01:29:05 INFO - PROCESS | 5096 | 01:29:08 INFO - PROCESS | 5096 | Cycle 1(1): loaded http://localhost:34892/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34892/tests/kraken/driver.html?testName=audio-oscillator) 01:29:08 INFO - PROCESS | 5096 | RSS: Main: 173768704 01:29:08 INFO - PROCESS | 5096 | 01:29:10 INFO - PROCESS | 5096 | Cycle 1(1): loaded http://localhost:34892/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34892/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:29:11 INFO - PROCESS | 5096 | RSS: Main: 173756416 01:29:11 INFO - PROCESS | 5096 | 01:29:14 INFO - PROCESS | 5096 | Cycle 1(1): loaded http://localhost:34892/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34892/tests/kraken/driver.html?testName=imaging-darkroom) 01:29:15 INFO - PROCESS | 5096 | RSS: Main: 173326336 01:29:15 INFO - PROCESS | 5096 | 01:29:18 INFO - PROCESS | 5096 | Cycle 1(1): loaded http://localhost:34892/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34892/tests/kraken/driver.html?testName=imaging-desaturate) 01:29:19 INFO - PROCESS | 5096 | RSS: Main: 174727168 01:29:19 INFO - PROCESS | 5096 | 01:29:22 INFO - PROCESS | 5096 | Cycle 1(1): loaded http://localhost:34892/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34892/tests/kraken/driver.html?testName=json-parse-financial) 01:29:22 INFO - PROCESS | 5096 | RSS: Main: 174292992 01:29:22 INFO - PROCESS | 5096 | 01:29:24 INFO - PROCESS | 5096 | Cycle 1(1): loaded http://localhost:34892/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34892/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:29:25 INFO - PROCESS | 5096 | RSS: Main: 185585664 01:29:25 INFO - PROCESS | 5096 | 01:29:26 INFO - PROCESS | 5096 | Cycle 1(1): loaded http://localhost:34892/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34892/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:29:27 INFO - PROCESS | 5096 | RSS: Main: 183316480 01:29:27 INFO - PROCESS | 5096 | 01:29:29 INFO - PROCESS | 5096 | Cycle 1(1): loaded http://localhost:34892/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34892/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:29:30 INFO - PROCESS | 5096 | RSS: Main: 195592192 01:29:30 INFO - PROCESS | 5096 | 01:29:32 INFO - PROCESS | 5096 | Cycle 1(1): loaded http://localhost:34892/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34892/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:29:33 INFO - PROCESS | 5096 | RSS: Main: 199651328 01:29:33 INFO - PROCESS | 5096 | 01:29:35 INFO - PROCESS | 5096 | Cycle 1(1): loaded http://localhost:34892/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34892/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:29:36 INFO - PROCESS | 5096 | RSS: Main: 198512640 01:29:36 INFO - PROCESS | 5096 | 01:29:38 INFO - PROCESS | 5096 | Cycle 1(1): loaded http://localhost:34892/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34892/tests/kraken/driver.html?testName=ai-astar) 01:29:38 INFO - PROCESS | 5096 | RSS: Main: 261296128 01:29:38 INFO - PROCESS | 5096 | 01:29:38 INFO - PROCESS | 5096 | __start_tp_report 01:29:38 INFO - PROCESS | 5096 | _x_x_mozilla_page_load 01:29:38 INFO - PROCESS | 5096 | _x_x_mozilla_page_load_details 01:29:38 INFO - PROCESS | 5096 | |i|pagename|runs| 01:29:38 INFO - PROCESS | 5096 | |0;ai-astar;112;113;108;114;114;114;102;112;112;113 01:29:38 INFO - PROCESS | 5096 | |1;audio-beat-detection;170;132;158;185;133;162;163;133;185;133 01:29:38 INFO - PROCESS | 5096 | |2;audio-dft;162;162;162;162;160;163;164;162;164;162 01:29:38 INFO - PROCESS | 5096 | |3;audio-fft;76;74;77;156;77;74;74;75;168;74 01:29:38 INFO - PROCESS | 5096 | |4;audio-oscillator;96;95;150;94;95;96;135;95;94;135 01:29:38 INFO - PROCESS | 5096 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 01:29:38 INFO - PROCESS | 5096 | |6;imaging-darkroom;146;147;146;146;146;147;146;146;146;145 01:29:38 INFO - PROCESS | 5096 | |7;imaging-desaturate;96;96;96;95;96;97;97;97;96;95 01:29:38 INFO - PROCESS | 5096 | |8;json-parse-financial;67;68;66;67;68;66;65;74;64;64 01:29:38 INFO - PROCESS | 5096 | |9;json-stringify-tinderbox;63;65;64;65;65;65;64;65;64;65 01:29:38 INFO - PROCESS | 5096 | |10;stanford-crypto-aes;81;82;85;82;84;83;82;81;86;83 01:29:38 INFO - PROCESS | 5096 | |11;stanford-crypto-ccm;118;120;118;123;120;120;116;116;116;116 01:29:38 INFO - PROCESS | 5096 | |12;stanford-crypto-pbkdf2;141;141;141;138;141;135;147;137;151;129 01:29:38 INFO - PROCESS | 5096 | |13;stanford-crypto-sha256-iterative;68;67;71;67;72;67;67;70;69;68 01:29:38 INFO - PROCESS | 5096 | __end_tp_report 01:29:38 INFO - PROCESS | 5096 | __start_cc_report 01:29:38 INFO - PROCESS | 5096 | _x_x_mozilla_cycle_collect,1169 01:29:38 INFO - PROCESS | 5096 | __end_cc_report 01:29:38 INFO - PROCESS | 5096 | __startTimestamp1459844978547__endTimestamp 01:29:38 INFO - PROCESS | 5096 | 01:29:38 INFO - PROCESS | 5096 | ------- Summary: start ------- 01:29:38 INFO - PROCESS | 5096 | Number of tests: 14 01:29:38 INFO - PROCESS | 5096 | 01:29:38 INFO - PROCESS | 5096 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.00 stddev:3.75 (3.3%) stddev-sans-first:3.97 01:29:38 INFO - PROCESS | 5096 | Values: 112.0 113.0 108.0 114.0 114.0 114.0 102.0 112.0 112.0 113.0 01:29:38 INFO - PROCESS | 5096 | 01:29:38 INFO - PROCESS | 5096 | [#1] audio-beat-detection Cycles:10 Average:155.40 Median:162.50 stddev:21.41 (13.2%) stddev-sans-first:22.05 01:29:38 INFO - PROCESS | 5096 | Values: 170.0 132.0 158.0 185.0 133.0 162.0 163.0 133.0 185.0 133.0 01:29:38 INFO - PROCESS | 5096 | 01:29:38 INFO - PROCESS | 5096 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 01:29:38 INFO - PROCESS | 5096 | Values: 162.0 162.0 162.0 162.0 160.0 163.0 164.0 162.0 164.0 162.0 01:29:38 INFO - PROCESS | 5096 | 01:29:38 INFO - PROCESS | 5096 | [#3] audio-fft Cycles:10 Average:92.50 Median:74.50 stddev:36.76 (49.3%) stddev-sans-first:38.50 01:29:38 INFO - PROCESS | 5096 | Values: 76.0 74.0 77.0 156.0 77.0 74.0 74.0 75.0 168.0 74.0 01:29:38 INFO - PROCESS | 5096 | 01:29:38 INFO - PROCESS | 5096 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:95.00 stddev:22.13 (23.3%) stddev-sans-first:23.00 01:29:38 INFO - PROCESS | 5096 | Values: 96.0 95.0 150.0 94.0 95.0 96.0 135.0 95.0 94.0 135.0 01:29:38 INFO - PROCESS | 5096 | 01:29:38 INFO - PROCESS | 5096 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:29:38 INFO - PROCESS | 5096 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 01:29:38 INFO - PROCESS | 5096 | 01:29:38 INFO - PROCESS | 5096 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 01:29:38 INFO - PROCESS | 5096 | Values: 146.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 145.0 01:29:38 INFO - PROCESS | 5096 | 01:29:38 INFO - PROCESS | 5096 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 01:29:38 INFO - PROCESS | 5096 | Values: 96.0 96.0 96.0 95.0 96.0 97.0 97.0 97.0 96.0 95.0 01:29:38 INFO - PROCESS | 5096 | 01:29:38 INFO - PROCESS | 5096 | [#8] json-parse-financial Cycles:10 Average:66.90 Median:67.00 stddev:2.88 (4.3%) stddev-sans-first:3.06 01:29:38 INFO - PROCESS | 5096 | Values: 67.0 68.0 66.0 67.0 68.0 66.0 65.0 74.0 64.0 64.0 01:29:38 INFO - PROCESS | 5096 | 01:29:38 INFO - PROCESS | 5096 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.71 (1.1%) stddev-sans-first:0.50 01:29:38 INFO - PROCESS | 5096 | Values: 63.0 65.0 64.0 65.0 65.0 65.0 64.0 65.0 64.0 65.0 01:29:38 INFO - PROCESS | 5096 | 01:29:38 INFO - PROCESS | 5096 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:1.66 (2.0%) stddev-sans-first:1.62 01:29:38 INFO - PROCESS | 5096 | Values: 81.0 82.0 85.0 82.0 84.0 83.0 82.0 81.0 86.0 83.0 01:29:38 INFO - PROCESS | 5096 | 01:29:38 INFO - PROCESS | 5096 | [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:119.00 stddev:2.41 (2.0%) stddev-sans-first:2.55 01:29:38 INFO - PROCESS | 5096 | Values: 118.0 120.0 118.0 123.0 120.0 120.0 116.0 116.0 116.0 116.0 01:29:38 INFO - PROCESS | 5096 | 01:29:38 INFO - PROCESS | 5096 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.10 Median:141.00 stddev:6.08 (4.3%) stddev-sans-first:6.44 01:29:38 INFO - PROCESS | 5096 | Values: 141.0 141.0 141.0 138.0 141.0 135.0 147.0 137.0 151.0 129.0 01:29:38 INFO - PROCESS | 5096 | 01:29:38 INFO - PROCESS | 5096 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:1.84 (2.7%) stddev-sans-first:1.94 01:29:38 INFO - PROCESS | 5096 | Values: 68.0 67.0 71.0 67.0 72.0 67.0 67.0 70.0 69.0 68.0 01:29:38 INFO - PROCESS | 5096 | -------- Summary: end -------- 01:29:38 INFO - PROCESS | 5096 | 01:29:39 INFO - TEST-INFO | 5096: exit 0 01:29:39 INFO - TEST-OK | kraken | took 61751ms 01:29:39 INFO - SUITE-END | took 1177s 01:29:39 INFO - Completed test suite (00:19:37) 01:29:39 INFO - javascript benchmark 01:29:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2597.0780372967597, 2639.1158961747815, 2667.4665066986595, 2674.211107723222, 2677.290518012726, 4455.841481214883, 4543.681942264043, 4602.4707158676765, 4641.535846415361, 4698.107359601673, 4526.411566496351, 4599.885002874921, 4665.440147182335, 4674.719516828993, 4674.929876051853, 4195.538490766014, 4209.557996410379, 4211.452511173543, 4259.0, 4355.869323920271, 4308.138372325532, 4311.116221174651, 4314.288142456491, 4347.456567929009, 4366.628836548881, 4153.314703073989, 4228.9154216915795, 4231.87304380869, 4254.829806807724, 4265.7440553566885, 4146.212219678282, 4149.83400663973, 4150.792460376999, 4156.334986402161, 4161.4382058422025, 4110.383442483651, 4129.463169787939, 4131.132462182945, 4132.2561938850995, 4135.8966025849295, 4405.251107311765, 4414.4040554525045, 4484.686071974963, 4523.185826551219, 4548.295014272793, 4839.927401088987, 4842.757862106881, 4844.612431005511, 4868.683535570177, 4885.951140488585, 4826.203676393391, 4850.393700787402, 4880.072786170652, 4880.194767863299, 4915.041566894457, 4587.42657167854, 4645.790939407735, 4648.2562789953445, 4669.32294817253, 4693.037927224911, 4931.630127740434, 4975.950240497548, 4991.5258050485145, 4998.975005124951, 5049.697018178921, 4577.885552861205, 4789.30555069513, 4795.832145874878, 4812.109759694467, 4857.392825896763, 4887.657863949489, 4901.632377571696, 4923.040007198562, 4945.901081978341, 4956.182229932093, 4851.054044461367, 4875.658703890765, 4880.0, 4886.193778026657, 4911.901761964741, 4756.9524304756505, 4855.902881942341, 4863.9513604864205, 4865.829695960695, 4916.778744956486, 4116.0327323079055, 4140.109876376593, 4164.541900390955, 4178.12259425518, 4178.185253875465, 3620.728445366608, 3644.0707619556842, 3651.774397972123, 3666.395044817575, 3671.1005803578296, 4121.608447197512, 4198.87403377893, 4237.809298581571, 4239.915201695949, 4286.871393858127, 4893.363862697826, 4932.778024988884, 4943.975280123648, 4970.826021089317, 4986.650934434555, 4188.225178342016, 4228.429162063144, 4242.384854196124, 4243.787810609457, 4278.187144442546, 4307.3754305626135, 4399.054203346296, 4402.3836662867225, 4404.66964977628, 4428.490723566831, 4656.278276867091, 4668.183067963025, 4685.5782979532005, 4698.95301046992, 4728.550787675165, 4929.285253638274, 4929.6549241554185, 4935.358403407534, 4937.987712518997, 4978.751062446936, 4510.391097201967, 4573.634109271184, 4644.39622849041, 4662.0, 4696.553827386393, 4774.737389443614, 4801.663883528259, 4814.494478079891, 4843.539863712942, 4852.078105160008, 4860.878478038077, 4864.537868902448, 4870.220764677634, 4876.634252431011, 4911.042346742351, 4648.86053418398, 4698.0, 4716.056788642217, 4774.665773395829, 4807.0, 4708.058388322281, 4730.1958667027375, 4738.336632871332, 4751.501092385388, 4802.207635740064, 4670.673052886265, 4672.065586882705, 4678.766061696833, 4681.602063824613, 4718.032803275251, 4684.5549672781035, 4743.0988112258565, 4783.402074740658, 4824.0, 4839.782209800497, 4641.883952901205, 4655.674102812906, 4656.487786343432, 4672.065586882569, 4705.894114883068], "unit": "score", "name": "dojo.html", "value": 4497.910828985914}, {"lowerIsBetter": false, "replicates": [517.6997341541904, 517.8529557031176, 518.0648928683725, 525.921111833225, 539.2558269587968, 26750.5987410189, 34083.0, 34445.0, 34447.48328775067, 34451.0, 36729.265414691756, 37230.0, 37281.0, 37297.62702372976, 37306.626933730724, 7625.656845441955, 7793.649285782153, 7794.922050779504, 7808.414368922326, 7810.9609451952665, 7632.771016869503, 7757.5345479271145, 7761.223877612222, 7766.805829854271, 7941.483803552751, 7907.565083920411, 7989.800254993614, 7996.480228785111, 7997.480163789364, 7998.400119990994, 7867.6459559319965, 7911.446198766089, 7924.167962363956, 7924.366050715929, 7928.841423171504, 7809.531428114275, 7874.685012599489, 7898.210178982114, 7942.205779422069, 7948.682052717884, 35437.64562354369, 35744.10639734028, 35806.82096589526, 35874.0, 35888.64111358879, 3252.5771649685626, 3264.8857289994976, 3368.989303209052, 3646.252518233756, 3728.5898551159353, 28849.278768030967, 28864.0, 29033.854830725923, 29551.40897182044, 30387.240318991982, 3502.320635267685, 3505.4917037029486, 3510.227749895019, 3669.5963444021136, 3706.22169344438, 240032.0, 240417.0, 241835.0, 242484.78757606275, 242566.0, 47996.520034799905, 54126.18810717842, 55046.44953550413, 55073.0, 55085.72457137769, 59709.402905971256, 60682.08976865262, 60696.696516517135, 60783.0, 60860.39139608636, 12999.415026323839, 13056.1513501624, 13088.60734177957, 13090.476380944847, 13100.541481048118, 10328.535215915303, 11166.106711463064, 11214.215004949576, 11240.606578769868, 11287.435628218556, 17685.55786105332, 17904.9104754478, 17923.551911202325, 17957.371491997717, 18474.168662410222, 7206.927930720731, 7273.6726847292, 7345.88981165283, 7424.473375146762, 7481.214472480311, 837.7151768398774, 888.1118881118881, 922.6908985489802, 940.9811803763887, 1039.5529922133403, 26015.73984260171, 26584.734152658613, 26926.461470770475, 26933.86533067322, 27047.459050819267, 970.3062310448064, 999.9200063994863, 1029.5212726082407, 1060.7931453366518, 1077.65515035188, 13896.305184740924, 13961.162330260015, 14330.713385732435, 14406.927965360106, 14434.278286085864, 287914.0, 292017.0, 293443.0, 293719.0, 294955.0, 46297.76851115723, 46611.53388466072, 46666.30000549994, 46677.533224668, 46784.2982355265, 1174.4362705901215, 1181.480148734554, 1228.0912125027414, 1244.9377531123407, 1246.6010876519426, 24572.6314105285, 26157.869210654586, 26617.600735988588, 26625.0, 26644.467110658064, 34939.82530087333, 35126.29747404986, 35326.0, 35361.46957795584, 35400.29199415946, 170296.0, 172672.0, 173207.1339643344, 179491.10254448644, 181219.0, 30010.0, 31405.0, 32292.515612266303, 32410.51384229191, 32435.675643243267, 38974.0, 39244.0, 39771.60228397679, 39896.80051599723, 40179.39730903981, 32750.0, 32885.83557082199, 33169.336613267114, 33392.0, 33465.33069338648, 32403.35193296168, 32671.0, 32879.506807398386, 33321.66678333186, 33363.33273334471, 33565.32869342648, 33897.15257118493, 34000.0, 34301.65698342985, 34625.13437164091, 24771.504569908142, 27018.324541885824, 27344.863275683496, 27601.171964841087, 27749.722502774715, 22335.44161395978, 22456.0, 22756.20353287627, 22816.657750134094, 22834.771652283263], "unit": "score", "name": "ext.html", "value": 16692.018637089444}, {"lowerIsBetter": false, "replicates": [353.27402188502623, 356.1861147278471, 358.20835952544877, 363.60730411155936, 367.3864646041111, 15533.301001454933, 15912.212615690441, 16049.11729854859, 16533.66932661346, 16548.83451165488, 16203.108829014429, 16581.253843577037, 16586.917065414655, 16631.66736665266, 16678.249478773454, 4860.829870954517, 4905.288733133693, 5044.772985215655, 5046.0, 5068.695878247298, 4892.68197567157, 4946.530079642428, 4973.950260497385, 4983.950160498385, 4987.027529631723, 4904.215325547913, 4925.236588328797, 4935.9753201234125, 4937.901241975158, 4940.2342636891335, 4880.487548807378, 4961.9751901240625, 4989.800407983676, 5008.924866127011, 5015.473375295578, 4413.757243351614, 4459.955400445986, 4460.063386688799, 4464.843730469451, 4470.977645111753, 18969.24123035077, 19545.80454195454, 19702.80297197024, 19754.604907901907, 19777.703334449994, 1975.3975037613523, 1982.831459325959, 2205.8235341172667, 2587.9870600647064, 2603.5834266517268, 12450.626481205578, 12498.562550310786, 12841.486340546368, 13045.282509461977, 13342.13276137048, 1641.8193998660138, 1647.3575305630814, 1707.3853412771393, 1730.2905808618532, 1748.8513476354526, 58637.41362586362, 59032.40967590312, 59294.70352648209, 59958.700206499125, 60044.699776501715, 9081.364304498753, 9272.30457715674, 9456.966752148184, 9457.574409151466, 9597.184239339595, 12581.056420768478, 12708.110432269652, 12710.682232944066, 12713.364331783374, 12716.618501444971, 7265.963670181615, 7299.635018249172, 7408.555486670817, 7508.361789247866, 7548.094228692592, 7234.529755565872, 7249.528780629243, 7281.308275713799, 7352.154502232205, 7363.447741419415, 5674.26234589509, 5758.74085666146, 5775.191473193756, 5787.247657804459, 5823.126531020296, 1647.8712082223476, 1715.9571010724833, 1726.8743574130863, 1752.1852338662584, 1759.1380223690555, 398.9301872172416, 403.2861834552884, 421.3910898751336, 845.4631309118754, 878.6748902905965, 10149.34029288094, 10199.38803671782, 10288.845667314996, 10596.417197054236, 10777.515011824487, 417.48023710480646, 420.34845988717365, 423.2508460025737, 433.425710933015, 435.8104224662282, 9229.492377919145, 9536.28477864163, 9586.568604412818, 9682.95158524217, 9965.352252103736, 375574.0, 409825.0, 412022.0, 415420.0, 416892.0, 50991.490085098674, 72304.63847680727, 73382.63308683422, 73993.63003185057, 76060.61969690227, 956.6077908057663, 960.4285450157146, 990.7424069741919, 993.1260490768078, 998.5855869814092, 14871.40514379456, 15043.849561504245, 15116.168610726516, 15322.61693457628, 15381.615459613598, 33002.0, 33127.503087453224, 33350.66649333476, 33563.83218083894, 34221.14447138841, 41654.0, 45372.31941520946, 45856.0, 46316.30525542187, 46358.0, 7407.925920740724, 7556.788364944767, 7657.310842024244, 7810.843783124192, 7846.372290216883, 9287.0, 11475.0, 11663.88336116662, 11992.0, 12305.815412768636, 10258.384496930208, 10455.634052808115, 10470.162387009173, 10498.527566259383, 10588.576456941637, 10051.648192313527, 10110.090091891765, 10167.288289819642, 10315.17478601725, 10475.476226188812, 10248.64129755455, 10534.578616855546, 10870.184736144978, 10897.237193396386, 10972.23194376386, 7446.069241344832, 7577.734779282699, 7595.848083038419, 7647.231320546635, 7656.617169141632, 7791.727289544839, 9059.0, 10252.58989640406, 10285.53715082838, 10442.843357349493], "unit": "score", "name": "jquery.html", "value": 7760.4539189067345}, {"lowerIsBetter": false, "replicates": [1391.4851504943172, 1411.4495346814745, 1516.2721893491123, 1695.7965044194698, 1749.3789704654848, 7193.892091618623, 7312.96343518283, 7373.041504604401, 7373.778786636396, 7378.926210737898, 6403.071554624588, 6984.266652001543, 7136.464765142609, 7173.784786456415, 7254.383377412926, 2143.967840482394, 2170.8806015669134, 2171.0989939175224, 2173.0330003148606, 2176.1621775616345, 2116.8306535477127, 2142.3787101740477, 2197.2748992832326, 2208.4920468292303, 2210.5689390568846, 1895.7725072991261, 1930.4884205685435, 1942.8154325339142, 2172.0768673313855, 2231.241377931503, 2133.5519540896353, 2140.2616097446357, 2148.334016454904, 2154.3213887625348, 2157.0, 2106.820920221783, 2171.0447403142725, 2174.1194816099505, 2175.8259339252822, 2182.650775875868, 7156.785296441115, 7224.422046236341, 7240.167380751228, 7242.6378681065735, 7243.311885370934, 4468.2850743881145, 4573.382593349888, 4575.908481830378, 4592.9665825189395, 4603.976980115078, 2882.553204253344, 2924.400497897947, 2983.194537474891, 3004.354063876277, 3004.6094007779066, 913.9588718507683, 940.3981451870808, 947.0766003146946, 1785.1788177438264, 1858.6654402207732, 9600.567974441166, 9674.56464459101, 9683.951580242125, 9699.70900872975, 9717.222622190207, 3851.0372406898277, 4021.778802165909, 4041.2927737645796, 4059.0867054913, 4078.021274894004, 7800.726974555863, 7843.72546960865, 7866.685332586632, 7867.331276841418, 7875.251851074138, 4500.639948804088, 4550.590446859798, 4578.748168850745, 4584.106099310669, 4585.426821647294, 4200.075983283673, 4202.159568086395, 4205.3481710334945, 4224.1129362834145, 4230.788460576959, 3168.1921110116773, 3305.0910999475336, 3341.0478013766447, 3423.6747508987105, 3431.7769344992994, 1016.1312078173056, 1018.7809620931536, 1023.3859684189575, 1027.2860362048305, 1029.5881647341123, 944.0842382888587, 959.8800149981253, 1015.9136473399844, 1016.4612755239734, 1178.5109179690503, 6636.203655561363, 6679.532432729759, 6724.66376681164, 6732.0, 6734.764283250062, 599.3048064245454, 605.8031139879469, 608.7260732670316, 621.7077973352517, 746.0040845471248, 5114.174882502918, 5179.974100129475, 5327.893442131136, 5336.092864213093, 5426.8371948841595, 8578.227959483676, 8849.247813935759, 8920.197182253629, 8954.2836573074, 8994.910050899538, 8638.611262493203, 8805.635126555266, 8840.8673869892, 8953.686620968365, 8967.820643587092, 6817.863642727118, 6902.309769023058, 6913.89629155563, 6928.064711264015, 6950.930490695028, 6565.179352580927, 6654.76708315226, 6691.631960242234, 6710.396064354231, 6838.247792742894, 7558.9244107558225, 7673.923260767321, 7716.691332346868, 7741.651625676971, 7760.728374506865, 7704.614769261627, 7842.960785196037, 7892.6053697313755, 7987.960060199662, 8017.759467215993, 7047.224805271519, 7147.82130446743, 7180.210176880643, 7194.388476979515, 7204.207537171012, 6949.2008419030435, 6977.2673869243, 7013.509054366145, 7052.541584796972, 7054.858902822018, 6232.470240029648, 6291.716872740829, 6353.523485738496, 6425.5502114851515, 6550.574212676161, 6380.840478988062, 6395.5203359747275, 6458.903116453163, 6459.095726598374, 6463.7737679181, 6351.237851457855, 6610.735570577123, 6634.734610615521, 6666.766663166766, 6677.0, 6060.424259695498, 6070.575059745775, 6077.665728384804, 6078.7264573093435, 6130.141780150871, 5982.4017598239825, 6120.357362477054, 6134.938650613437, 6138.815835524942, 6139.0], "unit": "score", "name": "mootools.html", "value": 4177.9349388661085}, {"lowerIsBetter": false, "replicates": [315.3535252731899, 316.8289123873109, 320.038284953714, 320.3864599292357, 322.17844496533843, 5281.313429254196, 5482.5339846113075, 5486.835394938148, 5519.31008623922, 5521.089020311644, 5300.946990530094, 5398.082326004579, 5402.540784033352, 5410.188471729242, 5417.891642167155, 3951.269015232177, 4058.6144316289906, 4167.583241675823, 4187.72779769314, 4189.853355132571, 4155.39746736723, 4172.561881002496, 4174.457320548325, 4175.290200665879, 4176.770277634729, 4129.442525259082, 4132.855350062749, 4135.17296540693, 4136.731112477694, 4143.02638879863, 3914.17802261524, 4055.0673345130785, 4057.9391309130388, 4069.1658210066867, 4129.194807012634, 3503.386907291214, 3584.0860580552053, 3589.2821435712963, 3598.0285322962914, 3603.4594810778594, 5131.076406246874, 5134.897302053975, 5154.252633368178, 5166.509181627739, 5169.586433085382, 4747.240441529373, 4750.667453278272, 4750.857474275743, 4755.667103302771, 4760.976195119002, 5591.496765291144, 5612.971935140298, 5620.0, 5633.436656334334, 5638.887222255573, 3970.8411663533425, 3972.8609498667697, 3978.104926391539, 3978.76127432355, 3981.124152686404, 5688.800891968803, 5832.387599302097, 5878.706064696791, 5905.143754155666, 5912.40875912414, 3993.1414745829206, 4004.759714417144, 4008.7795171265275, 4024.1750441159493, 4050.1292222172374, 4073.1242782801246, 4099.754014759124, 4105.67154627629, 4109.137081212979, 4114.629683328515, 4725.054989002213, 4729.337892695025, 4729.55069268419, 4730.266808644666, 4732.905341893143, 5645.745941432645, 5649.096144616841, 5652.830415087554, 5655.066913959233, 5659.688717120598, 1425.308725268244, 1449.1956963885145, 1451.905626134319, 1452.5206681795194, 1455.8180227471566, 947.280067148958, 951.6193522591019, 966.6906589891167, 972.1833659725722, 974.5858010345717, 4753.738544380092, 4844.0, 4889.242167464049, 4927.039227350632, 4928.334674818925, 5866.911996320058, 5883.676397798162, 5890.204822349014, 5890.2342695449315, 5905.055191169392, 4958.082754690322, 4965.726885021359, 4970.975145124251, 4971.254311853251, 4972.254161875748, 3124.9218769530944, 3153.858076386568, 3157.463231250647, 3159.810411375279, 3164.4620414529586, 5530.087535556588, 5533.750981205855, 5544.805931792368, 5544.944550554524, 5548.944510554843, 5803.129530570448, 6019.2175017248355, 6022.427869352405, 6030.758769649253, 6056.545759068087, 5497.752601132958, 5520.420355862577, 5522.30971128617, 5525.419830917776, 5538.501534861882, 5852.297724273115, 5855.414458554111, 5860.677662728591, 5864.384239654945, 5866.6186697864505, 5693.946619875336, 5722.256106706268, 5736.6558006519745, 5750.453706897838, 5773.24947756789, 5517.531009864207, 5529.281193444987, 5532.6680399176175, 5536.141898005815, 5539.7784088636, 3902.3561112416132, 4032.9395059074723, 4038.495188101487, 4058.45210896537, 4064.1262128642484, 5807.593468457168, 5812.622179558484, 5839.386864379179, 5843.912341314799, 5851.034579294369, 5611.747471363717, 5614.831555053355, 5617.634853734494, 5624.578156638187, 5624.915626265528, 5529.364123125892, 5560.694161821139, 5582.469665381782, 5586.888262234651, 5589.133684278943, 5528.032594296063, 5532.585056120887, 5534.564791491731, 5540.861478463071, 5550.888982220414, 5455.208994695826, 5627.43725627434, 5630.02948967858, 5653.378128405954, 5657.236273103078, 5489.286392768914, 5506.889862202654, 5507.476789704971, 5511.58663100261, 5512.724363781875], "unit": "score", "name": "prototype.html", "value": 4232.828701009074}, {"lowerIsBetter": false, "replicates": [687.6492988575826, 712.33040941515, 766.6013672890095, 774.4385320642535, 794.6543253684644, 11808.468618912148, 11884.405779711002, 11938.224015438991, 11960.820587691182, 11972.102092343088, 11882.702932426671, 11893.464794084266, 11897.464614092365, 11907.880921190785, 11949.522019119226, 624.8906441372753, 794.7019867549669, 818.0, 818.5947955761876, 818.7011740714626, 794.8648729715933, 809.2312303311847, 809.2352726673296, 813.3127507256388, 817.8568750468673, 668.0346898731311, 837.7151768398774, 839.3033781960988, 844.4595458906305, 845.4589062999685, 822.3832125905541, 838.4382463749272, 840.7645859159445, 841.5876220651897, 842.7935155886786, 617.2654541096126, 620.6152185644884, 621.6083867163703, 622.9159063526412, 623.8440389902524, 11925.463354148997, 12021.398930053463, 12039.63881083569, 12115.091368147336, 12156.696082598006, 11453.942730286295, 11947.462364193632, 12247.448864801105, 12291.815622765665, 12406.503739850485, 9919.355241909325, 10060.295779295453, 10061.446620435872, 10204.540795664212, 10544.841827372595, 3252.1869532616847, 3265.314284000339, 3278.246003419227, 3371.662833716633, 3396.3207358528393, 43214.78392608048, 43615.78192109051, 43626.0, 43684.56315436868, 44644.77677611591, 9853.852192217122, 9929.851052234222, 9975.551100200508, 10043.899561004442, 10070.345427547187, 16608.418705345495, 16687.249073791707, 16713.582160446087, 16736.748948765777, 16813.15934203285, 6606.0, 6880.0, 6924.826879328057, 7061.046758687614, 7229.819254518679, 3844.7885366304563, 3846.942295865564, 3883.1457079442475, 3946.506686664167, 3962.128331767007, 2686.7044625091225, 2709.647745793034, 2723.4553089382202, 2736.2885649730815, 2736.521108805951, 501.19307914258013, 516.4422423782306, 517.6402400331733, 518.9922151167735, 526.4524894110083, 497.5522030172801, 518.6732358614049, 550.529297450682, 641.4771960851891, 656.2420404432887, 7510.037156180688, 7594.202608726115, 7772.883406748903, 7789.922100779033, 8020.5588692621295, 602.8726281852963, 606.7330374635146, 611.5718996702326, 618.245740196959, 627.5513008199068, 3679.8344074516713, 3722.683571896365, 3769.378052621342, 3812.1232116612778, 3870.825812838429, 41715.582844171775, 42582.36126458106, 51172.48827511752, 51249.23126153111, 51270.487295127314, 44972.77513612411, 45536.0, 45898.311525327146, 46613.0, 46796.5320346799, 40239.39640905389, 40537.79731101326, 40598.39102413407, 40730.38904416436, 41311.58688413138, 6960.3735663788475, 7339.266073392618, 7353.0, 7362.263773622595, 7487.8876816846705, 30074.849625751733, 30525.0, 31057.534136988415, 31607.367852643278, 31617.683823161475, 37573.06067348338, 37665.2466950665, 38064.42903356507, 40158.79920600378, 40266.396004060545, 9319.673811416567, 9471.905280947103, 9879.753006174904, 9972.351797133164, 10603.840942385716, 10721.892781072089, 11019.889801101886, 11034.889651103385, 11415.143864210051, 11706.063514918957, 10839.620613278497, 11054.944725276322, 11083.113350932068, 11093.889061109285, 11193.832092518456, 9137.543122843697, 9582.47296398677, 9617.0, 11049.28179668319, 11586.594469193538, 10102.09081182697, 10242.334248273839, 10434.21743369235, 10649.89350106489, 10851.511681974172, 8632.0, 8763.474191548528, 8918.598663060047, 9045.502497362708, 9290.303227257848, 8961.417507861968, 9243.630254789734, 9350.364530851672, 9488.905110949077, 9520.52397380142], "unit": "score", "name": "yui.html", "value": 5812.65559830174}], "name": "dromaeo_css", "value": 6255.1274841262}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 108.0, 114.0, 114.0, 114.0, 102.0, 112.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [170.0, 132.0, 158.0, 185.0, 133.0, 162.0, 163.0, 133.0, 185.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 155.4}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 162.0, 160.0, 163.0, 164.0, 162.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.3}, {"lowerIsBetter": true, "replicates": [76.0, 74.0, 77.0, 156.0, 77.0, 74.0, 74.0, 75.0, 168.0, 74.0], "unit": "score", "name": "audio-fft", "value": 92.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 150.0, 94.0, 95.0, 96.0, 135.0, 95.0, 94.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 97.0, 97.0, 97.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 66.0, 67.0, 68.0, 66.0, 65.0, 74.0, 64.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 66.9}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 64.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 85.0, 82.0, 84.0, 83.0, 82.0, 81.0, 86.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [118.0, 120.0, 118.0, 123.0, 120.0, 120.0, 116.0, 116.0, 116.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.3}, {"lowerIsBetter": true, "replicates": [141.0, 141.0, 141.0, 138.0, 141.0, 135.0, 147.0, 137.0, 151.0, 129.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.1}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 71.0, 67.0, 72.0, 67.0, 67.0, 70.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1530.5}]} 01:29:39 INFO - Return code: 0 01:29:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:29:39 ERROR - # TBPL SUCCESS # 01:29:39 INFO - Running post-action listener: _resource_record_post_action 01:29:39 INFO - Running post-run listener: _resource_record_post_run 01:29:40 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 196608; Write bytes: 284069888; Read time: 68; Write time: 212996 01:29:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1208320; Read time: 0; Write time: 56 01:29:40 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 196608; Write bytes: 282861568; Read time: 68; Write time: 212940 01:29:40 INFO - Running post-run listener: _upload_blobber_files 01:29:40 INFO - Blob upload gear active. 01:29:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:29:40 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 01:29:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:29:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:29:41 INFO - (blobuploader) - INFO - Open directory for files ... 01:29:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:29:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:29:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:42 INFO - (blobuploader) - INFO - Done attempting. 01:29:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:29:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:29:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:29:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:29:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:29:42 INFO - (blobuploader) - INFO - Done attempting. 01:29:42 INFO - (blobuploader) - INFO - Iteration through files over. 01:29:42 INFO - Return code: 0 01:29:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:29:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:29:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7405f9ef085c64265b9d05531afad640118923b542c87e52ab6e0ac87a101837bcdc625747e51a4e9e399acbf6c29153a822c1db2295850ef23f8411dfb0957", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00df056be21528399e4d973973f00774a1d48939ac8aa859e7427cd837c4082a84bdaa2af827a558f088816d220a86a8b40d7ab003d46c1f1bf3d2023935a245"} 01:29:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:29:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:29:42 INFO - Contents: 01:29:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7405f9ef085c64265b9d05531afad640118923b542c87e52ab6e0ac87a101837bcdc625747e51a4e9e399acbf6c29153a822c1db2295850ef23f8411dfb0957", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00df056be21528399e4d973973f00774a1d48939ac8aa859e7427cd837c4082a84bdaa2af827a558f088816d220a86a8b40d7ab003d46c1f1bf3d2023935a245"} 01:29:42 INFO - Running post-run listener: copy_logs_to_upload_dir 01:29:42 INFO - Copying logs to upload dir... 01:29:42 INFO - mkdir: /builds/slave/test/build/upload/logs 01:29:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1315.299310 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2016-04-05 01:29:42.824829) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 01:29:42.828670) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7405f9ef085c64265b9d05531afad640118923b542c87e52ab6e0ac87a101837bcdc625747e51a4e9e399acbf6c29153a822c1db2295850ef23f8411dfb0957", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00df056be21528399e4d973973f00774a1d48939ac8aa859e7427cd837c4082a84bdaa2af827a558f088816d220a86a8b40d7ab003d46c1f1bf3d2023935a245"} build_url:https://queue.taskcluster.net/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011455 build_url: 'https://queue.taskcluster.net/v1/task/Lo0-gFxnTS6TvNsLTmitJg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7405f9ef085c64265b9d05531afad640118923b542c87e52ab6e0ac87a101837bcdc625747e51a4e9e399acbf6c29153a822c1db2295850ef23f8411dfb0957", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/00df056be21528399e4d973973f00774a1d48939ac8aa859e7427cd837c4082a84bdaa2af827a558f088816d220a86a8b40d7ab003d46c1f1bf3d2023935a245"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-05 01:29:42.857719) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:29:42.858495) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1459836091.255017-1168476734 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 01:29:42.938109) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 01:29:42.938444) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 01:29:42.938765) ========= ========= Total master_lag: 0.31 =========