builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1449577764.24 results: success (0) buildid: 20151208030125 builduid: 045c91b50a4c4729baca9164489995a1 revision: 2bdd9ec79799eff3ceec0a318f5a0632d918a527 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-08 04:29:24.240351) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-08 04:29:24.240909) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-08 04:29:24.241199) ========= 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=20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006306 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-08 04:29:24.278735) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-08 04:29:24.279020) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-08 04:29:24.300731) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 04:29:24.300991) ========= 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=20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004603 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 04:29:24.359164) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-08 04:29:24.359728) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-08 04:29:24.360352) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 04:29:24.360897) ========= 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=20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-08 04:29:24-- 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% 14.8M=0.001s 2015-12-08 04:29:24 (14.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108733 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 04:29:24.484830) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 04:29:24.485113) ========= 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=20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019443 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 04:29:24.534963) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-08 04:29:24.535272) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2bdd9ec79799eff3ceec0a318f5a0632d918a527 --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 2bdd9ec79799eff3ceec0a318f5a0632d918a527 --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=20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-08 04:29:24,957 truncating revision to first 12 chars 2015-12-08 04:29:24,957 Setting DEBUG logging. 2015-12-08 04:29:24,957 attempt 1/10 2015-12-08 04:29:24,957 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2bdd9ec79799?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-08 04:29:26,203 unpacking tar archive at: mozilla-central-2bdd9ec79799/testing/mozharness/ program finished with exit code 0 elapsedTime=1.523712 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-08 04:29:26.073329) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-08 04:29:26.073650) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-08 04:29:26.084206) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-08 04:29:26.084475) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-08 04:29:26.084856) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2015-12-08 04:29:26.085145) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --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', '--system-bits', '64', '--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=20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:29:26 INFO - MultiFileLogger online at 20151208 04:29:26 in /builds/slave/test 04:29:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:29:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:29:26 INFO - {'append_to_log': False, 04:29:26 INFO - 'base_work_dir': '/builds/slave/test', 04:29:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:29:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:29:26 INFO - 'branch': 'Firefox-Non-PGO', 04:29:26 INFO - 'buildbot_json_path': 'buildprops.json', 04:29:26 INFO - 'config_files': ('talos/linux_config.py',), 04:29:26 INFO - 'default_actions': ('clobber', 04:29:26 INFO - 'read-buildbot-config', 04:29:26 INFO - 'download-and-extract', 04:29:26 INFO - 'populate-webroot', 04:29:26 INFO - 'create-virtualenv', 04:29:26 INFO - 'install', 04:29:26 INFO - 'run-tests'), 04:29:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:29:26 INFO - 'download_minidump_stackwalk': True, 04:29:26 INFO - 'download_symbols': 'ondemand', 04:29:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:29:26 INFO - 'tooltool.py': '/tools/tooltool.py', 04:29:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:29:26 INFO - '/tools/misc-python/virtualenv.py')}, 04:29:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:29:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:29:26 INFO - 'installer_path': 'installer.exe', 04:29:26 INFO - 'log_level': 'info', 04:29:26 INFO - 'log_name': 'talos', 04:29:26 INFO - 'log_to_console': True, 04:29:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:29:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:29:26 INFO - 'opt_config_files': (), 04:29:26 INFO - 'pip_index': False, 04:29:26 INFO - 'sps_profile': False, 04:29:26 INFO - 'sps_profile_interval': 0, 04:29:26 INFO - 'suite': 'dromaeojs', 04:29:26 INFO - 'system_bits': '64', 04:29:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:29:26 INFO - 'title': 'talos-linux64-ix-065', 04:29:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:29:26 INFO - 'use_talos_json': True, 04:29:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:29:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:29:26 INFO - 'work_dir': 'build'} 04:29:26 INFO - ##### 04:29:26 INFO - ##### Running clobber step. 04:29:26 INFO - ##### 04:29:26 INFO - Running pre-action listener: _resource_record_pre_action 04:29:26 INFO - Running main action method: clobber 04:29:26 INFO - rmtree: /builds/slave/test/build 04:29:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:29:27 INFO - Running post-action listener: _resource_record_post_action 04:29:27 INFO - ##### 04:29:27 INFO - ##### Running read-buildbot-config step. 04:29:27 INFO - ##### 04:29:27 INFO - Running pre-action listener: _resource_record_pre_action 04:29:27 INFO - Running main action method: read_buildbot_config 04:29:27 INFO - Using buildbot properties: 04:29:27 INFO - { 04:29:27 INFO - "properties": { 04:29:27 INFO - "buildnumber": 234, 04:29:27 INFO - "product": "firefox", 04:29:27 INFO - "script_repo_revision": "production", 04:29:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:29:27 INFO - "repository": "", 04:29:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:29:27 INFO - "buildid": "20151208030125", 04:29:27 INFO - "slavename": "talos-linux64-ix-065", 04:29:27 INFO - "pgo_build": "False", 04:29:27 INFO - "basedir": "/builds/slave/test", 04:29:27 INFO - "project": "", 04:29:27 INFO - "platform": "ubuntu64_hw", 04:29:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:29:27 INFO - "slavebuilddir": "test", 04:29:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:29:27 INFO - "branch": "mozilla-central", 04:29:27 INFO - "repo_path": "mozilla-central", 04:29:27 INFO - "stage_platform": "linux64", 04:29:27 INFO - "builduid": "045c91b50a4c4729baca9164489995a1", 04:29:27 INFO - "revision": "2bdd9ec79799eff3ceec0a318f5a0632d918a527" 04:29:27 INFO - }, 04:29:27 INFO - "sourcestamp": { 04:29:27 INFO - "repository": "", 04:29:27 INFO - "hasPatch": false, 04:29:27 INFO - "project": "", 04:29:27 INFO - "branch": "mozilla-central-linux64-talos", 04:29:27 INFO - "changes": [ 04:29:27 INFO - { 04:29:27 INFO - "category": null, 04:29:27 INFO - "files": [ 04:29:27 INFO - { 04:29:27 INFO - "url": null, 04:29:27 INFO - "name": "https://queue.taskcluster.net/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:29:27 INFO - } 04:29:27 INFO - ], 04:29:27 INFO - "repository": "", 04:29:27 INFO - "rev": "2bdd9ec79799eff3ceec0a318f5a0632d918a527", 04:29:27 INFO - "who": "cbook@mozilla.com", 04:29:27 INFO - "when": 1449577690, 04:29:27 INFO - "number": 7050842, 04:29:27 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 04:29:27 INFO - "project": "", 04:29:27 INFO - "at": "Tue 08 Dec 2015 04:28:10", 04:29:27 INFO - "branch": "mozilla-central-linux64-talos", 04:29:27 INFO - "revlink": "", 04:29:27 INFO - "properties": [ 04:29:27 INFO - [ 04:29:27 INFO - "buildid", 04:29:27 INFO - "20151208030125", 04:29:27 INFO - "Change" 04:29:27 INFO - ], 04:29:27 INFO - [ 04:29:27 INFO - "builduid", 04:29:27 INFO - "045c91b50a4c4729baca9164489995a1", 04:29:27 INFO - "Change" 04:29:27 INFO - ], 04:29:27 INFO - [ 04:29:27 INFO - "pgo_build", 04:29:27 INFO - "False", 04:29:27 INFO - "Change" 04:29:27 INFO - ] 04:29:27 INFO - ], 04:29:27 INFO - "revision": "2bdd9ec79799eff3ceec0a318f5a0632d918a527" 04:29:27 INFO - } 04:29:27 INFO - ], 04:29:27 INFO - "revision": "2bdd9ec79799eff3ceec0a318f5a0632d918a527" 04:29:27 INFO - } 04:29:27 INFO - } 04:29:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:29:27 INFO - Running post-action listener: _resource_record_post_action 04:29:27 INFO - ##### 04:29:27 INFO - ##### Running download-and-extract step. 04:29:27 INFO - ##### 04:29:27 INFO - Running pre-action listener: _resource_record_pre_action 04:29:27 INFO - Running main action method: download_and_extract 04:29:27 INFO - mkdir: /builds/slave/test/build/tests 04:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:27 INFO - https://queue.taskcluster.net/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:29:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/test_packages.json 04:29:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/test_packages.json 04:29:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:29:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:29:37 INFO - Downloaded 1302 bytes. 04:29:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:29:37 INFO - Using the following test package requirements: 04:29:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:29:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:29:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:29:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:29:37 INFO - u'jsshell-linux-x86_64.zip'], 04:29:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:29:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:29:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:29:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:29:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:29:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:29:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:29:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:29:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:29:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:29:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:29:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:29:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:29:37 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')]} 04:29:37 INFO - https://queue.taskcluster.net/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:29:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:29:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:29:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:29:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:29:48 INFO - Downloaded 21860094 bytes. 04:29:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:29:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:29:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:29:49 INFO - Return code: 0 04:29:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:49 INFO - https://queue.taskcluster.net/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:29:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:29:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:29:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:29:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:29:50 INFO - Downloaded 21860094 bytes. 04:29:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:29:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:29:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:29:51 INFO - Return code: 0 04:29: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')]} 04:29:51 INFO - https://queue.taskcluster.net/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:29:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:29:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:29:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:29:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:29:52 INFO - Downloaded 11132038 bytes. 04:29:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 04:29:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:29:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:29:53 INFO - Return code: 0 04:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:29:53 INFO - https://queue.taskcluster.net/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:29:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:29:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:29:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:29:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:29:54 INFO - Downloaded 57729338 bytes. 04:29:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:29:54 INFO - mkdir: /builds/slave/test/properties 04:29:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:29:54 INFO - Writing to file /builds/slave/test/properties/build_url 04:29:54 INFO - Contents: 04:29:54 INFO - build_url:https://queue.taskcluster.net/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:29:54 INFO - Running post-action listener: _resource_record_post_action 04:29:54 INFO - Running post-action listener: set_extra_try_arguments 04:29:54 INFO - ##### 04:29:54 INFO - ##### Running populate-webroot step. 04:29:54 INFO - ##### 04:29:54 INFO - Running pre-action listener: _resource_record_pre_action 04:29:54 INFO - Running main action method: populate_webroot 04:29:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:29:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:29:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:29:54 INFO - '--tppagecycles', 04:29:54 INFO - '7'], 04:29:54 INFO - 'tests': ['tsvgm']}}, 04:29:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:29:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:29:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:29:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:29:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:29:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:29:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:29:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:54 INFO - 'talos_options': ['--e10s'], 04:29:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:29:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:54 INFO - 'tests': ['damp', 'tps']}, 04:29:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:54 INFO - 'talos_options': ['--e10s'], 04:29:54 INFO - 'tests': ['damp', 'tps']}, 04:29:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:29:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:29:54 INFO - 'other': {'tests': ['a11yr', 04:29:54 INFO - 'ts_paint', 04:29:54 INFO - 'tpaint', 04:29:54 INFO - 'sessionrestore', 04:29:54 INFO - 'sessionrestore_no_auto_restore']}, 04:29:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:29:54 INFO - 'tests': ['a11yr', 04:29:54 INFO - 'ts_paint', 04:29:54 INFO - 'tpaint', 04:29:54 INFO - 'sessionrestore', 04:29:54 INFO - 'sessionrestore_no_auto_restore']}, 04:29:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:29:54 INFO - 'tests': ['a11yr', 04:29:54 INFO - 'ts_paint', 04:29:54 INFO - 'tpaint', 04:29:54 INFO - 'sessionrestore', 04:29:54 INFO - 'sessionrestore_no_auto_restore']}, 04:29:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:29:54 INFO - 'tests': ['a11yr', 04:29:54 INFO - 'ts_paint', 04:29:54 INFO - 'tpaint', 04:29:54 INFO - 'sessionrestore', 04:29:54 INFO - 'sessionrestore_no_auto_restore']}, 04:29:54 INFO - 'other_l64': {'tests': ['a11yr', 04:29:54 INFO - 'ts_paint', 04:29:54 INFO - 'tpaint', 04:29:54 INFO - 'sessionrestore', 04:29:54 INFO - 'sessionrestore_no_auto_restore']}, 04:29:54 INFO - 'other_nol64': {'tests': ['a11yr', 04:29:54 INFO - 'ts_paint', 04:29:54 INFO - 'tpaint', 04:29:54 INFO - 'sessionrestore', 04:29:54 INFO - 'sessionrestore_no_auto_restore']}, 04:29:54 INFO - 'svgr': {'tests': ['tsvgx', 04:29:54 INFO - 'tsvgr_opacity', 04:29:54 INFO - 'tart', 04:29:54 INFO - 'tscrollx', 04:29:54 INFO - 'cart']}, 04:29:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:29:54 INFO - 'tests': ['tsvgx', 04:29:54 INFO - 'tsvgr_opacity', 04:29:54 INFO - 'tart', 04:29:54 INFO - 'tscrollx', 04:29:54 INFO - 'cart']}, 04:29:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:54 INFO - 'tests': ['tp5o']}, 04:29:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:54 INFO - 'talos_options': ['--e10s'], 04:29:54 INFO - 'tests': ['tp5o']}, 04:29:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:54 INFO - 'talos_options': ['--xperf_path', 04:29:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:29:54 INFO - 'tests': ['tp5n']}, 04:29:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:29:54 INFO - 'talos_options': ['--e10s', 04:29:54 INFO - '--xperf_path', 04:29:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:29:54 INFO - 'tests': ['tp5n']}}, 04:29:54 INFO - 'talos.zip': {'path': '', 04:29:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:29:54 INFO - Running post-action listener: _resource_record_post_action 04:29:54 INFO - ##### 04:29:54 INFO - ##### Running create-virtualenv step. 04:29:54 INFO - ##### 04:29:54 INFO - Running pre-action listener: _resource_record_pre_action 04:29:54 INFO - Running main action method: create_virtualenv 04:29:54 INFO - Creating virtualenv /builds/slave/test/build/venv 04:29:54 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 04:29:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:29:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:29:54 INFO - Using real prefix '/usr' 04:29:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:29:54 INFO - Installing distribute.............................................................................................................................................................................................done. 04:29:56 INFO - Installing pip.................done. 04:29:56 INFO - Return code: 0 04:29:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:29: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')]} 04:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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')]} 04:29:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f32feb0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e64240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef30b0>, '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 0x1ef3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef4440>, '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': '20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870', '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 04:29:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:29:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:29:56 INFO - Using env: {'DISPLAY': ':0', 04:29:56 INFO - 'HOME': '/home/cltbld', 04:29:56 INFO - 'LANG': 'en_US.UTF-8', 04:29:56 INFO - 'LANGUAGE': 'en_US:en', 04:29:56 INFO - 'LOGNAME': 'cltbld', 04:29:56 INFO - 'MAIL': '/var/mail/cltbld', 04:29:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:56 INFO - 'MOZ_NO_REMOTE': '1', 04:29:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:56 INFO - 'NO_EM_RESTART': '1', 04:29:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:56 INFO - 'PWD': '/builds/slave/test', 04:29:56 INFO - 'SHELL': '/bin/bash', 04:29:56 INFO - 'SHLVL': '1', 04:29:56 INFO - 'TERM': 'linux', 04:29:56 INFO - 'TMOUT': '86400', 04:29:56 INFO - 'USER': 'cltbld', 04:29:56 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870', 04:29:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:56 INFO - '_': '/tools/buildbot/bin/python'} 04:29:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:57 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 04:29:57 INFO - Cleaning up... 04:29:57 INFO - Return code: 0 04:29:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:29: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')]} 04:29:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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')]} 04:29:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f32feb0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e64240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef30b0>, '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 0x1ef3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef4440>, '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': '20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870', '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 04:29:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:29:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:29:57 INFO - Using env: {'DISPLAY': ':0', 04:29:57 INFO - 'HOME': '/home/cltbld', 04:29:57 INFO - 'LANG': 'en_US.UTF-8', 04:29:57 INFO - 'LANGUAGE': 'en_US:en', 04:29:57 INFO - 'LOGNAME': 'cltbld', 04:29:57 INFO - 'MAIL': '/var/mail/cltbld', 04:29:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:57 INFO - 'MOZ_NO_REMOTE': '1', 04:29:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:57 INFO - 'NO_EM_RESTART': '1', 04:29:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:57 INFO - 'PWD': '/builds/slave/test', 04:29:57 INFO - 'SHELL': '/bin/bash', 04:29:57 INFO - 'SHLVL': '1', 04:29:57 INFO - 'TERM': 'linux', 04:29:57 INFO - 'TMOUT': '86400', 04:29:57 INFO - 'USER': 'cltbld', 04:29:57 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870', 04:29:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:57 INFO - '_': '/tools/buildbot/bin/python'} 04:29:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:57 INFO - Downloading/unpacking psutil>=0.7.1 04:29:57 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 04:29:57 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 04:29:57 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 04:29:57 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 04:29:57 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 04:29:57 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 04:29:58 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:29:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:29:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:29:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:29:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:29:59 INFO - Installing collected packages: psutil 04:29:59 INFO - Running setup.py install for psutil 04:29:59 INFO - building 'psutil._psutil_linux' extension 04:29:59 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 04:29:59 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 04:29:59 INFO - building 'psutil._psutil_posix' extension 04:29:59 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 04:29:59 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 04:29:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:29:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:29:59 INFO - Successfully installed psutil 04:29:59 INFO - Cleaning up... 04:29:59 INFO - Return code: 0 04:29:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:29:59 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')]} 04:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:59 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')]} 04:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f32feb0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e64240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef30b0>, '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 0x1ef3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef4440>, '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': '20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870', '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 04:29:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:29:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:29:59 INFO - Using env: {'DISPLAY': ':0', 04:29:59 INFO - 'HOME': '/home/cltbld', 04:29:59 INFO - 'LANG': 'en_US.UTF-8', 04:29:59 INFO - 'LANGUAGE': 'en_US:en', 04:29:59 INFO - 'LOGNAME': 'cltbld', 04:29:59 INFO - 'MAIL': '/var/mail/cltbld', 04:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:59 INFO - 'MOZ_NO_REMOTE': '1', 04:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:59 INFO - 'NO_EM_RESTART': '1', 04:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:59 INFO - 'PWD': '/builds/slave/test', 04:29:59 INFO - 'SHELL': '/bin/bash', 04:29:59 INFO - 'SHLVL': '1', 04:29:59 INFO - 'TERM': 'linux', 04:29:59 INFO - 'TMOUT': '86400', 04:29:59 INFO - 'USER': 'cltbld', 04:29:59 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870', 04:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:59 INFO - '_': '/tools/buildbot/bin/python'} 04:29:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:29:59 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 04:29:59 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 04:29:59 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 04:29:59 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 04:29:59 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 04:29:59 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 04:30:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:30:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:30:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:30:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:30:01 INFO - Installing collected packages: mozsystemmonitor 04:30:01 INFO - Running setup.py install for mozsystemmonitor 04:30:01 INFO - Successfully installed mozsystemmonitor 04:30:01 INFO - Cleaning up... 04:30:01 INFO - Return code: 0 04:30:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f32feb0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e64240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef30b0>, '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 0x1ef3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef4440>, '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': '20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870', '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 04:30:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:30:01 INFO - Using env: {'DISPLAY': ':0', 04:30:01 INFO - 'HOME': '/home/cltbld', 04:30:01 INFO - 'LANG': 'en_US.UTF-8', 04:30:01 INFO - 'LANGUAGE': 'en_US:en', 04:30:01 INFO - 'LOGNAME': 'cltbld', 04:30:01 INFO - 'MAIL': '/var/mail/cltbld', 04:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:01 INFO - 'MOZ_NO_REMOTE': '1', 04:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:01 INFO - 'NO_EM_RESTART': '1', 04:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:01 INFO - 'PWD': '/builds/slave/test', 04:30:01 INFO - 'SHELL': '/bin/bash', 04:30:01 INFO - 'SHLVL': '1', 04:30:01 INFO - 'TERM': 'linux', 04:30:01 INFO - 'TMOUT': '86400', 04:30:01 INFO - 'USER': 'cltbld', 04:30:01 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870', 04:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:01 INFO - '_': '/tools/buildbot/bin/python'} 04:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:01 INFO - Downloading/unpacking blobuploader==1.2.4 04:30:01 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 04:30:01 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 04:30:01 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 04:30:01 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 04:30:01 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 04:30:01 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 04:30:03 INFO - Downloading blobuploader-1.2.4.tar.gz 04:30:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:30:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:30:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:30:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:30:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:30:04 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 04:30:04 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 04:30:04 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 04:30:04 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 04:30:04 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 04:30:04 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 04:30:04 INFO - Downloading docopt-0.6.1.tar.gz 04:30:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:30:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:30:04 INFO - Installing collected packages: blobuploader, requests, docopt 04:30:04 INFO - Running setup.py install for blobuploader 04:30:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:30:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:30:04 INFO - Running setup.py install for requests 04:30:04 INFO - Running setup.py install for docopt 04:30:04 INFO - Successfully installed blobuploader requests docopt 04:30:04 INFO - Cleaning up... 04:30:04 INFO - Return code: 0 04:30:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30:04 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')]} 04:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:04 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')]} 04:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f32feb0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e64240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef30b0>, '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 0x1ef3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef4440>, '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': '20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870', '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 04:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 04:30:04 INFO - Using env: {'DISPLAY': ':0', 04:30:04 INFO - 'HOME': '/home/cltbld', 04:30:04 INFO - 'LANG': 'en_US.UTF-8', 04:30:04 INFO - 'LANGUAGE': 'en_US:en', 04:30:04 INFO - 'LOGNAME': 'cltbld', 04:30:04 INFO - 'MAIL': '/var/mail/cltbld', 04:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:04 INFO - 'MOZ_NO_REMOTE': '1', 04:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:04 INFO - 'NO_EM_RESTART': '1', 04:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:04 INFO - 'PWD': '/builds/slave/test', 04:30:04 INFO - 'SHELL': '/bin/bash', 04:30:04 INFO - 'SHLVL': '1', 04:30:04 INFO - 'TERM': 'linux', 04:30:04 INFO - 'TMOUT': '86400', 04:30:04 INFO - 'USER': 'cltbld', 04:30:04 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870', 04:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:04 INFO - '_': '/tools/buildbot/bin/python'} 04:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:05 INFO - Running setup.py (path:/tmp/pip-yCsHRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:05 INFO - Running setup.py (path:/tmp/pip-Ytc5VR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:05 INFO - Running setup.py (path:/tmp/pip-ZscA7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:05 INFO - Running setup.py (path:/tmp/pip-FoAkju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:05 INFO - Running setup.py (path:/tmp/pip-4jNYtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:05 INFO - Running setup.py (path:/tmp/pip-ebqNso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:05 INFO - Running setup.py (path:/tmp/pip-Xe6Qtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:05 INFO - Running setup.py (path:/tmp/pip-90CX1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:05 INFO - Running setup.py (path:/tmp/pip-iMa8wP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:05 INFO - Running setup.py (path:/tmp/pip-VJtyMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:05 INFO - Running setup.py (path:/tmp/pip-gmNHoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:05 INFO - Running setup.py (path:/tmp/pip-DEz62v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:06 INFO - Running setup.py (path:/tmp/pip-1oFBcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:06 INFO - Running setup.py (path:/tmp/pip-ViUyZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:06 INFO - Running setup.py (path:/tmp/pip-HDaNwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:30:06 INFO - Running setup.py (path:/tmp/pip-pyNb_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:30:06 INFO - Running setup.py (path:/tmp/pip-tgJKZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:30:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:30:06 INFO - Running setup.py install for manifestparser 04:30:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:30:06 INFO - Running setup.py install for mozcrash 04:30:06 INFO - Running setup.py install for mozdebug 04:30:06 INFO - Running setup.py install for mozdevice 04:30:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:30:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:30:06 INFO - Running setup.py install for mozfile 04:30:06 INFO - Running setup.py install for mozhttpd 04:30:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:30:07 INFO - Running setup.py install for mozinfo 04:30:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:30:07 INFO - Running setup.py install for mozInstall 04:30:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:30:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:30:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:30:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:30:07 INFO - Running setup.py install for mozleak 04:30:07 INFO - Running setup.py install for mozlog 04:30:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:30:07 INFO - Running setup.py install for moznetwork 04:30:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:30:07 INFO - Running setup.py install for mozprocess 04:30:07 INFO - Running setup.py install for mozprofile 04:30:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:30:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:30:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:30:07 INFO - Running setup.py install for mozrunner 04:30:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:30:07 INFO - Running setup.py install for mozscreenshot 04:30:07 INFO - Running setup.py install for moztest 04:30:08 INFO - Running setup.py install for mozversion 04:30:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:30:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:30:08 INFO - Cleaning up... 04:30:08 INFO - Return code: 0 04:30:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f32feb0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e64240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef30b0>, '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 0x1ef3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef4440>, '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': '20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870', '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 04:30:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:30:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:30:08 INFO - Using env: {'DISPLAY': ':0', 04:30:08 INFO - 'HOME': '/home/cltbld', 04:30:08 INFO - 'LANG': 'en_US.UTF-8', 04:30:08 INFO - 'LANGUAGE': 'en_US:en', 04:30:08 INFO - 'LOGNAME': 'cltbld', 04:30:08 INFO - 'MAIL': '/var/mail/cltbld', 04:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:08 INFO - 'MOZ_NO_REMOTE': '1', 04:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:08 INFO - 'NO_EM_RESTART': '1', 04:30:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:08 INFO - 'PWD': '/builds/slave/test', 04:30:08 INFO - 'SHELL': '/bin/bash', 04:30:08 INFO - 'SHLVL': '1', 04:30:08 INFO - 'TERM': 'linux', 04:30:08 INFO - 'TMOUT': '86400', 04:30:08 INFO - 'USER': 'cltbld', 04:30:08 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870', 04:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:08 INFO - '_': '/tools/buildbot/bin/python'} 04:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:30:08 INFO - Running setup.py (path:/tmp/pip-kbZ__4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:30:08 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)) 04:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:30:08 INFO - Running setup.py (path:/tmp/pip-AUNsCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 04:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:30:08 INFO - Running setup.py (path:/tmp/pip-enBwvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:30:08 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)) 04:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:30:08 INFO - Running setup.py (path:/tmp/pip-b0jQu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 04:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:30:08 INFO - Running setup.py (path:/tmp/pip-EJ4BLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:30:08 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)) 04:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:30:08 INFO - Running setup.py (path:/tmp/pip-SRkgPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:30:08 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)) 04:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:30:08 INFO - Running setup.py (path:/tmp/pip-NWtgx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:30:08 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)) 04:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:30:08 INFO - Running setup.py (path:/tmp/pip-q90Zuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:30:08 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)) 04:30:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:30:08 INFO - Running setup.py (path:/tmp/pip-8Rj8d6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:30:09 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)) 04:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:30:09 INFO - Running setup.py (path:/tmp/pip-nU15im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:30:09 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)) 04:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:30:09 INFO - Running setup.py (path:/tmp/pip-u87Z8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:30:09 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)) 04:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:30:09 INFO - Running setup.py (path:/tmp/pip-Mon99G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:30:09 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)) 04:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:30:09 INFO - Running setup.py (path:/tmp/pip-zHp3H6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:30:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 04:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:30:09 INFO - Running setup.py (path:/tmp/pip-6rABIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:30:09 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)) 04:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:09 INFO - Running setup.py (path:/tmp/pip-UHr5jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:30:09 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)) 04:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:30:09 INFO - Running setup.py (path:/tmp/pip-V9iJbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:30:09 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)) 04:30:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:30:09 INFO - Running setup.py (path:/tmp/pip-bW_tnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:30:09 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)) 04:30:09 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:30:09 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:30:09 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)) 04:30:09 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:30:09 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:30:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:30:09 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 04:30:09 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 04:30:09 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 04:30:09 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 04:30:09 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 04:30:09 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 04:30:11 INFO - Downloading blessings-1.5.1.tar.gz 04:30:11 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:30:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:30:11 INFO - Installing collected packages: blessings 04:30:11 INFO - Running setup.py install for blessings 04:30:11 INFO - Successfully installed blessings 04:30:11 INFO - Cleaning up... 04:30:11 INFO - Return code: 0 04:30:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:30:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:30:11 INFO - Reading from file tmpfile_stdout 04:30:11 INFO - Current package versions: 04:30:11 INFO - argparse == 1.2.1 04:30:11 INFO - blessings == 1.5.1 04:30:11 INFO - blobuploader == 1.2.4 04:30:11 INFO - docopt == 0.6.1 04:30:11 INFO - manifestparser == 1.1 04:30:11 INFO - mozInstall == 1.12 04:30:11 INFO - mozcrash == 0.16 04:30:11 INFO - mozdebug == 0.1 04:30:11 INFO - mozdevice == 0.47 04:30:11 INFO - mozfile == 1.2 04:30:11 INFO - mozhttpd == 0.7 04:30:11 INFO - mozinfo == 0.9 04:30:11 INFO - mozleak == 0.1 04:30:11 INFO - mozlog == 3.1 04:30:11 INFO - moznetwork == 0.27 04:30:11 INFO - mozprocess == 0.22 04:30:11 INFO - mozprofile == 0.27 04:30:11 INFO - mozrunner == 6.11 04:30:11 INFO - mozscreenshot == 0.1 04:30:11 INFO - mozsystemmonitor == 0.0 04:30:11 INFO - moztest == 0.7 04:30:11 INFO - mozversion == 1.4 04:30:11 INFO - psutil == 3.1.1 04:30:11 INFO - requests == 1.2.3 04:30:11 INFO - wsgiref == 0.1.2 04:30:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f32feb0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e64240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef30b0>, '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 0x1ef3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef4440>, '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': '20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870', '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 04:30:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:30:11 INFO - Using env: {'DISPLAY': ':0', 04:30:11 INFO - 'HOME': '/home/cltbld', 04:30:11 INFO - 'LANG': 'en_US.UTF-8', 04:30:11 INFO - 'LANGUAGE': 'en_US:en', 04:30:11 INFO - 'LOGNAME': 'cltbld', 04:30:11 INFO - 'MAIL': '/var/mail/cltbld', 04:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:11 INFO - 'MOZ_NO_REMOTE': '1', 04:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:11 INFO - 'NO_EM_RESTART': '1', 04:30:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:11 INFO - 'PWD': '/builds/slave/test', 04:30:11 INFO - 'SHELL': '/bin/bash', 04:30:11 INFO - 'SHLVL': '1', 04:30:11 INFO - 'TERM': 'linux', 04:30:11 INFO - 'TMOUT': '86400', 04:30:11 INFO - 'USER': 'cltbld', 04:30:11 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870', 04:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:11 INFO - '_': '/tools/buildbot/bin/python'} 04:30:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:11 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 1)) 04:30:11 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 2)) 04:30:11 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 3)) 04:30:11 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 4)) 04:30:11 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 5)) 04:30:11 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 6)) 04:30:11 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 7)) 04:30:11 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 8)) 04:30:11 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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:30:11 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 3)) 04:30:11 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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:30:11 INFO - Cleaning up... 04:30:11 INFO - Return code: 0 04:30:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f32feb0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e64240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef30b0>, '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 0x1ef3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef4440>, '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': '20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870', '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 04:30:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:30:11 INFO - Using env: {'DISPLAY': ':0', 04:30:11 INFO - 'HOME': '/home/cltbld', 04:30:11 INFO - 'LANG': 'en_US.UTF-8', 04:30:11 INFO - 'LANGUAGE': 'en_US:en', 04:30:11 INFO - 'LOGNAME': 'cltbld', 04:30:11 INFO - 'MAIL': '/var/mail/cltbld', 04:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:11 INFO - 'MOZ_NO_REMOTE': '1', 04:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:11 INFO - 'NO_EM_RESTART': '1', 04:30:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:11 INFO - 'PWD': '/builds/slave/test', 04:30:11 INFO - 'SHELL': '/bin/bash', 04:30:11 INFO - 'SHLVL': '1', 04:30:11 INFO - 'TERM': 'linux', 04:30:11 INFO - 'TMOUT': '86400', 04:30:11 INFO - 'USER': 'cltbld', 04:30:11 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870', 04:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:11 INFO - '_': '/tools/buildbot/bin/python'} 04:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:12 INFO - Downloading/unpacking jsonschema 04:30:12 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 04:30:12 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 04:30:12 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 04:30:12 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 04:30:12 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 04:30:12 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 04:30:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:30:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:30:13 INFO - Downloading/unpacking functools32 (from jsonschema) 04:30:13 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 04:30:13 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 04:30:13 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 04:30:13 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 04:30:13 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 04:30:13 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 04:30:14 INFO - Downloading functools32-3.2.3-2.tar.gz 04:30:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:30:14 INFO - warning: no files found matching '*.txt' 04:30:14 INFO - no previously-included directories found matching 'build' 04:30:14 INFO - no previously-included directories found matching 'dist' 04:30:14 INFO - no previously-included directories found matching '.git*' 04:30:14 INFO - Installing collected packages: jsonschema, functools32 04:30:14 INFO - Running setup.py install for functools32 04:30:14 INFO - warning: no files found matching '*.txt' 04:30:14 INFO - no previously-included directories found matching 'build' 04:30:14 INFO - no previously-included directories found matching 'dist' 04:30:14 INFO - no previously-included directories found matching '.git*' 04:30:14 INFO - Successfully installed jsonschema functools32 04:30:14 INFO - Cleaning up... 04:30:14 INFO - Return code: 0 04:30:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:30: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')]} 04:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30: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')]} 04:30:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7f32feb0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e64240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ef30b0>, '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 0x1ef3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef4440>, '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': '20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870', '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 04:30:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 04:30:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 04:30:14 INFO - Using env: {'DISPLAY': ':0', 04:30:14 INFO - 'HOME': '/home/cltbld', 04:30:14 INFO - 'LANG': 'en_US.UTF-8', 04:30:14 INFO - 'LANGUAGE': 'en_US:en', 04:30:14 INFO - 'LOGNAME': 'cltbld', 04:30:14 INFO - 'MAIL': '/var/mail/cltbld', 04:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:14 INFO - 'MOZ_NO_REMOTE': '1', 04:30:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:14 INFO - 'NO_EM_RESTART': '1', 04:30:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:14 INFO - 'PWD': '/builds/slave/test', 04:30:14 INFO - 'SHELL': '/bin/bash', 04:30:14 INFO - 'SHLVL': '1', 04:30:14 INFO - 'TERM': 'linux', 04:30:14 INFO - 'TMOUT': '86400', 04:30:14 INFO - 'USER': 'cltbld', 04:30:14 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870', 04:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:14 INFO - '_': '/tools/buildbot/bin/python'} 04:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:14 INFO - Downloading/unpacking flake8 04:30:14 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 04:30:14 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 04:30:14 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 04:30:14 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 04:30:14 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 04:30:14 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 04:30:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:30:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:30:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:30:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:30:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:30:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30: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 04:30:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:30:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:30:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:30:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:30:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:30:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:30:16 INFO - no previously-included directories found matching 'docs/_build' 04:30:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:30:16 INFO - Running setup.py install for pep8 04:30:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:30:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:30:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:30:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:30:17 INFO - no previously-included directories found matching 'docs/_build' 04:30:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:30:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:30:17 INFO - Cleaning up... 04:30:17 INFO - Return code: 0 04:30:17 INFO - Running post-action listener: _resource_record_post_action 04:30:17 INFO - Running post-action listener: _start_resource_monitoring 04:30:17 INFO - Starting resource monitoring. 04:30:17 INFO - ##### 04:30:17 INFO - ##### Running install step. 04:30:17 INFO - ##### 04:30:17 INFO - Running pre-action listener: _resource_record_pre_action 04:30:17 INFO - Running main action method: install 04:30:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:30:17 INFO - Reading from file tmpfile_stdout 04:30:17 INFO - Detecting whether we're running mozinstall >=1.0... 04:30:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:30:17 INFO - Reading from file tmpfile_stdout 04:30:17 INFO - Output received: 04:30:17 INFO - Usage: mozinstall [options] installer 04:30:17 INFO - Options: 04:30:17 INFO - -h, --help show this help message and exit 04:30:17 INFO - -d DEST, --destination=DEST 04:30:17 INFO - Directory to install application into. [default: 04:30:17 INFO - "/builds/slave/test"] 04:30:17 INFO - --app=APP Application being installed. [default: firefox] 04:30:17 INFO - mkdir: /builds/slave/test/build/application 04:30:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:30:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:30:31 INFO - Reading from file tmpfile_stdout 04:30:31 INFO - Output received: 04:30:31 INFO - /builds/slave/test/build/application/firefox/firefox 04:30:31 INFO - Running post-action listener: _resource_record_post_action 04:30:31 INFO - ##### 04:30:31 INFO - ##### Running run-tests step. 04:30:31 INFO - ##### 04:30:31 INFO - Running pre-action listener: _resource_record_pre_action 04:30:31 INFO - Running main action method: run_tests 04:30:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:30:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:30:31 INFO - Python 2.7.3 04:30:31 INFO - Return code: 0 04:30:31 INFO - grabbing minidump binary from tooltool 04:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:31 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 0x1ef30b0>, '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 0x1ef3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ef4440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:30:31 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 04:30:31 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 04:30:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:30:32 INFO - Return code: 0 04:30:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:30:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:30:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:30:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:30:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:30:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:30:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:30:32 INFO - Return code: 0 04:30:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost'] in /builds/slave/test/build 04:30:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost 04:30:32 INFO - Using env: {'DISPLAY': ':0', 04:30:32 INFO - 'HOME': '/home/cltbld', 04:30:32 INFO - 'LANG': 'en_US.UTF-8', 04:30:32 INFO - 'LANGUAGE': 'en_US:en', 04:30:32 INFO - 'LOGNAME': 'cltbld', 04:30:32 INFO - 'MAIL': '/var/mail/cltbld', 04:30:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:30:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:30:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:32 INFO - 'MOZ_NO_REMOTE': '1', 04:30:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:30:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:32 INFO - 'NO_EM_RESTART': '1', 04:30:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:32 INFO - 'PWD': '/builds/slave/test', 04:30:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:30:32 INFO - 'SHELL': '/bin/bash', 04:30:32 INFO - 'SHLVL': '1', 04:30:32 INFO - 'TERM': 'linux', 04:30:32 INFO - 'TMOUT': '86400', 04:30:32 INFO - 'USER': 'cltbld', 04:30:32 INFO - 'XDG_SESSION_COOKIE': '20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870', 04:30:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:32 INFO - '_': '/tools/buildbot/bin/python'} 04:30:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost'] with output_timeout 3600 04:30:33 INFO - mozversion INFO | application_buildid: 20151208030125 04:30:33 INFO - mozversion INFO | application_changeset: 2bdd9ec79799eff3ceec0a318f5a0632d918a527 04:30:33 INFO - mozversion INFO | application_display_name: Nightly 04:30:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:30:33 INFO - mozversion INFO | application_name: Firefox 04:30:33 INFO - mozversion INFO | application_remotingname: firefox 04:30:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:30:33 INFO - mozversion INFO | application_vendor: Mozilla 04:30:33 INFO - mozversion INFO | application_version: 45.0a1 04:30:33 INFO - mozversion INFO | platform_buildid: 20151208030125 04:30:33 INFO - mozversion INFO | platform_changeset: 2bdd9ec79799eff3ceec0a318f5a0632d918a527 04:30:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:30:33 INFO - mozversion INFO | platform_version: 45.0a1 04:30:33 INFO - 2015-12-08 04:30:33,170 DEBUG : using testdate: 1449577833 04:30:33 INFO - 2015-12-08 04:30:33,170 DEBUG : actual date: 1449577833 04:30:33 INFO - 2015-12-08 04:30:33,258 INFO : starting webserver on 'localhost:33609' 04:30:33 INFO - 2015-12-08 04:30:33,259 INFO : Starting test suite talos-linux64-ix-065 04:30:33 INFO - 2015-12-08 04:30:33,259 INFO : Starting test dromaeo_css 04:30:33 INFO - 2015-12-08 04:30:33,259 DEBUG : operating with platform_type : linux_ 04:30:33 INFO - 2015-12-08 04:30:33,260 INFO : Initialising browser for dromaeo_css test... 04:30:33 INFO - 2015-12-08 04:30:33,276 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL0rz41/profile http://localhost:33609/getInfo.html 04:30:37 INFO - 2015-12-08 04:30:37,869 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:30:37 INFO - 2015-12-08 04:30:37,869 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:30:37 INFO - 2015-12-08 04:30:37,869 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:30:37 INFO - 2015-12-08 04:30:37,869 DEBUG : BROWSER_OUTPUT: __metrics 04:30:37 INFO - 2015-12-08 04:30:37,966 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:30:38 INFO - 2015-12-08 04:30:38,030 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:30:38 INFO - 2015-12-08 04:30:38,947 INFO : Browser initialized. 04:30:38 INFO - 2015-12-08 04:30:38,947 INFO : Running cycle 1/1 for dromaeo_css test... 04:30:38 INFO - 2015-12-08 04:30:38,948 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL0rz41/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:30:51 INFO - 2015-12-08 04:30:51,013 DEBUG : BROWSER_OUTPUT: RSS: Main: 143085568 04:30:51 INFO - 2015-12-08 04:30:51,013 DEBUG : BROWSER_OUTPUT: 04:31:42 INFO - 2015-12-08 04:31:42,303 DEBUG : BROWSER_OUTPUT: 1449577902299 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] 04:33:54 INFO - 2015-12-08 04:33:54,272 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33609/tests/dromaeo/cssquery-ext.html) 04:33:55 INFO - 2015-12-08 04:33:55,707 DEBUG : BROWSER_OUTPUT: RSS: Main: 277856256 04:33:55 INFO - 2015-12-08 04:33:55,708 DEBUG : BROWSER_OUTPUT: 04:36:58 INFO - 2015-12-08 04:36:58,341 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/dromaeo/cssquery-ext.html (next: http://localhost:33609/tests/dromaeo/cssquery-jquery.html) 04:36:58 INFO - 2015-12-08 04:36:58,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 226148352 04:36:58 INFO - 2015-12-08 04:36:58,910 DEBUG : BROWSER_OUTPUT: 04:40:00 INFO - 2015-12-08 04:40:00,904 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33609/tests/dromaeo/cssquery-mootools.html) 04:40:01 INFO - 2015-12-08 04:40:01,485 DEBUG : BROWSER_OUTPUT: RSS: Main: 218165248 04:40:01 INFO - 2015-12-08 04:40:01,485 DEBUG : BROWSER_OUTPUT: 04:43:03 INFO - 2015-12-08 04:43:03,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33609/tests/dromaeo/cssquery-prototype.html) 04:43:04 INFO - 2015-12-08 04:43:04,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 205389824 04:43:04 INFO - 2015-12-08 04:43:04,043 DEBUG : BROWSER_OUTPUT: 04:46:06 INFO - 2015-12-08 04:46:06,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33609/tests/dromaeo/cssquery-yui.html) 04:46:07 INFO - 2015-12-08 04:46:07,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 210767872 04:46:07 INFO - 2015-12-08 04:46:07,279 DEBUG : BROWSER_OUTPUT: 04:49:09 INFO - 2015-12-08 04:49:09,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/dromaeo/cssquery-yui.html (next: http://localhost:33609/tests/dromaeo/cssquery-dojo.html) 04:49:10 INFO - 2015-12-08 04:49:10,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 269914112 04:49:10 INFO - 2015-12-08 04:49:10,187 DEBUG : BROWSER_OUTPUT: 04:49:10 INFO - 2015-12-08 04:49:10,187 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:49:10 INFO - 2015-12-08 04:49:10,187 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:49:10 INFO - 2015-12-08 04:49:10,187 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:49:10 INFO - 2015-12-08 04:49:10,187 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:49:10 INFO - 2015-12-08 04:49:10,187 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2591.842233954431;2693.528632489314;2694.5149873022874;2701.6352792373023;2703.351195713029;4407.250767369547;4534.4558652961605;4639.536046395363;4731;4767.928481072787;4584.7478388688605;4616.422947131608;4719.9292010619865;4728.52714728527;4762.7856746446405;4295.570442955711;4313.762743049139;4347.13057388522;4428.136513379892;4437.5784300491405;4389.056352884145;4447.644188464931;4454.510003899569;4457.10857828434;4493.955060449386;4162.583741625828;4193.161367726437;4259.403683484315;4259.5740425957465;4310.849120280775;4322.524522302544;4327.2643650579475;4335.436393268887;4345.304751239786;4383.868483945486;4299.978500107511;4303.505096913864;4305.418768466279;4311.935320970157;4350.695451318409;4430.401895744066;4520.751358675271;4536.523665015159;4562.77186140695;4671.252599584084;4895.412550493964;4957.983613359253;4959.355283813081;4987.5760560352055;5007.123753343187;5074.797008119671;5084.9745751271;5105.33630628016;5108.438071812097;5149.897002059938;4465.12929978651;4564.954350456453;4723.881902952419;4733.905321893543;4739.834105806315;5032.0690672225755;5119.744012799345;5136.743162841843;5141.871453213699;5150.8969820604125;4950.777215025332;4988.476209997971;4990.950090499121;4992.750362481861;5002.1496345621335;5078.644494885322;5078.974605127025;5086.364204474441;5086.491350864958;5114.181730923109;4690.81236750533;4851.345068415719;4854.563089321978;4911.87720306988;5007.849764506997;5007.324011258506;5034.546890779848;5037.874053148627;5052.418971818214;5073.162928116893;4218.767967761742;4221.176870510282;4221.894452638647;4256.233877901946;4258.02065524931;3570.767900086486;3680.0063982724514;3691.3724666806706;3716.9778310964703;3762.1535154589997;4214.957850421518;4284.635805956528;4289.485261768607;4322.308430651081;4330.978345108318;5003.874903127451;5005.024020316004;5027.346444962204;5033.0688822567945;5065.290859279704;4111.6299533042165;4206.957930420718;4303.74177549348;4306.849260275938;4330.653547716175;4305.268104422193;4361.847335343311;4377.868663940087;4379.4525684289465;4419.447569053868;4743.430788305425;4748.738819364969;4754.405699287589;4757.119932812441;4764.737939413296;4777.331173635764;4910.631702622246;5037.7733002014265;5040.84877453677;5076.416212135652;4637.513061128533;4649.5350464953235;4684.6252299816615;4792.065547218398;4804.231322988305;4994.1260279450225;5018.4981501849525;5022.698638081727;5025.572826309658;5054.848354549369;5027.698338099725;5080.466551012239;5081.8475445736685;5086.237064440215;5092.261622064854;4630.86107416778;4750.477447480705;4751.192297309535;4756.19144745401;4760.333553302609;4799.3760811094335;4819.855404337875;4825.252085926687;4826;4827.155247831545;4639.628829693549;4698.765061746967;4712.646551508719;4758.095961767253;4758.857234282977;4833.879153021062;4864;4865.56209941107;4881.170201065898;4910.729909854992;4655.976720116378;4761.381020467317;4771.665983381269;4771.785269662804;4826.348442960156 04:49:10 INFO - 2015-12-08 04:49:10,187 DEBUG : BROWSER_OUTPUT: |1;ext.html;532.1299675031324;537.4813305160519;539.0889396919206;540.2814257038137;542.6825307195293;25739.613905791404;26650.600240996402;26743;34658.30683386337;35635.10912227189;39863;40225;40269.798651006706;40403.79798101005;40455;7810.531368117902;7965.522068675898;7983.441159118864;7988.360931125525;7995.640196191156;7164.391026762705;7377.4835761496715;9849.950750246275;10059.798804023914;10073.44596047217;9665.758356041086;9713.708588742315;9716.90283097167;9739.172170365528;9751.26865485088;7183.820404489878;7370.742024029187;9913.306068575203;10036.347637403618;10043.246756493256;7049.4712896532965;9988.500574971222;10227.23295752814;10247.84628230577;10259.487025648763;36351;36707.4493882592;36739;36863.4470482943;36900.26199475995;2752.2844060544403;2769.3424054313323;2853.1155341844096;3180.3639272145665;3225.951610725841;27216.139527282998;27747.612619368952;27922.441551168864;27949.441011179864;28279.293017674518;3406.880759173417;3458.429359155736;3491;3498.7900725956524;3557.0929412999776;207037;207598;207751;208030;208173;50560.74719626379;54094.45905540973;54738.72630636901;54786.17820732692;54805.45194548083;45130.54869451263;63784.68107659432;65712.67143664251;65738;65766.34233657602;12917.09580329368;13181.736365272833;13203.603891883258;13220.603381898558;13237.404316805767;9881.160101391462;9952.601895924083;9990.700278991642;10004.849927251096;10010.449425281533;18469.445916622524;18643.067846607617;18743.25026998932;18764.530886727942;18785;6952.400947782038;7105.32499412555;7200.495965282485;7252.528585642022;7380;750.5534207146738;780.0600276666603;782.6986610155132;813.1340122769232;952.309575557729;25047;25214.621780673304;25859.353516162246;26032;26670.733292666824;910.7632015675972;927.4018258223408;940.2384068904073;981.3277904635205;1061.8194906865697;13431;13728.45086196561;13807.654808629664;14099.647508812363;14144.929275353763;260231;265151;265776;265979;266201;44949.3030418176;45088.54911450909;45166.32250516245;45189;45279.54720452819;1188.803847365175;1205.6804946689135;1207.2575366149754;1211.9091068169746;1225.724212052281;24552.263432097065;24803.751962480143;26244.475110498064;26275;26277.343066422727;35236.64763352334;36400.63599364078;39740;39941.20117597574;40156.3976540358;242239;249247;249505;250993;251518;24342.63486047746;24630.01479940782;24638.13766518163;24646;24686.629700554146;29831;35733.64266357303;37614.43578346272;38133.4279985806;38456;28121.57817632778;28438;28616.57075143916;28719;30895.691043089282;31215.84392078025;31500.68499315069;31795.36409271848;31972.68027319697;32019;30970.225744356572;31739.68260317367;31982.6801731989;32044.83977580097;32074.67925320717;27669.723302766713;28694;29523.704762952955;30049;30613.08160755181;21597.892010540476;23435.882820585786;23749.79377783977;24120.155794547107;24215.515689685755 04:49:10 INFO - 2015-12-08 04:49:10,188 DEBUG : BROWSER_OUTPUT: |2;jquery.html;283.37374402570316;284.21556504048834;284.57456103125804;285.7685274927308;290.1848934912125;12374.938125309383;12733.363331833394;15708.371665133394;15989.800764942618;16265.268062937166;12452.626421207355;12785.04112191587;12859.035572332066;12996.090273680846;14200.289985500709;3826.9043273918096;4780.737059461728;4836.153673107201;4973.353464049668;4981.651284410093;3705.1292946157632;3806.029462487062;4918.778654960517;4959.380077490314;5419.214213938976;5490.478404551581;5502.339719233698;5507.7246137692955;5542.0301447246775;5545.168224766277;5352.063388906945;5421.105517589593;5422;5424.891502169974;5511.200875872996;4627.745473998929;4643.419572553431;4643.791029403685;4646.558576935186;4648.48866624671;18408.815911840844;18498.982555959417;18617;18636.906815465973;19352.61294774111;1823.8540916726763;1874.962500749991;1966.6558352288291;1967.5868067705799;2087.8538502304846;12301.3234272115;12394.31831249281;12464.563740269046;12507.717739847525;12942.288174150419;1685.2753316074084;1697.2616911643474;1725.1546742096407;1757.5430388099187;1805.4583624912605;52654.73672631651;54008.72995635036;54086;54551.45448545503;54571.45428545743;8130.878036829452;8183.508989460652;8429.620667069996;8459.703910363107;8496.320294376435;10495.790084198274;10522.789544209072;10524.579016839394;10530.947345263225;10535.525901334458;6409.455196308366;6417.935820641827;6422.678866056678;6429.839254018687;6474.384933431316;6152.046432802923;6163.137160797492;6206.627602343874;6240.563160578716;6251.874962500725;5254.238135470336;5258.6581872178185;5287.286216360819;5298.072837253465;5309.548688361532;1374.7594171020032;1415.8442571317353;1426.8787153091896;1443.6246575890343;1462.166565057928;753.3408267765705;872.9825403492022;956.4070276428658;978.6232300564192;1029.3155051890558;14612.415503379958;14913.776293355608;15026.398944042334;15161.620959476102;15450.690986180214;697.7941507255372;814.4868732698362;827.7723626002897;829.1087081387412;851.7657644147909;8416.495010299279;8876.733697988942;9030.187283144549;9112.8633070504;9441;495445;497001;504073;506802;510338;71706.56586868338;73409.63295183597;74290.25709742942;74454.62772686101;75464.24535754682;1023.1814548361281;1040.3393844908387;1049.7218237167158;1051.6687243518268;1053.4048262731685;13676.589702308947;14302.57092287233;14336.139831610137;14464;14503.709925801635;29707.405851883275;30602.84698576493;31377.52933706042;31427.68572314339;32064.67935320617;36786.26427471382;38186.80906595449;38311.80844095873;39047.21905561816;40686.38970415505;8237.258646721824;8433.87349189775;8458.619362128597;8496.787580310542;9011.053839347036;14621.122732636077;15052.54842354731;15117.244137793286;15144;16663.50009499717;12891;13247.470101195844;13358.866411335763;13530.864691353354;13532.458701651824;12696.619101426972;12702.36488175606;12731.172473789175;13534.526291579747;13801.723965520834;13156.276404797445;13339.66650833737;13529;13773.931130344285;13790.655233618838;7739.651715672696;7822;8079.515229086273;8308.875366869623;8309.750707478785;8077.717279895175;8128.634211460617;9721.659741909;12977.935110324388;13253.469861205444 04:49:10 INFO - 2015-12-08 04:49:10,189 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1435.196290077556;1660.310970947057;1704.8636109111264;1728.7147620642595;1738.6348866737976;5880.206172166756;6870.725170993161;7063.752768653098;7072;7078.752243671466;6936.445084393249;7084.8583028339535;7087.89368159478;7088.468364872642;7095.1485821701335;2000.2299114840746;2030.766461856883;2042.0504465423576;2042.3260324093014;2042.8161465468104;2030.1168991488676;2075.56413153238;2077.729895113641;2078.1687325069943;2080.334293026232;2017.1124705129696;2030.8984550772477;2055.1676570988698;2055.6402629539843;2058.372196480073;2005.147812179825;2023.6863286190664;2026.8378529717588;2027.1182035814468;2027.1587291274104;2021.5653634468513;2046.9590608187902;2081.687746837971;2084.1038353507984;2085.165933626546;7048;7134.393576546;7134.678939447737;7137.321954414322;7143.392811611019;4026.2148880968225;4106.753594784323;4114.444549985744;4131.421600975866;4138.772367519785;2650.165197962655;2675.62541244226;2686.0867305116158;2718.4698983698186;2727.890884364623;836.8744688296744;845.243507061183;853.739609419127;862.3532350736947;869.6825658634616;9491;9494.715158545254;9504;9515;9554.378965367228;3592.5688917329567;3649.251903359805;3659.5608526976935;3670.4127339625534;3706.684931780775;8025.478343907627;8040.115587285394;8042.235987581171;8047;8051.396145289127;4034.5158580969883;4042.969042894102;4043.8584649537124;4049.9392509112386;4073.042834933788;3143.528470729409;3250.089974807058;3634.127809325743;3703.685186759156;3706.981465092711;3351.1789611545328;3371.477420999749;3383.052745231339;3394.185395505061;3413.1637748751714;1072.2279958429917;1080.2978064258139;1081.2269227502375;1085.7459634122602;1091.9727006824894;679.3919442099293;681.4582406986359;682.8156397772673;683.5795985468901;733.6185183704443;6534.7386104556235;6633.2703402625675;6640.269570347258;6712.127423434922;6716.697748601325;511.5983952597268;517.8782985998288;525.3275806967089;525.5926656840902;528.2577977940999;4809.062232864558;4871.537203965618;4874.634402419832;4886.022795440855;4894.657373983858;8258.132896045949;8259.463134896212;8426.831463370698;8431.451955622864;8436.662533498715;8255.174482551696;8259.95870020646;8360.498370097814;8366.916330836735;8373;6575.736970521126;6644.169478815148;6649.534532582673;6680.933190668031;6723.125993620798;6171.938280617136;6217.564770466024;6222.688865556795;6223.097650840693;6226.066090086342;7416.035915330973;7430.777076687708;7624.6950121996715;7634.351080158249;7660.808479787827;7611.3530349920875;7687.2697093776005;7690.653920573475;7819.374450044096;7823.491473054461;5965.70171491415;6031.577789554689;6037.366076561898;6043.244594425697;6043.7884674036195;6551.541392102507;6574.145361103026;6667.733290668319;6699.263081060982;6700.966495167493;6226.657533835682;6270.561060725706;6322.33615470369;6351.71417286214;6357.300696923242;6136.079588061826;6178.783742568989;6182.443580077815;6192.876142477216;6237;5175.171972484384;5430.239766432782;5702.572307076903;6306.873862522815;6347.9525878231425;5767.279090113736;5814.854628634318;5819.301683797802;5829;5856.092305692625;5658.490735833795;5733.655980641175;5753.252077229933;5762.30852297727;5766.481016708516 04:49:10 INFO - 2015-12-08 04:49:10,190 DEBUG : BROWSER_OUTPUT: |4;prototype.html;256.65479929494825;258.1970073072744;259.9779018783402;263.5032962864999;264.24030911130507;5131.717755523445;5228.973855130728;5231.424543300234;5248.396434410044;5255.08036093683;4971.726555039471;5028.120078986181;5107.616928730342;5121.078205922932;5123.820666276681;3932.724709270359;3935.8425662973445;3936.1930804185217;3937.940930886039;3948.2300951314505;3944.0337117406275;3947.822347994347;3952.7233093683453;3953;3958.1094253792953;3909.4331321958443;3910.042039700263;3914.4911161548957;3915.11909820291;3922.313595120857;3836.5204349456317;3907.179492306619;3908.042529580257;3916.0992971616547;3921.8823435296986;3355.882544110969;3359.6304406515264;3360.630330663625;3369.309291595217;3371.6965473107293;4987.376577927759;4989.3264409305;4994.400671919357;4999.7750101245165;5002.774875130628;4464.37498750172;4469.530699276562;4476.082403107355;4481.753503557303;4482.238019536687;5385.515303622654;5401.081816091235;5401.081816091274;5415.079436495806;5415.783368665248;3409.09658940381;3439.8968030959113;3646.398344273192;3655.3968595181764;3659.298426231788;5734.283214598176;5787.421257874179;5788.797392091299;5811.88376232473;5821.970890145564;3865.903352416156;3866.149447121629;3870.0324918770307;3870.322693528621;3871.3031654302495;3650.7261955353456;3732.272206919679;3822.140018495816;3932.6264004919485;3941.3102707026155;4542.909141817211;4544.7045942013665;4547.8635640930825;4551.38556294896;4558.97720511402;5528.170774383874;5546.057170281062;5547.805826796042;5554.91667624986;5561.944380556223;1357.056845492393;1381.1505923856957;1383.2461308586844;1384.563862383366;1386.4939297156666;909.7862002429424;919.8252332056887;922.6678395777515;937.376644531379;937.8921424036323;4856.732879691651;4859.854204373874;4867.342908707279;4868.8782780430065;4868.902621947541;5761.049426844607;5771.412861463047;5772.740226689809;5774.422557744192;5780.5953583248765;4854.247591623304;4858.708477491362;4863.051704917507;4867.902641947141;4870.196417591058;3006.2634654509784;3077.2460747117098;3093.5359696045325;3097.860596273173;3100.767442441826;5366.6779993200535;5390.4879036491475;5392.514673679309;5395.62230643859;5396.055690254189;5849.795257165979;5873.089671100986;5874.148248504029;5875;5879.559033072536;5382.542483888835;5386.057439947994;5389.3562463449025;5398.62209645321;5401.4868587484125;5651.773929042793;5724.599278050663;5825.446582574648;5830.387809279964;5838.153467747068;5686.147077938343;5689.516391106637;5691.146328050825;5693.857653558694;5695.487406133302;5448.210009548672;5476.835694929158;5480.698561578992;5483.314585676791;5484.808031718871;3633.073566240592;3713.20166164276;3722.4602432647657;3726.850925962931;3763.134479069884;5565.6104072714525;5719.31280272329;5770.3364113125845;5813.709314534171;5824.5631577631;5405.24326594285;5510.897820435849;5611.607187496836;5623.128415095667;5626.015447296789;5583.469570390806;5605.159226116115;5606.439356064361;5607.046802043581;5609.467100625434;5326.467353264643;5458.1266997280245;5483.396826349019;5484.670919744828;5491.533219676372;5614.326280846324;5617.354004289396;5625.071863142535;5633.690147041952;5643.266375371176;5483.369412517612;5500.4499550044675;5505.532029777513;5523.143912693539;5523.475269849358 04:49:10 INFO - 2015-12-08 04:49:10,190 DEBUG : BROWSER_OUTPUT: |5;yui.html;594.6045879490139;651.3356376495977;671.5198632977421;693.712109474568;716.3302312337963;12166.756664866698;12394.132410731241;12403.503859845607;12421.875781242185;12429.627111186679;11608.303501789878;11679.065674746022;11709.59016434425;11712.472938717758;11739.589114380999;611.5535658968955;618.001926888077;618.5700937848197;780.2860382749791;796.3271035974622;618.6968385491122;623.9313675495691;626.3892704612989;794.4716763352393;809.7368355284526;794.4637369775407;802.4904185841974;808.559335162335;809.6761295481825;809.7327881798992;643.9034144878259;797.3860127701666;801.9117897031322;803.2048272210469;803.2650125135494;480.2580013878531;591.798788411942;606.6238931862274;607.2500461929513;607.7386723708803;11983.460744266442;12109.15235933485;12163.756724865452;12166.87833121675;12205.93897030518;10974.890251097546;11568.074554035657;11813.350265735382;11822.763544729058;11940.641780746504;9007.504587247699;9255.953720231355;9353.438793672334;9459.290553208468;9483.857742133874;3119.173419043955;3152.0543836849083;3171.7462602991704;3182.840857957093;3214.7106760391443;36599.4510082349;37692;38270.61729382698;38397.232055358734;38995.805020975;9434.716958491255;9476.763080923032;9630.27772917034;9667.46828924416;9742.902570974342;16660.250288737036;16682.83317166837;16736.581585460463;16826.91586542084;16844.24200910962;5936.5844390892225;6113.877722445615;6252.5935814171935;6414.134091897534;6417.294097649255;3525.8413371398346;3531.9293614127573;3553.129483276562;3583.498310236569;3609.909752256162;2593.6368908352847;2636.8286061405947;2648.4173481833964;2655.243255672124;2662.0948877381784;451.4492319370363;455.897423079811;463.71713254914476;471.6227018385347;475.1494824264528;539.6514626741063;552.2489414396417;562.9352624448159;580.7734983356494;587.4096532984408;7504.212057733968;8064.435489515678;8251.33989280856;8255.504669719716;8297;365.0194627586177;521.5514657394638;581.9621724587888;585.1632166002572;590.7961753195141;3343.348047130835;3490.616032236452;3520.313538859949;3558.839852206657;3652.8721494747556;48269.275960860614;48659.756701216975;48777.756111219926;48794;48990;38190;38990.415143772865;41581.376279355834;41877.79061104675;43464.130717386106;38221.42667859984;42257.78871105686;42753.14493710108;42796.786016069724;42907;7638.350740187147;7965.960170199112;8076.353891688768;8094.3929205311015;8247.381446391424;29701.257468563457;29945.700542995164;29996.25009374696;30049.69950300469;30242.395152097273;34494.85162620876;38222.23555528929;38236.235275294894;38278.23443531058;38340.61659383371;9600.951995239979;9641.37331073478;9813.067758562926;9941.801163976825;10036.698899033041;10793.892061079288;10911.672649820519;10929.726756830825;11028.5037173329;11112.944435277772;10266.486675666336;10328.380297182193;10431.68704938853;10508.21188410857;10763.138948883914;9766.951165244129;9975.351602145838;10418.426986515511;10621.787564248518;10663.8933610666;10212;10314.845277320996;10445.11216546602;10509.894901050891;10812.621558245424;9117.908820911705;9213.76965575866;9265.629374824932;9290.535473226448;9338.112879276458;8977.596008179778;9210.539473026189;9245.630174793201;9274.44353338802;9281.303902207226 04:49:10 INFO - 2015-12-08 04:49:10,190 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:49:10 INFO - 2015-12-08 04:49:10,190 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:49:10 INFO - 2015-12-08 04:49:10,191 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1174 04:49:10 INFO - 2015-12-08 04:49:10,191 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:49:10 INFO - 2015-12-08 04:49:10,191 DEBUG : BROWSER_OUTPUT: __startTimestamp1449578950180__endTimestamp 04:49:10 INFO - 2015-12-08 04:49:10,191 DEBUG : BROWSER_OUTPUT: 04:49:10 INFO - 2015-12-08 04:49:10,191 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:49:10 INFO - 2015-12-08 04:49:10,191 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:49:10 INFO - 2015-12-08 04:49:10,191 DEBUG : BROWSER_OUTPUT: 04:49:10 INFO - 2015-12-08 04:49:10,191 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4615.55 Median:4743.43 stddev:482.88 (10.2%) stddev-sans-first:457.52 04:49:10 INFO - 2015-12-08 04:49:10,192 DEBUG : BROWSER_OUTPUT: Values: 2591.8 2693.5 2694.5 2701.6 2703.4 4407.3 4534.5 4639.5 4731.0 4767.9 4584.7 4616.4 4719.9 4728.5 4762.8 4295.6 4313.8 4347.1 4428.1 4437.6 4389.1 4447.6 4454.5 4457.1 4494.0 4162.6 4193.2 4259.4 4259.6 4310.8 4322.5 4327.3 4335.4 4345.3 4383.9 4300.0 4303.5 4305.4 4311.9 4350.7 4430.4 4520.8 4536.5 4562.8 4671.3 4895.4 4958.0 4959.4 4987.6 5007.1 5074.8 5085.0 5105.3 5108.4 5149.9 4465.1 4565.0 4723.9 4733.9 4739.8 5032.1 5119.7 5136.7 5141.9 5150.9 4950.8 4988.5 4991.0 4992.8 5002.1 5078.6 5079.0 5086.4 5086.5 5114.2 4690.8 4851.3 4854.6 4911.9 5007.8 5007.3 5034.5 5037.9 5052.4 5073.2 4218.8 4221.2 4221.9 4256.2 4258.0 3570.8 3680.0 3691.4 3717.0 3762.2 4215.0 4284.6 4289.5 4322.3 4331.0 5003.9 5005.0 5027.3 5033.1 5065.3 4111.6 4207.0 4303.7 4306.8 4330.7 4305.3 4361.8 4377.9 4379.5 4419.4 4743.4 4748.7 4754.4 4757.1 4764.7 4777.3 4910.6 5037.8 5040.8 5076.4 4637.5 4649.5 4684.6 4792.1 4804.2 4994.1 5018.5 5022.7 5025.6 5054.8 5027.7 5080.5 5081.8 5086.2 5092.3 4630.9 4750.5 4751.2 4756.2 4760.3 4799.4 4819.9 4825.3 4826.0 4827.2 4639.6 4698.8 4712.6 4758.1 4758.9 4833.9 4864.0 4865.6 4881.2 4910.7 4656.0 4761.4 4771.7 4771.8 4826.3 04:49:10 INFO - 2015-12-08 04:49:10,192 DEBUG : BROWSER_OUTPUT: 04:49:10 INFO - 2015-12-08 04:49:10,192 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39697.70 Median:31767.52 stddev:62979.46 (198.3%) stddev-sans-first:63087.48 04:49:10 INFO - 2015-12-08 04:49:10,193 DEBUG : BROWSER_OUTPUT: Values: 532.1 537.5 539.1 540.3 542.7 25739.6 26650.6 26743.0 34658.3 35635.1 39863.0 40225.0 40269.8 40403.8 40455.0 7810.5 7965.5 7983.4 7988.4 7995.6 7164.4 7377.5 9850.0 10059.8 10073.4 9665.8 9713.7 9716.9 9739.2 9751.3 7183.8 7370.7 9913.3 10036.3 10043.2 7049.5 9988.5 10227.2 10247.8 10259.5 36351.0 36707.4 36739.0 36863.4 36900.3 2752.3 2769.3 2853.1 3180.4 3226.0 27216.1 27747.6 27922.4 27949.4 28279.3 3406.9 3458.4 3491.0 3498.8 3557.1 207037.0 207598.0 207751.0 208030.0 208173.0 50560.7 54094.5 54738.7 54786.2 54805.5 45130.5 63784.7 65712.7 65738.0 65766.3 12917.1 13181.7 13203.6 13220.6 13237.4 9881.2 9952.6 9990.7 10004.8 10010.4 18469.4 18643.1 18743.3 18764.5 18785.0 6952.4 7105.3 7200.5 7252.5 7380.0 750.6 780.1 782.7 813.1 952.3 25047.0 25214.6 25859.4 26032.0 26670.7 910.8 927.4 940.2 981.3 1061.8 13431.0 13728.5 13807.7 14099.6 14144.9 260231.0 265151.0 265776.0 265979.0 266201.0 44949.3 45088.5 45166.3 45189.0 45279.5 1188.8 1205.7 1207.3 1211.9 1225.7 24552.3 24803.8 26244.5 26275.0 26277.3 35236.6 36400.6 39740.0 39941.2 40156.4 242239.0 249247.0 249505.0 250993.0 251518.0 24342.6 24630.0 24638.1 24646.0 24686.6 29831.0 35733.6 37614.4 38133.4 38456.0 28121.6 28438.0 28616.6 28719.0 30895.7 31215.8 31500.7 31795.4 31972.7 32019.0 30970.2 31739.7 31982.7 32044.8 32074.7 27669.7 28694.0 29523.7 30049.0 30613.1 21597.9 23435.9 23749.8 24120.2 24215.5 04:49:10 INFO - 2015-12-08 04:49:10,193 DEBUG : BROWSER_OUTPUT: 04:49:10 INFO - 2015-12-08 04:49:10,193 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26371.87 Median:20996.42 stddev:82117.36 (391.1%) stddev-sans-first:82324.36 04:49:10 INFO - 2015-12-08 04:49:10,193 DEBUG : BROWSER_OUTPUT: Values: 283.4 284.2 284.6 285.8 290.2 12374.9 12733.4 15708.4 15989.8 16265.3 12452.6 12785.0 12859.0 12996.1 14200.3 3826.9 4780.7 4836.2 4973.4 4981.7 3705.1 3806.0 4918.8 4959.4 5419.2 5490.5 5502.3 5507.7 5542.0 5545.2 5352.1 5421.1 5422.0 5424.9 5511.2 4627.7 4643.4 4643.8 4646.6 4648.5 18408.8 18499.0 18617.0 18636.9 19352.6 1823.9 1875.0 1966.7 1967.6 2087.9 12301.3 12394.3 12464.6 12507.7 12942.3 1685.3 1697.3 1725.2 1757.5 1805.5 52654.7 54008.7 54086.0 54551.5 54571.5 8130.9 8183.5 8429.6 8459.7 8496.3 10495.8 10522.8 10524.6 10530.9 10535.5 6409.5 6417.9 6422.7 6429.8 6474.4 6152.0 6163.1 6206.6 6240.6 6251.9 5254.2 5258.7 5287.3 5298.1 5309.5 1374.8 1415.8 1426.9 1443.6 1462.2 753.3 873.0 956.4 978.6 1029.3 14612.4 14913.8 15026.4 15161.6 15450.7 697.8 814.5 827.8 829.1 851.8 8416.5 8876.7 9030.2 9112.9 9441.0 495445.0 497001.0 504073.0 506802.0 510338.0 71706.6 73409.6 74290.3 74454.6 75464.2 1023.2 1040.3 1049.7 1051.7 1053.4 13676.6 14302.6 14336.1 14464.0 14503.7 29707.4 30602.8 31377.5 31427.7 32064.7 36786.3 38186.8 38311.8 39047.2 40686.4 8237.3 8433.9 8458.6 8496.8 9011.1 14621.1 15052.5 15117.2 15144.0 16663.5 12891.0 13247.5 13358.9 13530.9 13532.5 12696.6 12702.4 12731.2 13534.5 13801.7 13156.3 13339.7 13529.0 13773.9 13790.7 7739.7 7822.0 8079.5 8308.9 8309.8 8077.7 8128.6 9721.7 12977.9 13253.5 04:49:10 INFO - 2015-12-08 04:49:10,194 DEBUG : BROWSER_OUTPUT: 04:49:10 INFO - 2015-12-08 04:49:10,194 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4827.02 Median:6034.47 stddev:2549.48 (42.2%) stddev-sans-first:2543.89 04:49:10 INFO - 2015-12-08 04:49:10,194 DEBUG : BROWSER_OUTPUT: Values: 1435.2 1660.3 1704.9 1728.7 1738.6 5880.2 6870.7 7063.8 7072.0 7078.8 6936.4 7084.9 7087.9 7088.5 7095.1 2000.2 2030.8 2042.1 2042.3 2042.8 2030.1 2075.6 2077.7 2078.2 2080.3 2017.1 2030.9 2055.2 2055.6 2058.4 2005.1 2023.7 2026.8 2027.1 2027.2 2021.6 2047.0 2081.7 2084.1 2085.2 7048.0 7134.4 7134.7 7137.3 7143.4 4026.2 4106.8 4114.4 4131.4 4138.8 2650.2 2675.6 2686.1 2718.5 2727.9 836.9 845.2 853.7 862.4 869.7 9491.0 9494.7 9504.0 9515.0 9554.4 3592.6 3649.3 3659.6 3670.4 3706.7 8025.5 8040.1 8042.2 8047.0 8051.4 4034.5 4043.0 4043.9 4049.9 4073.0 3143.5 3250.1 3634.1 3703.7 3707.0 3351.2 3371.5 3383.1 3394.2 3413.2 1072.2 1080.3 1081.2 1085.7 1092.0 679.4 681.5 682.8 683.6 733.6 6534.7 6633.3 6640.3 6712.1 6716.7 511.6 517.9 525.3 525.6 528.3 4809.1 4871.5 4874.6 4886.0 4894.7 8258.1 8259.5 8426.8 8431.5 8436.7 8255.2 8260.0 8360.5 8366.9 8373.0 6575.7 6644.2 6649.5 6680.9 6723.1 6171.9 6217.6 6222.7 6223.1 6226.1 7416.0 7430.8 7624.7 7634.4 7660.8 7611.4 7687.3 7690.7 7819.4 7823.5 5965.7 6031.6 6037.4 6043.2 6043.8 6551.5 6574.1 6667.7 6699.3 6701.0 6226.7 6270.6 6322.3 6351.7 6357.3 6136.1 6178.8 6182.4 6192.9 6237.0 5175.2 5430.2 5702.6 6306.9 6348.0 5767.3 5814.9 5819.3 5829.0 5856.1 5658.5 5733.7 5753.3 5762.3 5766.5 04:49:10 INFO - 2015-12-08 04:49:10,194 DEBUG : BROWSER_OUTPUT: 04:49:10 INFO - 2015-12-08 04:49:10,194 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4535.56 Median:5180.35 stddev:1384.01 (26.7%) stddev-sans-first:1350.12 04:49:10 INFO - 2015-12-08 04:49:10,195 DEBUG : BROWSER_OUTPUT: Values: 256.7 258.2 260.0 263.5 264.2 5131.7 5229.0 5231.4 5248.4 5255.1 4971.7 5028.1 5107.6 5121.1 5123.8 3932.7 3935.8 3936.2 3937.9 3948.2 3944.0 3947.8 3952.7 3953.0 3958.1 3909.4 3910.0 3914.5 3915.1 3922.3 3836.5 3907.2 3908.0 3916.1 3921.9 3355.9 3359.6 3360.6 3369.3 3371.7 4987.4 4989.3 4994.4 4999.8 5002.8 4464.4 4469.5 4476.1 4481.8 4482.2 5385.5 5401.1 5401.1 5415.1 5415.8 3409.1 3439.9 3646.4 3655.4 3659.3 5734.3 5787.4 5788.8 5811.9 5822.0 3865.9 3866.1 3870.0 3870.3 3871.3 3650.7 3732.3 3822.1 3932.6 3941.3 4542.9 4544.7 4547.9 4551.4 4559.0 5528.2 5546.1 5547.8 5554.9 5561.9 1357.1 1381.2 1383.2 1384.6 1386.5 909.8 919.8 922.7 937.4 937.9 4856.7 4859.9 4867.3 4868.9 4868.9 5761.0 5771.4 5772.7 5774.4 5780.6 4854.2 4858.7 4863.1 4867.9 4870.2 3006.3 3077.2 3093.5 3097.9 3100.8 5366.7 5390.5 5392.5 5395.6 5396.1 5849.8 5873.1 5874.1 5875.0 5879.6 5382.5 5386.1 5389.4 5398.6 5401.5 5651.8 5724.6 5825.4 5830.4 5838.2 5686.1 5689.5 5691.1 5693.9 5695.5 5448.2 5476.8 5480.7 5483.3 5484.8 3633.1 3713.2 3722.5 3726.9 3763.1 5565.6 5719.3 5770.3 5813.7 5824.6 5405.2 5510.9 5611.6 5623.1 5626.0 5583.5 5605.2 5606.4 5607.0 5609.5 5326.5 5458.1 5483.4 5484.7 5491.5 5614.3 5617.4 5625.1 5633.7 5643.3 5483.4 5500.4 5505.5 5523.1 5523.5 04:49:10 INFO - 2015-12-08 04:49:10,196 DEBUG : BROWSER_OUTPUT: 04:49:10 INFO - 2015-12-08 04:49:10,196 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11989.17 Median:453.67 stddev:13292.61 (2930.0%) stddev-sans-first:13302.36 04:49:10 INFO - 2015-12-08 04:49:10,196 DEBUG : BROWSER_OUTPUT: Values: 594.6 651.3 671.5 693.7 716.3 12166.8 12394.1 12403.5 12421.9 12429.6 11608.3 11679.1 11709.6 11712.5 11739.6 611.6 618.0 618.6 780.3 796.3 618.7 623.9 626.4 794.5 809.7 794.5 802.5 808.6 809.7 809.7 643.9 797.4 801.9 803.2 803.3 480.3 591.8 606.6 607.3 607.7 11983.5 12109.2 12163.8 12166.9 12205.9 10974.9 11568.1 11813.4 11822.8 11940.6 9007.5 9256.0 9353.4 9459.3 9483.9 3119.2 3152.1 3171.7 3182.8 3214.7 36599.5 37692.0 38270.6 38397.2 38995.8 9434.7 9476.8 9630.3 9667.5 9742.9 16660.3 16682.8 16736.6 16826.9 16844.2 5936.6 6113.9 6252.6 6414.1 6417.3 3525.8 3531.9 3553.1 3583.5 3609.9 2593.6 2636.8 2648.4 2655.2 2662.1 451.4 455.9 463.7 471.6 475.1 539.7 552.2 562.9 580.8 587.4 7504.2 8064.4 8251.3 8255.5 8297.0 365.0 521.6 582.0 585.2 590.8 3343.3 3490.6 3520.3 3558.8 3652.9 48269.3 48659.8 48777.8 48794.0 48990.0 38190.0 38990.4 41581.4 41877.8 43464.1 38221.4 42257.8 42753.1 42796.8 42907.0 7638.4 7966.0 8076.4 8094.4 8247.4 29701.3 29945.7 29996.3 30049.7 30242.4 34494.9 38222.2 38236.2 38278.2 38340.6 9601.0 9641.4 9813.1 9941.8 10036.7 10793.9 10911.7 10929.7 11028.5 11112.9 10266.5 10328.4 10431.7 10508.2 10763.1 9767.0 9975.4 10418.4 10621.8 10663.9 10212.0 10314.8 10445.1 10509.9 10812.6 9117.9 9213.8 9265.6 9290.5 9338.1 8977.6 9210.5 9245.6 9274.4 9281.3 04:49:10 INFO - 2015-12-08 04:49:10,196 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:49:10 INFO - 2015-12-08 04:49:10,196 DEBUG : BROWSER_OUTPUT: 04:49:11 INFO - 2015-12-08 04:49:11,011 INFO : Browser exited with error code: 0 04:49:11 INFO - 2015-12-08 04:49:11,032 INFO : Completed test dromaeo_css (00:18:37) 04:49:11 INFO - 2015-12-08 04:49:11,033 INFO : Starting test kraken 04:49:11 INFO - 2015-12-08 04:49:11,033 DEBUG : operating with platform_type : linux_ 04:49:11 INFO - 2015-12-08 04:49:11,033 INFO : Initialising browser for kraken test... 04:49:11 INFO - 2015-12-08 04:49:11,039 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp27QHgU/profile http://localhost:33609/getInfo.html 04:49:15 INFO - 2015-12-08 04:49:15,663 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:49:15 INFO - 2015-12-08 04:49:15,664 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:49:15 INFO - 2015-12-08 04:49:15,664 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:49:15 INFO - 2015-12-08 04:49:15,664 DEBUG : BROWSER_OUTPUT: __metrics 04:49:15 INFO - 2015-12-08 04:49:15,740 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:49:15 INFO - 2015-12-08 04:49:15,796 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:49:16 INFO - 2015-12-08 04:49:16,709 INFO : Browser initialized. 04:49:16 INFO - 2015-12-08 04:49:16,709 INFO : Running cycle 1/1 for kraken test... 04:49:16 INFO - 2015-12-08 04:49:16,710 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp27QHgU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:49:28 INFO - 2015-12-08 04:49:28,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 142716928 04:49:28 INFO - 2015-12-08 04:49:28,723 DEBUG : BROWSER_OUTPUT: 04:49:31 INFO - 2015-12-08 04:49:31,326 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33609/tests/kraken/driver.html?testName=audio-beat-detection) 04:49:31 INFO - 2015-12-08 04:49:31,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 177745920 04:49:31 INFO - 2015-12-08 04:49:31,912 DEBUG : BROWSER_OUTPUT: 04:49:34 INFO - 2015-12-08 04:49:34,675 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33609/tests/kraken/driver.html?testName=audio-dft) 04:49:35 INFO - 2015-12-08 04:49:35,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 165490688 04:49:35 INFO - 2015-12-08 04:49:35,249 DEBUG : BROWSER_OUTPUT: 04:49:38 INFO - 2015-12-08 04:49:38,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33609/tests/kraken/driver.html?testName=audio-fft) 04:49:38 INFO - 2015-12-08 04:49:38,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 154284032 04:49:38 INFO - 2015-12-08 04:49:38,848 DEBUG : BROWSER_OUTPUT: 04:49:40 INFO - 2015-12-08 04:49:40,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33609/tests/kraken/driver.html?testName=audio-oscillator) 04:49:41 INFO - 2015-12-08 04:49:41,472 DEBUG : BROWSER_OUTPUT: RSS: Main: 154152960 04:49:41 INFO - 2015-12-08 04:49:41,472 DEBUG : BROWSER_OUTPUT: 04:49:43 INFO - 2015-12-08 04:49:43,730 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33609/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:49:44 INFO - 2015-12-08 04:49:44,311 DEBUG : BROWSER_OUTPUT: RSS: Main: 156655616 04:49:44 INFO - 2015-12-08 04:49:44,311 DEBUG : BROWSER_OUTPUT: 04:49:47 INFO - 2015-12-08 04:49:47,296 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33609/tests/kraken/driver.html?testName=imaging-darkroom) 04:49:47 INFO - 2015-12-08 04:49:47,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 157011968 04:49:47 INFO - 2015-12-08 04:49:47,877 DEBUG : BROWSER_OUTPUT: 04:49:51 INFO - 2015-12-08 04:49:51,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33609/tests/kraken/driver.html?testName=imaging-desaturate) 04:49:51 INFO - 2015-12-08 04:49:51,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 158978048 04:49:51 INFO - 2015-12-08 04:49:51,926 DEBUG : BROWSER_OUTPUT: 04:49:54 INFO - 2015-12-08 04:49:54,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33609/tests/kraken/driver.html?testName=json-parse-financial) 04:49:55 INFO - 2015-12-08 04:49:55,337 DEBUG : BROWSER_OUTPUT: RSS: Main: 158294016 04:49:55 INFO - 2015-12-08 04:49:55,337 DEBUG : BROWSER_OUTPUT: 04:49:57 INFO - 2015-12-08 04:49:57,139 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33609/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:49:57 INFO - 2015-12-08 04:49:57,704 DEBUG : BROWSER_OUTPUT: RSS: Main: 168366080 04:49:57 INFO - 2015-12-08 04:49:57,704 DEBUG : BROWSER_OUTPUT: 04:49:59 INFO - 2015-12-08 04:49:59,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33609/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:50:00 INFO - 2015-12-08 04:50:00,144 DEBUG : BROWSER_OUTPUT: RSS: Main: 167505920 04:50:00 INFO - 2015-12-08 04:50:00,144 DEBUG : BROWSER_OUTPUT: 04:50:02 INFO - 2015-12-08 04:50:02,300 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33609/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:50:02 INFO - 2015-12-08 04:50:02,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 179712000 04:50:02 INFO - 2015-12-08 04:50:02,881 DEBUG : BROWSER_OUTPUT: 04:50:05 INFO - 2015-12-08 04:50:05,380 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33609/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:50:05 INFO - 2015-12-08 04:50:05,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 183672832 04:50:05 INFO - 2015-12-08 04:50:05,969 DEBUG : BROWSER_OUTPUT: 04:50:08 INFO - 2015-12-08 04:50:08,597 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33609/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:50:09 INFO - 2015-12-08 04:50:09,178 DEBUG : BROWSER_OUTPUT: RSS: Main: 179949568 04:50:09 INFO - 2015-12-08 04:50:09,178 DEBUG : BROWSER_OUTPUT: 04:50:10 INFO - 2015-12-08 04:50:10,947 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33609/tests/kraken/driver.html?testName=ai-astar) 04:50:11 INFO - 2015-12-08 04:50:11,197 DEBUG : BROWSER_OUTPUT: RSS: Main: 238366720 04:50:11 INFO - 2015-12-08 04:50:11,197 DEBUG : BROWSER_OUTPUT: 04:50:11 INFO - 2015-12-08 04:50:11,197 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:50:11 INFO - 2015-12-08 04:50:11,198 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:50:11 INFO - 2015-12-08 04:50:11,198 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:50:11 INFO - 2015-12-08 04:50:11,198 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:50:11 INFO - 2015-12-08 04:50:11,198 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;113;108;113;114;114;102;114;112;103 04:50:11 INFO - 2015-12-08 04:50:11,198 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;131;150;170;131;153;152;137;168;130 04:50:11 INFO - 2015-12-08 04:50:11,198 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;160;161;161;163;162;163;163;161;161 04:50:11 INFO - 2015-12-08 04:50:11,199 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;79;96;72;72;73;101;91;73 04:50:11 INFO - 2015-12-08 04:50:11,199 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;96;131;94;95;95;135;94;95;133 04:50:11 INFO - 2015-12-08 04:50:11,199 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;110;110;110;111;110;110 04:50:11 INFO - 2015-12-08 04:50:11,199 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;147;146;146;146;146;148;148 04:50:11 INFO - 2015-12-08 04:50:11,199 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;94;98;95;95;96;95;95 04:50:11 INFO - 2015-12-08 04:50:11,199 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;80;73;73;73;74;73;73;74;75;72 04:50:11 INFO - 2015-12-08 04:50:11,199 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;68;68;68;69;68;68;68;68 04:50:11 INFO - 2015-12-08 04:50:11,200 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;83;84;84;83;82;84;85;86;85 04:50:11 INFO - 2015-12-08 04:50:11,200 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;123;118;118;114;126;128;121;123;125 04:50:11 INFO - 2015-12-08 04:50:11,200 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;148;151;150;140;140;149;155;148;135 04:50:11 INFO - 2015-12-08 04:50:11,200 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;70;70;69;67;68;69;69;69 04:50:11 INFO - 2015-12-08 04:50:11,200 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:50:11 INFO - 2015-12-08 04:50:11,200 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:50:11 INFO - 2015-12-08 04:50:11,200 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,978 04:50:11 INFO - 2015-12-08 04:50:11,200 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:50:11 INFO - 2015-12-08 04:50:11,201 DEBUG : BROWSER_OUTPUT: __startTimestamp1449579011196__endTimestamp 04:50:11 INFO - 2015-12-08 04:50:11,201 DEBUG : BROWSER_OUTPUT: 04:50:11 INFO - 2015-12-08 04:50:11,208 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:50:11 INFO - 2015-12-08 04:50:11,208 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:50:11 INFO - 2015-12-08 04:50:11,208 DEBUG : BROWSER_OUTPUT: 04:50:11 INFO - 2015-12-08 04:50:11,208 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.50 Median:113.00 stddev:4.58 (4.1%) stddev-sans-first:4.82 04:50:11 INFO - 2015-12-08 04:50:11,208 DEBUG : BROWSER_OUTPUT: Values: 112.0 113.0 108.0 113.0 114.0 114.0 102.0 114.0 112.0 103.0 04:50:11 INFO - 2015-12-08 04:50:11,209 DEBUG : BROWSER_OUTPUT: 04:50:11 INFO - 2015-12-08 04:50:11,209 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.00 Median:152.50 stddev:15.10 (9.9%) stddev-sans-first:15.58 04:50:11 INFO - 2015-12-08 04:50:11,209 DEBUG : BROWSER_OUTPUT: Values: 158.0 131.0 150.0 170.0 131.0 153.0 152.0 137.0 168.0 130.0 04:50:11 INFO - 2015-12-08 04:50:11,209 DEBUG : BROWSER_OUTPUT: 04:50:11 INFO - 2015-12-08 04:50:11,209 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:162.50 stddev:1.14 (0.7%) stddev-sans-first:1.12 04:50:11 INFO - 2015-12-08 04:50:11,209 DEBUG : BROWSER_OUTPUT: Values: 163.0 160.0 161.0 161.0 163.0 162.0 163.0 163.0 161.0 161.0 04:50:11 INFO - 2015-12-08 04:50:11,209 DEBUG : BROWSER_OUTPUT: 04:50:11 INFO - 2015-12-08 04:50:11,209 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.20 Median:73.00 stddev:11.34 (15.5%) stddev-sans-first:11.63 04:50:11 INFO - 2015-12-08 04:50:11,209 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 79.0 96.0 72.0 72.0 73.0 101.0 91.0 73.0 04:50:11 INFO - 2015-12-08 04:50:11,209 DEBUG : BROWSER_OUTPUT: 04:50:11 INFO - 2015-12-08 04:50:11,209 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.30 Median:95.00 stddev:18.46 (19.4%) stddev-sans-first:19.12 04:50:11 INFO - 2015-12-08 04:50:11,209 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 131.0 94.0 95.0 95.0 135.0 94.0 95.0 133.0 04:50:11 INFO - 2015-12-08 04:50:11,209 DEBUG : BROWSER_OUTPUT: 04:50:11 INFO - 2015-12-08 04:50:11,210 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 04:50:11 INFO - 2015-12-08 04:50:11,210 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 110.0 110.0 110.0 111.0 110.0 110.0 04:50:11 INFO - 2015-12-08 04:50:11,210 DEBUG : BROWSER_OUTPUT: 04:50:11 INFO - 2015-12-08 04:50:11,210 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 04:50:11 INFO - 2015-12-08 04:50:11,210 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 148.0 148.0 04:50:11 INFO - 2015-12-08 04:50:11,210 DEBUG : BROWSER_OUTPUT: 04:50:11 INFO - 2015-12-08 04:50:11,210 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.06 (1.1%) stddev-sans-first:1.12 04:50:11 INFO - 2015-12-08 04:50:11,210 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 94.0 98.0 95.0 95.0 96.0 95.0 95.0 04:50:11 INFO - 2015-12-08 04:50:11,210 DEBUG : BROWSER_OUTPUT: 04:50:11 INFO - 2015-12-08 04:50:11,210 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.00 Median:73.50 stddev:2.26 (3.1%) stddev-sans-first:0.87 04:50:11 INFO - 2015-12-08 04:50:11,210 DEBUG : BROWSER_OUTPUT: Values: 80.0 73.0 73.0 73.0 74.0 73.0 73.0 74.0 75.0 72.0 04:50:11 INFO - 2015-12-08 04:50:11,211 DEBUG : BROWSER_OUTPUT: 04:50:11 INFO - 2015-12-08 04:50:11,211 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.57 (0.8%) stddev-sans-first:0.50 04:50:11 INFO - 2015-12-08 04:50:11,211 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 68.0 04:50:11 INFO - 2015-12-08 04:50:11,211 DEBUG : BROWSER_OUTPUT: 04:50:11 INFO - 2015-12-08 04:50:11,211 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:1.15 (1.4%) stddev-sans-first:1.22 04:50:11 INFO - 2015-12-08 04:50:11,211 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 84.0 84.0 83.0 82.0 84.0 85.0 86.0 85.0 04:50:11 INFO - 2015-12-08 04:50:11,211 DEBUG : BROWSER_OUTPUT: 04:50:11 INFO - 2015-12-08 04:50:11,211 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:123.00 stddev:4.25 (3.5%) stddev-sans-first:4.47 04:50:11 INFO - 2015-12-08 04:50:11,211 DEBUG : BROWSER_OUTPUT: Values: 120.0 123.0 118.0 118.0 114.0 126.0 128.0 121.0 123.0 125.0 04:50:11 INFO - 2015-12-08 04:50:11,211 DEBUG : BROWSER_OUTPUT: 04:50:11 INFO - 2015-12-08 04:50:11,211 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.00 Median:148.50 stddev:7.20 (4.8%) stddev-sans-first:6.44 04:50:11 INFO - 2015-12-08 04:50:11,211 DEBUG : BROWSER_OUTPUT: Values: 134.0 148.0 151.0 150.0 140.0 140.0 149.0 155.0 148.0 135.0 04:50:11 INFO - 2015-12-08 04:50:11,211 DEBUG : BROWSER_OUTPUT: 04:50:11 INFO - 2015-12-08 04:50:11,211 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 04:50:11 INFO - 2015-12-08 04:50:11,211 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 70.0 70.0 69.0 67.0 68.0 69.0 69.0 69.0 04:50:11 INFO - 2015-12-08 04:50:11,211 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:50:11 INFO - 2015-12-08 04:50:11,212 DEBUG : BROWSER_OUTPUT: 04:50:12 INFO - 2015-12-08 04:50:12,095 INFO : Browser exited with error code: 0 04:50:12 INFO - 2015-12-08 04:50:12,148 INFO : Completed test kraken (00:01:01) 04:50:12 INFO - 2015-12-08 04:50:12,148 INFO : Starting test v8_7 04:50:12 INFO - 2015-12-08 04:50:12,149 DEBUG : operating with platform_type : linux_ 04:50:12 INFO - 2015-12-08 04:50:12,149 INFO : Initialising browser for v8_7 test... 04:50:12 INFO - 2015-12-08 04:50:12,155 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3hqrTX/profile http://localhost:33609/getInfo.html 04:50:16 INFO - 2015-12-08 04:50:16,781 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:50:16 INFO - 2015-12-08 04:50:16,781 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:50:16 INFO - 2015-12-08 04:50:16,781 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:50:16 INFO - 2015-12-08 04:50:16,781 DEBUG : BROWSER_OUTPUT: __metrics 04:50:16 INFO - 2015-12-08 04:50:16,923 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:50:16 INFO - 2015-12-08 04:50:16,987 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:17 INFO - 2015-12-08 04:50:17,925 INFO : Browser initialized. 04:50:17 INFO - 2015-12-08 04:50:17,925 INFO : Running cycle 1/1 for v8_7 test... 04:50:17 INFO - 2015-12-08 04:50:17,925 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3hqrTX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:50:29 INFO - 2015-12-08 04:50:29,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 142909440 04:50:29 INFO - 2015-12-08 04:50:29,927 DEBUG : BROWSER_OUTPUT: 04:50:51 INFO - 2015-12-08 04:50:51,313 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33609/tests/v8_7/run.html (next: http://localhost:33609/tests/v8_7/run.html) 04:50:51 INFO - 2015-12-08 04:50:51,563 DEBUG : BROWSER_OUTPUT: RSS: Main: 452579328 04:50:51 INFO - 2015-12-08 04:50:51,563 DEBUG : BROWSER_OUTPUT: 04:50:51 INFO - 2015-12-08 04:50:51,565 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:50:51 INFO - 2015-12-08 04:50:51,565 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:50:51 INFO - 2015-12-08 04:50:51,565 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:50:51 INFO - 2015-12-08 04:50:51,565 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:50:51 INFO - 2015-12-08 04:50:51,565 DEBUG : BROWSER_OUTPUT: |0;Richards;167.9261125104954 04:50:51 INFO - 2015-12-08 04:50:51,565 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.42555164101614 04:50:51 INFO - 2015-12-08 04:50:51,565 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.17364600781684 04:50:51 INFO - 2015-12-08 04:50:51,565 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5122.448979591837 04:50:51 INFO - 2015-12-08 04:50:51,566 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1980.1980198019803 04:50:51 INFO - 2015-12-08 04:50:51,566 DEBUG : BROWSER_OUTPUT: |5;Earley;789.2659826361484 04:50:51 INFO - 2015-12-08 04:50:51,566 DEBUG : BROWSER_OUTPUT: |6;Boyer;12506.172839506173 04:50:51 INFO - 2015-12-08 04:50:51,566 DEBUG : BROWSER_OUTPUT: |7;RegExp;28714.285714285714 04:50:51 INFO - 2015-12-08 04:50:51,566 DEBUG : BROWSER_OUTPUT: |8;Splay;617.283950617284 04:50:51 INFO - 2015-12-08 04:50:51,566 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 04:50:51 INFO - 2015-12-08 04:50:51,566 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:50:51 INFO - 2015-12-08 04:50:51,567 DEBUG : BROWSER_OUTPUT: __startTimestamp1449579051563__endTimestamp 04:50:51 INFO - 2015-12-08 04:50:51,567 DEBUG : BROWSER_OUTPUT: 04:50:51 INFO - 2015-12-08 04:50:51,567 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:50:51 INFO - 2015-12-08 04:50:51,567 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:50:51 INFO - 2015-12-08 04:50:51,568 DEBUG : BROWSER_OUTPUT: 04:50:51 INFO - 2015-12-08 04:50:51,568 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.93 Median:167.93 stddev:0.00 (0.0%) 04:50:51 INFO - 2015-12-08 04:50:51,569 DEBUG : BROWSER_OUTPUT: Values: 167.9 04:50:51 INFO - 2015-12-08 04:50:51,569 DEBUG : BROWSER_OUTPUT: 04:50:51 INFO - 2015-12-08 04:50:51,569 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.43 Median:185.43 stddev:0.00 (0.0%) 04:50:51 INFO - 2015-12-08 04:50:51,569 DEBUG : BROWSER_OUTPUT: Values: 185.4 04:50:51 INFO - 2015-12-08 04:50:51,570 DEBUG : BROWSER_OUTPUT: 04:50:51 INFO - 2015-12-08 04:50:51,570 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 04:50:51 INFO - 2015-12-08 04:50:51,570 DEBUG : BROWSER_OUTPUT: Values: 279.2 04:50:51 INFO - 2015-12-08 04:50:51,570 DEBUG : BROWSER_OUTPUT: 04:50:51 INFO - 2015-12-08 04:50:51,570 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5122.45 Median:5122.45 stddev:0.00 (0.0%) 04:50:51 INFO - 2015-12-08 04:50:51,570 DEBUG : BROWSER_OUTPUT: Values: 5122.4 04:50:51 INFO - 2015-12-08 04:50:51,570 DEBUG : BROWSER_OUTPUT: 04:50:51 INFO - 2015-12-08 04:50:51,570 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1980.20 Median:1980.20 stddev:0.00 (0.0%) 04:50:51 INFO - 2015-12-08 04:50:51,571 DEBUG : BROWSER_OUTPUT: Values: 1980.2 04:50:51 INFO - 2015-12-08 04:50:51,571 DEBUG : BROWSER_OUTPUT: 04:50:51 INFO - 2015-12-08 04:50:51,571 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.27 Median:789.27 stddev:0.00 (0.0%) 04:50:51 INFO - 2015-12-08 04:50:51,571 DEBUG : BROWSER_OUTPUT: Values: 789.3 04:50:51 INFO - 2015-12-08 04:50:51,571 DEBUG : BROWSER_OUTPUT: 04:50:51 INFO - 2015-12-08 04:50:51,571 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12506.17 Median:12506.17 stddev:0.00 (0.0%) 04:50:51 INFO - 2015-12-08 04:50:51,571 DEBUG : BROWSER_OUTPUT: Values: 12506.2 04:50:51 INFO - 2015-12-08 04:50:51,572 DEBUG : BROWSER_OUTPUT: 04:50:51 INFO - 2015-12-08 04:50:51,572 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28714.29 Median:28714.29 stddev:0.00 (0.0%) 04:50:51 INFO - 2015-12-08 04:50:51,572 DEBUG : BROWSER_OUTPUT: Values: 28714.3 04:50:51 INFO - 2015-12-08 04:50:51,572 DEBUG : BROWSER_OUTPUT: 04:50:51 INFO - 2015-12-08 04:50:51,572 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:617.28 Median:617.28 stddev:0.00 (0.0%) 04:50:51 INFO - 2015-12-08 04:50:51,572 DEBUG : BROWSER_OUTPUT: Values: 617.3 04:50:51 INFO - 2015-12-08 04:50:51,572 DEBUG : BROWSER_OUTPUT: 04:50:51 INFO - 2015-12-08 04:50:51,572 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 04:50:51 INFO - 2015-12-08 04:50:51,573 DEBUG : BROWSER_OUTPUT: Values: 4840.6 04:50:51 INFO - 2015-12-08 04:50:51,573 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:50:51 INFO - 2015-12-08 04:50:51,573 DEBUG : BROWSER_OUTPUT: 04:50:52 INFO - 2015-12-08 04:50:52,435 INFO : Browser exited with error code: 0 04:50:52 INFO - 2015-12-08 04:50:52,452 INFO : Completed test v8_7 (00:00:40) 04:50:52 INFO - 2015-12-08 04:50:52,607 INFO : Completed test suite (00:20:19) 04:50:52 INFO - 2015-12-08 04:50:52,607 DEBUG : Working with test: dromaeo_css 04:50:52 INFO - 2015-12-08 04:50:52,607 DEBUG : Generating results file: dromaeo_css 04:50:52 INFO - 2015-12-08 04:50:52,608 DEBUG : Working with test: kraken 04:50:52 INFO - 2015-12-08 04:50:52,609 DEBUG : Generating results file: kraken 04:50:52 INFO - 2015-12-08 04:50:52,609 INFO : javascript benchmark 04:50:52 INFO - 2015-12-08 04:50:52,609 DEBUG : Working with test: v8_7 04:50:52 INFO - 2015-12-08 04:50:52,609 DEBUG : Generating results file: v8_7 04:50:52 INFO - 2015-12-08 04:50:52,610 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:50:52 INFO - 2015-12-08 04:50:52,664 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:50:52 INFO - 2015-12-08 04:50:52,664 DEBUG : process_Request line: dromaeo_css 6143.11 graph.html#tests=[[72,94,35]] 04:50:52 INFO - 2015-12-08 04:50:52,665 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:50:52 INFO - 2015-12-08 04:50:52,695 DEBUG : process_Request line: kraken 1519.80 graph.html#tests=[[232,94,35]] 04:50:52 INFO - 2015-12-08 04:50:52,696 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:50:52 INFO - 2015-12-08 04:50:52,734 DEBUG : process_Request line: v8_7 19597.26 graph.html#tests=[[230,94,35]] 04:50:52 INFO - 2015-12-08 04:50:52,736 INFO : javascript benchmark 04:50:52 INFO - 2015-12-08 04:50:52,739 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2591.842233954431, 2693.528632489314, 2694.5149873022874, 2701.6352792373023, 2703.351195713029, 4407.250767369547, 4534.4558652961605, 4639.536046395363, 4731.0, 4767.928481072787, 4584.7478388688605, 4616.422947131608, 4719.9292010619865, 4728.52714728527, 4762.7856746446405, 4295.570442955711, 4313.762743049139, 4347.13057388522, 4428.136513379892, 4437.5784300491405, 4389.056352884145, 4447.644188464931, 4454.510003899569, 4457.10857828434, 4493.955060449386, 4162.583741625828, 4193.161367726437, 4259.403683484315, 4259.5740425957465, 4310.849120280775, 4322.524522302544, 4327.2643650579475, 4335.436393268887, 4345.304751239786, 4383.868483945486, 4299.978500107511, 4303.505096913864, 4305.418768466279, 4311.935320970157, 4350.695451318409, 4430.401895744066, 4520.751358675271, 4536.523665015159, 4562.77186140695, 4671.252599584084, 4895.412550493964, 4957.983613359253, 4959.355283813081, 4987.5760560352055, 5007.123753343187, 5074.797008119671, 5084.9745751271, 5105.33630628016, 5108.438071812097, 5149.897002059938, 4465.12929978651, 4564.954350456453, 4723.881902952419, 4733.905321893543, 4739.834105806315, 5032.0690672225755, 5119.744012799345, 5136.743162841843, 5141.871453213699, 5150.8969820604125, 4950.777215025332, 4988.476209997971, 4990.950090499121, 4992.750362481861, 5002.1496345621335, 5078.644494885322, 5078.974605127025, 5086.364204474441, 5086.491350864958, 5114.181730923109, 4690.81236750533, 4851.345068415719, 4854.563089321978, 4911.87720306988, 5007.849764506997, 5007.324011258506, 5034.546890779848, 5037.874053148627, 5052.418971818214, 5073.162928116893, 4218.767967761742, 4221.176870510282, 4221.894452638647, 4256.233877901946, 4258.02065524931, 3570.767900086486, 3680.0063982724514, 3691.3724666806706, 3716.9778310964703, 3762.1535154589997, 4214.957850421518, 4284.635805956528, 4289.485261768607, 4322.308430651081, 4330.978345108318, 5003.874903127451, 5005.024020316004, 5027.346444962204, 5033.0688822567945, 5065.290859279704, 4111.6299533042165, 4206.957930420718, 4303.74177549348, 4306.849260275938, 4330.653547716175, 4305.268104422193, 4361.847335343311, 4377.868663940087, 4379.4525684289465, 4419.447569053868, 4743.430788305425, 4748.738819364969, 4754.405699287589, 4757.119932812441, 4764.737939413296, 4777.331173635764, 4910.631702622246, 5037.7733002014265, 5040.84877453677, 5076.416212135652, 4637.513061128533, 4649.5350464953235, 4684.6252299816615, 4792.065547218398, 4804.231322988305, 4994.1260279450225, 5018.4981501849525, 5022.698638081727, 5025.572826309658, 5054.848354549369, 5027.698338099725, 5080.466551012239, 5081.8475445736685, 5086.237064440215, 5092.261622064854, 4630.86107416778, 4750.477447480705, 4751.192297309535, 4756.19144745401, 4760.333553302609, 4799.3760811094335, 4819.855404337875, 4825.252085926687, 4826.0, 4827.155247831545, 4639.628829693549, 4698.765061746967, 4712.646551508719, 4758.095961767253, 4758.857234282977, 4833.879153021062, 4864.0, 4865.56209941107, 4881.170201065898, 4910.729909854992, 4655.976720116378, 4761.381020467317, 4771.665983381269, 4771.785269662804, 4826.348442960156], "unit": "ms", "name": "dojo.html", "value": 4585.574641171036}, {"lowerIsBetter": false, "replicates": [532.1299675031324, 537.4813305160519, 539.0889396919206, 540.2814257038137, 542.6825307195293, 25739.613905791404, 26650.600240996402, 26743.0, 34658.30683386337, 35635.10912227189, 39863.0, 40225.0, 40269.798651006706, 40403.79798101005, 40455.0, 7810.531368117902, 7965.522068675898, 7983.441159118864, 7988.360931125525, 7995.640196191156, 7164.391026762705, 7377.4835761496715, 9849.950750246275, 10059.798804023914, 10073.44596047217, 9665.758356041086, 9713.708588742315, 9716.90283097167, 9739.172170365528, 9751.26865485088, 7183.820404489878, 7370.742024029187, 9913.306068575203, 10036.347637403618, 10043.246756493256, 7049.4712896532965, 9988.500574971222, 10227.23295752814, 10247.84628230577, 10259.487025648763, 36351.0, 36707.4493882592, 36739.0, 36863.4470482943, 36900.26199475995, 2752.2844060544403, 2769.3424054313323, 2853.1155341844096, 3180.3639272145665, 3225.951610725841, 27216.139527282998, 27747.612619368952, 27922.441551168864, 27949.441011179864, 28279.293017674518, 3406.880759173417, 3458.429359155736, 3491.0, 3498.7900725956524, 3557.0929412999776, 207037.0, 207598.0, 207751.0, 208030.0, 208173.0, 50560.74719626379, 54094.45905540973, 54738.72630636901, 54786.17820732692, 54805.45194548083, 45130.54869451263, 63784.68107659432, 65712.67143664251, 65738.0, 65766.34233657602, 12917.09580329368, 13181.736365272833, 13203.603891883258, 13220.603381898558, 13237.404316805767, 9881.160101391462, 9952.601895924083, 9990.700278991642, 10004.849927251096, 10010.449425281533, 18469.445916622524, 18643.067846607617, 18743.25026998932, 18764.530886727942, 18785.0, 6952.400947782038, 7105.32499412555, 7200.495965282485, 7252.528585642022, 7380.0, 750.5534207146738, 780.0600276666603, 782.6986610155132, 813.1340122769232, 952.309575557729, 25047.0, 25214.621780673304, 25859.353516162246, 26032.0, 26670.733292666824, 910.7632015675972, 927.4018258223408, 940.2384068904073, 981.3277904635205, 1061.8194906865697, 13431.0, 13728.45086196561, 13807.654808629664, 14099.647508812363, 14144.929275353763, 260231.0, 265151.0, 265776.0, 265979.0, 266201.0, 44949.3030418176, 45088.54911450909, 45166.32250516245, 45189.0, 45279.54720452819, 1188.803847365175, 1205.6804946689135, 1207.2575366149754, 1211.9091068169746, 1225.724212052281, 24552.263432097065, 24803.751962480143, 26244.475110498064, 26275.0, 26277.343066422727, 35236.64763352334, 36400.63599364078, 39740.0, 39941.20117597574, 40156.3976540358, 242239.0, 249247.0, 249505.0, 250993.0, 251518.0, 24342.63486047746, 24630.01479940782, 24638.13766518163, 24646.0, 24686.629700554146, 29831.0, 35733.64266357303, 37614.43578346272, 38133.4279985806, 38456.0, 28121.57817632778, 28438.0, 28616.57075143916, 28719.0, 30895.691043089282, 31215.84392078025, 31500.68499315069, 31795.36409271848, 31972.68027319697, 32019.0, 30970.225744356572, 31739.68260317367, 31982.6801731989, 32044.83977580097, 32074.67925320717, 27669.723302766713, 28694.0, 29523.704762952955, 30049.0, 30613.08160755181, 21597.892010540476, 23435.882820585786, 23749.79377783977, 24120.155794547107, 24215.515689685755], "unit": "ms", "name": "ext.html", "value": 16601.847621194174}, {"lowerIsBetter": false, "replicates": [283.37374402570316, 284.21556504048834, 284.57456103125804, 285.7685274927308, 290.1848934912125, 12374.938125309383, 12733.363331833394, 15708.371665133394, 15989.800764942618, 16265.268062937166, 12452.626421207355, 12785.04112191587, 12859.035572332066, 12996.090273680846, 14200.289985500709, 3826.9043273918096, 4780.737059461728, 4836.153673107201, 4973.353464049668, 4981.651284410093, 3705.1292946157632, 3806.029462487062, 4918.778654960517, 4959.380077490314, 5419.214213938976, 5490.478404551581, 5502.339719233698, 5507.7246137692955, 5542.0301447246775, 5545.168224766277, 5352.063388906945, 5421.105517589593, 5422.0, 5424.891502169974, 5511.200875872996, 4627.745473998929, 4643.419572553431, 4643.791029403685, 4646.558576935186, 4648.48866624671, 18408.815911840844, 18498.982555959417, 18617.0, 18636.906815465973, 19352.61294774111, 1823.8540916726763, 1874.962500749991, 1966.6558352288291, 1967.5868067705799, 2087.8538502304846, 12301.3234272115, 12394.31831249281, 12464.563740269046, 12507.717739847525, 12942.288174150419, 1685.2753316074084, 1697.2616911643474, 1725.1546742096407, 1757.5430388099187, 1805.4583624912605, 52654.73672631651, 54008.72995635036, 54086.0, 54551.45448545503, 54571.45428545743, 8130.878036829452, 8183.508989460652, 8429.620667069996, 8459.703910363107, 8496.320294376435, 10495.790084198274, 10522.789544209072, 10524.579016839394, 10530.947345263225, 10535.525901334458, 6409.455196308366, 6417.935820641827, 6422.678866056678, 6429.839254018687, 6474.384933431316, 6152.046432802923, 6163.137160797492, 6206.627602343874, 6240.563160578716, 6251.874962500725, 5254.238135470336, 5258.6581872178185, 5287.286216360819, 5298.072837253465, 5309.548688361532, 1374.7594171020032, 1415.8442571317353, 1426.8787153091896, 1443.6246575890343, 1462.166565057928, 753.3408267765705, 872.9825403492022, 956.4070276428658, 978.6232300564192, 1029.3155051890558, 14612.415503379958, 14913.776293355608, 15026.398944042334, 15161.620959476102, 15450.690986180214, 697.7941507255372, 814.4868732698362, 827.7723626002897, 829.1087081387412, 851.7657644147909, 8416.495010299279, 8876.733697988942, 9030.187283144549, 9112.8633070504, 9441.0, 495445.0, 497001.0, 504073.0, 506802.0, 510338.0, 71706.56586868338, 73409.63295183597, 74290.25709742942, 74454.62772686101, 75464.24535754682, 1023.1814548361281, 1040.3393844908387, 1049.7218237167158, 1051.6687243518268, 1053.4048262731685, 13676.589702308947, 14302.57092287233, 14336.139831610137, 14464.0, 14503.709925801635, 29707.405851883275, 30602.84698576493, 31377.52933706042, 31427.68572314339, 32064.67935320617, 36786.26427471382, 38186.80906595449, 38311.80844095873, 39047.21905561816, 40686.38970415505, 8237.258646721824, 8433.87349189775, 8458.619362128597, 8496.787580310542, 9011.053839347036, 14621.122732636077, 15052.54842354731, 15117.244137793286, 15144.0, 16663.50009499717, 12891.0, 13247.470101195844, 13358.866411335763, 13530.864691353354, 13532.458701651824, 12696.619101426972, 12702.36488175606, 12731.172473789175, 13534.526291579747, 13801.723965520834, 13156.276404797445, 13339.66650833737, 13529.0, 13773.931130344285, 13790.655233618838, 7739.651715672696, 7822.0, 8079.515229086273, 8308.875366869623, 8309.750707478785, 8077.717279895175, 8128.634211460617, 9721.659741909, 12977.935110324388, 13253.469861205444], "unit": "ms", "name": "jquery.html", "value": 7991.068729566495}, {"lowerIsBetter": false, "replicates": [1435.196290077556, 1660.310970947057, 1704.8636109111264, 1728.7147620642595, 1738.6348866737976, 5880.206172166756, 6870.725170993161, 7063.752768653098, 7072.0, 7078.752243671466, 6936.445084393249, 7084.8583028339535, 7087.89368159478, 7088.468364872642, 7095.1485821701335, 2000.2299114840746, 2030.766461856883, 2042.0504465423576, 2042.3260324093014, 2042.8161465468104, 2030.1168991488676, 2075.56413153238, 2077.729895113641, 2078.1687325069943, 2080.334293026232, 2017.1124705129696, 2030.8984550772477, 2055.1676570988698, 2055.6402629539843, 2058.372196480073, 2005.147812179825, 2023.6863286190664, 2026.8378529717588, 2027.1182035814468, 2027.1587291274104, 2021.5653634468513, 2046.9590608187902, 2081.687746837971, 2084.1038353507984, 2085.165933626546, 7048.0, 7134.393576546, 7134.678939447737, 7137.321954414322, 7143.392811611019, 4026.2148880968225, 4106.753594784323, 4114.444549985744, 4131.421600975866, 4138.772367519785, 2650.165197962655, 2675.62541244226, 2686.0867305116158, 2718.4698983698186, 2727.890884364623, 836.8744688296744, 845.243507061183, 853.739609419127, 862.3532350736947, 869.6825658634616, 9491.0, 9494.715158545254, 9504.0, 9515.0, 9554.378965367228, 3592.5688917329567, 3649.251903359805, 3659.5608526976935, 3670.4127339625534, 3706.684931780775, 8025.478343907627, 8040.115587285394, 8042.235987581171, 8047.0, 8051.396145289127, 4034.5158580969883, 4042.969042894102, 4043.8584649537124, 4049.9392509112386, 4073.042834933788, 3143.528470729409, 3250.089974807058, 3634.127809325743, 3703.685186759156, 3706.981465092711, 3351.1789611545328, 3371.477420999749, 3383.052745231339, 3394.185395505061, 3413.1637748751714, 1072.2279958429917, 1080.2978064258139, 1081.2269227502375, 1085.7459634122602, 1091.9727006824894, 679.3919442099293, 681.4582406986359, 682.8156397772673, 683.5795985468901, 733.6185183704443, 6534.7386104556235, 6633.2703402625675, 6640.269570347258, 6712.127423434922, 6716.697748601325, 511.5983952597268, 517.8782985998288, 525.3275806967089, 525.5926656840902, 528.2577977940999, 4809.062232864558, 4871.537203965618, 4874.634402419832, 4886.022795440855, 4894.657373983858, 8258.132896045949, 8259.463134896212, 8426.831463370698, 8431.451955622864, 8436.662533498715, 8255.174482551696, 8259.95870020646, 8360.498370097814, 8366.916330836735, 8373.0, 6575.736970521126, 6644.169478815148, 6649.534532582673, 6680.933190668031, 6723.125993620798, 6171.938280617136, 6217.564770466024, 6222.688865556795, 6223.097650840693, 6226.066090086342, 7416.035915330973, 7430.777076687708, 7624.6950121996715, 7634.351080158249, 7660.808479787827, 7611.3530349920875, 7687.2697093776005, 7690.653920573475, 7819.374450044096, 7823.491473054461, 5965.70171491415, 6031.577789554689, 6037.366076561898, 6043.244594425697, 6043.7884674036195, 6551.541392102507, 6574.145361103026, 6667.733290668319, 6699.263081060982, 6700.966495167493, 6226.657533835682, 6270.561060725706, 6322.33615470369, 6351.71417286214, 6357.300696923242, 6136.079588061826, 6178.783742568989, 6182.443580077815, 6192.876142477216, 6237.0, 5175.171972484384, 5430.239766432782, 5702.572307076903, 6306.873862522815, 6347.9525878231425, 5767.279090113736, 5814.854628634318, 5819.301683797802, 5829.0, 5856.092305692625, 5658.490735833795, 5733.655980641175, 5753.252077229933, 5762.30852297727, 5766.481016708516], "unit": "ms", "name": "mootools.html", "value": 3883.995190058985}, {"lowerIsBetter": false, "replicates": [256.65479929494825, 258.1970073072744, 259.9779018783402, 263.5032962864999, 264.24030911130507, 5131.717755523445, 5228.973855130728, 5231.424543300234, 5248.396434410044, 5255.08036093683, 4971.726555039471, 5028.120078986181, 5107.616928730342, 5121.078205922932, 5123.820666276681, 3932.724709270359, 3935.8425662973445, 3936.1930804185217, 3937.940930886039, 3948.2300951314505, 3944.0337117406275, 3947.822347994347, 3952.7233093683453, 3953.0, 3958.1094253792953, 3909.4331321958443, 3910.042039700263, 3914.4911161548957, 3915.11909820291, 3922.313595120857, 3836.5204349456317, 3907.179492306619, 3908.042529580257, 3916.0992971616547, 3921.8823435296986, 3355.882544110969, 3359.6304406515264, 3360.630330663625, 3369.309291595217, 3371.6965473107293, 4987.376577927759, 4989.3264409305, 4994.400671919357, 4999.7750101245165, 5002.774875130628, 4464.37498750172, 4469.530699276562, 4476.082403107355, 4481.753503557303, 4482.238019536687, 5385.515303622654, 5401.081816091235, 5401.081816091274, 5415.079436495806, 5415.783368665248, 3409.09658940381, 3439.8968030959113, 3646.398344273192, 3655.3968595181764, 3659.298426231788, 5734.283214598176, 5787.421257874179, 5788.797392091299, 5811.88376232473, 5821.970890145564, 3865.903352416156, 3866.149447121629, 3870.0324918770307, 3870.322693528621, 3871.3031654302495, 3650.7261955353456, 3732.272206919679, 3822.140018495816, 3932.6264004919485, 3941.3102707026155, 4542.909141817211, 4544.7045942013665, 4547.8635640930825, 4551.38556294896, 4558.97720511402, 5528.170774383874, 5546.057170281062, 5547.805826796042, 5554.91667624986, 5561.944380556223, 1357.056845492393, 1381.1505923856957, 1383.2461308586844, 1384.563862383366, 1386.4939297156666, 909.7862002429424, 919.8252332056887, 922.6678395777515, 937.376644531379, 937.8921424036323, 4856.732879691651, 4859.854204373874, 4867.342908707279, 4868.8782780430065, 4868.902621947541, 5761.049426844607, 5771.412861463047, 5772.740226689809, 5774.422557744192, 5780.5953583248765, 4854.247591623304, 4858.708477491362, 4863.051704917507, 4867.902641947141, 4870.196417591058, 3006.2634654509784, 3077.2460747117098, 3093.5359696045325, 3097.860596273173, 3100.767442441826, 5366.6779993200535, 5390.4879036491475, 5392.514673679309, 5395.62230643859, 5396.055690254189, 5849.795257165979, 5873.089671100986, 5874.148248504029, 5875.0, 5879.559033072536, 5382.542483888835, 5386.057439947994, 5389.3562463449025, 5398.62209645321, 5401.4868587484125, 5651.773929042793, 5724.599278050663, 5825.446582574648, 5830.387809279964, 5838.153467747068, 5686.147077938343, 5689.516391106637, 5691.146328050825, 5693.857653558694, 5695.487406133302, 5448.210009548672, 5476.835694929158, 5480.698561578992, 5483.314585676791, 5484.808031718871, 3633.073566240592, 3713.20166164276, 3722.4602432647657, 3726.850925962931, 3763.134479069884, 5565.6104072714525, 5719.31280272329, 5770.3364113125845, 5813.709314534171, 5824.5631577631, 5405.24326594285, 5510.897820435849, 5611.607187496836, 5623.128415095667, 5626.015447296789, 5583.469570390806, 5605.159226116115, 5606.439356064361, 5607.046802043581, 5609.467100625434, 5326.467353264643, 5458.1266997280245, 5483.396826349019, 5484.670919744828, 5491.533219676372, 5614.326280846324, 5617.354004289396, 5625.071863142535, 5633.690147041952, 5643.266375371176, 5483.369412517612, 5500.4499550044675, 5505.532029777513, 5523.143912693539, 5523.475269849358], "unit": "ms", "name": "prototype.html", "value": 4077.620718336812}, {"lowerIsBetter": false, "replicates": [594.6045879490139, 651.3356376495977, 671.5198632977421, 693.712109474568, 716.3302312337963, 12166.756664866698, 12394.132410731241, 12403.503859845607, 12421.875781242185, 12429.627111186679, 11608.303501789878, 11679.065674746022, 11709.59016434425, 11712.472938717758, 11739.589114380999, 611.5535658968955, 618.001926888077, 618.5700937848197, 780.2860382749791, 796.3271035974622, 618.6968385491122, 623.9313675495691, 626.3892704612989, 794.4716763352393, 809.7368355284526, 794.4637369775407, 802.4904185841974, 808.559335162335, 809.6761295481825, 809.7327881798992, 643.9034144878259, 797.3860127701666, 801.9117897031322, 803.2048272210469, 803.2650125135494, 480.2580013878531, 591.798788411942, 606.6238931862274, 607.2500461929513, 607.7386723708803, 11983.460744266442, 12109.15235933485, 12163.756724865452, 12166.87833121675, 12205.93897030518, 10974.890251097546, 11568.074554035657, 11813.350265735382, 11822.763544729058, 11940.641780746504, 9007.504587247699, 9255.953720231355, 9353.438793672334, 9459.290553208468, 9483.857742133874, 3119.173419043955, 3152.0543836849083, 3171.7462602991704, 3182.840857957093, 3214.7106760391443, 36599.4510082349, 37692.0, 38270.61729382698, 38397.232055358734, 38995.805020975, 9434.716958491255, 9476.763080923032, 9630.27772917034, 9667.46828924416, 9742.902570974342, 16660.250288737036, 16682.83317166837, 16736.581585460463, 16826.91586542084, 16844.24200910962, 5936.5844390892225, 6113.877722445615, 6252.5935814171935, 6414.134091897534, 6417.294097649255, 3525.8413371398346, 3531.9293614127573, 3553.129483276562, 3583.498310236569, 3609.909752256162, 2593.6368908352847, 2636.8286061405947, 2648.4173481833964, 2655.243255672124, 2662.0948877381784, 451.4492319370363, 455.897423079811, 463.71713254914476, 471.6227018385347, 475.1494824264528, 539.6514626741063, 552.2489414396417, 562.9352624448159, 580.7734983356494, 587.4096532984408, 7504.212057733968, 8064.435489515678, 8251.33989280856, 8255.504669719716, 8297.0, 365.0194627586177, 521.5514657394638, 581.9621724587888, 585.1632166002572, 590.7961753195141, 3343.348047130835, 3490.616032236452, 3520.313538859949, 3558.839852206657, 3652.8721494747556, 48269.275960860614, 48659.756701216975, 48777.756111219926, 48794.0, 48990.0, 38190.0, 38990.415143772865, 41581.376279355834, 41877.79061104675, 43464.130717386106, 38221.42667859984, 42257.78871105686, 42753.14493710108, 42796.786016069724, 42907.0, 7638.350740187147, 7965.960170199112, 8076.353891688768, 8094.3929205311015, 8247.381446391424, 29701.257468563457, 29945.700542995164, 29996.25009374696, 30049.69950300469, 30242.395152097273, 34494.85162620876, 38222.23555528929, 38236.235275294894, 38278.23443531058, 38340.61659383371, 9600.951995239979, 9641.37331073478, 9813.067758562926, 9941.801163976825, 10036.698899033041, 10793.892061079288, 10911.672649820519, 10929.726756830825, 11028.5037173329, 11112.944435277772, 10266.486675666336, 10328.380297182193, 10431.68704938853, 10508.21188410857, 10763.138948883914, 9766.951165244129, 9975.351602145838, 10418.426986515511, 10621.787564248518, 10663.8933610666, 10212.0, 10314.845277320996, 10445.11216546602, 10509.894901050891, 10812.621558245424, 9117.908820911705, 9213.76965575866, 9265.629374824932, 9290.535473226448, 9338.112879276458, 8977.596008179778, 9210.539473026189, 9245.630174793201, 9274.44353338802, 9281.303902207226], "unit": "ms", "name": "yui.html", "value": 5577.532144541501}], "name": "dromaeo_css", "value": 6143.110258232559}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 108.0, 113.0, 114.0, 114.0, 102.0, 114.0, 112.0, 103.0], "unit": "ms", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [158.0, 131.0, 150.0, 170.0, 131.0, 153.0, 152.0, 137.0, 168.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [163.0, 160.0, 161.0, 161.0, 163.0, 162.0, 163.0, 163.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 79.0, 96.0, 72.0, 72.0, 73.0, 101.0, 91.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 131.0, 94.0, 95.0, 95.0, 135.0, 94.0, 95.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 106.3}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 148.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 94.0, 98.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [80.0, 73.0, 73.0, 73.0, 74.0, 73.0, 73.0, 74.0, 75.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 74.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 84.0, 84.0, 83.0, 82.0, 84.0, 85.0, 86.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [120.0, 123.0, 118.0, 118.0, 114.0, 126.0, 128.0, 121.0, 123.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.6}, {"lowerIsBetter": true, "replicates": [134.0, 148.0, 151.0, 150.0, 140.0, 140.0, 149.0, 155.0, 148.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 70.0, 70.0, 69.0, 67.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1519.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.9261125104954], "unit": "score", "name": "Richards", "value": 210.22340999999997}, {"lowerIsBetter": false, "replicates": [185.42555164101614], "unit": "score", "name": "DeltaBlue", "value": 356.5743740000001}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5122.448979591837], "unit": "score", "name": "Decrypt", "value": 51.96362151394425}, {"lowerIsBetter": false, "replicates": [1980.1980198019803], "unit": "score", "name": "RayTrace", "value": 373.6944450000001}, {"lowerIsBetter": false, "replicates": [789.2659826361484], "unit": "score", "name": "Earley", "value": 844.4086210000003}, {"lowerIsBetter": false, "replicates": [12506.172839506173], "unit": "score", "name": "Boyer", "value": 53.29072359328728}, {"lowerIsBetter": false, "replicates": [28714.285714285714], "unit": "score", "name": "RegExp", "value": 31.725845771144286}, {"lowerIsBetter": false, "replicates": [617.283950617284], "unit": "score", "name": "Splay", "value": 132.01541999999998}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19597.255782303993}]} 04:50:52 INFO - RETURN: dromaeo_css: 6143.11 04:50:52 INFO - RETURN: kraken: 1519.80 04:50:52 INFO - RETURN: v8_7: 19597.26 04:50:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19597.26"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1519.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6143.11"}}} 04:50:52 INFO - Return code: 0 04:50:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:50:52 INFO - # TBPL SUCCESS # 04:50:52 INFO - Running post-action listener: _resource_record_post_action 04:50:52 INFO - Running post-run listener: _resource_record_post_run 04:50:53 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 12288; Write bytes: 507195392; Read time: 68; Write time: 396348 04:50:53 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 231325696; Read time: 0; Write time: 276180 04:50:53 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 12288; Write bytes: 274890752; Read time: 68; Write time: 120132 04:50:53 INFO - Running post-run listener: _upload_blobber_files 04:50:53 INFO - Blob upload gear active. 04:50:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:50:53 INFO - Copying logs to upload dir... 04:50:53 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1287.548494 ========= master_lag: 2.85 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2015-12-08 04:50:56.479954) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:56.483905) ========= 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=20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009513 build_url: 'https://queue.taskcluster.net/v1/task/WS8cO7qLQ4m_2GFvWdTX-Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:56.513935) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:56.514596) ========= 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=20aa3857bbc5a756c598c738000001bb-1449575227.511910-547137870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-08 04:50:56.565548) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-08 04:50:56.565896) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-08 04:50:56.566216) ========= ========= Total master_lag: 3.06 =========