builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1458575208.26 results: success (0) buildid: 20160321073147 builduid: 5f252f702a1346129f49ba67b82b76b6 revision: e10424cf620fabac9a0850668bff5875583402f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 08:46:48.260200) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-21 08:46:48.260999) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 08:46:48.261449) ========= 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=4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006248 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-21 08:46:48.285350) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-21 08:46:48.285683) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-21 08:46:48.300915) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 08:46:48.301314) ========= 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=4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004690 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 08:46:48.351297) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 08:46:48.351632) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-21 08:46:48.352006) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 08:46:48.352289) ========= 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=4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-21 08:46:49-- 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% 44.5K=0.3s 2016-03-21 08:46:49 (44.5 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.483948 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 08:46:48.848536) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 08:46:48.848860) ========= 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=4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019228 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 08:46:48.898785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 08:46:48.899173) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e10424cf620fabac9a0850668bff5875583402f0 --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 e10424cf620fabac9a0850668bff5875583402f0 --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=4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-21 08:46:49,617 truncating revision to first 12 chars 2016-03-21 08:46:49,617 Setting DEBUG logging. 2016-03-21 08:46:49,617 attempt 1/10 2016-03-21 08:46:49,617 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e10424cf620f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-21 08:46:50,015 unpacking tar archive at: mozilla-central-e10424cf620f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.665781 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 08:46:49.577991) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 08:46:49.578356) ========= echo e10424cf620fabac9a0850668bff5875583402f0 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e10424cf620fabac9a0850668bff5875583402f0'] 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=4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False e10424cf620fabac9a0850668bff5875583402f0 program finished with exit code 0 elapsedTime=0.003825 script_repo_revision: 'e10424cf620fabac9a0850668bff5875583402f0' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-21 08:46:49.627724) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-21 08:46:49.628038) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-21 08:46:49.638153) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-21 08:46:49.638526) ========= /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=4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:46:50 INFO - MultiFileLogger online at 20160321 08:46:50 in /builds/slave/test 08:46:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:46:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:46:50 INFO - {'append_to_log': False, 08:46:50 INFO - 'base_work_dir': '/builds/slave/test', 08:46:50 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:46:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:46:50 INFO - 'branch': 'Firefox-Non-PGO', 08:46:50 INFO - 'buildbot_json_path': 'buildprops.json', 08:46:50 INFO - 'config_files': ('talos/linux_config.py',), 08:46:50 INFO - 'default_actions': ('clobber', 08:46:50 INFO - 'read-buildbot-config', 08:46:50 INFO - 'download-and-extract', 08:46:50 INFO - 'populate-webroot', 08:46:50 INFO - 'create-virtualenv', 08:46:50 INFO - 'install', 08:46:50 INFO - 'run-tests'), 08:46:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:46:50 INFO - 'download_minidump_stackwalk': True, 08:46:50 INFO - 'download_symbols': 'ondemand', 08:46:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:46:50 INFO - 'tooltool.py': '/tools/tooltool.py', 08:46:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:46:50 INFO - '/tools/misc-python/virtualenv.py')}, 08:46:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:46:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:46:50 INFO - 'installer_path': 'installer.exe', 08:46:50 INFO - 'log_level': 'info', 08:46:50 INFO - 'log_name': 'talos', 08:46:50 INFO - 'log_to_console': True, 08:46:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:46:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:46:50 INFO - 'opt_config_files': (), 08:46:50 INFO - 'pip_index': False, 08:46:50 INFO - 'sps_profile': False, 08:46:50 INFO - 'sps_profile_interval': 0, 08:46:50 INFO - 'suite': 'dromaeojs', 08:46:50 INFO - 'system_bits': '32', 08:46:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:46:50 INFO - 'title': 'talos-linux64-ix-030', 08:46:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:46:50 INFO - 'use_talos_json': True, 08:46:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:46:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:46:50 INFO - 'work_dir': 'build'} 08:46:50 INFO - ##### 08:46:50 INFO - ##### Running clobber step. 08:46:50 INFO - ##### 08:46:50 INFO - Running pre-action listener: _resource_record_pre_action 08:46:50 INFO - Running main action method: clobber 08:46:50 INFO - rmtree: /builds/slave/test/build 08:46:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:46:51 INFO - Running post-action listener: _resource_record_post_action 08:46:51 INFO - ##### 08:46:51 INFO - ##### Running read-buildbot-config step. 08:46:51 INFO - ##### 08:46:51 INFO - Running pre-action listener: _resource_record_pre_action 08:46:51 INFO - Running main action method: read_buildbot_config 08:46:51 INFO - Using buildbot properties: 08:46:51 INFO - { 08:46:51 INFO - "project": "", 08:46:51 INFO - "product": "firefox", 08:46:51 INFO - "script_repo_revision": "production", 08:46:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:46:51 INFO - "repository": "", 08:46:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:46:51 INFO - "buildid": "20160321073147", 08:46:51 INFO - "pgo_build": "False", 08:46:51 INFO - "basedir": "/builds/slave/test", 08:46:51 INFO - "buildnumber": 453, 08:46:51 INFO - "slavename": "talos-linux64-ix-030", 08:46:51 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:46:51 INFO - "platform": "ubuntu64_hw", 08:46:51 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:46:51 INFO - "branch": "mozilla-central", 08:46:51 INFO - "repo_path": "mozilla-central", 08:46:51 INFO - "revision": "e10424cf620fabac9a0850668bff5875583402f0", 08:46:51 INFO - "stage_platform": "linux64", 08:46:51 INFO - "builduid": "5f252f702a1346129f49ba67b82b76b6", 08:46:51 INFO - "slavebuilddir": "test" 08:46:51 INFO - } 08:46:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 08:46:51 INFO - Running post-action listener: _resource_record_post_action 08:46:51 INFO - ##### 08:46:51 INFO - ##### Running download-and-extract step. 08:46:51 INFO - ##### 08:46:51 INFO - Running pre-action listener: _resource_record_pre_action 08:46:51 INFO - Running main action method: download_and_extract 08:46:51 INFO - mkdir: /builds/slave/test/build/tests 08:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:51 INFO - https://queue.taskcluster.net/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:46:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:46:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:46:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/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 08:46:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/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 08:46:52 INFO - Downloaded 1361 bytes. 08:46:52 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 08:46:52 INFO - Using the following test package requirements: 08:46:52 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:46:52 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:46:52 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:46:52 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:52 INFO - u'jsshell-linux-x86_64.zip'], 08:46:52 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:46:52 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 08:46:52 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:46:52 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:46:52 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:46:52 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 08:46:52 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:46:52 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:52 INFO - https://queue.taskcluster.net/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:46:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:46:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:46:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/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 08:46:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/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 08:46:53 INFO - Downloaded 21999699 bytes. 08:46:53 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'] 08:46:53 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 08:46:54 INFO - Return code: 0 08:46:54 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 08:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:54 INFO - https://queue.taskcluster.net/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:46:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:46:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 08:46:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/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 08:46:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/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 08:46:55 INFO - Downloaded 21999699 bytes. 08:46:55 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'] 08:46:55 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 08:46:56 INFO - Return code: 0 08:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:56 INFO - https://queue.taskcluster.net/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:46:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:46:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 08:46:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/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 08:46:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/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 08:46:57 INFO - Downloaded 10847637 bytes. 08:46:57 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'] 08:46:57 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 08:46:57 INFO - Return code: 0 08:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:46:57 INFO - https://queue.taskcluster.net/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:46:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:46:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:46:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/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 08:46:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/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 08:46:59 INFO - Downloaded 54159942 bytes. 08:46:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:46:59 INFO - mkdir: /builds/slave/test/properties 08:46:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:46:59 INFO - Writing to file /builds/slave/test/properties/build_url 08:46:59 INFO - Contents: 08:46:59 INFO - build_url:https://queue.taskcluster.net/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 08:47:00 INFO - Running post-action listener: _resource_record_post_action 08:47:00 INFO - Running post-action listener: set_extra_try_arguments 08:47:00 INFO - ##### 08:47:00 INFO - ##### Running populate-webroot step. 08:47:00 INFO - ##### 08:47:00 INFO - Running pre-action listener: _resource_record_pre_action 08:47:00 INFO - Running main action method: populate_webroot 08:47:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:47:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:47:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:47:00 INFO - '--tppagecycles', 08:47:00 INFO - '7'], 08:47:00 INFO - 'tests': ['tsvgm']}}, 08:47:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:47:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:47:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:47:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:47:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:47:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:47:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:47:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:00 INFO - 'talos_options': ['--e10s'], 08:47:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:47:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:00 INFO - 'tests': ['damp', 'tps']}, 08:47:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:00 INFO - 'talos_options': ['--e10s'], 08:47:00 INFO - 'tests': ['damp', 'tps']}, 08:47:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:47:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:47:00 INFO - 'other': {'tests': ['a11yr', 08:47:00 INFO - 'ts_paint', 08:47:00 INFO - 'tpaint', 08:47:00 INFO - 'sessionrestore', 08:47:00 INFO - 'sessionrestore_no_auto_restore', 08:47:00 INFO - 'tabpaint']}, 08:47:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:47:00 INFO - 'tests': ['a11yr', 08:47:00 INFO - 'ts_paint', 08:47:00 INFO - 'tpaint', 08:47:00 INFO - 'sessionrestore', 08:47:00 INFO - 'sessionrestore_no_auto_restore', 08:47:00 INFO - 'tabpaint']}, 08:47:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:47:00 INFO - 'tests': ['a11yr', 08:47:00 INFO - 'ts_paint', 08:47:00 INFO - 'tpaint', 08:47:00 INFO - 'sessionrestore', 08:47:00 INFO - 'sessionrestore_no_auto_restore', 08:47:00 INFO - 'tabpaint']}, 08:47:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:47:00 INFO - 'tests': ['a11yr', 08:47:00 INFO - 'ts_paint', 08:47:00 INFO - 'tpaint', 08:47:00 INFO - 'sessionrestore', 08:47:00 INFO - 'sessionrestore_no_auto_restore', 08:47:00 INFO - 'tabpaint']}, 08:47:00 INFO - 'other_l64': {'tests': ['a11yr', 08:47:00 INFO - 'ts_paint', 08:47:00 INFO - 'tpaint', 08:47:00 INFO - 'sessionrestore', 08:47:00 INFO - 'sessionrestore_no_auto_restore', 08:47:00 INFO - 'tabpaint']}, 08:47:00 INFO - 'other_nol64': {'tests': ['a11yr', 08:47:00 INFO - 'ts_paint', 08:47:00 INFO - 'tpaint', 08:47:00 INFO - 'sessionrestore', 08:47:00 INFO - 'sessionrestore_no_auto_restore', 08:47:00 INFO - 'tabpaint']}, 08:47:00 INFO - 'svgr': {'tests': ['tsvgx', 08:47:00 INFO - 'tsvgr_opacity', 08:47:00 INFO - 'tart', 08:47:00 INFO - 'tscrollx', 08:47:00 INFO - 'cart']}, 08:47:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:47:00 INFO - 'tests': ['tsvgx', 08:47:00 INFO - 'tsvgr_opacity', 08:47:00 INFO - 'tart', 08:47:00 INFO - 'tscrollx', 08:47:00 INFO - 'cart']}, 08:47:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:00 INFO - 'tests': ['tp5o']}, 08:47:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:00 INFO - 'talos_options': ['--e10s'], 08:47:00 INFO - 'tests': ['tp5o']}, 08:47:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:00 INFO - 'talos_options': ['--xperf_path', 08:47:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:47:00 INFO - 'tests': ['tp5n']}, 08:47:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:47:00 INFO - 'talos_options': ['--e10s', 08:47:00 INFO - '--xperf_path', 08:47:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:47:00 INFO - 'tests': ['tp5n']}}, 08:47:00 INFO - 'talos.zip': {'path': '', 08:47:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:47:00 INFO - Running post-action listener: _resource_record_post_action 08:47:00 INFO - ##### 08:47:00 INFO - ##### Running create-virtualenv step. 08:47:00 INFO - ##### 08:47:00 INFO - Running pre-action listener: _resource_record_pre_action 08:47:00 INFO - Running main action method: create_virtualenv 08:47:00 INFO - Creating virtualenv /builds/slave/test/build/venv 08:47:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:47:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:47:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:47:00 INFO - Using real prefix '/usr' 08:47:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:47:01 INFO - Installing distribute.............................................................................................................................................................................................done. 08:47:03 INFO - Installing pip.................done. 08:47:03 INFO - Return code: 0 08:47:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:03 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 0x7f4c819b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a2410>, '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 0x13a3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a37a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:47:03 INFO - Using env: {'DISPLAY': ':0', 08:47:03 INFO - 'HOME': '/home/cltbld', 08:47:03 INFO - 'LANG': 'en_US.UTF-8', 08:47:03 INFO - 'LANGUAGE': 'en_US:en', 08:47:03 INFO - 'LOGNAME': 'cltbld', 08:47:03 INFO - 'MAIL': '/var/mail/cltbld', 08:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:03 INFO - 'MOZ_NO_REMOTE': '1', 08:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:03 INFO - 'NO_EM_RESTART': '1', 08:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:03 INFO - 'PWD': '/builds/slave/test', 08:47:03 INFO - 'SHELL': '/bin/bash', 08:47:03 INFO - 'SHLVL': '1', 08:47:03 INFO - 'TERM': 'linux', 08:47:03 INFO - 'TMOUT': '86400', 08:47:03 INFO - 'USER': 'cltbld', 08:47:03 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838', 08:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:03 INFO - '_': '/tools/buildbot/bin/python'} 08:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:47:03 INFO - Cleaning up... 08:47:03 INFO - Return code: 0 08:47:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:03 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 0x7f4c819b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a2410>, '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 0x13a3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a37a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47:03 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 08:47:03 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 08:47:03 INFO - Using env: {'DISPLAY': ':0', 08:47:03 INFO - 'HOME': '/home/cltbld', 08:47:03 INFO - 'LANG': 'en_US.UTF-8', 08:47:03 INFO - 'LANGUAGE': 'en_US:en', 08:47:03 INFO - 'LOGNAME': 'cltbld', 08:47:03 INFO - 'MAIL': '/var/mail/cltbld', 08:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:03 INFO - 'MOZ_NO_REMOTE': '1', 08:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:03 INFO - 'NO_EM_RESTART': '1', 08:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:03 INFO - 'PWD': '/builds/slave/test', 08:47:03 INFO - 'SHELL': '/bin/bash', 08:47:03 INFO - 'SHLVL': '1', 08:47:03 INFO - 'TERM': 'linux', 08:47:03 INFO - 'TMOUT': '86400', 08:47:03 INFO - 'USER': 'cltbld', 08:47:03 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838', 08:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:03 INFO - '_': '/tools/buildbot/bin/python'} 08:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:03 INFO - Downloading/unpacking psutil>=0.7.1 08:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:47:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:47:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:47:05 INFO - Installing collected packages: psutil 08:47:05 INFO - Running setup.py install for psutil 08:47:05 INFO - building 'psutil._psutil_linux' extension 08:47:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:47:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:47:05 INFO - building 'psutil._psutil_posix' extension 08:47:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:47:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:47:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:47:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:47:05 INFO - Successfully installed psutil 08:47:05 INFO - Cleaning up... 08:47:06 INFO - Return code: 0 08:47:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:06 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 0x7f4c819b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a2410>, '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 0x13a3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a37a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47:06 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 08:47:06 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 08:47:06 INFO - Using env: {'DISPLAY': ':0', 08:47:06 INFO - 'HOME': '/home/cltbld', 08:47:06 INFO - 'LANG': 'en_US.UTF-8', 08:47:06 INFO - 'LANGUAGE': 'en_US:en', 08:47:06 INFO - 'LOGNAME': 'cltbld', 08:47:06 INFO - 'MAIL': '/var/mail/cltbld', 08:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:06 INFO - 'MOZ_NO_REMOTE': '1', 08:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:06 INFO - 'NO_EM_RESTART': '1', 08:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:06 INFO - 'PWD': '/builds/slave/test', 08:47:06 INFO - 'SHELL': '/bin/bash', 08:47:06 INFO - 'SHLVL': '1', 08:47:06 INFO - 'TERM': 'linux', 08:47:06 INFO - 'TMOUT': '86400', 08:47:06 INFO - 'USER': 'cltbld', 08:47:06 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838', 08:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:06 INFO - '_': '/tools/buildbot/bin/python'} 08:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:47:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:47:08 INFO - Installing collected packages: mozsystemmonitor 08:47:08 INFO - Running setup.py install for mozsystemmonitor 08:47:08 INFO - Successfully installed mozsystemmonitor 08:47:08 INFO - Cleaning up... 08:47:08 INFO - Return code: 0 08:47:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:08 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 0x7f4c819b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a2410>, '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 0x13a3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a37a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:47:08 INFO - Using env: {'DISPLAY': ':0', 08:47:08 INFO - 'HOME': '/home/cltbld', 08:47:08 INFO - 'LANG': 'en_US.UTF-8', 08:47:08 INFO - 'LANGUAGE': 'en_US:en', 08:47:08 INFO - 'LOGNAME': 'cltbld', 08:47:08 INFO - 'MAIL': '/var/mail/cltbld', 08:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:08 INFO - 'MOZ_NO_REMOTE': '1', 08:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:08 INFO - 'NO_EM_RESTART': '1', 08:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:08 INFO - 'PWD': '/builds/slave/test', 08:47:08 INFO - 'SHELL': '/bin/bash', 08:47:08 INFO - 'SHLVL': '1', 08:47:08 INFO - 'TERM': 'linux', 08:47:08 INFO - 'TMOUT': '86400', 08:47:08 INFO - 'USER': 'cltbld', 08:47:08 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838', 08:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:08 INFO - '_': '/tools/buildbot/bin/python'} 08:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:08 INFO - Downloading/unpacking blobuploader==1.2.4 08:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:10 INFO - Downloading blobuploader-1.2.4.tar.gz 08:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:47:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:47:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:10 INFO - Downloading docopt-0.6.1.tar.gz 08:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:47:11 INFO - Installing collected packages: blobuploader, requests, docopt 08:47:11 INFO - Running setup.py install for blobuploader 08:47:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:47:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:47:11 INFO - Running setup.py install for requests 08:47:11 INFO - Running setup.py install for docopt 08:47:11 INFO - Successfully installed blobuploader requests docopt 08:47:11 INFO - Cleaning up... 08:47:11 INFO - Return code: 0 08:47:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:11 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 0x7f4c819b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a2410>, '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 0x13a3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a37a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:47:11 INFO - Using env: {'DISPLAY': ':0', 08:47:11 INFO - 'HOME': '/home/cltbld', 08:47:11 INFO - 'LANG': 'en_US.UTF-8', 08:47:11 INFO - 'LANGUAGE': 'en_US:en', 08:47:11 INFO - 'LOGNAME': 'cltbld', 08:47:11 INFO - 'MAIL': '/var/mail/cltbld', 08:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:11 INFO - 'MOZ_NO_REMOTE': '1', 08:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:11 INFO - 'NO_EM_RESTART': '1', 08:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:11 INFO - 'PWD': '/builds/slave/test', 08:47:11 INFO - 'SHELL': '/bin/bash', 08:47:11 INFO - 'SHLVL': '1', 08:47:11 INFO - 'TERM': 'linux', 08:47:11 INFO - 'TMOUT': '86400', 08:47:11 INFO - 'USER': 'cltbld', 08:47:11 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838', 08:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:11 INFO - '_': '/tools/buildbot/bin/python'} 08:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:47:11 INFO - Running setup.py (path:/tmp/pip-m4ldZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:47:11 INFO - Running setup.py (path:/tmp/pip-fL8xvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:47:12 INFO - Running setup.py (path:/tmp/pip-AB51UJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:47:12 INFO - Running setup.py (path:/tmp/pip-OqNXQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:47:12 INFO - Running setup.py (path:/tmp/pip-6j9xol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:47:12 INFO - Running setup.py (path:/tmp/pip-34j4dE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:47:12 INFO - Running setup.py (path:/tmp/pip-BMJ1Ru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:47:12 INFO - Running setup.py (path:/tmp/pip-mztwqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:12 INFO - Running setup.py (path:/tmp/pip-tZWcaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:12 INFO - Running setup.py (path:/tmp/pip-3RSr2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:12 INFO - Running setup.py (path:/tmp/pip-uXqmom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:12 INFO - Running setup.py (path:/tmp/pip-mtPZ_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:12 INFO - Running setup.py (path:/tmp/pip-iePcEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:12 INFO - Running setup.py (path:/tmp/pip-KfJCy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:12 INFO - Running setup.py (path:/tmp/pip-zXq4d_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:12 INFO - Running setup.py (path:/tmp/pip-CKvKRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:13 INFO - Running setup.py (path:/tmp/pip-cASslZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:47:13 INFO - Running setup.py install for manifestparser 08:47:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:47:13 INFO - Running setup.py install for mozcrash 08:47:13 INFO - Running setup.py install for mozdebug 08:47:13 INFO - Running setup.py install for mozdevice 08:47:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:47:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:47:13 INFO - Running setup.py install for mozfile 08:47:13 INFO - Running setup.py install for mozhttpd 08:47:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:47:13 INFO - Running setup.py install for mozinfo 08:47:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:47:13 INFO - Running setup.py install for mozInstall 08:47:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:47:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:47:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:47:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:47:13 INFO - Running setup.py install for mozleak 08:47:13 INFO - Running setup.py install for mozlog 08:47:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:47:14 INFO - Running setup.py install for moznetwork 08:47:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:47:14 INFO - Running setup.py install for mozprocess 08:47:14 INFO - Running setup.py install for mozprofile 08:47:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:47:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:47:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:47:14 INFO - Running setup.py install for mozrunner 08:47:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:47:14 INFO - Running setup.py install for mozscreenshot 08:47:14 INFO - Running setup.py install for moztest 08:47:14 INFO - Running setup.py install for mozversion 08:47:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:47:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:47:14 INFO - Cleaning up... 08:47:14 INFO - Return code: 0 08:47:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47: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')]} 08:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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')]} 08:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:14 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 0x7f4c819b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a2410>, '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 0x13a3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a37a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:47:14 INFO - Using env: {'DISPLAY': ':0', 08:47:14 INFO - 'HOME': '/home/cltbld', 08:47:14 INFO - 'LANG': 'en_US.UTF-8', 08:47:14 INFO - 'LANGUAGE': 'en_US:en', 08:47:14 INFO - 'LOGNAME': 'cltbld', 08:47:14 INFO - 'MAIL': '/var/mail/cltbld', 08:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:14 INFO - 'MOZ_NO_REMOTE': '1', 08:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:14 INFO - 'NO_EM_RESTART': '1', 08:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:14 INFO - 'PWD': '/builds/slave/test', 08:47:14 INFO - 'SHELL': '/bin/bash', 08:47:14 INFO - 'SHLVL': '1', 08:47:14 INFO - 'TERM': 'linux', 08:47:14 INFO - 'TMOUT': '86400', 08:47:14 INFO - 'USER': 'cltbld', 08:47:14 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838', 08:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:14 INFO - '_': '/tools/buildbot/bin/python'} 08:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:47:15 INFO - Running setup.py (path:/tmp/pip-OG2t1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:47:15 INFO - Running setup.py (path:/tmp/pip-LoDgNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:47:15 INFO - Running setup.py (path:/tmp/pip-VjER3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:47:15 INFO - Running setup.py (path:/tmp/pip-c_J4Gh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:47:15 INFO - Running setup.py (path:/tmp/pip-5aQEJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:47:15 INFO - Running setup.py (path:/tmp/pip-neJNwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:47:15 INFO - Running setup.py (path:/tmp/pip-eornd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:47:15 INFO - Running setup.py (path:/tmp/pip-Cm7U2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:47:15 INFO - Running setup.py (path:/tmp/pip-QJMfnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:47:15 INFO - Running setup.py (path:/tmp/pip-FnnXbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:47:15 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)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:47:15 INFO - Running setup.py (path:/tmp/pip-P10NwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:47:15 INFO - Running setup.py (path:/tmp/pip-xMtRwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:47:15 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)) 08:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:47:15 INFO - Running setup.py (path:/tmp/pip-eJ0Nb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:47:16 INFO - Running setup.py (path:/tmp/pip-yaaowr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:47:16 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)) 08:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:16 INFO - Running setup.py (path:/tmp/pip-uQMXOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:47:16 INFO - Running setup.py (path:/tmp/pip-gzZ79i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:47:16 INFO - Running setup.py (path:/tmp/pip-BL7zD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:47:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:18 INFO - Downloading blessings-1.6.tar.gz 08:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:47:18 INFO - Installing collected packages: blessings 08:47:18 INFO - Running setup.py install for blessings 08:47:18 INFO - Successfully installed blessings 08:47:18 INFO - Cleaning up... 08:47:18 INFO - Return code: 0 08:47:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:47:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:18 INFO - Reading from file tmpfile_stdout 08:47:18 INFO - Current package versions: 08:47:18 INFO - argparse == 1.2.1 08:47:18 INFO - blessings == 1.6 08:47:18 INFO - blobuploader == 1.2.4 08:47:18 INFO - docopt == 0.6.1 08:47:18 INFO - manifestparser == 1.1 08:47:18 INFO - mozInstall == 1.12 08:47:18 INFO - mozcrash == 0.17 08:47:18 INFO - mozdebug == 0.1 08:47:18 INFO - mozdevice == 0.48 08:47:18 INFO - mozfile == 1.2 08:47:18 INFO - mozhttpd == 0.7 08:47:18 INFO - mozinfo == 0.9 08:47:18 INFO - mozleak == 0.1 08:47:18 INFO - mozlog == 3.1 08:47:18 INFO - moznetwork == 0.27 08:47:18 INFO - mozprocess == 0.22 08:47:18 INFO - mozprofile == 0.28 08:47:18 INFO - mozrunner == 6.11 08:47:18 INFO - mozscreenshot == 0.1 08:47:18 INFO - mozsystemmonitor == 0.0 08:47:18 INFO - moztest == 0.7 08:47:18 INFO - mozversion == 1.4 08:47:18 INFO - psutil == 3.1.1 08:47:18 INFO - requests == 1.2.3 08:47:18 INFO - wsgiref == 0.1.2 08:47:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:18 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 0x7f4c819b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a2410>, '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 0x13a3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a37a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:47:18 INFO - Using env: {'DISPLAY': ':0', 08:47:18 INFO - 'HOME': '/home/cltbld', 08:47:18 INFO - 'LANG': 'en_US.UTF-8', 08:47:18 INFO - 'LANGUAGE': 'en_US:en', 08:47:18 INFO - 'LOGNAME': 'cltbld', 08:47:18 INFO - 'MAIL': '/var/mail/cltbld', 08:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:18 INFO - 'MOZ_NO_REMOTE': '1', 08:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:18 INFO - 'NO_EM_RESTART': '1', 08:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:18 INFO - 'PWD': '/builds/slave/test', 08:47:18 INFO - 'SHELL': '/bin/bash', 08:47:18 INFO - 'SHLVL': '1', 08:47:18 INFO - 'TERM': 'linux', 08:47:18 INFO - 'TMOUT': '86400', 08:47:18 INFO - 'USER': 'cltbld', 08:47:18 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838', 08:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:18 INFO - '_': '/tools/buildbot/bin/python'} 08:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:47:18 INFO - Cleaning up... 08:47:18 INFO - Return code: 0 08:47:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c819b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a2410>, '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 0x13a3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a37a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:47:18 INFO - Using env: {'DISPLAY': ':0', 08:47:18 INFO - 'HOME': '/home/cltbld', 08:47:18 INFO - 'LANG': 'en_US.UTF-8', 08:47:18 INFO - 'LANGUAGE': 'en_US:en', 08:47:18 INFO - 'LOGNAME': 'cltbld', 08:47:18 INFO - 'MAIL': '/var/mail/cltbld', 08:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:18 INFO - 'MOZ_NO_REMOTE': '1', 08:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:18 INFO - 'NO_EM_RESTART': '1', 08:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:18 INFO - 'PWD': '/builds/slave/test', 08:47:18 INFO - 'SHELL': '/bin/bash', 08:47:18 INFO - 'SHLVL': '1', 08:47:18 INFO - 'TERM': 'linux', 08:47:18 INFO - 'TMOUT': '86400', 08:47:18 INFO - 'USER': 'cltbld', 08:47:18 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838', 08:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:18 INFO - '_': '/tools/buildbot/bin/python'} 08:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:19 INFO - Downloading/unpacking jsonschema 08:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:47:20 INFO - Downloading/unpacking functools32 (from jsonschema) 08:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:21 INFO - Downloading functools32-3.2.3-2.tar.gz 08:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:47:21 INFO - warning: no files found matching '*.txt' 08:47:21 INFO - no previously-included directories found matching 'build' 08:47:21 INFO - no previously-included directories found matching 'dist' 08:47:21 INFO - no previously-included directories found matching '.git*' 08:47:21 INFO - Installing collected packages: jsonschema, functools32 08:47:21 INFO - Running setup.py install for functools32 08:47:21 INFO - warning: no files found matching '*.txt' 08:47:21 INFO - no previously-included directories found matching 'build' 08:47:21 INFO - no previously-included directories found matching 'dist' 08:47:21 INFO - no previously-included directories found matching '.git*' 08:47:21 INFO - Successfully installed jsonschema functools32 08:47:21 INFO - Cleaning up... 08:47:21 INFO - Return code: 0 08:47:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:47: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')]} 08:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:47:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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')]} 08:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:47:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:47: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4c819b1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12488a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13135a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a2410>, '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 0x13a3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a37a0>, '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': '4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:47: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', 'flake8'] in /builds/slave/test/build 08:47: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 flake8 08:47:21 INFO - Using env: {'DISPLAY': ':0', 08:47:21 INFO - 'HOME': '/home/cltbld', 08:47:21 INFO - 'LANG': 'en_US.UTF-8', 08:47:21 INFO - 'LANGUAGE': 'en_US:en', 08:47:21 INFO - 'LOGNAME': 'cltbld', 08:47:21 INFO - 'MAIL': '/var/mail/cltbld', 08:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:21 INFO - 'MOZ_NO_REMOTE': '1', 08:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:21 INFO - 'NO_EM_RESTART': '1', 08:47:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:21 INFO - 'PWD': '/builds/slave/test', 08:47:21 INFO - 'SHELL': '/bin/bash', 08:47:21 INFO - 'SHLVL': '1', 08:47:21 INFO - 'TERM': 'linux', 08:47:21 INFO - 'TMOUT': '86400', 08:47:21 INFO - 'USER': 'cltbld', 08:47:21 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838', 08:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:21 INFO - '_': '/tools/buildbot/bin/python'} 08:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:47:21 INFO - Downloading/unpacking flake8 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47: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 08:47:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:47:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:47:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:47:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:47:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:47:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:47:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:47:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:47:24 INFO - no previously-included directories found matching 'docs/_build' 08:47:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:47:24 INFO - Running setup.py install for pep8 08:47:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:47:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:47:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:47:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:47:24 INFO - no previously-included directories found matching 'docs/_build' 08:47:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:47:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:47:24 INFO - Cleaning up... 08:47:24 INFO - Return code: 0 08:47:24 INFO - Running post-action listener: _resource_record_post_action 08:47:24 INFO - Running post-action listener: _start_resource_monitoring 08:47:24 INFO - Starting resource monitoring. 08:47:24 INFO - ##### 08:47:24 INFO - ##### Running install step. 08:47:24 INFO - ##### 08:47:24 INFO - Running pre-action listener: _resource_record_pre_action 08:47:24 INFO - Running main action method: install 08:47:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:47:24 INFO - Reading from file tmpfile_stdout 08:47:24 INFO - Detecting whether we're running mozinstall >=1.0... 08:47:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:47:24 INFO - Reading from file tmpfile_stdout 08:47:24 INFO - Output received: 08:47:24 INFO - Usage: mozinstall [options] installer 08:47:24 INFO - Options: 08:47:24 INFO - -h, --help show this help message and exit 08:47:24 INFO - -d DEST, --destination=DEST 08:47:24 INFO - Directory to install application into. [default: 08:47:24 INFO - "/builds/slave/test"] 08:47:24 INFO - --app=APP Application being installed. [default: firefox] 08:47:24 INFO - mkdir: /builds/slave/test/build/application 08:47:24 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'] 08:47:24 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 08:47:40 INFO - Reading from file tmpfile_stdout 08:47:40 INFO - Output received: 08:47:40 INFO - /builds/slave/test/build/application/firefox/firefox 08:47:40 INFO - Running post-action listener: _resource_record_post_action 08:47:40 INFO - ##### 08:47:40 INFO - ##### Running run-tests step. 08:47:40 INFO - ##### 08:47:40 INFO - Running pre-action listener: _resource_record_pre_action 08:47:40 INFO - Running main action method: run_tests 08:47:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:47:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:47:40 INFO - Python 2.7.3 08:47:40 INFO - Return code: 0 08:47:40 INFO - grabbing minidump binary from tooltool 08:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:47:40 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 0x13a2410>, '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 0x13a3310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a37a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:47:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:47:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:47:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:47:40 INFO - Return code: 0 08:47:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:47:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:47:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:47:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:47:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:47:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:47:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:47:41 INFO - Return code: 0 08:47:41 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/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:47:41 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/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:47:41 INFO - Using env: {'DISPLAY': ':0', 08:47:41 INFO - 'HOME': '/home/cltbld', 08:47:41 INFO - 'LANG': 'en_US.UTF-8', 08:47:41 INFO - 'LANGUAGE': 'en_US:en', 08:47:41 INFO - 'LOGNAME': 'cltbld', 08:47:41 INFO - 'MAIL': '/var/mail/cltbld', 08:47:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:47:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:47:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:41 INFO - 'MOZ_NO_REMOTE': '1', 08:47:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:47:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:47:41 INFO - 'NO_EM_RESTART': '1', 08:47:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:47:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:41 INFO - 'PWD': '/builds/slave/test', 08:47:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:47:41 INFO - 'SHELL': '/bin/bash', 08:47:41 INFO - 'SHLVL': '1', 08:47:41 INFO - 'TERM': 'linux', 08:47:41 INFO - 'TMOUT': '86400', 08:47:41 INFO - 'USER': 'cltbld', 08:47:41 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838', 08:47:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:41 INFO - '_': '/tools/buildbot/bin/python'} 08:47:41 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/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:47:41 INFO - mozversion application_buildid: 20160321073147 08:47:41 INFO - mozversion application_changeset: e10424cf620fabac9a0850668bff5875583402f0 08:47:41 INFO - mozversion application_display_name: Nightly 08:47:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:47:41 INFO - mozversion application_name: Firefox 08:47:41 INFO - mozversion application_remotingname: firefox 08:47:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:47:41 INFO - mozversion application_vendor: Mozilla 08:47:41 INFO - mozversion application_version: 48.0a1 08:47:41 INFO - mozversion platform_buildid: 20160321073147 08:47:41 INFO - mozversion platform_changeset: e10424cf620fabac9a0850668bff5875583402f0 08:47:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:47:41 INFO - mozversion platform_version: 48.0a1 08:47:41 INFO - using testdate: 1458575261 08:47:41 INFO - actual date: 1458575261 08:47:41 INFO - starting webserver on 'localhost:41717' 08:47:41 INFO - SUITE-START | Running 2 tests 08:47:41 INFO - TEST-START | dromaeo_css 08:47:41 INFO - operating with platform_type : linux_ 08:47:41 INFO - Initialising browser for dromaeo_css test... 08:47:41 INFO - TEST-INFO | started process 24012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEA9WUk/profile http://localhost:41717/getInfo.html) 08:47:45 INFO - PROCESS | 24012 | __metrics Screen width/height:1600/1200 08:47:45 INFO - PROCESS | 24012 | colorDepth:24 08:47:45 INFO - PROCESS | 24012 | Browser inner width/height: 1024/697 08:47:45 INFO - PROCESS | 24012 | __metrics 08:47:46 ERROR - PROCESS | 24012 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 08:47:46 INFO - PROCESS | 24012 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 08:47:47 INFO - TEST-INFO | 24012: exit 0 08:47:47 INFO - Browser initialized. 08:47:47 INFO - Running cycle 1/1 for dromaeo_css test... 08:47:47 INFO - TEST-INFO | started process 24108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEA9WUk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:47:59 INFO - PROCESS | 24108 | RSS: Main: 157736960 08:47:59 INFO - PROCESS | 24108 | 08:48:50 INFO - PROCESS | 24108 | 1458575330658 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:51:03 INFO - PROCESS | 24108 | Cycle 1(1): loaded http://localhost:41717/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41717/tests/dromaeo/cssquery-ext.html) 08:51:04 INFO - PROCESS | 24108 | RSS: Main: 255049728 08:51:04 INFO - PROCESS | 24108 | 08:54:06 INFO - PROCESS | 24108 | Cycle 1(1): loaded http://localhost:41717/tests/dromaeo/cssquery-ext.html (next: http://localhost:41717/tests/dromaeo/cssquery-jquery.html) 08:54:07 INFO - PROCESS | 24108 | RSS: Main: 237592576 08:54:07 INFO - PROCESS | 24108 | 08:57:09 INFO - PROCESS | 24108 | Cycle 1(1): loaded http://localhost:41717/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41717/tests/dromaeo/cssquery-mootools.html) 08:57:09 INFO - PROCESS | 24108 | RSS: Main: 246628352 08:57:09 INFO - PROCESS | 24108 | 09:00:11 INFO - PROCESS | 24108 | Cycle 1(1): loaded http://localhost:41717/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41717/tests/dromaeo/cssquery-prototype.html) 09:00:12 INFO - PROCESS | 24108 | RSS: Main: 225898496 09:00:12 INFO - PROCESS | 24108 | 09:03:15 INFO - PROCESS | 24108 | Cycle 1(1): loaded http://localhost:41717/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41717/tests/dromaeo/cssquery-yui.html) 09:03:15 INFO - PROCESS | 24108 | RSS: Main: 208642048 09:03:15 INFO - PROCESS | 24108 | 09:06:18 INFO - PROCESS | 24108 | Cycle 1(1): loaded http://localhost:41717/tests/dromaeo/cssquery-yui.html (next: http://localhost:41717/tests/dromaeo/cssquery-dojo.html) 09:06:18 INFO - PROCESS | 24108 | RSS: Main: 264695808 09:06:18 INFO - PROCESS | 24108 | 09:06:18 INFO - PROCESS | 24108 | __start_tp_report 09:06:18 INFO - PROCESS | 24108 | _x_x_mozilla_page_load 09:06:18 INFO - PROCESS | 24108 | _x_x_mozilla_page_load_details 09:06:18 INFO - PROCESS | 24108 | |i|pagename|runs| 09:06:18 INFO - PROCESS | 24108 | |0;dojo.html;2633.144228125859;2692.1923422973105;2693.070890542762;2706.729327067292;2729.4950434169673;4571.428571428572;4648.674592778507;4677.251639737643;4695.788689508971;4703.05938812238;4709.152352576535;4725.220338644128;4757.26262429324;4759.666823322369;4761.285807128932;4245.7240279381895;4328.982689068066;4384.7149935254265;4429.867103986886;4452.220861349267;4233.640140588053;4320.1143765527995;4380.58384453478;4397.032652816375;4398.120375924812;4279.144171165748;4295.91408171838;4361.280388735855;4370.147821174872;4392.231359512072;4318.5033721121845;4320.049589090395;4327.0480494291205;4328.935065974013;4375.124975005012;4301.354796780477;4312.202242585132;4317.201317756194;4342.240107981091;4354.782260886943;4543;4639.095376401603;4688.718676879398;4706.905861882778;4718.693284936468;5058.949410505921;5064.037832811754;5074.13739664258;5115.718635475047;5116;4923.286123512106;5111.514406131411;5112.156494178456;5116.692998420107;5121.923171152435;4737.147313483571;4766.022965292107;4820.517948205152;4831.251156070814;4833.3958255218095;5226.529612334832;5232.189010703347;5234.816781412632;5236.005159019774;5243.397009343974;4809.062232864558;5001.624878134155;5014.648974571745;5019.272205530177;5064.366954130734;5011.874703132451;5065.797368105308;5084.059449001872;5094.057599344059;5105.744712764347;5048.924266136011;5052.292679024939;5060.038592667382;5064.164412871909;5111.284420181178;4919.581835543947;5047.2429135629945;5055.848324550196;5058;5060.266261392151;4221.282381995068;4265.0403659177055;4269.893252668646;4271.8718438446895;4274.20927128476;3747.4191500317493;3797.050737315671;3811.6569508744346;3812.1232116612778;3813.3326667833016;4348.9565104349185;4381.715188512737;4383.145286669069;4402.669799764966;4429.424174857312;4977.32806071183;4987.551120399182;4989.151844186497;4990.650654454226;5045.672031317952;4278.4010238566625;4310.676699247569;4316.5467625899455;4362.21480133579;4371.213181627274;4592.377907584776;4593.54064593538;4594.816207351735;4595.655325850575;4637.25803871379;4788.664793464424;4794.137055330074;4815.181419158681;4857.635677324215;4857.878553036202;4934.457209707001;5041.873953151201;5099.821506247264;5109.437961824271;5111.974440127776;4784.4497882742535;4801.1117943180625;4803.807847686193;4823.879403014953;4848.636352273523;5011.810925727984;5012.824551140692;5013.273075403973;5013.874653133701;5020.272060551127;4905.5094490550655;5031.949680503149;5129.102407078821;5131.846044618667;5143.665661731976;4993.375828021497;4994.1260279450225;4997.125503037027;5002.624803139852;5049.697018178774;4991.276264941635;5005.599552035901;5006.123928312603;5007.899842003212;5060.063888180698;4723.740194289209;4809.0862736080035;4877;4908.779104940215;4927.852164435073;4910.042541704476;4929.728864912321;4937.950620493749;4944.381952255968;4990.900181996267;4692.601128904082;4829.106615276185;4832.275158726219;4832.661713680009;4845.370101886873 09:06:18 INFO - PROCESS | 24108 | |1;ext.html;526.8972550352682;538.2545174932718;542.7394850471776;555.0259294937384;558.3774091887544;27595.862020689892;38580.61419385809;39147.60852391475;39191.412128818054;39212.21575568487;41645;42395.57604423955;42397.57602423975;42414.57585424145;42418.787906060505;7748.883766743504;7938.761837144895;7939;7940.642671079815;7943.285104340608;7802.804929876742;7920.445568810185;7921.56431396273;7923.9207607924045;7926.524408535477;7885.172056934025;7957.761267161965;7965.60171991401;7967.362610991136;7968.8406231875615;7849.529028258323;7910.762677119696;7913;7918.564478953655;7923.286904178594;7678.923210767876;7811.960940195319;7814;7815;7819.452638315321;39624.60375396238;39994.800025999975;40139.59860401388;40168.59831401678;40178.799106004284;3154.779165458419;3156.573862528552;3284.343131373711;3361.2941282330494;3543.4153364694794;29215.70784292151;29595.556066659017;29664.70335296641;29797.30098348957;30751;3396.371671240828;3402.3195360927666;3428.5542879425766;3430.3139372125424;3549.254656522108;244526;245136;245390;247039;247526;43201.56798432038;56899.43100569024;57549.13676294859;57648.423515764305;57800.71099644475;40991.795041024605;41533.1693366131;41546.58453415427;41557.792211039356;41606;13208.33958302081;13408.463661453628;13409.329533523285;13424.798628020588;13428.798568021488;9762;9825.705228843146;9826.115649591571;9835;9844.704658860246;14763.48327808543;14813.777793333109;14850.2574871256;14968.101913885203;15085.396584136512;5718.456746609066;5811.506021988093;5853.853653658607;5937.52499800015;5951.672658003765;862.8101817600118;914.9679761208325;941.0166376136954;1018.3380802478448;1039.8180318444242;27045;28017.43965120727;28458.430831383255;28471.71528284732;28541;994.5922171909482;996.9052939970691;1011.3476807459148;1036.9688909332733;1047.2983101322131;14151.15093094397;14544.709105818036;14769.852301477062;14792.556223313319;14853.628659283388;284722;444546;452652;454690;455541;48047.75976120097;48391;48756.26865597019;48785;48808.511914881106;1071.839224116373;1154.32472003877;1219.16487206264;1238.5912648825865;1250.787366147757;26169.60745588856;27995;28573.857130714212;28677;28791.5681264777;38029.809850950565;40139.598604014755;40217.79891100526;40320.983950801754;40331.59668403278;217737;219663;219706;219993;220004;27689.58465622977;31945.6805431952;32336;32420.189495262806;32492.675073248964;35116.29767404689;35754.10614734652;36467;36690.63309366872;36883.262334753694;30884.382312354075;31011;32832.67167328296;33922.660773392934;34247.657523424445;34135.146621334665;34255.0606680225;34255.82872085624;34404;34470;34254;34745.478817817246;37546;37677.81161094177;38678.2264354717;28527.886316167802;32139.143302803812;32221.35557288888;32486.51270230901;32575.674243257265;24828.751712483365;24898.50202995966;24901.626475603243;24976.25071247793;25152.62271065972 09:06:18 INFO - PROCESS | 24108 | |2;jquery.html;347.73969200198707;351.371045827968;354.3055611002433;357.77638975640224;359.2294528236932;15810.84189158108;16312;16875.999999999985;17599.472015839547;17616.207270672818;15703.21483925805;15951.52145435636;16268.674626507493;16275.348986040544;16297.429589964353;4549.385832912564;4720.315554244632;4721.150192965265;5084.720340381277;5337.306150200468;5233.319668443097;5236.240745091959;5253.527182553569;5272.23552584875;5273.815416460425;4966.776495057731;5229.424763276036;5240.161574148137;5247.160454327309;5249.4750524947585;5075.568576670988;5112.156494178456;5143.228515722634;5150.459201783834;5154.768035438396;4974.10466116099;4980.77586508608;4989;4992.775325110379;4993.151164302078;12404;17904;18393.448196554124;18523.44429667112;18537.258509659598;1810.7374430707605;1906.2470324221854;2148.516583768655;2273.863068465767;2441.987790061056;9314.115159059878;9352.158305752448;11228.719282017933;12181.208221465577;13171.802422963663;1729.6800091982898;1771.0133523250781;1783.8751287409757;1812.8368446839715;1853.0364210610542;56364.43635563633;58362;58505.414945850425;58872.87889847712;62297;10112;10133.61859962908;10207.387556746618;10291.53688084038;10486.213533984981;13057.21656700601;13078.869211307765;13135.34323283832;13145.868541314465;13174.538891138764;6825.931740682529;7019.613921234381;7187.89218161728;7188.353048225685;7269.781906542812;6592.30780768022;6766.086578311963;6777.93222067773;6827.2490026098085;6905.274946130685;4343.609075183185;4363.694541382136;4387;4417.226985277628;4433.290673492225;1683.8652907767348;1755.2013833705632;1766.4170823628172;1795.1742198588533;1835.4585397307826;841.5371545649868;906.7370462565782;935.6865450074165;947.7583216279943;959;15366.136885805632;16145.192740362934;16189.02865828054;16302;16746.4138755143;844.2444012608681;857.7512521368858;871.6644092024616;873.2053831013747;882.3602887906345;9105.954470227607;9441.339106262632;9455.14903658674;9480.762980925532;9504.95247523758;397365;400328;400459;409041;410444;69781;69922.30077699259;70136.64931675309;70599.29400706029;71343;915.345527947534;925.4817302310728;953.9475328856979;968.7917097824002;970.7233438470003;11810.291382517076;14129.929350353183;14569.271536423348;14642.926785366006;14819.184944828137;30747.231319217197;31680.36639267248;31701;31997;32216.83891580527;36820.63179368279;36837;36973;37379;37724.81137594295;7202.027726256888;7211.8557628848175;7264.273572642694;7354.485186036926;7557.659905304385;9605.47169905662;10423.68728938133;10905.509252083833;11083.390413527011;11375.943120284677;9332.113449222314;9379;9572.377795443273;9901.702948911545;10183.949080254552;9601.47191904452;9758.121769040821;9758.902410976083;9838.557264922953;9841.557129929313;9977;10007.549660265451;10269.794604107727;10422.270441069053;10499.790004200026;7193.244709305448;7291.234420385996;7391.260873912781;7422.665980030803;7639.732609358646;8101.756947291591;10223;10301.330413523097;10363.740906477398;10430.165586753194 09:06:18 INFO - PROCESS | 24108 | |3;mootools.html;1269.4160686084401;1357.1856885868478;1365.7405093032323;1460.7516722157231;1677.2536221381483;6845.383915447609;7022.36798688118;7029.472789540786;7032.64836758162;7037.859242815153;6970.16358037035;7138.571685698848;7144.249853765357;7146.213916469184;7157.2127066022695;1899.4301709487167;2169.8915054247304;2177.379446857642;2204.889755512226;2224.6996655451467;2194.58302922445;2207.23850271656;2209.994452524106;2210.7568167501563;2212.3362991102604;2120.4168853565316;2190.321000489845;2192.473806286496;2196.3410976707005;2196.670499425083;2159.8164156046832;2177.096504950444;2184.6176919039185;2213.557288542298;2216.4791274050585;2181.476445653048;2196.901139448729;2203.3389983005036;2204.2946257197705;2205.4155648753094;7137.500374973754;7161.104861892263;7182.569045857265;7185.065941427633;7206.207317195104;4422.181896349153;4523.773811309421;4538.1377538267625;4541.409616749835;4554.954450455486;2956.9556456653168;3005.6693763685976;3055.3736484020947;3069.217349575866;3110.4712198926236;946.8532377481501;949.7625593601599;963.3016063354012;983.9606415743433;986.4623780039896;9759.951200243953;9770.413775173442;9778.90221097787;9782.657606983721;9804.558794854249;4026.275270451347;4149.8962525937095;4205.3271476563605;4207.074443622399;4207.621314081747;8494.193051660082;8509.234168924826;8522.616482258314;8524.190201930807;8534.189252021048;3951.565327813938;4541.68208225421;4563.612092972135;4572.337011133367;4573.245414506569;4012.35802271641;4055.4727885374714;4080.2451546464;4096.201240758023;4097.201045796041;3500.4224302990233;3560.1633616100194;3574.195805943642;3600.0999750062483;3615.096225943514;1142.7543078238218;1148.5635458525708;1157.6932112989896;1157.6989982604584;1166.7666466706692;999.9150072243941;1022.1158697726413;1158.1256151605653;1162.5698491558007;1177.9646610601696;6706.865862682816;6748.392644662004;6762.526623136333;6764.830879228059;6775.457963362919;1065.0999905080196;1123.2474242257706;1126.8929451702074;1137.374444055766;1144.1418935798151;5345.251664766935;5368.973155134199;5389.083855744533;5402.405735369106;5418.539424148913;8076.152004039609;8192.508449493049;8271.255586997198;8397.454165479225;8402.285805706584;8229.79425514367;8243.05204901444;8272.503649780912;8272.586370681442;8272.751817445365;6725.764598239038;6750.223724271772;6846.520743547904;6925.272846351161;6965.164180298397;6758.4931130166415;6778.830529236809;6804.727810887707;6830.077939478306;6850.0752398425575;7712.652930618024;7918.485298455582;7961.6019199040975;7963.323117535075;8040.115587285511;8026;8156.877646835421;8226.136255693065;8259.091499934882;8279.875801863098;5583.944160558342;5689.54483641316;5700.81397657339;6413.647249401328;6497.447716943923;6666.400023997863;6758.222804377559;6759.932400675931;6761.492888033319;6763.425108865801;6112.572119951561;6233.345498722569;6255.53083518747;6293.905591416224;6344.080108384351;5956.8808623828145;6032.939670603238;6068.393160683896;6075.817725468243;6153.938460615336;6247.5939063960695;6446.967765161145;6450.161479007699;6463.385978332051;6466.935330646822;6098.878022439615;6105.084237364254;6117.99053156242;6130.448259656474;6136.723847426966;6181.412765787243;6217.347178546368;6220.502359811295;6221.377862213923;6261.060840873905 09:06:18 INFO - PROCESS | 24108 | |4;prototype.html;302.9454698154332;303.53255985781897;306.3428944913161;312.7857417668897;314.3555710792874;5360.678359298445;5361.142217245241;5361.7587208575615;5371.91942120868;5372.274742909706;5280.943811237748;5313.867153321169;5315.123004704229;5320.334958130234;5339.786408543654;3909.2181563687236;4040.7777572233517;4158.8336466541305;4159.376093585971;4162.146759914211;4124.731892426998;4151.501819781631;4162.500499939996;4164.396162556428;4166.312558427856;3905.1994341159993;4116.176764647068;4122.814473348706;4125.566815484376;4126.319157339036;3982.203559288154;4122.525909520398;4129.256733787917;4134.73124246926;4147.253494371012;3616.710663146942;3626.873059442933;3629.6370362963494;3633.8909832705062;3637.654422829827;5057.49425057495;5063.822766203165;5067.239914012891;5069.442361340287;5083.898322033576;4767.451743049559;4782.067496838118;4787.425508938914;4792.137415265251;4792.784324705397;5615.719214039282;5627.6904770237625;5631.71841407928;5633.070543360341;5644.096944488862;3746.138388170709;4024.8591299304676;4029.6171863672903;4030.45588845505;4031.5162180538523;5772.451617096369;5846.415358464162;5856.76572937082;5864.736086876101;5884.735186916556;3932.783696896698;3933.527976642821;3934.488516492838;3934.6852251819787;3946.3291240489184;3984.9003774905277;3989.2420440116284;3993.4209539617173;3994.021464741157;3994.2211268802303;4630.189716799547;4632.768361581975;4633.050224703928;4636.83771068011;4644.396228490275;5627.352854421712;5634.690092044977;5636.379998200195;5637.23897273871;5639.8590035249445;1403.1440821099122;1425.201886943315;1425.907316024455;1426.4436869620856;1430.177647852489;890.0343127706382;932;935.8596210568469;936.5879013234155;972.0910948263396;4903.901921961541;4924.581410580069;4927.482614325516;4929.975350123226;4938.9012219755405;5799.217105690678;5801.593888427769;5802.883942321215;5805.7387417566315;5812.244408226903;4903.141950158708;4909.631777616693;4923.704577725348;4927.063857866994;4927.482614325444;3084.922876928095;3122.125804774667;3123.3597112591865;3123.54708567261;3124.8593813278458;5412.215228791803;5445.809396671177;5455.072637651609;5455.318085239345;5464.562834973272;5885.793997210163;6066.211392519032;6068.393160683896;6068.423499767515;6068.575199736064;5530.198121272393;5538.252335934597;5547;5553.111502159716;5556.277683901067;5889.852753681193;5894.616849904743;5894.793682221273;5895.852603684943;5898.941010590011;5773.22061521706;5782.335031471434;5784.161296612052;5785.450382213683;5791.478766910998;5332;5544.916826247691;5551;5553.305836770403;5554.555635549065;4004.4593979812353;4016.297147999147;4041.009952561641;4044.3124668805785;4049.716519843583;5858.414158584278;5861.6189947653265;5869.647821130746;5871.089981052944;5873;5670.149477578396;5676.68778217202;5678.432156784454;5680.715964201856;5683.090705487102;5626.43735626434;5668.914966275592;5674.659520428788;5675.57433192504;5676.9432305678065;5401.189821526802;5548.889022219614;5560.332760068818;5562.22128901946;5564.638298510584;5656.971715141398;5690.3456102548735;5694.430556944438;5700.572457065654;5705.315362156568;5544.0575102231915;5549.278593782782;5552.361478430033;5556.611037227355;5565.443455654564 09:06:18 INFO - PROCESS | 24108 | |5;yui.html;707.7133760826865;724.1780579042785;725.5066554742774;770.5299767142043;771.7723271634867;11974.28154310742;11984.921357077861;12011.2793232406;12080.395980200989;12143.39283035849;11902.940485297582;11923.821142682846;11964.641060768168;11967.820482692745;11980.760384792298;612.2469362683902;764.8393837294175;769.1961899814679;787.4566549081144;791.9406044546653;782.917793631669;784.7528028670979;787.9212078792132;788.6451097006342;789.0058526256929;828.2421584250434;830.6760363458257;831.3889291370838;831.3972370031739;831.3972370031739;654.7708302094253;808.4219782855257;819.5533434278333;821.9958900205461;822.01358369956;601.2364297342351;603.2158194347331;604.4952464691987;606.7785258380703;606.7936901453527;12212.145149839514;12251.387430628432;12277.508899644003;12278.570250041206;12298.20061695987;11581;12420.875791242062;12500.874991250153;12647.683807904785;12872.42074106658;9662.178714809179;9783.755406114833;10312.690619281433;10387.11709504693;10437.739056523571;3317.452620317669;3369.359821633882;3375.2405708715587;3416.9829150854334;3466.237427765913;44776.3283550747;45206.77396613029;45330.09339813185;45337.546624533665;45784.08431831378;9511.619535218651;9544.856827147598;9571.234301255883;9653;9659.130678238993;16806.915965420096;16833.07418091992;16979.91510042442;17038.57403564896;17046.23291951865;6606.471482281406;6617.569857959217;6641.966790166115;6727.428168605626;6897.103376561015;3749.7375183736876;3750.3436898542645;3764.153065560282;3821.102041020358;3824.2351529694174;2898.1595337352355;2903.8693258803405;2906.055531952124;2908.69458706837;2928.341123247252;473.5075521457645;517.1131509461292;526.531387065512;575.194727381669;576.0869022599227;478.2921276510784;579.547952596975;579.7217335678898;589.2134001108483;598.3806760003375;8041.919580804234;8065.112837587861;8176.713815016446;8192.590370481452;8212.876806847902;460.83179639432035;547.5400663442728;576.5790972589949;587.8324677466901;670.1622971285892;3673.504076949631;3845.750026248285;3903.082775547744;3905.5313362396696;3979.801009949491;50515.7474212634;50836.49163508391;50862.491375086516;50902.23646645303;50927.7453612737;43036.56963430388;44472;47107.528924711;47608.285875711896;47794;42000;42392.57607423948;42744.78627606842;43028.354574681405;43366.349504757454;8552.358573107167;8770.605322760364;8787.604557795043;8955.865662015205;9071.546422678972;31081;32347.838260808545;32817.17957050997;32996.50505242375;33581.664183357854;39776;40599.797001014806;41033.384499233136;41309.173816524104;41609.58390416057;9334.439933604006;9407.623695052122;9491.715248542554;9553.904460955302;9662.71011869645;11746.765064698488;11818.468168932246;12229.449674764479;12351.567695130627;12378.133530652767;9111.863322050307;10320.690379288633;10390.116840068376;10623.309484883457;11002.064824490008;10388.272820902464;10725.41010244444;10786.73033174177;10900.34597924127;11154.665360039211;11143.2199746017;11206.43967801623;11274.210805243882;11524.481398337262;11928.224665396721;9246.907530924605;9350.111739384747;9535.761605959906;9611.903880961101;9892.010798920339;9377.249820014518;9585.281103917374;9612.1829644481;9617.903820961701;9724.70825875225 09:06:18 INFO - PROCESS | 24108 | __end_tp_report 09:06:18 INFO - PROCESS | 24108 | __start_cc_report 09:06:18 INFO - PROCESS | 24108 | _x_x_mozilla_cycle_collect,878 09:06:18 INFO - PROCESS | 24108 | __end_cc_report 09:06:18 INFO - PROCESS | 24108 | __startTimestamp1458576378720__endTimestamp 09:06:18 INFO - PROCESS | 24108 | 09:06:18 INFO - PROCESS | 24108 | ------- Summary: start ------- 09:06:18 INFO - PROCESS | 24108 | Number of tests: 6 09:06:18 INFO - PROCESS | 24108 | 09:06:18 INFO - PROCESS | 24108 | [#0] dojo.html Cycles:165 Average:4684.30 Median:4820.52 stddev:487.95 (10.1%) stddev-sans-first:462.16 09:06:18 INFO - PROCESS | 24108 | Values: 2633.1 2692.2 2693.1 2706.7 2729.5 4571.4 4648.7 4677.3 4695.8 4703.1 4709.2 4725.2 4757.3 4759.7 4761.3 4245.7 4329.0 4384.7 4429.9 4452.2 4233.6 4320.1 4380.6 4397.0 4398.1 4279.1 4295.9 4361.3 4370.1 4392.2 4318.5 4320.0 4327.0 4328.9 4375.1 4301.4 4312.2 4317.2 4342.2 4354.8 4543.0 4639.1 4688.7 4706.9 4718.7 5058.9 5064.0 5074.1 5115.7 5116.0 4923.3 5111.5 5112.2 5116.7 5121.9 4737.1 4766.0 4820.5 4831.3 4833.4 5226.5 5232.2 5234.8 5236.0 5243.4 4809.1 5001.6 5014.6 5019.3 5064.4 5011.9 5065.8 5084.1 5094.1 5105.7 5048.9 5052.3 5060.0 5064.2 5111.3 4919.6 5047.2 5055.8 5058.0 5060.3 4221.3 4265.0 4269.9 4271.9 4274.2 3747.4 3797.1 3811.7 3812.1 3813.3 4349.0 4381.7 4383.1 4402.7 4429.4 4977.3 4987.6 4989.2 4990.7 5045.7 4278.4 4310.7 4316.5 4362.2 4371.2 4592.4 4593.5 4594.8 4595.7 4637.3 4788.7 4794.1 4815.2 4857.6 4857.9 4934.5 5041.9 5099.8 5109.4 5112.0 4784.4 4801.1 4803.8 4823.9 4848.6 5011.8 5012.8 5013.3 5013.9 5020.3 4905.5 5031.9 5129.1 5131.8 5143.7 4993.4 4994.1 4997.1 5002.6 5049.7 4991.3 5005.6 5006.1 5007.9 5060.1 4723.7 4809.1 4877.0 4908.8 4927.9 4910.0 4929.7 4938.0 4944.4 4990.9 4692.6 4829.1 4832.3 4832.7 4845.4 09:06:18 INFO - PROCESS | 24108 | 09:06:18 INFO - PROCESS | 24108 | [#1] ext.html Cycles:180 Average:44700.00 Median:36110.55 stddev:82005.21 (227.1%) stddev-sans-first:82168.18 09:06:18 INFO - PROCESS | 24108 | Values: 526.9 538.3 542.7 555.0 558.4 27595.9 38580.6 39147.6 39191.4 39212.2 41645.0 42395.6 42397.6 42414.6 42418.8 7748.9 7938.8 7939.0 7940.6 7943.3 7802.8 7920.4 7921.6 7923.9 7926.5 7885.2 7957.8 7965.6 7967.4 7968.8 7849.5 7910.8 7913.0 7918.6 7923.3 7678.9 7812.0 7814.0 7815.0 7819.5 39624.6 39994.8 40139.6 40168.6 40178.8 3154.8 3156.6 3284.3 3361.3 3543.4 29215.7 29595.6 29664.7 29797.3 30751.0 3396.4 3402.3 3428.6 3430.3 3549.3 244526.0 245136.0 245390.0 247039.0 247526.0 43201.6 56899.4 57549.1 57648.4 57800.7 40991.8 41533.2 41546.6 41557.8 41606.0 13208.3 13408.5 13409.3 13424.8 13428.8 9762.0 9825.7 9826.1 9835.0 9844.7 14763.5 14813.8 14850.3 14968.1 15085.4 5718.5 5811.5 5853.9 5937.5 5951.7 862.8 915.0 941.0 1018.3 1039.8 27045.0 28017.4 28458.4 28471.7 28541.0 994.6 996.9 1011.3 1037.0 1047.3 14151.2 14544.7 14769.9 14792.6 14853.6 284722.0 444546.0 452652.0 454690.0 455541.0 48047.8 48391.0 48756.3 48785.0 48808.5 1071.8 1154.3 1219.2 1238.6 1250.8 26169.6 27995.0 28573.9 28677.0 28791.6 38029.8 40139.6 40217.8 40321.0 40331.6 217737.0 219663.0 219706.0 219993.0 220004.0 27689.6 31945.7 32336.0 32420.2 32492.7 35116.3 35754.1 36467.0 36690.6 36883.3 30884.4 31011.0 32832.7 33922.7 34247.7 34135.1 34255.1 34255.8 34404.0 34470.0 34254.0 34745.5 37546.0 37677.8 38678.2 28527.9 32139.1 32221.4 32486.5 32575.7 24828.8 24898.5 24901.6 24976.3 25152.6 09:06:18 INFO - PROCESS | 24108 | 09:06:18 INFO - PROCESS | 24108 | [#2] jquery.html Cycles:180 Average:23417.31 Median:4491.34 stddev:66136.19 (1472.5%) stddev-sans-first:66299.04 09:06:18 INFO - PROCESS | 24108 | Values: 347.7 351.4 354.3 357.8 359.2 15810.8 16312.0 16876.0 17599.5 17616.2 15703.2 15951.5 16268.7 16275.3 16297.4 4549.4 4720.3 4721.2 5084.7 5337.3 5233.3 5236.2 5253.5 5272.2 5273.8 4966.8 5229.4 5240.2 5247.2 5249.5 5075.6 5112.2 5143.2 5150.5 5154.8 4974.1 4980.8 4989.0 4992.8 4993.2 12404.0 17904.0 18393.4 18523.4 18537.3 1810.7 1906.2 2148.5 2273.9 2442.0 9314.1 9352.2 11228.7 12181.2 13171.8 1729.7 1771.0 1783.9 1812.8 1853.0 56364.4 58362.0 58505.4 58872.9 62297.0 10112.0 10133.6 10207.4 10291.5 10486.2 13057.2 13078.9 13135.3 13145.9 13174.5 6825.9 7019.6 7187.9 7188.4 7269.8 6592.3 6766.1 6777.9 6827.2 6905.3 4343.6 4363.7 4387.0 4417.2 4433.3 1683.9 1755.2 1766.4 1795.2 1835.5 841.5 906.7 935.7 947.8 959.0 15366.1 16145.2 16189.0 16302.0 16746.4 844.2 857.8 871.7 873.2 882.4 9106.0 9441.3 9455.1 9480.8 9505.0 397365.0 400328.0 400459.0 409041.0 410444.0 69781.0 69922.3 70136.6 70599.3 71343.0 915.3 925.5 953.9 968.8 970.7 11810.3 14129.9 14569.3 14642.9 14819.2 30747.2 31680.4 31701.0 31997.0 32216.8 36820.6 36837.0 36973.0 37379.0 37724.8 7202.0 7211.9 7264.3 7354.5 7557.7 9605.5 10423.7 10905.5 11083.4 11375.9 9332.1 9379.0 9572.4 9901.7 10183.9 9601.5 9758.1 9758.9 9838.6 9841.6 9977.0 10007.5 10269.8 10422.3 10499.8 7193.2 7291.2 7391.3 7422.7 7639.7 8101.8 10223.0 10301.3 10363.7 10430.2 09:06:18 INFO - PROCESS | 24108 | 09:06:18 INFO - PROCESS | 24108 | [#3] mootools.html Cycles:180 Average:5062.38 Median:6133.59 stddev:2543.64 (41.5%) stddev-sans-first:2534.79 09:06:18 INFO - PROCESS | 24108 | Values: 1269.4 1357.2 1365.7 1460.8 1677.3 6845.4 7022.4 7029.5 7032.6 7037.9 6970.2 7138.6 7144.2 7146.2 7157.2 1899.4 2169.9 2177.4 2204.9 2224.7 2194.6 2207.2 2210.0 2210.8 2212.3 2120.4 2190.3 2192.5 2196.3 2196.7 2159.8 2177.1 2184.6 2213.6 2216.5 2181.5 2196.9 2203.3 2204.3 2205.4 7137.5 7161.1 7182.6 7185.1 7206.2 4422.2 4523.8 4538.1 4541.4 4555.0 2957.0 3005.7 3055.4 3069.2 3110.5 946.9 949.8 963.3 984.0 986.5 9760.0 9770.4 9778.9 9782.7 9804.6 4026.3 4149.9 4205.3 4207.1 4207.6 8494.2 8509.2 8522.6 8524.2 8534.2 3951.6 4541.7 4563.6 4572.3 4573.2 4012.4 4055.5 4080.2 4096.2 4097.2 3500.4 3560.2 3574.2 3600.1 3615.1 1142.8 1148.6 1157.7 1157.7 1166.8 999.9 1022.1 1158.1 1162.6 1178.0 6706.9 6748.4 6762.5 6764.8 6775.5 1065.1 1123.2 1126.9 1137.4 1144.1 5345.3 5369.0 5389.1 5402.4 5418.5 8076.2 8192.5 8271.3 8397.5 8402.3 8229.8 8243.1 8272.5 8272.6 8272.8 6725.8 6750.2 6846.5 6925.3 6965.2 6758.5 6778.8 6804.7 6830.1 6850.1 7712.7 7918.5 7961.6 7963.3 8040.1 8026.0 8156.9 8226.1 8259.1 8279.9 5583.9 5689.5 5700.8 6413.6 6497.4 6666.4 6758.2 6759.9 6761.5 6763.4 6112.6 6233.3 6255.5 6293.9 6344.1 5956.9 6032.9 6068.4 6075.8 6153.9 6247.6 6447.0 6450.2 6463.4 6466.9 6098.9 6105.1 6118.0 6130.4 6136.7 6181.4 6217.3 6220.5 6221.4 6261.1 09:06:18 INFO - PROCESS | 24108 | 09:06:18 INFO - PROCESS | 24108 | [#4] prototype.html Cycles:180 Average:4663.21 Median:5350.23 stddev:1384.66 (25.9%) stddev-sans-first:1349.31 09:06:18 INFO - PROCESS | 24108 | Values: 302.9 303.5 306.3 312.8 314.4 5360.7 5361.1 5361.8 5371.9 5372.3 5280.9 5313.9 5315.1 5320.3 5339.8 3909.2 4040.8 4158.8 4159.4 4162.1 4124.7 4151.5 4162.5 4164.4 4166.3 3905.2 4116.2 4122.8 4125.6 4126.3 3982.2 4122.5 4129.3 4134.7 4147.3 3616.7 3626.9 3629.6 3633.9 3637.7 5057.5 5063.8 5067.2 5069.4 5083.9 4767.5 4782.1 4787.4 4792.1 4792.8 5615.7 5627.7 5631.7 5633.1 5644.1 3746.1 4024.9 4029.6 4030.5 4031.5 5772.5 5846.4 5856.8 5864.7 5884.7 3932.8 3933.5 3934.5 3934.7 3946.3 3984.9 3989.2 3993.4 3994.0 3994.2 4630.2 4632.8 4633.1 4636.8 4644.4 5627.4 5634.7 5636.4 5637.2 5639.9 1403.1 1425.2 1425.9 1426.4 1430.2 890.0 932.0 935.9 936.6 972.1 4903.9 4924.6 4927.5 4930.0 4938.9 5799.2 5801.6 5802.9 5805.7 5812.2 4903.1 4909.6 4923.7 4927.1 4927.5 3084.9 3122.1 3123.4 3123.5 3124.9 5412.2 5445.8 5455.1 5455.3 5464.6 5885.8 6066.2 6068.4 6068.4 6068.6 5530.2 5538.3 5547.0 5553.1 5556.3 5889.9 5894.6 5894.8 5895.9 5898.9 5773.2 5782.3 5784.2 5785.5 5791.5 5332.0 5544.9 5551.0 5553.3 5554.6 4004.5 4016.3 4041.0 4044.3 4049.7 5858.4 5861.6 5869.6 5871.1 5873.0 5670.1 5676.7 5678.4 5680.7 5683.1 5626.4 5668.9 5674.7 5675.6 5676.9 5401.2 5548.9 5560.3 5562.2 5564.6 5657.0 5690.3 5694.4 5700.6 5705.3 5544.1 5549.3 5552.4 5556.6 5565.4 09:06:18 INFO - PROCESS | 24108 | 09:06:18 INFO - PROCESS | 24108 | [#5] yui.html Cycles:180 Average:12791.76 Median:23790.52 stddev:14480.01 (60.9%) stddev-sans-first:14492.19 09:06:18 INFO - PROCESS | 24108 | Values: 707.7 724.2 725.5 770.5 771.8 11974.3 11984.9 12011.3 12080.4 12143.4 11902.9 11923.8 11964.6 11967.8 11980.8 612.2 764.8 769.2 787.5 791.9 782.9 784.8 787.9 788.6 789.0 828.2 830.7 831.4 831.4 831.4 654.8 808.4 819.6 822.0 822.0 601.2 603.2 604.5 606.8 606.8 12212.1 12251.4 12277.5 12278.6 12298.2 11581.0 12420.9 12500.9 12647.7 12872.4 9662.2 9783.8 10312.7 10387.1 10437.7 3317.5 3369.4 3375.2 3417.0 3466.2 44776.3 45206.8 45330.1 45337.5 45784.1 9511.6 9544.9 9571.2 9653.0 9659.1 16806.9 16833.1 16979.9 17038.6 17046.2 6606.5 6617.6 6642.0 6727.4 6897.1 3749.7 3750.3 3764.2 3821.1 3824.2 2898.2 2903.9 2906.1 2908.7 2928.3 473.5 517.1 526.5 575.2 576.1 478.3 579.5 579.7 589.2 598.4 8041.9 8065.1 8176.7 8192.6 8212.9 460.8 547.5 576.6 587.8 670.2 3673.5 3845.8 3903.1 3905.5 3979.8 50515.7 50836.5 50862.5 50902.2 50927.7 43036.6 44472.0 47107.5 47608.3 47794.0 42000.0 42392.6 42744.8 43028.4 43366.3 8552.4 8770.6 8787.6 8955.9 9071.5 31081.0 32347.8 32817.2 32996.5 33581.7 39776.0 40599.8 41033.4 41309.2 41609.6 9334.4 9407.6 9491.7 9553.9 9662.7 11746.8 11818.5 12229.4 12351.6 12378.1 9111.9 10320.7 10390.1 10623.3 11002.1 10388.3 10725.4 10786.7 10900.3 11154.7 11143.2 11206.4 11274.2 11524.5 11928.2 9246.9 9350.1 9535.8 9611.9 9892.0 9377.2 9585.3 9612.2 9617.9 9724.7 09:06:18 INFO - PROCESS | 24108 | -------- Summary: end -------- 09:06:18 INFO - PROCESS | 24108 | 09:06:19 INFO - TEST-INFO | 24108: exit 0 09:06:19 INFO - TEST-OK | dromaeo_css | took 1117815ms 09:06:19 INFO - TEST-START | kraken 09:06:19 INFO - operating with platform_type : linux_ 09:06:19 INFO - Initialising browser for kraken test... 09:06:19 INFO - TEST-INFO | started process 24285 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwYcLAR/profile http://localhost:41717/getInfo.html) 09:06:23 INFO - PROCESS | 24285 | __metrics Screen width/height:1600/1200 09:06:23 INFO - PROCESS | 24285 | colorDepth:24 09:06:23 INFO - PROCESS | 24285 | Browser inner width/height: 1024/697 09:06:23 INFO - PROCESS | 24285 | __metrics 09:06:24 ERROR - PROCESS | 24285 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 09:06:25 INFO - TEST-INFO | 24285: exit 0 09:06:25 INFO - Browser initialized. 09:06:25 INFO - Running cycle 1/1 for kraken test... 09:06:25 INFO - TEST-INFO | started process 24368 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwYcLAR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:37 INFO - PROCESS | 24368 | RSS: Main: 157655040 09:06:37 INFO - PROCESS | 24368 | 09:06:39 INFO - PROCESS | 24368 | Cycle 1(1): loaded http://localhost:41717/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41717/tests/kraken/driver.html?testName=audio-beat-detection) 09:06:40 INFO - PROCESS | 24368 | RSS: Main: 199368704 09:06:40 INFO - PROCESS | 24368 | 09:06:42 INFO - PROCESS | 24368 | Cycle 1(1): loaded http://localhost:41717/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41717/tests/kraken/driver.html?testName=audio-dft) 09:06:43 INFO - PROCESS | 24368 | RSS: Main: 188534784 09:06:43 INFO - PROCESS | 24368 | 09:06:46 INFO - PROCESS | 24368 | Cycle 1(1): loaded http://localhost:41717/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41717/tests/kraken/driver.html?testName=audio-fft) 09:06:47 INFO - PROCESS | 24368 | RSS: Main: 173973504 09:06:47 INFO - PROCESS | 24368 | 09:06:49 INFO - PROCESS | 24368 | Cycle 1(1): loaded http://localhost:41717/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41717/tests/kraken/driver.html?testName=audio-oscillator) 09:06:49 INFO - PROCESS | 24368 | RSS: Main: 175939584 09:06:49 INFO - PROCESS | 24368 | 09:06:52 INFO - PROCESS | 24368 | Cycle 1(1): loaded http://localhost:41717/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41717/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:06:52 INFO - PROCESS | 24368 | RSS: Main: 176660480 09:06:52 INFO - PROCESS | 24368 | 09:06:55 INFO - PROCESS | 24368 | Cycle 1(1): loaded http://localhost:41717/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41717/tests/kraken/driver.html?testName=imaging-darkroom) 09:06:56 INFO - PROCESS | 24368 | RSS: Main: 177528832 09:06:56 INFO - PROCESS | 24368 | 09:06:59 INFO - PROCESS | 24368 | Cycle 1(1): loaded http://localhost:41717/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41717/tests/kraken/driver.html?testName=imaging-desaturate) 09:07:00 INFO - PROCESS | 24368 | RSS: Main: 178565120 09:07:00 INFO - PROCESS | 24368 | 09:07:03 INFO - PROCESS | 24368 | Cycle 1(1): loaded http://localhost:41717/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41717/tests/kraken/driver.html?testName=json-parse-financial) 09:07:03 INFO - PROCESS | 24368 | RSS: Main: 177864704 09:07:03 INFO - PROCESS | 24368 | 09:07:05 INFO - PROCESS | 24368 | Cycle 1(1): loaded http://localhost:41717/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41717/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:07:06 INFO - PROCESS | 24368 | RSS: Main: 187031552 09:07:06 INFO - PROCESS | 24368 | 09:07:07 INFO - PROCESS | 24368 | Cycle 1(1): loaded http://localhost:41717/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41717/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:07:08 INFO - PROCESS | 24368 | RSS: Main: 186134528 09:07:08 INFO - PROCESS | 24368 | 09:07:10 INFO - PROCESS | 24368 | Cycle 1(1): loaded http://localhost:41717/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41717/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:07:11 INFO - PROCESS | 24368 | RSS: Main: 193388544 09:07:11 INFO - PROCESS | 24368 | 09:07:13 INFO - PROCESS | 24368 | Cycle 1(1): loaded http://localhost:41717/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41717/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:07:14 INFO - PROCESS | 24368 | RSS: Main: 200380416 09:07:14 INFO - PROCESS | 24368 | 09:07:16 INFO - PROCESS | 24368 | Cycle 1(1): loaded http://localhost:41717/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41717/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:07:17 INFO - PROCESS | 24368 | RSS: Main: 200499200 09:07:17 INFO - PROCESS | 24368 | 09:07:19 INFO - PROCESS | 24368 | Cycle 1(1): loaded http://localhost:41717/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41717/tests/kraken/driver.html?testName=ai-astar) 09:07:19 INFO - PROCESS | 24368 | RSS: Main: 258957312 09:07:19 INFO - PROCESS | 24368 | 09:07:19 INFO - PROCESS | 24368 | __start_tp_report 09:07:19 INFO - PROCESS | 24368 | _x_x_mozilla_page_load 09:07:19 INFO - PROCESS | 24368 | _x_x_mozilla_page_load_details 09:07:19 INFO - PROCESS | 24368 | |i|pagename|runs| 09:07:19 INFO - PROCESS | 24368 | |0;ai-astar;111;112;108;112;114;112;100;111;111;112 09:07:19 INFO - PROCESS | 24368 | |1;audio-beat-detection;152;136;154;166;129;153;153;131;173;131 09:07:19 INFO - PROCESS | 24368 | |2;audio-dft;162;163;162;162;162;161;163;162;161;162 09:07:19 INFO - PROCESS | 24368 | |3;audio-fft;74;74;107;99;73;74;73;111;92;73 09:07:19 INFO - PROCESS | 24368 | |4;audio-oscillator;95;94;146;94;95;94;151;95;94;136 09:07:19 INFO - PROCESS | 24368 | |5;imaging-gaussian-blur;116;116;116;116;117;117;117;116;117;116 09:07:19 INFO - PROCESS | 24368 | |6;imaging-darkroom;146;146;145;145;146;146;146;146;146;145 09:07:19 INFO - PROCESS | 24368 | |7;imaging-desaturate;95;95;96;96;97;96;95;96;95;95 09:07:19 INFO - PROCESS | 24368 | |8;json-parse-financial;69;70;67;67;68;68;70;78;67;66 09:07:19 INFO - PROCESS | 24368 | |9;json-stringify-tinderbox;65;65;65;65;65;65;64;65;64;65 09:07:19 INFO - PROCESS | 24368 | |10;stanford-crypto-aes;81;81;81;82;81;81;83;81;84;82 09:07:19 INFO - PROCESS | 24368 | |11;stanford-crypto-ccm;116;125;129;116;116;118;115;116;116;116 09:07:19 INFO - PROCESS | 24368 | |12;stanford-crypto-pbkdf2;153;141;140;154;140;128;140;145;139;140 09:07:19 INFO - PROCESS | 24368 | |13;stanford-crypto-sha256-iterative;68;68;68;66;67;65;70;68;66;64 09:07:19 INFO - PROCESS | 24368 | __end_tp_report 09:07:19 INFO - PROCESS | 24368 | __start_cc_report 09:07:19 INFO - PROCESS | 24368 | _x_x_mozilla_cycle_collect,1146 09:07:19 INFO - PROCESS | 24368 | __end_cc_report 09:07:19 INFO - PROCESS | 24368 | __startTimestamp1458576439544__endTimestamp 09:07:19 INFO - PROCESS | 24368 | 09:07:19 INFO - PROCESS | 24368 | ------- Summary: start ------- 09:07:19 INFO - PROCESS | 24368 | Number of tests: 14 09:07:19 INFO - PROCESS | 24368 | 09:07:19 INFO - PROCESS | 24368 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.00 stddev:3.92 (3.5%) stddev-sans-first:4.15 09:07:19 INFO - PROCESS | 24368 | Values: 111.0 112.0 108.0 112.0 114.0 112.0 100.0 111.0 111.0 112.0 09:07:19 INFO - PROCESS | 24368 | 09:07:19 INFO - PROCESS | 24368 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:153.00 stddev:15.40 (10.1%) stddev-sans-first:16.26 09:07:19 INFO - PROCESS | 24368 | Values: 152.0 136.0 154.0 166.0 129.0 153.0 153.0 131.0 173.0 131.0 09:07:19 INFO - PROCESS | 24368 | 09:07:19 INFO - PROCESS | 24368 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 09:07:19 INFO - PROCESS | 24368 | Values: 162.0 163.0 162.0 162.0 162.0 161.0 163.0 162.0 161.0 162.0 09:07:19 INFO - PROCESS | 24368 | 09:07:19 INFO - PROCESS | 24368 | [#3] audio-fft Cycles:10 Average:85.00 Median:74.00 stddev:15.63 (21.1%) stddev-sans-first:16.07 09:07:19 INFO - PROCESS | 24368 | Values: 74.0 74.0 107.0 99.0 73.0 74.0 73.0 111.0 92.0 73.0 09:07:19 INFO - PROCESS | 24368 | 09:07:19 INFO - PROCESS | 24368 | [#4] audio-oscillator Cycles:10 Average:109.40 Median:94.00 stddev:24.38 (25.9%) stddev-sans-first:25.29 09:07:19 INFO - PROCESS | 24368 | Values: 95.0 94.0 146.0 94.0 95.0 94.0 151.0 95.0 94.0 136.0 09:07:19 INFO - PROCESS | 24368 | 09:07:19 INFO - PROCESS | 24368 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 09:07:19 INFO - PROCESS | 24368 | Values: 116.0 116.0 116.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 09:07:19 INFO - PROCESS | 24368 | 09:07:19 INFO - PROCESS | 24368 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:07:19 INFO - PROCESS | 24368 | Values: 146.0 146.0 145.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 09:07:19 INFO - PROCESS | 24368 | 09:07:19 INFO - PROCESS | 24368 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 09:07:19 INFO - PROCESS | 24368 | Values: 95.0 95.0 96.0 96.0 97.0 96.0 95.0 96.0 95.0 95.0 09:07:19 INFO - PROCESS | 24368 | 09:07:19 INFO - PROCESS | 24368 | [#8] json-parse-financial Cycles:10 Average:69.00 Median:68.50 stddev:3.43 (5.0%) stddev-sans-first:3.64 09:07:19 INFO - PROCESS | 24368 | Values: 69.0 70.0 67.0 67.0 68.0 68.0 70.0 78.0 67.0 66.0 09:07:19 INFO - PROCESS | 24368 | 09:07:19 INFO - PROCESS | 24368 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 09:07:19 INFO - PROCESS | 24368 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 64.0 65.0 64.0 65.0 09:07:19 INFO - PROCESS | 24368 | 09:07:19 INFO - PROCESS | 24368 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:81.50 stddev:1.06 (1.3%) stddev-sans-first:1.09 09:07:19 INFO - PROCESS | 24368 | Values: 81.0 81.0 81.0 82.0 81.0 81.0 83.0 81.0 84.0 82.0 09:07:19 INFO - PROCESS | 24368 | 09:07:19 INFO - PROCESS | 24368 | [#11] stanford-crypto-ccm Cycles:10 Average:118.30 Median:116.00 stddev:4.74 (4.1%) stddev-sans-first:4.95 09:07:19 INFO - PROCESS | 24368 | Values: 116.0 125.0 129.0 116.0 116.0 118.0 115.0 116.0 116.0 116.0 09:07:19 INFO - PROCESS | 24368 | 09:07:19 INFO - PROCESS | 24368 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.00 Median:140.50 stddev:7.42 (5.3%) stddev-sans-first:6.72 09:07:19 INFO - PROCESS | 24368 | Values: 153.0 141.0 140.0 154.0 140.0 128.0 140.0 145.0 139.0 140.0 09:07:19 INFO - PROCESS | 24368 | 09:07:19 INFO - PROCESS | 24368 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:68.00 stddev:1.76 (2.6%) stddev-sans-first:1.83 09:07:19 INFO - PROCESS | 24368 | Values: 68.0 68.0 68.0 66.0 67.0 65.0 70.0 68.0 66.0 64.0 09:07:19 INFO - PROCESS | 24368 | -------- Summary: end -------- 09:07:19 INFO - PROCESS | 24368 | 09:07:20 INFO - TEST-INFO | 24368: exit 0 09:07:20 INFO - TEST-OK | kraken | took 61020ms 09:07:20 INFO - SUITE-END | took 1178s 09:07:20 INFO - Completed test suite (00:19:39) 09:07:20 INFO - javascript benchmark 09:07:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2633.144228125859, 2692.1923422973105, 2693.070890542762, 2706.729327067292, 2729.4950434169673, 4571.428571428572, 4648.674592778507, 4677.251639737643, 4695.788689508971, 4703.05938812238, 4709.152352576535, 4725.220338644128, 4757.26262429324, 4759.666823322369, 4761.285807128932, 4245.7240279381895, 4328.982689068066, 4384.7149935254265, 4429.867103986886, 4452.220861349267, 4233.640140588053, 4320.1143765527995, 4380.58384453478, 4397.032652816375, 4398.120375924812, 4279.144171165748, 4295.91408171838, 4361.280388735855, 4370.147821174872, 4392.231359512072, 4318.5033721121845, 4320.049589090395, 4327.0480494291205, 4328.935065974013, 4375.124975005012, 4301.354796780477, 4312.202242585132, 4317.201317756194, 4342.240107981091, 4354.782260886943, 4543.0, 4639.095376401603, 4688.718676879398, 4706.905861882778, 4718.693284936468, 5058.949410505921, 5064.037832811754, 5074.13739664258, 5115.718635475047, 5116.0, 4923.286123512106, 5111.514406131411, 5112.156494178456, 5116.692998420107, 5121.923171152435, 4737.147313483571, 4766.022965292107, 4820.517948205152, 4831.251156070814, 4833.3958255218095, 5226.529612334832, 5232.189010703347, 5234.816781412632, 5236.005159019774, 5243.397009343974, 4809.062232864558, 5001.624878134155, 5014.648974571745, 5019.272205530177, 5064.366954130734, 5011.874703132451, 5065.797368105308, 5084.059449001872, 5094.057599344059, 5105.744712764347, 5048.924266136011, 5052.292679024939, 5060.038592667382, 5064.164412871909, 5111.284420181178, 4919.581835543947, 5047.2429135629945, 5055.848324550196, 5058.0, 5060.266261392151, 4221.282381995068, 4265.0403659177055, 4269.893252668646, 4271.8718438446895, 4274.20927128476, 3747.4191500317493, 3797.050737315671, 3811.6569508744346, 3812.1232116612778, 3813.3326667833016, 4348.9565104349185, 4381.715188512737, 4383.145286669069, 4402.669799764966, 4429.424174857312, 4977.32806071183, 4987.551120399182, 4989.151844186497, 4990.650654454226, 5045.672031317952, 4278.4010238566625, 4310.676699247569, 4316.5467625899455, 4362.21480133579, 4371.213181627274, 4592.377907584776, 4593.54064593538, 4594.816207351735, 4595.655325850575, 4637.25803871379, 4788.664793464424, 4794.137055330074, 4815.181419158681, 4857.635677324215, 4857.878553036202, 4934.457209707001, 5041.873953151201, 5099.821506247264, 5109.437961824271, 5111.974440127776, 4784.4497882742535, 4801.1117943180625, 4803.807847686193, 4823.879403014953, 4848.636352273523, 5011.810925727984, 5012.824551140692, 5013.273075403973, 5013.874653133701, 5020.272060551127, 4905.5094490550655, 5031.949680503149, 5129.102407078821, 5131.846044618667, 5143.665661731976, 4993.375828021497, 4994.1260279450225, 4997.125503037027, 5002.624803139852, 5049.697018178774, 4991.276264941635, 5005.599552035901, 5006.123928312603, 5007.899842003212, 5060.063888180698, 4723.740194289209, 4809.0862736080035, 4877.0, 4908.779104940215, 4927.852164435073, 4910.042541704476, 4929.728864912321, 4937.950620493749, 4944.381952255968, 4990.900181996267, 4692.601128904082, 4829.106615276185, 4832.275158726219, 4832.661713680009, 4845.370101886873], "unit": "score", "name": "dojo.html", "value": 4653.72562823395}, {"lowerIsBetter": false, "replicates": [526.8972550352682, 538.2545174932718, 542.7394850471776, 555.0259294937384, 558.3774091887544, 27595.862020689892, 38580.61419385809, 39147.60852391475, 39191.412128818054, 39212.21575568487, 41645.0, 42395.57604423955, 42397.57602423975, 42414.57585424145, 42418.787906060505, 7748.883766743504, 7938.761837144895, 7939.0, 7940.642671079815, 7943.285104340608, 7802.804929876742, 7920.445568810185, 7921.56431396273, 7923.9207607924045, 7926.524408535477, 7885.172056934025, 7957.761267161965, 7965.60171991401, 7967.362610991136, 7968.8406231875615, 7849.529028258323, 7910.762677119696, 7913.0, 7918.564478953655, 7923.286904178594, 7678.923210767876, 7811.960940195319, 7814.0, 7815.0, 7819.452638315321, 39624.60375396238, 39994.800025999975, 40139.59860401388, 40168.59831401678, 40178.799106004284, 3154.779165458419, 3156.573862528552, 3284.343131373711, 3361.2941282330494, 3543.4153364694794, 29215.70784292151, 29595.556066659017, 29664.70335296641, 29797.30098348957, 30751.0, 3396.371671240828, 3402.3195360927666, 3428.5542879425766, 3430.3139372125424, 3549.254656522108, 244526.0, 245136.0, 245390.0, 247039.0, 247526.0, 43201.56798432038, 56899.43100569024, 57549.13676294859, 57648.423515764305, 57800.71099644475, 40991.795041024605, 41533.1693366131, 41546.58453415427, 41557.792211039356, 41606.0, 13208.33958302081, 13408.463661453628, 13409.329533523285, 13424.798628020588, 13428.798568021488, 9762.0, 9825.705228843146, 9826.115649591571, 9835.0, 9844.704658860246, 14763.48327808543, 14813.777793333109, 14850.2574871256, 14968.101913885203, 15085.396584136512, 5718.456746609066, 5811.506021988093, 5853.853653658607, 5937.52499800015, 5951.672658003765, 862.8101817600118, 914.9679761208325, 941.0166376136954, 1018.3380802478448, 1039.8180318444242, 27045.0, 28017.43965120727, 28458.430831383255, 28471.71528284732, 28541.0, 994.5922171909482, 996.9052939970691, 1011.3476807459148, 1036.9688909332733, 1047.2983101322131, 14151.15093094397, 14544.709105818036, 14769.852301477062, 14792.556223313319, 14853.628659283388, 284722.0, 444546.0, 452652.0, 454690.0, 455541.0, 48047.75976120097, 48391.0, 48756.26865597019, 48785.0, 48808.511914881106, 1071.839224116373, 1154.32472003877, 1219.16487206264, 1238.5912648825865, 1250.787366147757, 26169.60745588856, 27995.0, 28573.857130714212, 28677.0, 28791.5681264777, 38029.809850950565, 40139.598604014755, 40217.79891100526, 40320.983950801754, 40331.59668403278, 217737.0, 219663.0, 219706.0, 219993.0, 220004.0, 27689.58465622977, 31945.6805431952, 32336.0, 32420.189495262806, 32492.675073248964, 35116.29767404689, 35754.10614734652, 36467.0, 36690.63309366872, 36883.262334753694, 30884.382312354075, 31011.0, 32832.67167328296, 33922.660773392934, 34247.657523424445, 34135.146621334665, 34255.0606680225, 34255.82872085624, 34404.0, 34470.0, 34254.0, 34745.478817817246, 37546.0, 37677.81161094177, 38678.2264354717, 28527.886316167802, 32139.143302803812, 32221.35557288888, 32486.51270230901, 32575.674243257265, 24828.751712483365, 24898.50202995966, 24901.626475603243, 24976.25071247793, 25152.62271065972], "unit": "score", "name": "ext.html", "value": 16989.382378764672}, {"lowerIsBetter": false, "replicates": [347.73969200198707, 351.371045827968, 354.3055611002433, 357.77638975640224, 359.2294528236932, 15810.84189158108, 16312.0, 16875.999999999985, 17599.472015839547, 17616.207270672818, 15703.21483925805, 15951.52145435636, 16268.674626507493, 16275.348986040544, 16297.429589964353, 4549.385832912564, 4720.315554244632, 4721.150192965265, 5084.720340381277, 5337.306150200468, 5233.319668443097, 5236.240745091959, 5253.527182553569, 5272.23552584875, 5273.815416460425, 4966.776495057731, 5229.424763276036, 5240.161574148137, 5247.160454327309, 5249.4750524947585, 5075.568576670988, 5112.156494178456, 5143.228515722634, 5150.459201783834, 5154.768035438396, 4974.10466116099, 4980.77586508608, 4989.0, 4992.775325110379, 4993.151164302078, 12404.0, 17904.0, 18393.448196554124, 18523.44429667112, 18537.258509659598, 1810.7374430707605, 1906.2470324221854, 2148.516583768655, 2273.863068465767, 2441.987790061056, 9314.115159059878, 9352.158305752448, 11228.719282017933, 12181.208221465577, 13171.802422963663, 1729.6800091982898, 1771.0133523250781, 1783.8751287409757, 1812.8368446839715, 1853.0364210610542, 56364.43635563633, 58362.0, 58505.414945850425, 58872.87889847712, 62297.0, 10112.0, 10133.61859962908, 10207.387556746618, 10291.53688084038, 10486.213533984981, 13057.21656700601, 13078.869211307765, 13135.34323283832, 13145.868541314465, 13174.538891138764, 6825.931740682529, 7019.613921234381, 7187.89218161728, 7188.353048225685, 7269.781906542812, 6592.30780768022, 6766.086578311963, 6777.93222067773, 6827.2490026098085, 6905.274946130685, 4343.609075183185, 4363.694541382136, 4387.0, 4417.226985277628, 4433.290673492225, 1683.8652907767348, 1755.2013833705632, 1766.4170823628172, 1795.1742198588533, 1835.4585397307826, 841.5371545649868, 906.7370462565782, 935.6865450074165, 947.7583216279943, 959.0, 15366.136885805632, 16145.192740362934, 16189.02865828054, 16302.0, 16746.4138755143, 844.2444012608681, 857.7512521368858, 871.6644092024616, 873.2053831013747, 882.3602887906345, 9105.954470227607, 9441.339106262632, 9455.14903658674, 9480.762980925532, 9504.95247523758, 397365.0, 400328.0, 400459.0, 409041.0, 410444.0, 69781.0, 69922.30077699259, 70136.64931675309, 70599.29400706029, 71343.0, 915.345527947534, 925.4817302310728, 953.9475328856979, 968.7917097824002, 970.7233438470003, 11810.291382517076, 14129.929350353183, 14569.271536423348, 14642.926785366006, 14819.184944828137, 30747.231319217197, 31680.36639267248, 31701.0, 31997.0, 32216.83891580527, 36820.63179368279, 36837.0, 36973.0, 37379.0, 37724.81137594295, 7202.027726256888, 7211.8557628848175, 7264.273572642694, 7354.485186036926, 7557.659905304385, 9605.47169905662, 10423.68728938133, 10905.509252083833, 11083.390413527011, 11375.943120284677, 9332.113449222314, 9379.0, 9572.377795443273, 9901.702948911545, 10183.949080254552, 9601.47191904452, 9758.121769040821, 9758.902410976083, 9838.557264922953, 9841.557129929313, 9977.0, 10007.549660265451, 10269.794604107727, 10422.270441069053, 10499.790004200026, 7193.244709305448, 7291.234420385996, 7391.260873912781, 7422.665980030803, 7639.732609358646, 8101.756947291591, 10223.0, 10301.330413523097, 10363.740906477398, 10430.165586753194], "unit": "score", "name": "jquery.html", "value": 7898.608676606983}, {"lowerIsBetter": false, "replicates": [1269.4160686084401, 1357.1856885868478, 1365.7405093032323, 1460.7516722157231, 1677.2536221381483, 6845.383915447609, 7022.36798688118, 7029.472789540786, 7032.64836758162, 7037.859242815153, 6970.16358037035, 7138.571685698848, 7144.249853765357, 7146.213916469184, 7157.2127066022695, 1899.4301709487167, 2169.8915054247304, 2177.379446857642, 2204.889755512226, 2224.6996655451467, 2194.58302922445, 2207.23850271656, 2209.994452524106, 2210.7568167501563, 2212.3362991102604, 2120.4168853565316, 2190.321000489845, 2192.473806286496, 2196.3410976707005, 2196.670499425083, 2159.8164156046832, 2177.096504950444, 2184.6176919039185, 2213.557288542298, 2216.4791274050585, 2181.476445653048, 2196.901139448729, 2203.3389983005036, 2204.2946257197705, 2205.4155648753094, 7137.500374973754, 7161.104861892263, 7182.569045857265, 7185.065941427633, 7206.207317195104, 4422.181896349153, 4523.773811309421, 4538.1377538267625, 4541.409616749835, 4554.954450455486, 2956.9556456653168, 3005.6693763685976, 3055.3736484020947, 3069.217349575866, 3110.4712198926236, 946.8532377481501, 949.7625593601599, 963.3016063354012, 983.9606415743433, 986.4623780039896, 9759.951200243953, 9770.413775173442, 9778.90221097787, 9782.657606983721, 9804.558794854249, 4026.275270451347, 4149.8962525937095, 4205.3271476563605, 4207.074443622399, 4207.621314081747, 8494.193051660082, 8509.234168924826, 8522.616482258314, 8524.190201930807, 8534.189252021048, 3951.565327813938, 4541.68208225421, 4563.612092972135, 4572.337011133367, 4573.245414506569, 4012.35802271641, 4055.4727885374714, 4080.2451546464, 4096.201240758023, 4097.201045796041, 3500.4224302990233, 3560.1633616100194, 3574.195805943642, 3600.0999750062483, 3615.096225943514, 1142.7543078238218, 1148.5635458525708, 1157.6932112989896, 1157.6989982604584, 1166.7666466706692, 999.9150072243941, 1022.1158697726413, 1158.1256151605653, 1162.5698491558007, 1177.9646610601696, 6706.865862682816, 6748.392644662004, 6762.526623136333, 6764.830879228059, 6775.457963362919, 1065.0999905080196, 1123.2474242257706, 1126.8929451702074, 1137.374444055766, 1144.1418935798151, 5345.251664766935, 5368.973155134199, 5389.083855744533, 5402.405735369106, 5418.539424148913, 8076.152004039609, 8192.508449493049, 8271.255586997198, 8397.454165479225, 8402.285805706584, 8229.79425514367, 8243.05204901444, 8272.503649780912, 8272.586370681442, 8272.751817445365, 6725.764598239038, 6750.223724271772, 6846.520743547904, 6925.272846351161, 6965.164180298397, 6758.4931130166415, 6778.830529236809, 6804.727810887707, 6830.077939478306, 6850.0752398425575, 7712.652930618024, 7918.485298455582, 7961.6019199040975, 7963.323117535075, 8040.115587285511, 8026.0, 8156.877646835421, 8226.136255693065, 8259.091499934882, 8279.875801863098, 5583.944160558342, 5689.54483641316, 5700.81397657339, 6413.647249401328, 6497.447716943923, 6666.400023997863, 6758.222804377559, 6759.932400675931, 6761.492888033319, 6763.425108865801, 6112.572119951561, 6233.345498722569, 6255.53083518747, 6293.905591416224, 6344.080108384351, 5956.8808623828145, 6032.939670603238, 6068.393160683896, 6075.817725468243, 6153.938460615336, 6247.5939063960695, 6446.967765161145, 6450.161479007699, 6463.385978332051, 6466.935330646822, 6098.878022439615, 6105.084237364254, 6117.99053156242, 6130.448259656474, 6136.723847426966, 6181.412765787243, 6217.347178546368, 6220.502359811295, 6221.377862213923, 6261.060840873905], "unit": "score", "name": "mootools.html", "value": 4209.881597287553}, {"lowerIsBetter": false, "replicates": [302.9454698154332, 303.53255985781897, 306.3428944913161, 312.7857417668897, 314.3555710792874, 5360.678359298445, 5361.142217245241, 5361.7587208575615, 5371.91942120868, 5372.274742909706, 5280.943811237748, 5313.867153321169, 5315.123004704229, 5320.334958130234, 5339.786408543654, 3909.2181563687236, 4040.7777572233517, 4158.8336466541305, 4159.376093585971, 4162.146759914211, 4124.731892426998, 4151.501819781631, 4162.500499939996, 4164.396162556428, 4166.312558427856, 3905.1994341159993, 4116.176764647068, 4122.814473348706, 4125.566815484376, 4126.319157339036, 3982.203559288154, 4122.525909520398, 4129.256733787917, 4134.73124246926, 4147.253494371012, 3616.710663146942, 3626.873059442933, 3629.6370362963494, 3633.8909832705062, 3637.654422829827, 5057.49425057495, 5063.822766203165, 5067.239914012891, 5069.442361340287, 5083.898322033576, 4767.451743049559, 4782.067496838118, 4787.425508938914, 4792.137415265251, 4792.784324705397, 5615.719214039282, 5627.6904770237625, 5631.71841407928, 5633.070543360341, 5644.096944488862, 3746.138388170709, 4024.8591299304676, 4029.6171863672903, 4030.45588845505, 4031.5162180538523, 5772.451617096369, 5846.415358464162, 5856.76572937082, 5864.736086876101, 5884.735186916556, 3932.783696896698, 3933.527976642821, 3934.488516492838, 3934.6852251819787, 3946.3291240489184, 3984.9003774905277, 3989.2420440116284, 3993.4209539617173, 3994.021464741157, 3994.2211268802303, 4630.189716799547, 4632.768361581975, 4633.050224703928, 4636.83771068011, 4644.396228490275, 5627.352854421712, 5634.690092044977, 5636.379998200195, 5637.23897273871, 5639.8590035249445, 1403.1440821099122, 1425.201886943315, 1425.907316024455, 1426.4436869620856, 1430.177647852489, 890.0343127706382, 932.0, 935.8596210568469, 936.5879013234155, 972.0910948263396, 4903.901921961541, 4924.581410580069, 4927.482614325516, 4929.975350123226, 4938.9012219755405, 5799.217105690678, 5801.593888427769, 5802.883942321215, 5805.7387417566315, 5812.244408226903, 4903.141950158708, 4909.631777616693, 4923.704577725348, 4927.063857866994, 4927.482614325444, 3084.922876928095, 3122.125804774667, 3123.3597112591865, 3123.54708567261, 3124.8593813278458, 5412.215228791803, 5445.809396671177, 5455.072637651609, 5455.318085239345, 5464.562834973272, 5885.793997210163, 6066.211392519032, 6068.393160683896, 6068.423499767515, 6068.575199736064, 5530.198121272393, 5538.252335934597, 5547.0, 5553.111502159716, 5556.277683901067, 5889.852753681193, 5894.616849904743, 5894.793682221273, 5895.852603684943, 5898.941010590011, 5773.22061521706, 5782.335031471434, 5784.161296612052, 5785.450382213683, 5791.478766910998, 5332.0, 5544.916826247691, 5551.0, 5553.305836770403, 5554.555635549065, 4004.4593979812353, 4016.297147999147, 4041.009952561641, 4044.3124668805785, 4049.716519843583, 5858.414158584278, 5861.6189947653265, 5869.647821130746, 5871.089981052944, 5873.0, 5670.149477578396, 5676.68778217202, 5678.432156784454, 5680.715964201856, 5683.090705487102, 5626.43735626434, 5668.914966275592, 5674.659520428788, 5675.57433192504, 5676.9432305678065, 5401.189821526802, 5548.889022219614, 5560.332760068818, 5562.22128901946, 5564.638298510584, 5656.971715141398, 5690.3456102548735, 5694.430556944438, 5700.572457065654, 5705.315362156568, 5544.0575102231915, 5549.278593782782, 5552.361478430033, 5556.611037227355, 5565.443455654564], "unit": "score", "name": "prototype.html", "value": 4215.45183643833}, {"lowerIsBetter": false, "replicates": [707.7133760826865, 724.1780579042785, 725.5066554742774, 770.5299767142043, 771.7723271634867, 11974.28154310742, 11984.921357077861, 12011.2793232406, 12080.395980200989, 12143.39283035849, 11902.940485297582, 11923.821142682846, 11964.641060768168, 11967.820482692745, 11980.760384792298, 612.2469362683902, 764.8393837294175, 769.1961899814679, 787.4566549081144, 791.9406044546653, 782.917793631669, 784.7528028670979, 787.9212078792132, 788.6451097006342, 789.0058526256929, 828.2421584250434, 830.6760363458257, 831.3889291370838, 831.3972370031739, 831.3972370031739, 654.7708302094253, 808.4219782855257, 819.5533434278333, 821.9958900205461, 822.01358369956, 601.2364297342351, 603.2158194347331, 604.4952464691987, 606.7785258380703, 606.7936901453527, 12212.145149839514, 12251.387430628432, 12277.508899644003, 12278.570250041206, 12298.20061695987, 11581.0, 12420.875791242062, 12500.874991250153, 12647.683807904785, 12872.42074106658, 9662.178714809179, 9783.755406114833, 10312.690619281433, 10387.11709504693, 10437.739056523571, 3317.452620317669, 3369.359821633882, 3375.2405708715587, 3416.9829150854334, 3466.237427765913, 44776.3283550747, 45206.77396613029, 45330.09339813185, 45337.546624533665, 45784.08431831378, 9511.619535218651, 9544.856827147598, 9571.234301255883, 9653.0, 9659.130678238993, 16806.915965420096, 16833.07418091992, 16979.91510042442, 17038.57403564896, 17046.23291951865, 6606.471482281406, 6617.569857959217, 6641.966790166115, 6727.428168605626, 6897.103376561015, 3749.7375183736876, 3750.3436898542645, 3764.153065560282, 3821.102041020358, 3824.2351529694174, 2898.1595337352355, 2903.8693258803405, 2906.055531952124, 2908.69458706837, 2928.341123247252, 473.5075521457645, 517.1131509461292, 526.531387065512, 575.194727381669, 576.0869022599227, 478.2921276510784, 579.547952596975, 579.7217335678898, 589.2134001108483, 598.3806760003375, 8041.919580804234, 8065.112837587861, 8176.713815016446, 8192.590370481452, 8212.876806847902, 460.83179639432035, 547.5400663442728, 576.5790972589949, 587.8324677466901, 670.1622971285892, 3673.504076949631, 3845.750026248285, 3903.082775547744, 3905.5313362396696, 3979.801009949491, 50515.7474212634, 50836.49163508391, 50862.491375086516, 50902.23646645303, 50927.7453612737, 43036.56963430388, 44472.0, 47107.528924711, 47608.285875711896, 47794.0, 42000.0, 42392.57607423948, 42744.78627606842, 43028.354574681405, 43366.349504757454, 8552.358573107167, 8770.605322760364, 8787.604557795043, 8955.865662015205, 9071.546422678972, 31081.0, 32347.838260808545, 32817.17957050997, 32996.50505242375, 33581.664183357854, 39776.0, 40599.797001014806, 41033.384499233136, 41309.173816524104, 41609.58390416057, 9334.439933604006, 9407.623695052122, 9491.715248542554, 9553.904460955302, 9662.71011869645, 11746.765064698488, 11818.468168932246, 12229.449674764479, 12351.567695130627, 12378.133530652767, 9111.863322050307, 10320.690379288633, 10390.116840068376, 10623.309484883457, 11002.064824490008, 10388.272820902464, 10725.41010244444, 10786.73033174177, 10900.34597924127, 11154.665360039211, 11143.2199746017, 11206.43967801623, 11274.210805243882, 11524.481398337262, 11928.224665396721, 9246.907530924605, 9350.111739384747, 9535.761605959906, 9611.903880961101, 9892.010798920339, 9377.249820014518, 9585.281103917374, 9612.1829644481, 9617.903820961701, 9724.70825875225], "unit": "score", "name": "yui.html", "value": 5907.712090970985}], "name": "dromaeo_css", "value": 6348.6916635827065}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 108.0, 112.0, 114.0, 112.0, 100.0, 111.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [152.0, 136.0, 154.0, 166.0, 129.0, 153.0, 153.0, 131.0, 173.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 162.0, 162.0, 162.0, 161.0, 163.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 107.0, 99.0, 73.0, 74.0, 73.0, 111.0, 92.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.0}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 146.0, 94.0, 95.0, 94.0, 151.0, 95.0, 94.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.4}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 67.0, 67.0, 68.0, 68.0, 70.0, 78.0, 67.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 69.0}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.8}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 81.0, 82.0, 81.0, 81.0, 83.0, 81.0, 84.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.7}, {"lowerIsBetter": true, "replicates": [116.0, 125.0, 129.0, 116.0, 116.0, 118.0, 115.0, 116.0, 116.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.3}, {"lowerIsBetter": true, "replicates": [153.0, 141.0, 140.0, 154.0, 140.0, 128.0, 140.0, 145.0, 139.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 66.0, 67.0, 65.0, 70.0, 68.0, 66.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1514.9999999999998}]} 09:07:20 INFO - Return code: 0 09:07:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:07:20 ERROR - # TBPL SUCCESS # 09:07:20 INFO - Running post-action listener: _resource_record_post_action 09:07:20 INFO - Running post-run listener: _resource_record_post_run 09:07:21 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 520720384; Read time: 0; Write time: 388156 09:07:21 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 232620032; Read time: 0; Write time: 187600 09:07:21 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288100352; Read time: 0; Write time: 200556 09:07:21 INFO - Running post-run listener: _upload_blobber_files 09:07:21 INFO - Blob upload gear active. 09:07:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:07:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:07:21 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'] 09:07:21 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 09:07:22 INFO - (blobuploader) - INFO - Open directory for files ... 09:07:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:07:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:07:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:24 INFO - (blobuploader) - INFO - Done attempting. 09:07:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:07:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:07:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:25 INFO - (blobuploader) - INFO - Done attempting. 09:07:25 INFO - (blobuploader) - INFO - Iteration through files over. 09:07:25 INFO - Return code: 0 09:07:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:07:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:07:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cd6af926178c48c113024452a3c759c9a5685942cfbb8d919ffdc71129c8b65419e67f19abc5496a6d3c71d146f50ffbe954a3cbf8b7c032903b9d175df12840", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c39f4904a2a033f5dd8ae76df58da50ba5484805ba78252e5482f52378297de6975516376fa21fc096f055d0f595c2a4605b5b7b926b3e379c567fd6d9c5e23"} 09:07:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:07:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:07:25 INFO - Contents: 09:07:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cd6af926178c48c113024452a3c759c9a5685942cfbb8d919ffdc71129c8b65419e67f19abc5496a6d3c71d146f50ffbe954a3cbf8b7c032903b9d175df12840", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c39f4904a2a033f5dd8ae76df58da50ba5484805ba78252e5482f52378297de6975516376fa21fc096f055d0f595c2a4605b5b7b926b3e379c567fd6d9c5e23"} 09:07:25 INFO - Running post-run listener: copy_logs_to_upload_dir 09:07:25 INFO - Copying logs to upload dir... 09:07:25 INFO - mkdir: /builds/slave/test/build/upload/logs 09:07:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.012290 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-03-21 09:07:24.693550) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 09:07:24.697270) ========= 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=4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838 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/cd6af926178c48c113024452a3c759c9a5685942cfbb8d919ffdc71129c8b65419e67f19abc5496a6d3c71d146f50ffbe954a3cbf8b7c032903b9d175df12840", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c39f4904a2a033f5dd8ae76df58da50ba5484805ba78252e5482f52378297de6975516376fa21fc096f055d0f595c2a4605b5b7b926b3e379c567fd6d9c5e23"} build_url:https://queue.taskcluster.net/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011374 build_url: 'https://queue.taskcluster.net/v1/task/cOE7J1J5Tpmf93jMCbzjzQ/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/cd6af926178c48c113024452a3c759c9a5685942cfbb8d919ffdc71129c8b65419e67f19abc5496a6d3c71d146f50ffbe954a3cbf8b7c032903b9d175df12840", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0c39f4904a2a033f5dd8ae76df58da50ba5484805ba78252e5482f52378297de6975516376fa21fc096f055d0f595c2a4605b5b7b926b3e379c567fd6d9c5e23"}' ========= master_lag: 0.10 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-21 09:07:24.808679) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 09:07:24.809010) ========= 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=4ac8d263c7293b36a1be1aed000001be-1458575208.345098-949854838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-21 09:07:24.942542) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 09:07:24.942852) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-21 09:07:24.943161) ========= ========= Total master_lag: 0.44 =========