builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1449686256.93 results: success (0) buildid: 20151209101039 builduid: dafbc9c202b74b399d280739a5391956 revision: 973264cc53e4e859f8c76b95c006a6aed16d0a8d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 10:37:36.928778) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 10:37:36.929245) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 10:37:36.929556) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004254 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 10:37:36.973324) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 10:37:36.973662) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 10:37:37.015197) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 10:37:37.015610) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003677 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 10:37:37.078884) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 10:37:37.079545) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 10:37:37.080395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 10:37:37.080919) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-09 10:37:37-- 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% 228M=0s 2015-12-09 10:37:37 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.230137 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 10:37:37.339456) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 10:37:37.339737) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013399 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 10:37:37.393121) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 10:37:37.393493) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 973264cc53e4e859f8c76b95c006a6aed16d0a8d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 973264cc53e4e859f8c76b95c006a6aed16d0a8d --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=b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-09 10:37:37,481 truncating revision to first 12 chars 2015-12-09 10:37:37,481 Setting DEBUG logging. 2015-12-09 10:37:37,481 attempt 1/10 2015-12-09 10:37:37,481 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/973264cc53e4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-09 10:37:37,725 unpacking tar archive at: fx-team-973264cc53e4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.526371 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 10:37:37.932923) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 10:37:37.933245) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 10:37:38.059668) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 10:37:38.060082) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 10:37:38.060587) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-09 10:37:38.060894) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:37:38 INFO - MultiFileLogger online at 20151209 10:37:38 in /builds/slave/test 10:37:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:37:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:37:38 INFO - {'append_to_log': False, 10:37:38 INFO - 'base_work_dir': '/builds/slave/test', 10:37:38 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:37:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:37:38 INFO - 'branch': 'Fx-Team-Non-PGO', 10:37:38 INFO - 'buildbot_json_path': 'buildprops.json', 10:37:38 INFO - 'config_files': ('talos/linux_config.py',), 10:37:38 INFO - 'default_actions': ('clobber', 10:37:38 INFO - 'read-buildbot-config', 10:37:38 INFO - 'download-and-extract', 10:37:38 INFO - 'populate-webroot', 10:37:38 INFO - 'create-virtualenv', 10:37:38 INFO - 'install', 10:37:38 INFO - 'run-tests'), 10:37:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:37:38 INFO - 'download_minidump_stackwalk': True, 10:37:38 INFO - 'download_symbols': 'ondemand', 10:37:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:37:38 INFO - 'tooltool.py': '/tools/tooltool.py', 10:37:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:37:38 INFO - '/tools/misc-python/virtualenv.py')}, 10:37:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:37:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:37:38 INFO - 'installer_path': 'installer.exe', 10:37:38 INFO - 'log_level': 'info', 10:37:38 INFO - 'log_name': 'talos', 10:37:38 INFO - 'log_to_console': True, 10:37:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:37:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:37:38 INFO - 'opt_config_files': (), 10:37:38 INFO - 'pip_index': False, 10:37:38 INFO - 'sps_profile': False, 10:37:38 INFO - 'sps_profile_interval': 0, 10:37:38 INFO - 'suite': 'dromaeojs', 10:37:38 INFO - 'system_bits': '64', 10:37:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:37:38 INFO - 'title': 'talos-linux64-ix-022', 10:37:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:37:38 INFO - 'use_talos_json': True, 10:37:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:37:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:37:38 INFO - 'work_dir': 'build'} 10:37:38 INFO - ##### 10:37:38 INFO - ##### Running clobber step. 10:37:38 INFO - ##### 10:37:38 INFO - Running pre-action listener: _resource_record_pre_action 10:37:38 INFO - Running main action method: clobber 10:37:38 INFO - rmtree: /builds/slave/test/build 10:37:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:37:39 INFO - Running post-action listener: _resource_record_post_action 10:37:39 INFO - ##### 10:37:39 INFO - ##### Running read-buildbot-config step. 10:37:39 INFO - ##### 10:37:39 INFO - Running pre-action listener: _resource_record_pre_action 10:37:39 INFO - Running main action method: read_buildbot_config 10:37:39 INFO - Using buildbot properties: 10:37:39 INFO - { 10:37:39 INFO - "properties": { 10:37:39 INFO - "buildnumber": 999, 10:37:39 INFO - "product": "firefox", 10:37:39 INFO - "script_repo_revision": "production", 10:37:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:37:39 INFO - "repository": "", 10:37:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:37:39 INFO - "buildid": "20151209101039", 10:37:39 INFO - "slavename": "talos-linux64-ix-022", 10:37:39 INFO - "pgo_build": "False", 10:37:39 INFO - "basedir": "/builds/slave/test", 10:37:39 INFO - "project": "", 10:37:39 INFO - "platform": "ubuntu64_hw", 10:37:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:37:39 INFO - "slavebuilddir": "test", 10:37:39 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:37:39 INFO - "branch": "fx-team", 10:37:39 INFO - "repo_path": "integration/fx-team", 10:37:39 INFO - "stage_platform": "linux64", 10:37:39 INFO - "builduid": "dafbc9c202b74b399d280739a5391956", 10:37:39 INFO - "revision": "973264cc53e4e859f8c76b95c006a6aed16d0a8d" 10:37:39 INFO - }, 10:37:39 INFO - "sourcestamp": { 10:37:39 INFO - "repository": "", 10:37:39 INFO - "hasPatch": false, 10:37:39 INFO - "project": "", 10:37:39 INFO - "branch": "fx-team-linux64-talos", 10:37:39 INFO - "changes": [ 10:37:39 INFO - { 10:37:39 INFO - "category": null, 10:37:39 INFO - "files": [ 10:37:39 INFO - { 10:37:39 INFO - "url": null, 10:37:39 INFO - "name": "https://queue.taskcluster.net/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 10:37:39 INFO - } 10:37:39 INFO - ], 10:37:39 INFO - "repository": "", 10:37:39 INFO - "rev": "973264cc53e4e859f8c76b95c006a6aed16d0a8d", 10:37:39 INFO - "who": "pbrosset@mozilla.com", 10:37:39 INFO - "when": 1449686230, 10:37:39 INFO - "number": 7169381, 10:37:39 INFO - "comments": "Bug 1228005 - 2 - Tests for the keyframes and animated properties panel; r=tromey", 10:37:39 INFO - "project": "", 10:37:39 INFO - "at": "Wed 09 Dec 2015 10:37:10", 10:37:39 INFO - "branch": "fx-team-linux64-talos", 10:37:39 INFO - "revlink": "", 10:37:39 INFO - "properties": [ 10:37:39 INFO - [ 10:37:39 INFO - "buildid", 10:37:39 INFO - "20151209101039", 10:37:39 INFO - "Change" 10:37:39 INFO - ], 10:37:39 INFO - [ 10:37:39 INFO - "builduid", 10:37:39 INFO - "dafbc9c202b74b399d280739a5391956", 10:37:39 INFO - "Change" 10:37:39 INFO - ], 10:37:39 INFO - [ 10:37:39 INFO - "pgo_build", 10:37:39 INFO - "False", 10:37:39 INFO - "Change" 10:37:39 INFO - ] 10:37:39 INFO - ], 10:37:39 INFO - "revision": "973264cc53e4e859f8c76b95c006a6aed16d0a8d" 10:37:39 INFO - } 10:37:39 INFO - ], 10:37:39 INFO - "revision": "973264cc53e4e859f8c76b95c006a6aed16d0a8d" 10:37:39 INFO - } 10:37:39 INFO - } 10:37:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 10:37:39 INFO - Running post-action listener: _resource_record_post_action 10:37:39 INFO - ##### 10:37:39 INFO - ##### Running download-and-extract step. 10:37:39 INFO - ##### 10:37:39 INFO - Running pre-action listener: _resource_record_pre_action 10:37:39 INFO - Running main action method: download_and_extract 10:37:39 INFO - mkdir: /builds/slave/test/build/tests 10:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:39 INFO - https://queue.taskcluster.net/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:37:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/test_packages.json 10:37:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/test_packages.json 10:37:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:37:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:37:39 INFO - Downloaded 1302 bytes. 10:37:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:37:39 INFO - Using the following test package requirements: 10:37:39 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:37:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:37:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:39 INFO - u'jsshell-linux-x86_64.zip'], 10:37:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:37:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:37:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:37:39 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:37:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:37:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:37:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:37:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:37:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:37:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:39 INFO - https://queue.taskcluster.net/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:37:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:37:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:37:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/av6V2N4uTQK0a2GTgGjhVQ/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 10:37:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/av6V2N4uTQK0a2GTgGjhVQ/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 10:37:40 INFO - Downloaded 21860154 bytes. 10:37:40 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 10:37:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:37:40 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 10:37:41 INFO - Return code: 0 10:37:41 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 10:37:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:37:41 INFO - https://queue.taskcluster.net/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:37:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:37:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:37:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/av6V2N4uTQK0a2GTgGjhVQ/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 10:37:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/av6V2N4uTQK0a2GTgGjhVQ/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 10:37:43 INFO - Downloaded 21860154 bytes. 10:37:43 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 10:37:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:37:43 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 10:37:44 INFO - Return code: 0 10:37:44 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')]} 10:37:44 INFO - https://queue.taskcluster.net/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:37:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:37:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:37:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/av6V2N4uTQK0a2GTgGjhVQ/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 10:37:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/av6V2N4uTQK0a2GTgGjhVQ/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 10:37:45 INFO - Downloaded 11132038 bytes. 10:37:45 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 10:37:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:37:45 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 10:37:46 INFO - Return code: 0 10:37:46 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')]} 10:37:46 INFO - https://queue.taskcluster.net/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:37:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:37:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:37:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/av6V2N4uTQK0a2GTgGjhVQ/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 10:37:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/av6V2N4uTQK0a2GTgGjhVQ/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 10:37:47 INFO - Downloaded 57733326 bytes. 10:37:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:37:47 INFO - mkdir: /builds/slave/test/properties 10:37:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:37:47 INFO - Writing to file /builds/slave/test/properties/build_url 10:37:47 INFO - Contents: 10:37:47 INFO - build_url:https://queue.taskcluster.net/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:37:47 INFO - Running post-action listener: _resource_record_post_action 10:37:47 INFO - Running post-action listener: set_extra_try_arguments 10:37:47 INFO - ##### 10:37:47 INFO - ##### Running populate-webroot step. 10:37:47 INFO - ##### 10:37:47 INFO - Running pre-action listener: _resource_record_pre_action 10:37:47 INFO - Running main action method: populate_webroot 10:37:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:37:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:37:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:37:47 INFO - '--tppagecycles', 10:37:47 INFO - '7'], 10:37:47 INFO - 'tests': ['tsvgm']}}, 10:37:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:37:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:37:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:37:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:37:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:37:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:37:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:37:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:47 INFO - 'talos_options': ['--e10s'], 10:37:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:37:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:47 INFO - 'tests': ['damp', 'tps']}, 10:37:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:47 INFO - 'talos_options': ['--e10s'], 10:37:47 INFO - 'tests': ['damp', 'tps']}, 10:37:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:37:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:37:47 INFO - 'other': {'tests': ['a11yr', 10:37:47 INFO - 'ts_paint', 10:37:47 INFO - 'tpaint', 10:37:47 INFO - 'sessionrestore', 10:37:47 INFO - 'sessionrestore_no_auto_restore']}, 10:37:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:37:47 INFO - 'tests': ['a11yr', 10:37:47 INFO - 'ts_paint', 10:37:47 INFO - 'tpaint', 10:37:47 INFO - 'sessionrestore', 10:37:47 INFO - 'sessionrestore_no_auto_restore']}, 10:37:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:37:47 INFO - 'tests': ['a11yr', 10:37:47 INFO - 'ts_paint', 10:37:47 INFO - 'tpaint', 10:37:47 INFO - 'sessionrestore', 10:37:47 INFO - 'sessionrestore_no_auto_restore']}, 10:37:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:37:47 INFO - 'tests': ['a11yr', 10:37:47 INFO - 'ts_paint', 10:37:47 INFO - 'tpaint', 10:37:47 INFO - 'sessionrestore', 10:37:47 INFO - 'sessionrestore_no_auto_restore']}, 10:37:47 INFO - 'other_l64': {'tests': ['a11yr', 10:37:47 INFO - 'ts_paint', 10:37:47 INFO - 'tpaint', 10:37:47 INFO - 'sessionrestore', 10:37:47 INFO - 'sessionrestore_no_auto_restore']}, 10:37:47 INFO - 'other_nol64': {'tests': ['a11yr', 10:37:47 INFO - 'ts_paint', 10:37:47 INFO - 'tpaint', 10:37:47 INFO - 'sessionrestore', 10:37:47 INFO - 'sessionrestore_no_auto_restore']}, 10:37:47 INFO - 'svgr': {'tests': ['tsvgx', 10:37:47 INFO - 'tsvgr_opacity', 10:37:47 INFO - 'tart', 10:37:47 INFO - 'tscrollx', 10:37:47 INFO - 'cart']}, 10:37:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:37:47 INFO - 'tests': ['tsvgx', 10:37:47 INFO - 'tsvgr_opacity', 10:37:47 INFO - 'tart', 10:37:47 INFO - 'tscrollx', 10:37:47 INFO - 'cart']}, 10:37:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:47 INFO - 'tests': ['tp5o']}, 10:37:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:47 INFO - 'talos_options': ['--e10s'], 10:37:47 INFO - 'tests': ['tp5o']}, 10:37:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:47 INFO - 'talos_options': ['--xperf_path', 10:37:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:37:47 INFO - 'tests': ['tp5n']}, 10:37:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:37:47 INFO - 'talos_options': ['--e10s', 10:37:47 INFO - '--xperf_path', 10:37:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:37:47 INFO - 'tests': ['tp5n']}}, 10:37:47 INFO - 'talos.zip': {'path': '', 10:37:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:37:47 INFO - Running post-action listener: _resource_record_post_action 10:37:47 INFO - ##### 10:37:47 INFO - ##### Running create-virtualenv step. 10:37:47 INFO - ##### 10:37:47 INFO - Running pre-action listener: _resource_record_pre_action 10:37:47 INFO - Running main action method: create_virtualenv 10:37:47 INFO - Creating virtualenv /builds/slave/test/build/venv 10:37:47 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 10:37:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:37:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:37:47 INFO - Using real prefix '/usr' 10:37:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:37:48 INFO - Installing distribute.............................................................................................................................................................................................done. 10:37:51 INFO - Installing pip.................done. 10:37:51 INFO - Return code: 0 10:37:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:37: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')]} 10:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37: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')]} 10:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:51 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 0x7f6ec4813f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e0b0>, '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 0x188efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188f440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703', '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 10:37:51 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 10:37:51 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 10:37:51 INFO - Using env: {'DISPLAY': ':0', 10:37:51 INFO - 'HOME': '/home/cltbld', 10:37:51 INFO - 'LANG': 'en_US.UTF-8', 10:37:51 INFO - 'LANGUAGE': 'en_US:en', 10:37:51 INFO - 'LOGNAME': 'cltbld', 10:37:51 INFO - 'MAIL': '/var/mail/cltbld', 10:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:51 INFO - 'MOZ_NO_REMOTE': '1', 10:37:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:51 INFO - 'NO_EM_RESTART': '1', 10:37:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:51 INFO - 'PWD': '/builds/slave/test', 10:37:51 INFO - 'SHELL': '/bin/bash', 10:37:51 INFO - 'SHLVL': '1', 10:37:51 INFO - 'TERM': 'linux', 10:37:51 INFO - 'TMOUT': '86400', 10:37:51 INFO - 'USER': 'cltbld', 10:37:51 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703', 10:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:51 INFO - '_': '/tools/buildbot/bin/python'} 10:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:53 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 10:37:53 INFO - Cleaning up... 10:37:53 INFO - Return code: 0 10:37:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:37: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')]} 10:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37: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')]} 10:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:53 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 0x7f6ec4813f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e0b0>, '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 0x188efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188f440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703', '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 10:37:53 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 10:37:53 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 10:37:53 INFO - Using env: {'DISPLAY': ':0', 10:37:53 INFO - 'HOME': '/home/cltbld', 10:37:53 INFO - 'LANG': 'en_US.UTF-8', 10:37:53 INFO - 'LANGUAGE': 'en_US:en', 10:37:53 INFO - 'LOGNAME': 'cltbld', 10:37:53 INFO - 'MAIL': '/var/mail/cltbld', 10:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:53 INFO - 'MOZ_NO_REMOTE': '1', 10:37:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:53 INFO - 'NO_EM_RESTART': '1', 10:37:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:53 INFO - 'PWD': '/builds/slave/test', 10:37:53 INFO - 'SHELL': '/bin/bash', 10:37:53 INFO - 'SHLVL': '1', 10:37:53 INFO - 'TERM': 'linux', 10:37:53 INFO - 'TMOUT': '86400', 10:37:53 INFO - 'USER': 'cltbld', 10:37:53 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703', 10:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:53 INFO - '_': '/tools/buildbot/bin/python'} 10:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:53 INFO - Downloading/unpacking psutil>=0.7.1 10:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:37:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:37:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:37:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:37:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:37:55 INFO - Installing collected packages: psutil 10:37:55 INFO - Running setup.py install for psutil 10:37:55 INFO - building 'psutil._psutil_linux' extension 10:37:55 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 10:37:56 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 10:37:56 INFO - building 'psutil._psutil_posix' extension 10:37:56 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 10:37:57 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 10:37:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:37:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:37:57 INFO - Successfully installed psutil 10:37:57 INFO - Cleaning up... 10:37:58 INFO - Return code: 0 10:37:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:37:58 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')]} 10:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:58 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')]} 10:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:37:58 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 0x7f6ec4813f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e0b0>, '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 0x188efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188f440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703', '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 10:37:58 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 10:37:58 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 10:37:58 INFO - Using env: {'DISPLAY': ':0', 10:37:58 INFO - 'HOME': '/home/cltbld', 10:37:58 INFO - 'LANG': 'en_US.UTF-8', 10:37:58 INFO - 'LANGUAGE': 'en_US:en', 10:37:58 INFO - 'LOGNAME': 'cltbld', 10:37:58 INFO - 'MAIL': '/var/mail/cltbld', 10:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:58 INFO - 'MOZ_NO_REMOTE': '1', 10:37:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:37:58 INFO - 'NO_EM_RESTART': '1', 10:37:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:58 INFO - 'PWD': '/builds/slave/test', 10:37:58 INFO - 'SHELL': '/bin/bash', 10:37:58 INFO - 'SHLVL': '1', 10:37:58 INFO - 'TERM': 'linux', 10:37:58 INFO - 'TMOUT': '86400', 10:37:58 INFO - 'USER': 'cltbld', 10:37:58 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703', 10:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:58 INFO - '_': '/tools/buildbot/bin/python'} 10:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:37:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:37:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:37:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:37:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:37:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:37:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:37:59 INFO - Installing collected packages: mozsystemmonitor 10:37:59 INFO - Running setup.py install for mozsystemmonitor 10:38:00 INFO - Successfully installed mozsystemmonitor 10:38:00 INFO - Cleaning up... 10:38:00 INFO - Return code: 0 10:38:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:00 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 0x7f6ec4813f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e0b0>, '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 0x188efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188f440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703', '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 10:38:00 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 10:38:00 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 10:38:00 INFO - Using env: {'DISPLAY': ':0', 10:38:00 INFO - 'HOME': '/home/cltbld', 10:38:00 INFO - 'LANG': 'en_US.UTF-8', 10:38:00 INFO - 'LANGUAGE': 'en_US:en', 10:38:00 INFO - 'LOGNAME': 'cltbld', 10:38:00 INFO - 'MAIL': '/var/mail/cltbld', 10:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:00 INFO - 'MOZ_NO_REMOTE': '1', 10:38:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:00 INFO - 'NO_EM_RESTART': '1', 10:38:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:00 INFO - 'PWD': '/builds/slave/test', 10:38:00 INFO - 'SHELL': '/bin/bash', 10:38:00 INFO - 'SHLVL': '1', 10:38:00 INFO - 'TERM': 'linux', 10:38:00 INFO - 'TMOUT': '86400', 10:38:00 INFO - 'USER': 'cltbld', 10:38:00 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703', 10:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:00 INFO - '_': '/tools/buildbot/bin/python'} 10:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:00 INFO - Downloading/unpacking blobuploader==1.2.4 10:38:00 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 10:38:00 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 10:38:00 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 10:38:00 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 10:38:00 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 10:38:00 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 10:38:01 INFO - Downloading blobuploader-1.2.4.tar.gz 10:38:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:38:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:38:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:38:02 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 10:38:02 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 10:38:02 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 10:38:02 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 10:38:02 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 10:38:02 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 10:38:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:38:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:38:02 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 10:38:02 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 10:38:02 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 10:38:02 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 10:38:02 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 10:38:02 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 10:38:02 INFO - Downloading docopt-0.6.1.tar.gz 10:38:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:38:02 INFO - Installing collected packages: blobuploader, requests, docopt 10:38:02 INFO - Running setup.py install for blobuploader 10:38:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:38:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:38:02 INFO - Running setup.py install for requests 10:38:03 INFO - Running setup.py install for docopt 10:38:03 INFO - Successfully installed blobuploader requests docopt 10:38:03 INFO - Cleaning up... 10:38:03 INFO - Return code: 0 10:38:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:03 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 0x7f6ec4813f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e0b0>, '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 0x188efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188f440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703', '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 10:38:03 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 10:38:03 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 10:38:03 INFO - Using env: {'DISPLAY': ':0', 10:38:03 INFO - 'HOME': '/home/cltbld', 10:38:03 INFO - 'LANG': 'en_US.UTF-8', 10:38:03 INFO - 'LANGUAGE': 'en_US:en', 10:38:03 INFO - 'LOGNAME': 'cltbld', 10:38:03 INFO - 'MAIL': '/var/mail/cltbld', 10:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:03 INFO - 'MOZ_NO_REMOTE': '1', 10:38:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:03 INFO - 'NO_EM_RESTART': '1', 10:38:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:03 INFO - 'PWD': '/builds/slave/test', 10:38:03 INFO - 'SHELL': '/bin/bash', 10:38:03 INFO - 'SHLVL': '1', 10:38:03 INFO - 'TERM': 'linux', 10:38:03 INFO - 'TMOUT': '86400', 10:38:03 INFO - 'USER': 'cltbld', 10:38:03 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703', 10:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:03 INFO - '_': '/tools/buildbot/bin/python'} 10:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:38:03 INFO - Running setup.py (path:/tmp/pip-UPwh1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:38:03 INFO - Running setup.py (path:/tmp/pip-aQJWZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:38:03 INFO - Running setup.py (path:/tmp/pip-WP8Ily-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:38:03 INFO - Running setup.py (path:/tmp/pip-xOs9No-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:38:03 INFO - Running setup.py (path:/tmp/pip-UrLA4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:38:03 INFO - Running setup.py (path:/tmp/pip-UUyQNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:38:03 INFO - Running setup.py (path:/tmp/pip-oIO8BS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:38:04 INFO - Running setup.py (path:/tmp/pip-1oV3_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:38:04 INFO - Running setup.py (path:/tmp/pip-N9UNfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:38:04 INFO - Running setup.py (path:/tmp/pip-vqzNtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:38:04 INFO - Running setup.py (path:/tmp/pip-X0GKi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:38:04 INFO - Running setup.py (path:/tmp/pip-PuLjJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:38:04 INFO - Running setup.py (path:/tmp/pip-WA8iSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:38:04 INFO - Running setup.py (path:/tmp/pip-sCPnvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:04 INFO - Running setup.py (path:/tmp/pip-hD9KQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:38:04 INFO - Running setup.py (path:/tmp/pip-JGoR0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:38:04 INFO - Running setup.py (path:/tmp/pip-nz02XJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:38:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:38:04 INFO - Running setup.py install for manifestparser 10:38:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:38:04 INFO - Running setup.py install for mozcrash 10:38:04 INFO - Running setup.py install for mozdebug 10:38:05 INFO - Running setup.py install for mozdevice 10:38:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:38:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:38:05 INFO - Running setup.py install for mozfile 10:38:05 INFO - Running setup.py install for mozhttpd 10:38:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:38:05 INFO - Running setup.py install for mozinfo 10:38:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:38:05 INFO - Running setup.py install for mozInstall 10:38:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:38:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:38:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:38:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:38:05 INFO - Running setup.py install for mozleak 10:38:05 INFO - Running setup.py install for mozlog 10:38:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:38:05 INFO - Running setup.py install for moznetwork 10:38:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:38:05 INFO - Running setup.py install for mozprocess 10:38:05 INFO - Running setup.py install for mozprofile 10:38:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:38:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:38:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:38:06 INFO - Running setup.py install for mozrunner 10:38:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:38:06 INFO - Running setup.py install for mozscreenshot 10:38:06 INFO - Running setup.py install for moztest 10:38:06 INFO - Running setup.py install for mozversion 10:38:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:38:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:38:06 INFO - Cleaning up... 10:38:06 INFO - Return code: 0 10:38:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:06 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 0x7f6ec4813f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e0b0>, '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 0x188efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188f440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703', '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 10:38:06 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 10:38:06 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 10:38:06 INFO - Using env: {'DISPLAY': ':0', 10:38:06 INFO - 'HOME': '/home/cltbld', 10:38:06 INFO - 'LANG': 'en_US.UTF-8', 10:38:06 INFO - 'LANGUAGE': 'en_US:en', 10:38:06 INFO - 'LOGNAME': 'cltbld', 10:38:06 INFO - 'MAIL': '/var/mail/cltbld', 10:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:06 INFO - 'MOZ_NO_REMOTE': '1', 10:38:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:06 INFO - 'NO_EM_RESTART': '1', 10:38:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:06 INFO - 'PWD': '/builds/slave/test', 10:38:06 INFO - 'SHELL': '/bin/bash', 10:38:06 INFO - 'SHLVL': '1', 10:38:06 INFO - 'TERM': 'linux', 10:38:06 INFO - 'TMOUT': '86400', 10:38:06 INFO - 'USER': 'cltbld', 10:38:06 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703', 10:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:06 INFO - '_': '/tools/buildbot/bin/python'} 10:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:38:06 INFO - Running setup.py (path:/tmp/pip-fvRwTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:38:06 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)) 10:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:38:06 INFO - Running setup.py (path:/tmp/pip-DYBq1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:38:06 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)) 10:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:38:06 INFO - Running setup.py (path:/tmp/pip-6RCI7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:38:06 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)) 10:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:38:06 INFO - Running setup.py (path:/tmp/pip-hxd6dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:38:07 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)) 10:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:38:07 INFO - Running setup.py (path:/tmp/pip-8gStIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:38:07 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)) 10:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:38:07 INFO - Running setup.py (path:/tmp/pip-mElV0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:38:07 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)) 10:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:38:07 INFO - Running setup.py (path:/tmp/pip-6RKjw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:38:07 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)) 10:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:38:07 INFO - Running setup.py (path:/tmp/pip-gFGgxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:38:07 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)) 10:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:38:07 INFO - Running setup.py (path:/tmp/pip-G2B4DW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:38:07 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)) 10:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:38:07 INFO - Running setup.py (path:/tmp/pip-eM37yS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:38:07 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)) 10:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:38:07 INFO - Running setup.py (path:/tmp/pip-odg4lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:38:07 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)) 10:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:38:07 INFO - Running setup.py (path:/tmp/pip-O2U694-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:38:07 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)) 10:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:38:07 INFO - Running setup.py (path:/tmp/pip-0s_MKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:38:07 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)) 10:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:38:07 INFO - Running setup.py (path:/tmp/pip-lcywvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:38:07 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)) 10:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:07 INFO - Running setup.py (path:/tmp/pip-NdcjB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:07 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)) 10:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:38:07 INFO - Running setup.py (path:/tmp/pip-JnHgT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:38:07 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)) 10:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:38:07 INFO - Running setup.py (path:/tmp/pip-6GbQpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:38:07 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)) 10:38:07 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)) 10:38:07 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)) 10:38:07 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)) 10:38:07 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)) 10:38:07 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)) 10:38:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:38:07 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 10:38:07 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 10:38:07 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 10:38:07 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 10:38:07 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 10:38:07 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 10:38:09 INFO - Downloading blessings-1.5.1.tar.gz 10:38:09 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 10:38:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:38:09 INFO - Installing collected packages: blessings 10:38:09 INFO - Running setup.py install for blessings 10:38:09 INFO - Successfully installed blessings 10:38:09 INFO - Cleaning up... 10:38:09 INFO - Return code: 0 10:38:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:38:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:38:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:38:10 INFO - Reading from file tmpfile_stdout 10:38:10 INFO - Current package versions: 10:38:10 INFO - argparse == 1.2.1 10:38:10 INFO - blessings == 1.5.1 10:38:10 INFO - blobuploader == 1.2.4 10:38:10 INFO - docopt == 0.6.1 10:38:10 INFO - manifestparser == 1.1 10:38:10 INFO - mozInstall == 1.12 10:38:10 INFO - mozcrash == 0.16 10:38:10 INFO - mozdebug == 0.1 10:38:10 INFO - mozdevice == 0.47 10:38:10 INFO - mozfile == 1.2 10:38:10 INFO - mozhttpd == 0.7 10:38:10 INFO - mozinfo == 0.9 10:38:10 INFO - mozleak == 0.1 10:38:10 INFO - mozlog == 3.1 10:38:10 INFO - moznetwork == 0.27 10:38:10 INFO - mozprocess == 0.22 10:38:10 INFO - mozprofile == 0.27 10:38:10 INFO - mozrunner == 6.11 10:38:10 INFO - mozscreenshot == 0.1 10:38:10 INFO - mozsystemmonitor == 0.0 10:38:10 INFO - moztest == 0.7 10:38:10 INFO - mozversion == 1.4 10:38:10 INFO - psutil == 3.1.1 10:38:10 INFO - requests == 1.2.3 10:38:10 INFO - wsgiref == 0.1.2 10:38:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:10 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 0x7f6ec4813f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e0b0>, '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 0x188efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188f440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703', '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 10:38:10 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 10:38:10 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 10:38:10 INFO - Using env: {'DISPLAY': ':0', 10:38:10 INFO - 'HOME': '/home/cltbld', 10:38:10 INFO - 'LANG': 'en_US.UTF-8', 10:38:10 INFO - 'LANGUAGE': 'en_US:en', 10:38:10 INFO - 'LOGNAME': 'cltbld', 10:38:10 INFO - 'MAIL': '/var/mail/cltbld', 10:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:10 INFO - 'MOZ_NO_REMOTE': '1', 10:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:10 INFO - 'NO_EM_RESTART': '1', 10:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:10 INFO - 'PWD': '/builds/slave/test', 10:38:10 INFO - 'SHELL': '/bin/bash', 10:38:10 INFO - 'SHLVL': '1', 10:38:10 INFO - 'TERM': 'linux', 10:38:10 INFO - 'TMOUT': '86400', 10:38:10 INFO - 'USER': 'cltbld', 10:38:10 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703', 10:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:10 INFO - '_': '/tools/buildbot/bin/python'} 10:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:10 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)) 10:38:10 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)) 10:38:10 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)) 10:38:10 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)) 10:38:10 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)) 10:38:10 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)) 10:38:10 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)) 10:38:10 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)) 10:38:10 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)) 10:38:10 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)) 10:38:10 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)) 10:38:10 INFO - Cleaning up... 10:38:10 INFO - Return code: 0 10:38:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:10 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 0x7f6ec4813f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e0b0>, '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 0x188efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188f440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703', '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 10:38:10 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 10:38:10 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 10:38:10 INFO - Using env: {'DISPLAY': ':0', 10:38:10 INFO - 'HOME': '/home/cltbld', 10:38:10 INFO - 'LANG': 'en_US.UTF-8', 10:38:10 INFO - 'LANGUAGE': 'en_US:en', 10:38:10 INFO - 'LOGNAME': 'cltbld', 10:38:10 INFO - 'MAIL': '/var/mail/cltbld', 10:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:10 INFO - 'MOZ_NO_REMOTE': '1', 10:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:10 INFO - 'NO_EM_RESTART': '1', 10:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:10 INFO - 'PWD': '/builds/slave/test', 10:38:10 INFO - 'SHELL': '/bin/bash', 10:38:10 INFO - 'SHLVL': '1', 10:38:10 INFO - 'TERM': 'linux', 10:38:10 INFO - 'TMOUT': '86400', 10:38:10 INFO - 'USER': 'cltbld', 10:38:10 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703', 10:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:10 INFO - '_': '/tools/buildbot/bin/python'} 10:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:10 INFO - Downloading/unpacking jsonschema 10:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:38:12 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 10:38:12 INFO - Downloading/unpacking functools32 (from jsonschema) 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38:12 INFO - Downloading functools32-3.2.3-2.tar.gz 10:38:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:38:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:38:12 INFO - warning: no files found matching '*.txt' 10:38:12 INFO - no previously-included directories found matching 'build' 10:38:12 INFO - no previously-included directories found matching 'dist' 10:38:12 INFO - no previously-included directories found matching '.git*' 10:38:12 INFO - Installing collected packages: jsonschema, functools32 10:38:12 INFO - Running setup.py install for functools32 10:38:12 INFO - warning: no files found matching '*.txt' 10:38:12 INFO - no previously-included directories found matching 'build' 10:38:12 INFO - no previously-included directories found matching 'dist' 10:38:12 INFO - no previously-included directories found matching '.git*' 10:38:12 INFO - Successfully installed jsonschema functools32 10:38:12 INFO - Cleaning up... 10:38:12 INFO - Return code: 0 10:38:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:12 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 0x7f6ec4813f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17318a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17ff240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x188e0b0>, '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 0x188efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188f440>, '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': 'b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703', '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 10:38:12 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 10:38:12 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 10:38:12 INFO - Using env: {'DISPLAY': ':0', 10:38:12 INFO - 'HOME': '/home/cltbld', 10:38:12 INFO - 'LANG': 'en_US.UTF-8', 10:38:12 INFO - 'LANGUAGE': 'en_US:en', 10:38:12 INFO - 'LOGNAME': 'cltbld', 10:38:12 INFO - 'MAIL': '/var/mail/cltbld', 10:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:12 INFO - 'MOZ_NO_REMOTE': '1', 10:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:12 INFO - 'NO_EM_RESTART': '1', 10:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:12 INFO - 'PWD': '/builds/slave/test', 10:38:12 INFO - 'SHELL': '/bin/bash', 10:38:12 INFO - 'SHLVL': '1', 10:38:12 INFO - 'TERM': 'linux', 10:38:12 INFO - 'TMOUT': '86400', 10:38:12 INFO - 'USER': 'cltbld', 10:38:12 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703', 10:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:12 INFO - '_': '/tools/buildbot/bin/python'} 10:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:12 INFO - Downloading/unpacking flake8 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:38:14 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 10:38:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:38:14 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 10:38:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38:15 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 10:38:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:38:15 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 10:38:15 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 10:38:15 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 10:38:15 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 10:38:15 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 10:38:15 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 10:38:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:38:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:38:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:38:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:38:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:38:15 INFO - no previously-included directories found matching 'docs/_build' 10:38:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:38:15 INFO - Running setup.py install for pep8 10:38:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:38:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:38:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:38:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:38:15 INFO - no previously-included directories found matching 'docs/_build' 10:38:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:38:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:38:15 INFO - Cleaning up... 10:38:15 INFO - Return code: 0 10:38:15 INFO - Running post-action listener: _resource_record_post_action 10:38:15 INFO - Running post-action listener: _start_resource_monitoring 10:38:15 INFO - Starting resource monitoring. 10:38:15 INFO - ##### 10:38:15 INFO - ##### Running install step. 10:38:15 INFO - ##### 10:38:15 INFO - Running pre-action listener: _resource_record_pre_action 10:38:15 INFO - Running main action method: install 10:38:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:38:15 INFO - Reading from file tmpfile_stdout 10:38:15 INFO - Detecting whether we're running mozinstall >=1.0... 10:38:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:38:15 INFO - Reading from file tmpfile_stdout 10:38:15 INFO - Output received: 10:38:15 INFO - Usage: mozinstall [options] installer 10:38:15 INFO - Options: 10:38:15 INFO - -h, --help show this help message and exit 10:38:15 INFO - -d DEST, --destination=DEST 10:38:15 INFO - Directory to install application into. [default: 10:38:15 INFO - "/builds/slave/test"] 10:38:15 INFO - --app=APP Application being installed. [default: firefox] 10:38:15 INFO - mkdir: /builds/slave/test/build/application 10:38:15 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'] 10:38:15 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 10:38:30 INFO - Reading from file tmpfile_stdout 10:38:30 INFO - Output received: 10:38:30 INFO - /builds/slave/test/build/application/firefox/firefox 10:38:30 INFO - Running post-action listener: _resource_record_post_action 10:38:30 INFO - ##### 10:38:30 INFO - ##### Running run-tests step. 10:38:30 INFO - ##### 10:38:30 INFO - Running pre-action listener: _resource_record_pre_action 10:38:30 INFO - Running main action method: run_tests 10:38:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:38:30 INFO - Python 2.7.3 10:38:30 INFO - Return code: 0 10:38:30 INFO - grabbing minidump binary from tooltool 10:38:30 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')]} 10:38:30 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 0x188e0b0>, '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 0x188efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x188f440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:38:30 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 10:38:30 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 10:38:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:38:30 INFO - Return code: 0 10:38:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:38:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:38:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:38:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:38:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:38:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:38:31 INFO - Return code: 0 10:38:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] in /builds/slave/test/build 10:38:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost 10:38:31 INFO - Using env: {'DISPLAY': ':0', 10:38:31 INFO - 'HOME': '/home/cltbld', 10:38:31 INFO - 'LANG': 'en_US.UTF-8', 10:38:31 INFO - 'LANGUAGE': 'en_US:en', 10:38:31 INFO - 'LOGNAME': 'cltbld', 10:38:31 INFO - 'MAIL': '/var/mail/cltbld', 10:38:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:38:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:38:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:31 INFO - 'MOZ_NO_REMOTE': '1', 10:38:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:38:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:31 INFO - 'NO_EM_RESTART': '1', 10:38:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:31 INFO - 'PWD': '/builds/slave/test', 10:38:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:38:31 INFO - 'SHELL': '/bin/bash', 10:38:31 INFO - 'SHLVL': '1', 10:38:31 INFO - 'TERM': 'linux', 10:38:31 INFO - 'TMOUT': '86400', 10:38:31 INFO - 'USER': 'cltbld', 10:38:31 INFO - 'XDG_SESSION_COOKIE': 'b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703', 10:38:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:31 INFO - '_': '/tools/buildbot/bin/python'} 10:38:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost'] with output_timeout 3600 10:38:32 INFO - mozversion INFO | application_buildid: 20151209101039 10:38:32 INFO - mozversion INFO | application_changeset: 973264cc53e4e859f8c76b95c006a6aed16d0a8d 10:38:32 INFO - mozversion INFO | application_display_name: Nightly 10:38:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:38:32 INFO - mozversion INFO | application_name: Firefox 10:38:32 INFO - mozversion INFO | application_remotingname: firefox 10:38:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:38:32 INFO - mozversion INFO | application_vendor: Mozilla 10:38:32 INFO - mozversion INFO | application_version: 45.0a1 10:38:32 INFO - mozversion INFO | platform_buildid: 20151209101039 10:38:32 INFO - mozversion INFO | platform_changeset: 973264cc53e4e859f8c76b95c006a6aed16d0a8d 10:38:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:38:32 INFO - mozversion INFO | platform_version: 45.0a1 10:38:32 INFO - 2015-12-09 10:38:32,277 DEBUG : using testdate: 1449686312 10:38:32 INFO - 2015-12-09 10:38:32,277 DEBUG : actual date: 1449686312 10:38:32 INFO - 2015-12-09 10:38:32,294 INFO : starting webserver on 'localhost:48128' 10:38:32 INFO - 2015-12-09 10:38:32,295 INFO : Starting test suite talos-linux64-ix-022 10:38:32 INFO - 2015-12-09 10:38:32,295 INFO : Starting test dromaeo_css 10:38:32 INFO - 2015-12-09 10:38:32,296 DEBUG : operating with platform_type : linux_ 10:38:32 INFO - 2015-12-09 10:38:32,296 INFO : Initialising browser for dromaeo_css test... 10:38:32 INFO - 2015-12-09 10:38:32,336 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBrbW3O/profile http://localhost:48128/getInfo.html 10:38:39 INFO - 2015-12-09 10:38:39,011 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:38:39 INFO - 2015-12-09 10:38:39,011 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:38:39 INFO - 2015-12-09 10:38:39,011 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:38:39 INFO - 2015-12-09 10:38:39,011 DEBUG : BROWSER_OUTPUT: __metrics 10:38:39 INFO - 2015-12-09 10:38:39,132 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] 10:38:39 INFO - 2015-12-09 10:38:39,200 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] 10:38:39 ERROR - 2015-12-09 10:38:39,216 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 10:38:40 INFO - 2015-12-09 10:38:40,157 INFO : Browser initialized. 10:38:40 INFO - 2015-12-09 10:38:40,157 INFO : Running cycle 1/1 for dromaeo_css test... 10:38:40 INFO - 2015-12-09 10:38:40,157 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBrbW3O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:38:52 INFO - 2015-12-09 10:38:52,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 143765504 10:38:52 INFO - 2015-12-09 10:38:52,128 DEBUG : BROWSER_OUTPUT: 10:39:43 INFO - 2015-12-09 10:39:43,620 DEBUG : BROWSER_OUTPUT: 1449686383619 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] 10:41:55 INFO - 2015-12-09 10:41:55,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48128/tests/dromaeo/cssquery-ext.html) 10:41:56 INFO - 2015-12-09 10:41:56,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 247443456 10:41:56 INFO - 2015-12-09 10:41:56,837 DEBUG : BROWSER_OUTPUT: 10:44:59 INFO - 2015-12-09 10:44:59,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/dromaeo/cssquery-ext.html (next: http://localhost:48128/tests/dromaeo/cssquery-jquery.html) 10:44:59 INFO - 2015-12-09 10:44:59,872 DEBUG : BROWSER_OUTPUT: RSS: Main: 215982080 10:44:59 INFO - 2015-12-09 10:44:59,872 DEBUG : BROWSER_OUTPUT: 10:48:01 INFO - 2015-12-09 10:48:01,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48128/tests/dromaeo/cssquery-mootools.html) 10:48:02 INFO - 2015-12-09 10:48:02,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 220045312 10:48:02 INFO - 2015-12-09 10:48:02,509 DEBUG : BROWSER_OUTPUT: 10:51:04 INFO - 2015-12-09 10:51:04,438 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48128/tests/dromaeo/cssquery-prototype.html) 10:51:05 INFO - 2015-12-09 10:51:05,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 206102528 10:51:05 INFO - 2015-12-09 10:51:05,020 DEBUG : BROWSER_OUTPUT: 10:54:07 INFO - 2015-12-09 10:54:07,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48128/tests/dromaeo/cssquery-yui.html) 10:54:08 INFO - 2015-12-09 10:54:08,270 DEBUG : BROWSER_OUTPUT: RSS: Main: 204767232 10:54:08 INFO - 2015-12-09 10:54:08,270 DEBUG : BROWSER_OUTPUT: 10:57:10 INFO - 2015-12-09 10:57:10,776 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/dromaeo/cssquery-yui.html (next: http://localhost:48128/tests/dromaeo/cssquery-dojo.html) 10:57:11 INFO - 2015-12-09 10:57:11,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 253296640 10:57:11 INFO - 2015-12-09 10:57:11,020 DEBUG : BROWSER_OUTPUT: 10:57:11 INFO - 2015-12-09 10:57:11,023 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:57:11 INFO - 2015-12-09 10:57:11,024 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:57:11 INFO - 2015-12-09 10:57:11,024 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:57:11 INFO - 2015-12-09 10:57:11,024 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:57:11 INFO - 2015-12-09 10:57:11,024 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2583.2433944917457;2745.6705195376558;2746.615473833665;2754.22881593154;2774.4312415954732;4422;4537.977310113445;4653.627709783218;4727.078219747155;4736.668433209677;4629.259318509039;4656.208444564424;4723.244280915054;4737.692050016746;4803.543663351985;4317.179735850178;4331.208921532969;4371.693981421302;4382.298832186851;4399.824007039714;4155.439015732868;4429.13631841791;4442.466903971512;4482.910341793162;4484.327350897375;4202.285611446031;4218.11419601884;4252.170826688797;4311.073119279338;4332.068605249855;4346.76092814895;4393.143337049277;4395.077033822901;4433.578810013076;4446.110777844444;4192.895177620553;4381.38660587518;4387.473503179639;4389.604935555783;4435.29035354345;4586.059857729191;4616.95383046172;4686.835960741358;4800.207965685658;4834.806607735686;5000.1249781288125;5037.29477873098;5041.369828771403;5043.445221025684;5088.516590923857;4940.061388336205;5059.089363914494;5064.215046667736;5066.9746651266505;5070.188769796851;4597.080583883237;4622.838200663028;4696.624270058387;4744.739039352799;4809.759512024385;5142.485751424828;5158.638895277295;5170.767315470813;5179;5222.3733152022005;4811.735354555463;4957.752112394438;4960.454350021495;4966.751662416865;5007.098722230034;4905.681130726492;4906.803727850846;4936.284238785356;4957.107720610325;4995.250712393097;4949.925751113737;4973.254011898244;4985.127602669519;4988.401391833003;5028.120078986163;4790.041991601694;4944.456109827916;4959;4962.15643340633;5008.398992120896;4127.4015267786;4135.91728165435;4168.333066709312;4191.077962848169;4221.2190744712325;3639.3267245559655;3643.8360273787744;3661.3043521730788;3672.412414013745;3694.5012423323046;4054.432379466877;4278.957210427856;4295.8281668733525;4333.328334108218;4334.783260837009;5010.148274793294;5029.446760856303;5063.3417655704525;5065.848024559269;5067.923981140286;4255.148970205972;4331.7184383015;4337.674674399433;4361.9127617447475;4378.540253273424;4505.279155335131;4513.977430112828;4525.547445255514;4532.206863798822;4558.202314594932;4510.526394728638;4618.168729628699;4618.399608050931;4817.084753896748;4835.226363781778;5003.699778013331;5058.6206034548295;5071.2139618359215;5076.82231121909;5118.00198961199;4762.904741905212;4819.566239038503;4820.035992801524;4837.298591704112;4865.0756356292195;4791.377120974391;4902.681325713817;4902.828401005948;5031.924521132113;5087.08432482142;4918.090153321504;4977.925331120108;4989.351384320015;5009.148444764472;5027.597792176544;4837.7097374157665;4863.659543831898;4864.756762161807;4873.610111191168;4911.656184067081;4620.561046700558;4850.46644869057;4869.342638743724;4874.53691899269;4921.975390123026;4702.623790096853;4716.198246298069;4782.258749893772;4792.640551958547;4806.831760888352;4953.950460495349;4962.404511458503;4964.379452568429;5007.799688012438;5034.244863270539;4864.294677271847;4866;4866.416030076413;4867.342908707279;4910.607151427948 10:57:11 INFO - 2015-12-09 10:57:11,028 DEBUG : BROWSER_OUTPUT: |1;ext.html;513.3865031287611;515.2374485761073;520.1988937036963;523.2073408785693;542.1488263426418;26703.4659306814;32720.181995450126;33263.16842078943;33268.16829579262;33335.99992000241;40247.59752402475;40900.59099409005;40927.59072409275;40971.79514102425;41002.58997410025;6936.479764017694;7014.368706816385;7942.126366099725;8111.148329425414;8116;10111.54498047586;10414.375137491737;10420.062194402502;10429.947850260738;10434;10044.296899217057;10084.394936303808;10153.492325383739;10168.694939151837;10172.6948191554;7153.499255052148;7303.926960730378;7347.742829000959;7349.889751653729;10073.345232559861;10139.847902281472;10319.43243121628;10368.222383321281;10380.584776608926;10388.065074143364;37933.620663793285;38457;38470.80764596159;38473.42289865654;38480.80759596212;2873.798834081615;2900.4054168895327;2909.156344660046;2928.1947464447235;2929.407548972768;28330.858345708344;28512.572311415344;28868.422631547463;29115.272118197;29514;3414.470757032664;3442.7590068695204;3454.2055327274866;3495.5106285120105;3563.94654080189;220542;220587;220803;221605;221737;46014.309785353245;53986.46013539893;54209;54219.45780542223;54252;41317.793411032755;63195;64730.67634661797;64781.35218647848;64785.25399071159;14676.706465870837;15029.624259393384;15035;15044.398224071134;15052.849471505364;9273.211776998896;9646.758831029281;9832.459214743258;11235.213535052631;11429;18551.44345669632;18709.25162993465;18722.906385467984;18745.437636870916;18766.249350025846;7342.669579868919;7436.66535005926;7473.103227612722;7512.812179695551;7541.924580754122;815.5432957543794;861.1259571534897;893.4996402014763;967.2697113679127;1017.4454922067491;27343.179704608894;27392.17823465299;27458.725412746015;27591.586126208123;27779.305517361823;944.6268723854176;1068.7595291059604;1077.9730506737394;1104.4643347976225;1115.1079136690614;14161.221132837587;14223.928880355532;14303.713925721428;14494.927525362305;14528.854711452961;280721;284546;285474;286087;286536;47406.76296618564;47526.52473475221;47689.5231047692;47766.761166193945;47768.5223147771;1183.1717797541755;1205.8010428279235;1207.927524348542;1214.7874122028786;1234.3211233821362;25825.225243242734;26621.334466637712;26760.19719408421;26935.461290774467;27162;41184;41264.58735412607;41446.513209207544;41453.75638730843;41565.79217103895;263379;264942;264990;265308;265496;24729.381765455288;28109.297267568476;28555.857765689972;28598.14205573836;28866.134015979555;33593.16519118125;37356.81321593375;37408;37669.81165094157;37892.810535947145;31607.525887111253;31749.682503174674;32033.199170020005;32113;32576.34847303088;28340.43319133647;31237.8438107808;32448.513272301407;32569.511457327684;33734.49398258979;30459.086227413212;33706;33860.661393386734;34053.148671283416;34196.14509637279;24734.134305299227;26948.595771063057;27089.72910270872;27118;29398.853005734836;22987.310380688607;23003.24270391619;23168.18911338095;23318.53362932766;23337.533249335258 10:57:11 INFO - 2015-12-09 10:57:11,028 DEBUG : BROWSER_OUTPUT: |2;jquery.html;267.4196992526218;269.53101603210416;271.3744818194062;274.8145002123566;275.24582643556647;11487.425628718573;14254.3585538651;14990.100593964356;15441;15446.382144714213;16374.83625163748;16550.586235344123;16673.082980436073;16714.66570668586;16938.491845244633;5564.693941833188;5711.343195532525;5725.570582206351;5725.885482290372;5732.828015159531;4088.632023117919;4219.683523735716;4221.894452638678;4233.661307095425;5584.246126772895;4201.138766552865;6321.146645202908;6538.967305163491;6552;6552.770653027145;6310.9902415613515;6556.737730490775;6574.079628851964;6589.04458853466;6593.307702691221;6175.722092505803;6283.968580157116;6302.212223472066;6316.936830631681;6345.048242763576;19723.802761972485;19780.208791648318;19864.20543178271;20606.072726727183;20739.170433182655;1963.4207908666835;2000.949976250591;2021.585574957145;2054.1269960266977;2082.0422605601443;13203.471861125543;13246.73506529864;13350.666233344147;13566.389512471962;13688.041837071409;1883.8210370014826;1903.8857668539792;1909.8663093583455;1912.177763561668;1931.2468137426274;60965.695171524305;61096.38903610996;62114;66151.66924165396;66419.33580664228;14593.635159120895;14709.338079786436;14812.481563145453;14823.555293341216;14869.479568215276;21680.241191558536;21810;21827.563448730936;21877.453063673216;21886.343409697736;8073.071596766447;8145.959270203611;8164.346852251806;8223.753287401387;8250.834983300421;6720.462363010947;6729;6737.562058466184;6794.3545363190415;6801.149856267966;7404.148522919825;7467.178610352966;7468.290512401313;7476.925230747732;7576.24237576238;2243.3830696558575;2914.7522460590662;2924.2104631749307;2927.312081660808;2931.311141881656;325.2778830995187;329.2394568546665;350.2784264415313;783.6786917363968;926.1942110364026;8782.692605758768;8970.461772293684;9456.338056336128;9741.123298903132;10007.599696012223;350.98596056157976;356.0724313164222;362.6645353048472;367.3882984830281;374.3000588898777;5031.949680503221;5094.159463688524;5096.21008743638;5162.9415969726115;5199.350081239845;286263;290505;473511;495662;498588;73513;76420.23579764132;76672.61663691646;76920.84618730724;77538;1024.3188279793853;1027.0807627173638;1030.1912998296302;1034.0745033195399;1050.9579616815395;13705.246211458465;13970.30148492551;14344.641383965485;14436.927815361276;14570.781438278646;31161.37677246488;31200.843995779876;31319.53020704737;32076.83961580177;34776.82611586926;41556;42585;42686.78656606697;42736.78631606822;45800;8393.160683931557;8511.574421279036;8589.055203927688;8597.398182127441;8645.697400590949;11960.222585531912;12141;12304.569340073054;15208.32708402097;16910.57723556921;13482.258475783927;13520.12119212248;13613.31933403306;13755.931220343835;13922.930385348009;12884.871151288367;13370.799438008244;13436.865631343562;13499.460021599027;13707;13718.245496497788;13873.167609943435;13907.096038757449;13929.791053134008;13995.51015714445;8625.956870215608;8670.82658346842;8720.869186962074;8866.335024873031;8898.59956301955;13778.448862045407;13891.235982021086;14051.36768845425;14108.36512356926;14343.354549045109 10:57:11 INFO - 2015-12-09 10:57:11,032 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1430.9427622895084;1592.3710134496873;1665.2256700634202;1688.4343744845476;1720.4580557124498;5734.340550836655;5937.821865344035;6928.930710692898;7099.503034787567;7160.677769500372;6982.511224214307;7044.366007059363;7075.964620176892;7102.538335008221;7109.289071092888;2030.9492262693402;2049.200811683437;2059.06312627754;2061.175529788082;2065.2461851424196;2056.8663036902626;2059.06312627754;2059.6704527275638;2108.3464126120875;2110.62008838409;2019.1519561784087;2036.287299445197;2059.835213182942;2060.0832629479814;2062.7215325931033;2050.1491880869494;2070.492729281321;2073.35725924963;2075.8650687705326;2076.6262072826885;1985.4242269741758;2006.7792542820278;2031.4413536277493;2033.1257559249516;2034.2168265217997;7097.964510177416;7194.244604316524;7194.820129496752;7201.063861697946;7208.315210055036;4162.41726158338;4191.057012172268;4194.517630472505;4197.748135111872;4219.050713589449;2759.1584566707147;2781.666200055986;2798.2164993801766;2824.124521398373;2829.7453229209264;839.8194388206504;852.7271273192581;860.2172023458685;875.2166810704384;889;9576.186024187882;9593.616255349778;9594.9520252399;9602.615895364177;9612.615495380176;3762.6425489578446;3785.6971442284553;3855.286771947143;3858.305505009125;3871.496705428276;8296.294814940798;8297.792555186048;8320.292775114061;8320.500769953702;8322.66709331632;4284.400183974246;4298.4197133387215;4301.462317210348;4306.827726890952;4307.5261721210645;3207.711305982426;3247.6752324767335;3750.662440380379;3904.2386734587053;3914.3149948759424;3373.241020770356;3393.8812141574926;3410.48842673596;3421.726261899042;3425.417678994577;1039.6828967164936;1048.575326992554;1049.9947500262604;1052.3528030261334;1052.7052425320921;948.0898337595847;966.8549717542285;967.2648786921849;1028.7068185567077;1205.9698507537207;6713.4964877634375;6718.798436046926;6734.8989765153565;6742.089817874622;6754.797356079325;394.37688452245385;395.74474463971154;404.7874865695533;404.9007993041724;406.43302592882765;5328.893422131613;5394.757235924393;5400.054990376669;5406.83779486616;5409.377921538995;8110.878336824952;8480.618372173267;8493.660253589911;8542.18849209324;8572.957135214285;8442.07137214906;8450.915490845136;8455.408121431563;8468.068512463624;8471.924378527301;6285.151504546828;6317.084022816758;6329.620222786648;6651.833704157435;6691.59850408977;6531.477481801349;6653.268140504444;6659.167604049494;6670.299618540177;6688.531802773759;7551.811204719926;7573.659090682741;7594.772156835304;7612.467127301035;7751.92248077512;7785.493942893694;7872.881906771518;7954.244346787046;8078.87881681787;8088;5601.271834661468;5705.828825135252;6043.516518678583;6839.965800170968;6958.965205173941;6572.868542629216;6799.878020126624;6817.522773405814;6850.177978642595;6850.349216824394;6206.379362063757;6367.968160159169;6457.354264573693;6482.54622176462;6615.37153970372;6224.844378890564;6294.8426289341305;6386.712597933011;6424.839379015375;6457.289698133108;6460.45086167681;6497.5126865484335;6504.642244676588;6511.413972742476;6520.869582608416;5729.398413166724;5757.0788673811985;5766.884662306814;5771.422857714363;6078.331383547895;6144.139820425234;6162.969185154046;6174.197354343906;6187.443130118311;6194.38056194377 10:57:11 INFO - 2015-12-09 10:57:11,033 DEBUG : BROWSER_OUTPUT: |4;prototype.html;252.79397291207664;252.95573274676937;260.11560693641604;260.14282937720213;260.60128004153637;5255.448177941318;5330.786768529264;5344.438833922436;5348.411674715778;5354.170103633938;5039.622028347871;5138.948610513903;5201.661891977028;5213.608979326556;5213.8957220855655;3999.040230344711;4007;4007.639312461878;4032.0121570215338;4033.455483509733;4026.0740029793164;4029.194161167778;4029.6776257899296;4032.717709760318;4034.3948407738926;3991.241664083829;3993.0616305168264;3996.9000774980714;3998.620131087542;4000.0399904023116;3823.541175058983;3989.242044011643;3998.3602623580086;3999.320115580358;4001.419794129835;3374.3420033093557;3374.8143852088124;3380.678835510623;3381.7970921744527;3386.983065084659;5117.769700363493;5118.6416950813455;5123.923141152885;5124.692518448905;5132.178851383761;4529.275315949432;4532.818687252506;4534.614557762594;4537.115262523809;4539.7049191802425;5556.611037227396;5561.054620714488;5569.303837020372;5580.051391263495;5580.63725857822;3598.2623562169692;3701.222743223926;3706.981465092684;3706.981465092684;3711.888643340704;5635.690037047961;5776.046952252873;5822.767089316422;5912.822615321505;5919.704014799286;3684.3736564783517;3747.512823333004;3773.52830896138;3774.094217387807;3775.811209439517;3814.065553939303;3815.809209539512;3818.59904710007;3820.9235815283537;3821.293060783764;4459.777011149429;4477.037436951006;4477.238869392211;4478.48497422794;4480.484744254452;5403.540699040547;5504.834854954358;5511.173324001352;5529.115341545334;5530.751116199781;1332.7601031814368;1337.832770903637;1340.6447291467769;1341.872522110398;1343.650650830791;872.5898827551041;884.4781578868499;885.2608072259607;895.2122132523338;897.0939351255149;4697.201475749131;4743.66794324394;4807.759612019455;4860.927086093711;4876.634252431082;5820.417958204231;5877.706114694248;5878.382769809194;5890.646561206341;5894.351621321651;4886.169351210303;4891.290762839369;4891.779869905863;4901.534354236342;4906.0433215522635;3101.9224519387194;3151.416987857254;3153.0225630054756;3155.5266709993225;3159.3365393267213;5384;5532.446755324516;5533.253010843485;5559.24950131727;5559.916601250984;6042.516598672096;6048.6975651218145;6052.061930400795;6053.3946605339115;6054.878902421927;5553.305836770403;5555.777768889361;5557.888842223133;5561;5563.248961390323;5706.828795136153;5835.533157347487;5882.7058647066615;5895.410458954242;5899.4985426239255;5744.770209191585;5757.453041961007;5758.049921762862;5759.596828221985;5759.827205183851;5546.72266386671;5548.140038294071;5551.278333816578;5553.611247212656;5557.110862262019;3777.9433308500943;3783.9432408513344;3787.0153760023145;3787.16682329887;3790.962090379061;5696.629719068247;5892.646441213541;5897.203877476486;5919.644821310735;5939.851503712442;5697.287839020122;5703.230063941315;5706.258186435737;5707.058335374617;5707.600467967202;5652.519535839499;5658.151277308272;5674.460926212003;5676.744546495335;5679.977604031314;5377.919331210113;5565.38780734127;5569.526590239713;5570.749316280696;5582.720863956867;5724;5729.885402292014;5730.5129064030025;5730.856728581819;5737.827865164052;5361.169018802092;5400.648957817729;5495.53287970527;5517.062099443185;5575.581831362583 10:57:11 INFO - 2015-12-09 10:57:11,034 DEBUG : BROWSER_OUTPUT: |5;yui.html;672.6771149848073;718.8382613911867;745.1468069060924;781.4998401023345;816.5794615772875;13713.451461941522;14066.64833379166;14106.929465352685;14124.78812817806;14128.646783830396;13402.93298533506;13504.12223205491;13507.729845403086;13520.526781562623;13522.932385338085;635.2630948100204;644.9580777249464;803.7508372404559;810.5379933437943;810.9837803243931;799.5282783157936;809.3039985612369;814.9959250203771;815.9510429374257;815.9959200204021;848.9363297752662;857.1300130367682;857.5969294431638;858.5535521528801;859.6776208921655;659.9670016499156;671.3320246354859;830.1532436914374;843.9957800210959;853.2065179383171;623.9282482514524;623.9812805615838;623.9875202495924;624.1231070346171;624.2540164503421;11897.881021189763;12013.038956883429;12036.518539258419;12036.699082522919;12043.759124817454;10845.51195196218;11319.773604527945;11352.14858885587;11456.633378748656;11538.653840384803;9343.859842102374;9376.812463750686;9415;9575.329726919119;9749.658761943298;3125.9374812503625;3162.509810979279;3194.2493514024186;3199.936001279961;3209.9197520062185;41844.953876153035;41888.37167442491;42290;42329.365059524134;42344.788276058425;8868.822623547492;8961.775955601162;9005.399843149777;9029.548522573845;9094.636214551476;16181.271842767104;16213;16213.67572648564;16236.188190590423;16246.268917898722;6350.7459701611415;6527.54307198501;6530.314316996742;6619;6639.668016599151;3412.84642191102;3421.3328400961573;3477.8434970426392;3506.0358401439807;3532.0816587686872;2674.946501069968;2706.2693072870215;2706.837589744582;2714.443539074485;2724.1827451764393;480.10460491183693;486.54264990908433;488.1213815132818;498.62353922788066;503.3883831145103;459.36148753233033;556.5269520907196;580.3673995345094;584.8011082525283;597.5876645114856;7399.6670149843385;7409.851802963911;7659.234076592296;7823.765287041398;8020.518768873886;580.6312991250586;580.9244798176295;585.4555263604803;607.7690477618477;614.9784757533554;3634.5093412388987;4052.615001574846;4103.466549348565;4109.445224894661;4172.207280616673;50894.745526272134;52135;52462;52566.474335256156;52641.21038184431;44938.77530612391;45030.09939801186;45424.09151816945;45499;45722.542774571826;41102.58897411048;42334.78832605879;42646.14707705828;42878.57121428808;43119.56880431156;8064.233897779702;8308;8381.706640267561;8438.451500652438;8526.573671316286;31798.682013179572;32012.359752805278;32104;32218.35563288768;32575.837120814245;36682.63317366792;37768;40096;40756.59243407528;40814;10630.149588032784;10717.142628589538;10722.195835312226;10840.783184336111;10854.837177442187;11264.66206013821;11267.661970140909;11277.830832537355;11375;11921.344326061802;10525.421101839473;10563.63027294041;10609.946950265508;10626.36241825493;10661.786764264516;10468.790624187626;10671.46642667848;10718.303310284806;10792.514336854703;11189.328640281283;10312.742181445525;10522.842157367799;10561.313514621525;10626.84059739089;10847.837282440612;9341.626334946797;9471.127633209418;9686.56410461545;9692.70921872345;9750.21998240125;8795.868061978947;9098.681546145854;9272.95363523205;9275.30435217348;9280 10:57:11 INFO - 2015-12-09 10:57:11,035 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:57:11 INFO - 2015-12-09 10:57:11,035 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:57:11 INFO - 2015-12-09 10:57:11,035 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,889 10:57:11 INFO - 2015-12-09 10:57:11,035 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:57:11 INFO - 2015-12-09 10:57:11,036 DEBUG : BROWSER_OUTPUT: __startTimestamp1449687431021__endTimestamp 10:57:11 INFO - 2015-12-09 10:57:11,036 DEBUG : BROWSER_OUTPUT: 10:57:11 INFO - 2015-12-09 10:57:11,036 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:57:11 INFO - 2015-12-09 10:57:11,037 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:57:11 INFO - 2015-12-09 10:57:11,038 DEBUG : BROWSER_OUTPUT: 10:57:11 INFO - 2015-12-09 10:57:11,038 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4639.19 Median:4800.21 stddev:479.59 (10.0%) stddev-sans-first:453.13 10:57:11 INFO - 2015-12-09 10:57:11,038 DEBUG : BROWSER_OUTPUT: Values: 2583.2 2745.7 2746.6 2754.2 2774.4 4422.0 4538.0 4653.6 4727.1 4736.7 4629.3 4656.2 4723.2 4737.7 4803.5 4317.2 4331.2 4371.7 4382.3 4399.8 4155.4 4429.1 4442.5 4482.9 4484.3 4202.3 4218.1 4252.2 4311.1 4332.1 4346.8 4393.1 4395.1 4433.6 4446.1 4192.9 4381.4 4387.5 4389.6 4435.3 4586.1 4617.0 4686.8 4800.2 4834.8 5000.1 5037.3 5041.4 5043.4 5088.5 4940.1 5059.1 5064.2 5067.0 5070.2 4597.1 4622.8 4696.6 4744.7 4809.8 5142.5 5158.6 5170.8 5179.0 5222.4 4811.7 4957.8 4960.5 4966.8 5007.1 4905.7 4906.8 4936.3 4957.1 4995.3 4949.9 4973.3 4985.1 4988.4 5028.1 4790.0 4944.5 4959.0 4962.2 5008.4 4127.4 4135.9 4168.3 4191.1 4221.2 3639.3 3643.8 3661.3 3672.4 3694.5 4054.4 4279.0 4295.8 4333.3 4334.8 5010.1 5029.4 5063.3 5065.8 5067.9 4255.1 4331.7 4337.7 4361.9 4378.5 4505.3 4514.0 4525.5 4532.2 4558.2 4510.5 4618.2 4618.4 4817.1 4835.2 5003.7 5058.6 5071.2 5076.8 5118.0 4762.9 4819.6 4820.0 4837.3 4865.1 4791.4 4902.7 4902.8 5031.9 5087.1 4918.1 4977.9 4989.4 5009.1 5027.6 4837.7 4863.7 4864.8 4873.6 4911.7 4620.6 4850.5 4869.3 4874.5 4922.0 4702.6 4716.2 4782.3 4792.6 4806.8 4954.0 4962.4 4964.4 5007.8 5034.2 4864.3 4866.0 4866.4 4867.3 4910.6 10:57:11 INFO - 2015-12-09 10:57:11,038 DEBUG : BROWSER_OUTPUT: 10:57:11 INFO - 2015-12-09 10:57:11,038 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41660.22 Median:16021.73 stddev:67346.31 (420.3%) stddev-sans-first:67464.37 10:57:11 INFO - 2015-12-09 10:57:11,040 DEBUG : BROWSER_OUTPUT: Values: 513.4 515.2 520.2 523.2 542.1 26703.5 32720.2 33263.2 33268.2 33336.0 40247.6 40900.6 40927.6 40971.8 41002.6 6936.5 7014.4 7942.1 8111.1 8116.0 10111.5 10414.4 10420.1 10429.9 10434.0 10044.3 10084.4 10153.5 10168.7 10172.7 7153.5 7303.9 7347.7 7349.9 10073.3 10139.8 10319.4 10368.2 10380.6 10388.1 37933.6 38457.0 38470.8 38473.4 38480.8 2873.8 2900.4 2909.2 2928.2 2929.4 28330.9 28512.6 28868.4 29115.3 29514.0 3414.5 3442.8 3454.2 3495.5 3563.9 220542.0 220587.0 220803.0 221605.0 221737.0 46014.3 53986.5 54209.0 54219.5 54252.0 41317.8 63195.0 64730.7 64781.4 64785.3 14676.7 15029.6 15035.0 15044.4 15052.8 9273.2 9646.8 9832.5 11235.2 11429.0 18551.4 18709.3 18722.9 18745.4 18766.2 7342.7 7436.7 7473.1 7512.8 7541.9 815.5 861.1 893.5 967.3 1017.4 27343.2 27392.2 27458.7 27591.6 27779.3 944.6 1068.8 1078.0 1104.5 1115.1 14161.2 14223.9 14303.7 14494.9 14528.9 280721.0 284546.0 285474.0 286087.0 286536.0 47406.8 47526.5 47689.5 47766.8 47768.5 1183.2 1205.8 1207.9 1214.8 1234.3 25825.2 26621.3 26760.2 26935.5 27162.0 41184.0 41264.6 41446.5 41453.8 41565.8 263379.0 264942.0 264990.0 265308.0 265496.0 24729.4 28109.3 28555.9 28598.1 28866.1 33593.2 37356.8 37408.0 37669.8 37892.8 31607.5 31749.7 32033.2 32113.0 32576.3 28340.4 31237.8 32448.5 32569.5 33734.5 30459.1 33706.0 33860.7 34053.1 34196.1 24734.1 26948.6 27089.7 27118.0 29398.9 22987.3 23003.2 23168.2 23318.5 23337.5 10:57:11 INFO - 2015-12-09 10:57:11,040 DEBUG : BROWSER_OUTPUT: 10:57:11 INFO - 2015-12-09 10:57:11,040 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24993.81 Median:31698.18 stddev:69058.06 (217.9%) stddev-sans-first:69226.83 10:57:11 INFO - 2015-12-09 10:57:11,041 DEBUG : BROWSER_OUTPUT: Values: 267.4 269.5 271.4 274.8 275.2 11487.4 14254.4 14990.1 15441.0 15446.4 16374.8 16550.6 16673.1 16714.7 16938.5 5564.7 5711.3 5725.6 5725.9 5732.8 4088.6 4219.7 4221.9 4233.7 5584.2 4201.1 6321.1 6539.0 6552.0 6552.8 6311.0 6556.7 6574.1 6589.0 6593.3 6175.7 6284.0 6302.2 6316.9 6345.0 19723.8 19780.2 19864.2 20606.1 20739.2 1963.4 2000.9 2021.6 2054.1 2082.0 13203.5 13246.7 13350.7 13566.4 13688.0 1883.8 1903.9 1909.9 1912.2 1931.2 60965.7 61096.4 62114.0 66151.7 66419.3 14593.6 14709.3 14812.5 14823.6 14869.5 21680.2 21810.0 21827.6 21877.5 21886.3 8073.1 8146.0 8164.3 8223.8 8250.8 6720.5 6729.0 6737.6 6794.4 6801.1 7404.1 7467.2 7468.3 7476.9 7576.2 2243.4 2914.8 2924.2 2927.3 2931.3 325.3 329.2 350.3 783.7 926.2 8782.7 8970.5 9456.3 9741.1 10007.6 351.0 356.1 362.7 367.4 374.3 5031.9 5094.2 5096.2 5162.9 5199.4 286263.0 290505.0 473511.0 495662.0 498588.0 73513.0 76420.2 76672.6 76920.8 77538.0 1024.3 1027.1 1030.2 1034.1 1051.0 13705.2 13970.3 14344.6 14436.9 14570.8 31161.4 31200.8 31319.5 32076.8 34776.8 41556.0 42585.0 42686.8 42736.8 45800.0 8393.2 8511.6 8589.1 8597.4 8645.7 11960.2 12141.0 12304.6 15208.3 16910.6 13482.3 13520.1 13613.3 13755.9 13922.9 12884.9 13370.8 13436.9 13499.5 13707.0 13718.2 13873.2 13907.1 13929.8 13995.5 8626.0 8670.8 8720.9 8866.3 8898.6 13778.4 13891.2 14051.4 14108.4 14343.4 10:57:11 INFO - 2015-12-09 10:57:11,042 DEBUG : BROWSER_OUTPUT: 10:57:11 INFO - 2015-12-09 10:57:11,042 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4945.67 Median:6190.91 stddev:2594.49 (41.9%) stddev-sans-first:2588.32 10:57:11 INFO - 2015-12-09 10:57:11,043 DEBUG : BROWSER_OUTPUT: Values: 1430.9 1592.4 1665.2 1688.4 1720.5 5734.3 5937.8 6928.9 7099.5 7160.7 6982.5 7044.4 7076.0 7102.5 7109.3 2030.9 2049.2 2059.1 2061.2 2065.2 2056.9 2059.1 2059.7 2108.3 2110.6 2019.2 2036.3 2059.8 2060.1 2062.7 2050.1 2070.5 2073.4 2075.9 2076.6 1985.4 2006.8 2031.4 2033.1 2034.2 7098.0 7194.2 7194.8 7201.1 7208.3 4162.4 4191.1 4194.5 4197.7 4219.1 2759.2 2781.7 2798.2 2824.1 2829.7 839.8 852.7 860.2 875.2 889.0 9576.2 9593.6 9595.0 9602.6 9612.6 3762.6 3785.7 3855.3 3858.3 3871.5 8296.3 8297.8 8320.3 8320.5 8322.7 4284.4 4298.4 4301.5 4306.8 4307.5 3207.7 3247.7 3750.7 3904.2 3914.3 3373.2 3393.9 3410.5 3421.7 3425.4 1039.7 1048.6 1050.0 1052.4 1052.7 948.1 966.9 967.3 1028.7 1206.0 6713.5 6718.8 6734.9 6742.1 6754.8 394.4 395.7 404.8 404.9 406.4 5328.9 5394.8 5400.1 5406.8 5409.4 8110.9 8480.6 8493.7 8542.2 8573.0 8442.1 8450.9 8455.4 8468.1 8471.9 6285.2 6317.1 6329.6 6651.8 6691.6 6531.5 6653.3 6659.2 6670.3 6688.5 7551.8 7573.7 7594.8 7612.5 7751.9 7785.5 7872.9 7954.2 8078.9 8088.0 5601.3 5705.8 6043.5 6840.0 6959.0 6572.9 6799.9 6817.5 6850.2 6850.3 6206.4 6368.0 6457.4 6482.5 6615.4 6224.8 6294.8 6386.7 6424.8 6457.3 6460.5 6497.5 6504.6 6511.4 6520.9 5729.4 5757.1 5766.9 5771.4 6078.3 6144.1 6163.0 6174.2 6187.4 6194.4 10:57:11 INFO - 2015-12-09 10:57:11,043 DEBUG : BROWSER_OUTPUT: 10:57:11 INFO - 2015-12-09 10:57:11,043 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4593.50 Median:5293.12 stddev:1416.56 (26.8%) stddev-sans-first:1382.56 10:57:11 INFO - 2015-12-09 10:57:11,044 DEBUG : BROWSER_OUTPUT: Values: 252.8 253.0 260.1 260.1 260.6 5255.4 5330.8 5344.4 5348.4 5354.2 5039.6 5138.9 5201.7 5213.6 5213.9 3999.0 4007.0 4007.6 4032.0 4033.5 4026.1 4029.2 4029.7 4032.7 4034.4 3991.2 3993.1 3996.9 3998.6 4000.0 3823.5 3989.2 3998.4 3999.3 4001.4 3374.3 3374.8 3380.7 3381.8 3387.0 5117.8 5118.6 5123.9 5124.7 5132.2 4529.3 4532.8 4534.6 4537.1 4539.7 5556.6 5561.1 5569.3 5580.1 5580.6 3598.3 3701.2 3707.0 3707.0 3711.9 5635.7 5776.0 5822.8 5912.8 5919.7 3684.4 3747.5 3773.5 3774.1 3775.8 3814.1 3815.8 3818.6 3820.9 3821.3 4459.8 4477.0 4477.2 4478.5 4480.5 5403.5 5504.8 5511.2 5529.1 5530.8 1332.8 1337.8 1340.6 1341.9 1343.7 872.6 884.5 885.3 895.2 897.1 4697.2 4743.7 4807.8 4860.9 4876.6 5820.4 5877.7 5878.4 5890.6 5894.4 4886.2 4891.3 4891.8 4901.5 4906.0 3101.9 3151.4 3153.0 3155.5 3159.3 5384.0 5532.4 5533.3 5559.2 5559.9 6042.5 6048.7 6052.1 6053.4 6054.9 5553.3 5555.8 5557.9 5561.0 5563.2 5706.8 5835.5 5882.7 5895.4 5899.5 5744.8 5757.5 5758.0 5759.6 5759.8 5546.7 5548.1 5551.3 5553.6 5557.1 3777.9 3783.9 3787.0 3787.2 3791.0 5696.6 5892.6 5897.2 5919.6 5939.9 5697.3 5703.2 5706.3 5707.1 5707.6 5652.5 5658.2 5674.5 5676.7 5680.0 5377.9 5565.4 5569.5 5570.7 5582.7 5724.0 5729.9 5730.5 5730.9 5737.8 5361.2 5400.6 5495.5 5517.1 5575.6 10:57:11 INFO - 2015-12-09 10:57:11,044 DEBUG : BROWSER_OUTPUT: 10:57:11 INFO - 2015-12-09 10:57:11,044 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12607.27 Median:44984.44 stddev:14249.43 (31.7%) stddev-sans-first:14261.22 10:57:11 INFO - 2015-12-09 10:57:11,046 DEBUG : BROWSER_OUTPUT: Values: 672.7 718.8 745.1 781.5 816.6 13713.5 14066.6 14106.9 14124.8 14128.6 13402.9 13504.1 13507.7 13520.5 13522.9 635.3 645.0 803.8 810.5 811.0 799.5 809.3 815.0 816.0 816.0 848.9 857.1 857.6 858.6 859.7 660.0 671.3 830.2 844.0 853.2 623.9 624.0 624.0 624.1 624.3 11897.9 12013.0 12036.5 12036.7 12043.8 10845.5 11319.8 11352.1 11456.6 11538.7 9343.9 9376.8 9415.0 9575.3 9749.7 3125.9 3162.5 3194.2 3199.9 3209.9 41845.0 41888.4 42290.0 42329.4 42344.8 8868.8 8961.8 9005.4 9029.5 9094.6 16181.3 16213.0 16213.7 16236.2 16246.3 6350.7 6527.5 6530.3 6619.0 6639.7 3412.8 3421.3 3477.8 3506.0 3532.1 2674.9 2706.3 2706.8 2714.4 2724.2 480.1 486.5 488.1 498.6 503.4 459.4 556.5 580.4 584.8 597.6 7399.7 7409.9 7659.2 7823.8 8020.5 580.6 580.9 585.5 607.8 615.0 3634.5 4052.6 4103.5 4109.4 4172.2 50894.7 52135.0 52462.0 52566.5 52641.2 44938.8 45030.1 45424.1 45499.0 45722.5 41102.6 42334.8 42646.1 42878.6 43119.6 8064.2 8308.0 8381.7 8438.5 8526.6 31798.7 32012.4 32104.0 32218.4 32575.8 36682.6 37768.0 40096.0 40756.6 40814.0 10630.1 10717.1 10722.2 10840.8 10854.8 11264.7 11267.7 11277.8 11375.0 11921.3 10525.4 10563.6 10609.9 10626.4 10661.8 10468.8 10671.5 10718.3 10792.5 11189.3 10312.7 10522.8 10561.3 10626.8 10847.8 9341.6 9471.1 9686.6 9692.7 9750.2 8795.9 9098.7 9273.0 9275.3 9280.0 10:57:11 INFO - 2015-12-09 10:57:11,046 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:57:11 INFO - 2015-12-09 10:57:11,046 DEBUG : BROWSER_OUTPUT: 10:57:11 INFO - 2015-12-09 10:57:11,805 INFO : Browser exited with error code: 0 10:57:11 INFO - 2015-12-09 10:57:11,823 INFO : Completed test dromaeo_css (00:18:39) 10:57:11 INFO - 2015-12-09 10:57:11,823 INFO : Starting test kraken 10:57:11 INFO - 2015-12-09 10:57:11,824 DEBUG : operating with platform_type : linux_ 10:57:11 INFO - 2015-12-09 10:57:11,824 INFO : Initialising browser for kraken test... 10:57:11 INFO - 2015-12-09 10:57:11,830 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsImF9n/profile http://localhost:48128/getInfo.html 10:57:16 INFO - 2015-12-09 10:57:16,201 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:57:16 INFO - 2015-12-09 10:57:16,202 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:57:16 INFO - 2015-12-09 10:57:16,202 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:57:16 INFO - 2015-12-09 10:57:16,202 DEBUG : BROWSER_OUTPUT: __metrics 10:57:16 INFO - 2015-12-09 10:57:16,303 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] 10:57:16 INFO - 2015-12-09 10:57:16,379 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] 10:57:17 INFO - 2015-12-09 10:57:17,199 INFO : Browser initialized. 10:57:17 INFO - 2015-12-09 10:57:17,200 INFO : Running cycle 1/1 for kraken test... 10:57:17 INFO - 2015-12-09 10:57:17,200 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsImF9n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:57:29 INFO - 2015-12-09 10:57:29,199 DEBUG : BROWSER_OUTPUT: RSS: Main: 142606336 10:57:29 INFO - 2015-12-09 10:57:29,200 DEBUG : BROWSER_OUTPUT: 10:57:31 INFO - 2015-12-09 10:57:31,856 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48128/tests/kraken/driver.html?testName=audio-beat-detection) 10:57:32 INFO - 2015-12-09 10:57:32,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 177053696 10:57:32 INFO - 2015-12-09 10:57:32,437 DEBUG : BROWSER_OUTPUT: 10:57:35 INFO - 2015-12-09 10:57:35,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48128/tests/kraken/driver.html?testName=audio-dft) 10:57:35 INFO - 2015-12-09 10:57:35,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 164925440 10:57:35 INFO - 2015-12-09 10:57:35,704 DEBUG : BROWSER_OUTPUT: 10:57:38 INFO - 2015-12-09 10:57:38,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48128/tests/kraken/driver.html?testName=audio-fft) 10:57:39 INFO - 2015-12-09 10:57:39,265 DEBUG : BROWSER_OUTPUT: RSS: Main: 153964544 10:57:39 INFO - 2015-12-09 10:57:39,265 DEBUG : BROWSER_OUTPUT: 10:57:41 INFO - 2015-12-09 10:57:41,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48128/tests/kraken/driver.html?testName=audio-oscillator) 10:57:41 INFO - 2015-12-09 10:57:41,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 156123136 10:57:41 INFO - 2015-12-09 10:57:41,865 DEBUG : BROWSER_OUTPUT: 10:57:44 INFO - 2015-12-09 10:57:44,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48128/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:57:44 INFO - 2015-12-09 10:57:44,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 158609408 10:57:44 INFO - 2015-12-09 10:57:44,667 DEBUG : BROWSER_OUTPUT: 10:57:47 INFO - 2015-12-09 10:57:47,748 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48128/tests/kraken/driver.html?testName=imaging-darkroom) 10:57:48 INFO - 2015-12-09 10:57:48,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 157618176 10:57:48 INFO - 2015-12-09 10:57:48,321 DEBUG : BROWSER_OUTPUT: 10:57:51 INFO - 2015-12-09 10:57:51,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48128/tests/kraken/driver.html?testName=imaging-desaturate) 10:57:52 INFO - 2015-12-09 10:57:52,289 DEBUG : BROWSER_OUTPUT: RSS: Main: 159559680 10:57:52 INFO - 2015-12-09 10:57:52,289 DEBUG : BROWSER_OUTPUT: 10:57:55 INFO - 2015-12-09 10:57:55,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48128/tests/kraken/driver.html?testName=json-parse-financial) 10:57:55 INFO - 2015-12-09 10:57:55,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 157405184 10:57:55 INFO - 2015-12-09 10:57:55,708 DEBUG : BROWSER_OUTPUT: 10:57:57 INFO - 2015-12-09 10:57:57,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48128/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:57:58 INFO - 2015-12-09 10:57:58,070 DEBUG : BROWSER_OUTPUT: RSS: Main: 167575552 10:57:58 INFO - 2015-12-09 10:57:58,071 DEBUG : BROWSER_OUTPUT: 10:57:59 INFO - 2015-12-09 10:57:59,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48128/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:58:00 INFO - 2015-12-09 10:58:00,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 168050688 10:58:00 INFO - 2015-12-09 10:58:00,575 DEBUG : BROWSER_OUTPUT: 10:58:02 INFO - 2015-12-09 10:58:02,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48128/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:58:03 INFO - 2015-12-09 10:58:03,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 175480832 10:58:03 INFO - 2015-12-09 10:58:03,491 DEBUG : BROWSER_OUTPUT: 10:58:06 INFO - 2015-12-09 10:58:06,035 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48128/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:58:06 INFO - 2015-12-09 10:58:06,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 181411840 10:58:06 INFO - 2015-12-09 10:58:06,622 DEBUG : BROWSER_OUTPUT: 10:58:09 INFO - 2015-12-09 10:58:09,243 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48128/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:58:09 INFO - 2015-12-09 10:58:09,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 180252672 10:58:09 INFO - 2015-12-09 10:58:09,823 DEBUG : BROWSER_OUTPUT: 10:58:11 INFO - 2015-12-09 10:58:11,618 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48128/tests/kraken/driver.html?testName=ai-astar) 10:58:11 INFO - 2015-12-09 10:58:11,868 DEBUG : BROWSER_OUTPUT: RSS: Main: 238497792 10:58:11 INFO - 2015-12-09 10:58:11,868 DEBUG : BROWSER_OUTPUT: 10:58:11 INFO - 2015-12-09 10:58:11,872 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:58:11 INFO - 2015-12-09 10:58:11,872 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:58:11 INFO - 2015-12-09 10:58:11,872 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:58:11 INFO - 2015-12-09 10:58:11,872 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:58:11 INFO - 2015-12-09 10:58:11,872 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;114;108;114;115;113;104;115;113;106 10:58:11 INFO - 2015-12-09 10:58:11,872 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;130;149;166;132;152;152;130;170;138 10:58:11 INFO - 2015-12-09 10:58:11,873 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;160;161;162;160;160;161;161;162 10:58:11 INFO - 2015-12-09 10:58:11,873 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;80;87;74;73;72;94;87;72 10:58:11 INFO - 2015-12-09 10:58:11,873 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;129;94;96;94;136;95;96;131 10:58:11 INFO - 2015-12-09 10:58:11,873 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;109;109;110;109;109;109 10:58:11 INFO - 2015-12-09 10:58:11,873 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;146;146;148;146;147;146;146 10:58:11 INFO - 2015-12-09 10:58:11,873 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;95;95;96;96;95;95 10:58:11 INFO - 2015-12-09 10:58:11,874 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;72;73;73;73;75;72;82;69;72 10:58:11 INFO - 2015-12-09 10:58:11,874 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;68;69;69;69;69;69;68 10:58:11 INFO - 2015-12-09 10:58:11,874 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;236;88;89;86;85;86;84;91;89;86 10:58:11 INFO - 2015-12-09 10:58:11,874 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;126;120;127;127;132;126;126;119;128 10:58:11 INFO - 2015-12-09 10:58:11,874 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;150;149;147;150;151;144;146;147;141 10:58:11 INFO - 2015-12-09 10:58:11,875 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;69;70;70;69;72;69;70;70;71 10:58:11 INFO - 2015-12-09 10:58:11,875 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:58:11 INFO - 2015-12-09 10:58:11,875 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:58:11 INFO - 2015-12-09 10:58:11,875 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,991 10:58:11 INFO - 2015-12-09 10:58:11,875 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:58:11 INFO - 2015-12-09 10:58:11,875 DEBUG : BROWSER_OUTPUT: __startTimestamp1449687491870__endTimestamp 10:58:11 INFO - 2015-12-09 10:58:11,876 DEBUG : BROWSER_OUTPUT: 10:58:11 INFO - 2015-12-09 10:58:11,883 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:58:11 INFO - 2015-12-09 10:58:11,883 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:58:11 INFO - 2015-12-09 10:58:11,883 DEBUG : BROWSER_OUTPUT: 10:58:11 INFO - 2015-12-09 10:58:11,883 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.40 Median:113.50 stddev:3.95 (3.5%) stddev-sans-first:4.18 10:58:11 INFO - 2015-12-09 10:58:11,884 DEBUG : BROWSER_OUTPUT: Values: 112.0 114.0 108.0 114.0 115.0 113.0 104.0 115.0 113.0 106.0 10:58:11 INFO - 2015-12-09 10:58:11,884 DEBUG : BROWSER_OUTPUT: 10:58:11 INFO - 2015-12-09 10:58:11,884 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.90 Median:151.00 stddev:14.29 (9.5%) stddev-sans-first:15.11 10:58:11 INFO - 2015-12-09 10:58:11,884 DEBUG : BROWSER_OUTPUT: Values: 150.0 130.0 149.0 166.0 132.0 152.0 152.0 130.0 170.0 138.0 10:58:11 INFO - 2015-12-09 10:58:11,884 DEBUG : BROWSER_OUTPUT: 10:58:11 INFO - 2015-12-09 10:58:11,884 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 10:58:11 INFO - 2015-12-09 10:58:11,884 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 160.0 161.0 162.0 160.0 160.0 161.0 161.0 162.0 10:58:11 INFO - 2015-12-09 10:58:11,884 DEBUG : BROWSER_OUTPUT: 10:58:11 INFO - 2015-12-09 10:58:11,884 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.40 Median:77.00 stddev:8.13 (10.6%) stddev-sans-first:8.28 10:58:11 INFO - 2015-12-09 10:58:11,884 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 80.0 87.0 74.0 73.0 72.0 94.0 87.0 72.0 10:58:11 INFO - 2015-12-09 10:58:11,884 DEBUG : BROWSER_OUTPUT: 10:58:11 INFO - 2015-12-09 10:58:11,884 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:94.50 stddev:18.04 (19.1%) stddev-sans-first:18.69 10:58:11 INFO - 2015-12-09 10:58:11,885 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 129.0 94.0 96.0 94.0 136.0 95.0 96.0 131.0 10:58:11 INFO - 2015-12-09 10:58:11,885 DEBUG : BROWSER_OUTPUT: 10:58:11 INFO - 2015-12-09 10:58:11,885 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 10:58:11 INFO - 2015-12-09 10:58:11,885 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 10:58:11 INFO - 2015-12-09 10:58:11,885 DEBUG : BROWSER_OUTPUT: 10:58:11 INFO - 2015-12-09 10:58:11,885 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 10:58:11 INFO - 2015-12-09 10:58:11,885 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 146.0 146.0 148.0 146.0 147.0 146.0 146.0 10:58:11 INFO - 2015-12-09 10:58:11,885 DEBUG : BROWSER_OUTPUT: 10:58:11 INFO - 2015-12-09 10:58:11,885 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 10:58:11 INFO - 2015-12-09 10:58:11,885 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 10:58:11 INFO - 2015-12-09 10:58:11,885 DEBUG : BROWSER_OUTPUT: 10:58:11 INFO - 2015-12-09 10:58:11,885 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.40 Median:73.00 stddev:3.37 (4.6%) stddev-sans-first:3.57 10:58:11 INFO - 2015-12-09 10:58:11,885 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 73.0 73.0 75.0 72.0 82.0 69.0 72.0 10:58:11 INFO - 2015-12-09 10:58:11,885 DEBUG : BROWSER_OUTPUT: 10:58:11 INFO - 2015-12-09 10:58:11,886 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 10:58:11 INFO - 2015-12-09 10:58:11,886 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 68.0 69.0 69.0 69.0 69.0 69.0 68.0 10:58:11 INFO - 2015-12-09 10:58:11,886 DEBUG : BROWSER_OUTPUT: 10:58:11 INFO - 2015-12-09 10:58:11,886 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:102.00 Median:87.00 stddev:47.13 (54.2%) stddev-sans-first:2.26 10:58:11 INFO - 2015-12-09 10:58:11,886 DEBUG : BROWSER_OUTPUT: Values: 236.0 88.0 89.0 86.0 85.0 86.0 84.0 91.0 89.0 86.0 10:58:11 INFO - 2015-12-09 10:58:11,886 DEBUG : BROWSER_OUTPUT: 10:58:11 INFO - 2015-12-09 10:58:11,886 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.10 Median:127.00 stddev:3.98 (3.1%) stddev-sans-first:3.97 10:58:11 INFO - 2015-12-09 10:58:11,886 DEBUG : BROWSER_OUTPUT: Values: 130.0 126.0 120.0 127.0 127.0 132.0 126.0 126.0 119.0 128.0 10:58:11 INFO - 2015-12-09 10:58:11,886 DEBUG : BROWSER_OUTPUT: 10:58:11 INFO - 2015-12-09 10:58:11,886 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.20 Median:148.00 stddev:4.44 (3.0%) stddev-sans-first:3.23 10:58:11 INFO - 2015-12-09 10:58:11,886 DEBUG : BROWSER_OUTPUT: Values: 137.0 150.0 149.0 147.0 150.0 151.0 144.0 146.0 147.0 141.0 10:58:11 INFO - 2015-12-09 10:58:11,886 DEBUG : BROWSER_OUTPUT: 10:58:11 INFO - 2015-12-09 10:58:11,886 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:1.14 (1.6%) stddev-sans-first:1.00 10:58:11 INFO - 2015-12-09 10:58:11,887 DEBUG : BROWSER_OUTPUT: Values: 72.0 69.0 70.0 70.0 69.0 72.0 69.0 70.0 70.0 71.0 10:58:11 INFO - 2015-12-09 10:58:11,887 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:58:11 INFO - 2015-12-09 10:58:11,887 DEBUG : BROWSER_OUTPUT: 10:58:12 INFO - 2015-12-09 10:58:12,813 INFO : Browser exited with error code: 0 10:58:12 INFO - 2015-12-09 10:58:12,863 INFO : Completed test kraken (00:01:01) 10:58:12 INFO - 2015-12-09 10:58:12,863 INFO : Starting test v8_7 10:58:12 INFO - 2015-12-09 10:58:12,863 DEBUG : operating with platform_type : linux_ 10:58:12 INFO - 2015-12-09 10:58:12,863 INFO : Initialising browser for v8_7 test... 10:58:12 INFO - 2015-12-09 10:58:12,869 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbQ50K4/profile http://localhost:48128/getInfo.html 10:58:16 INFO - 2015-12-09 10:58:16,970 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:58:16 INFO - 2015-12-09 10:58:16,970 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:58:16 INFO - 2015-12-09 10:58:16,971 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:58:16 INFO - 2015-12-09 10:58:16,971 DEBUG : BROWSER_OUTPUT: __metrics 10:58:17 INFO - 2015-12-09 10:58:17,108 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] 10:58:17 INFO - 2015-12-09 10:58:17,189 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] 10:58:18 INFO - 2015-12-09 10:58:18,239 INFO : Browser initialized. 10:58:18 INFO - 2015-12-09 10:58:18,239 INFO : Running cycle 1/1 for v8_7 test... 10:58:18 INFO - 2015-12-09 10:58:18,239 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbQ50K4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:58:30 INFO - 2015-12-09 10:58:30,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 142888960 10:58:30 INFO - 2015-12-09 10:58:30,213 DEBUG : BROWSER_OUTPUT: 10:58:51 INFO - 2015-12-09 10:58:51,658 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48128/tests/v8_7/run.html (next: http://localhost:48128/tests/v8_7/run.html) 10:58:51 INFO - 2015-12-09 10:58:51,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 435232768 10:58:51 INFO - 2015-12-09 10:58:51,908 DEBUG : BROWSER_OUTPUT: 10:58:51 INFO - 2015-12-09 10:58:51,908 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:58:51 INFO - 2015-12-09 10:58:51,908 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:58:51 INFO - 2015-12-09 10:58:51,908 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:58:51 INFO - 2015-12-09 10:58:51,908 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:58:51 INFO - 2015-12-09 10:58:51,908 DEBUG : BROWSER_OUTPUT: |0;Richards;166.25103906899417 10:58:51 INFO - 2015-12-09 10:58:51,908 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.42555164101614 10:58:51 INFO - 2015-12-09 10:58:51,908 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.87685418415896 10:58:51 INFO - 2015-12-09 10:58:51,908 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5164.948453608247 10:58:51 INFO - 2015-12-09 10:58:51,909 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1970.4724409448818 10:58:51 INFO - 2015-12-09 10:58:51,909 DEBUG : BROWSER_OUTPUT: |5;Earley;789.8894154818325 10:58:51 INFO - 2015-12-09 10:58:51,909 DEBUG : BROWSER_OUTPUT: |6;Boyer;12219.512195121952 10:58:51 INFO - 2015-12-09 10:58:51,909 DEBUG : BROWSER_OUTPUT: |7;RegExp;27216.216216216217 10:58:51 INFO - 2015-12-09 10:58:51,909 DEBUG : BROWSER_OUTPUT: |8;Splay;603.1363088057901 10:58:51 INFO - 2015-12-09 10:58:51,910 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 10:58:51 INFO - 2015-12-09 10:58:51,910 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:58:51 INFO - 2015-12-09 10:58:51,910 DEBUG : BROWSER_OUTPUT: __startTimestamp1449687531907__endTimestamp 10:58:51 INFO - 2015-12-09 10:58:51,910 DEBUG : BROWSER_OUTPUT: 10:58:51 INFO - 2015-12-09 10:58:51,910 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:58:51 INFO - 2015-12-09 10:58:51,910 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:58:51 INFO - 2015-12-09 10:58:51,910 DEBUG : BROWSER_OUTPUT: 10:58:51 INFO - 2015-12-09 10:58:51,910 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.25 Median:166.25 stddev:0.00 (0.0%) 10:58:51 INFO - 2015-12-09 10:58:51,910 DEBUG : BROWSER_OUTPUT: Values: 166.3 10:58:51 INFO - 2015-12-09 10:58:51,910 DEBUG : BROWSER_OUTPUT: 10:58:51 INFO - 2015-12-09 10:58:51,911 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.43 Median:185.43 stddev:0.00 (0.0%) 10:58:51 INFO - 2015-12-09 10:58:51,911 DEBUG : BROWSER_OUTPUT: Values: 185.4 10:58:51 INFO - 2015-12-09 10:58:51,911 DEBUG : BROWSER_OUTPUT: 10:58:51 INFO - 2015-12-09 10:58:51,911 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 10:58:51 INFO - 2015-12-09 10:58:51,911 DEBUG : BROWSER_OUTPUT: Values: 279.9 10:58:51 INFO - 2015-12-09 10:58:51,911 DEBUG : BROWSER_OUTPUT: 10:58:51 INFO - 2015-12-09 10:58:51,912 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 10:58:51 INFO - 2015-12-09 10:58:51,912 DEBUG : BROWSER_OUTPUT: Values: 5164.9 10:58:51 INFO - 2015-12-09 10:58:51,912 DEBUG : BROWSER_OUTPUT: 10:58:51 INFO - 2015-12-09 10:58:51,913 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1970.47 Median:1970.47 stddev:0.00 (0.0%) 10:58:51 INFO - 2015-12-09 10:58:51,913 DEBUG : BROWSER_OUTPUT: Values: 1970.5 10:58:51 INFO - 2015-12-09 10:58:51,913 DEBUG : BROWSER_OUTPUT: 10:58:51 INFO - 2015-12-09 10:58:51,913 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 10:58:51 INFO - 2015-12-09 10:58:51,913 DEBUG : BROWSER_OUTPUT: Values: 789.9 10:58:51 INFO - 2015-12-09 10:58:51,913 DEBUG : BROWSER_OUTPUT: 10:58:51 INFO - 2015-12-09 10:58:51,913 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 10:58:51 INFO - 2015-12-09 10:58:51,913 DEBUG : BROWSER_OUTPUT: Values: 12219.5 10:58:51 INFO - 2015-12-09 10:58:51,914 DEBUG : BROWSER_OUTPUT: 10:58:51 INFO - 2015-12-09 10:58:51,914 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27216.22 Median:27216.22 stddev:0.00 (0.0%) 10:58:51 INFO - 2015-12-09 10:58:51,914 DEBUG : BROWSER_OUTPUT: Values: 27216.2 10:58:51 INFO - 2015-12-09 10:58:51,914 DEBUG : BROWSER_OUTPUT: 10:58:51 INFO - 2015-12-09 10:58:51,914 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.14 Median:603.14 stddev:0.00 (0.0%) 10:58:51 INFO - 2015-12-09 10:58:51,914 DEBUG : BROWSER_OUTPUT: Values: 603.1 10:58:51 INFO - 2015-12-09 10:58:51,914 DEBUG : BROWSER_OUTPUT: 10:58:51 INFO - 2015-12-09 10:58:51,915 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 10:58:51 INFO - 2015-12-09 10:58:51,915 DEBUG : BROWSER_OUTPUT: Values: 4845.4 10:58:51 INFO - 2015-12-09 10:58:51,915 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:58:51 INFO - 2015-12-09 10:58:51,915 DEBUG : BROWSER_OUTPUT: 10:58:52 INFO - 2015-12-09 10:58:52,837 INFO : Browser exited with error code: 0 10:58:52 INFO - 2015-12-09 10:58:52,849 INFO : Completed test v8_7 (00:00:39) 10:58:52 INFO - 2015-12-09 10:58:52,911 INFO : Completed test suite (00:20:20) 10:58:52 INFO - 2015-12-09 10:58:52,911 DEBUG : Working with test: dromaeo_css 10:58:52 INFO - 2015-12-09 10:58:52,911 DEBUG : Generating results file: dromaeo_css 10:58:52 INFO - 2015-12-09 10:58:52,912 DEBUG : Working with test: kraken 10:58:52 INFO - 2015-12-09 10:58:52,912 DEBUG : Generating results file: kraken 10:58:52 INFO - 2015-12-09 10:58:52,913 INFO : javascript benchmark 10:58:52 INFO - 2015-12-09 10:58:52,913 DEBUG : Working with test: v8_7 10:58:52 INFO - 2015-12-09 10:58:52,913 DEBUG : Generating results file: v8_7 10:58:52 INFO - 2015-12-09 10:58:52,913 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:58:52 INFO - 2015-12-09 10:58:52,978 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 10:58:52 INFO - 2015-12-09 10:58:52,978 DEBUG : process_Request line: dromaeo_css 6321.40 graph.html#tests=[[72,132,35]] 10:58:52 INFO - 2015-12-09 10:58:52,979 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:58:53 INFO - 2015-12-09 10:58:53,022 DEBUG : process_Request line: kraken 1541.40 graph.html#tests=[[232,132,35]] 10:58:53 INFO - 2015-12-09 10:58:53,022 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:58:53 INFO - 2015-12-09 10:58:53,050 DEBUG : process_Request line: v8_7 19795.72 graph.html#tests=[[230,132,35]] 10:58:53 INFO - 2015-12-09 10:58:53,051 INFO : javascript benchmark 10:58:53 INFO - 2015-12-09 10:58:53,055 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2583.2433944917457, 2745.6705195376558, 2746.615473833665, 2754.22881593154, 2774.4312415954732, 4422.0, 4537.977310113445, 4653.627709783218, 4727.078219747155, 4736.668433209677, 4629.259318509039, 4656.208444564424, 4723.244280915054, 4737.692050016746, 4803.543663351985, 4317.179735850178, 4331.208921532969, 4371.693981421302, 4382.298832186851, 4399.824007039714, 4155.439015732868, 4429.13631841791, 4442.466903971512, 4482.910341793162, 4484.327350897375, 4202.285611446031, 4218.11419601884, 4252.170826688797, 4311.073119279338, 4332.068605249855, 4346.76092814895, 4393.143337049277, 4395.077033822901, 4433.578810013076, 4446.110777844444, 4192.895177620553, 4381.38660587518, 4387.473503179639, 4389.604935555783, 4435.29035354345, 4586.059857729191, 4616.95383046172, 4686.835960741358, 4800.207965685658, 4834.806607735686, 5000.1249781288125, 5037.29477873098, 5041.369828771403, 5043.445221025684, 5088.516590923857, 4940.061388336205, 5059.089363914494, 5064.215046667736, 5066.9746651266505, 5070.188769796851, 4597.080583883237, 4622.838200663028, 4696.624270058387, 4744.739039352799, 4809.759512024385, 5142.485751424828, 5158.638895277295, 5170.767315470813, 5179.0, 5222.3733152022005, 4811.735354555463, 4957.752112394438, 4960.454350021495, 4966.751662416865, 5007.098722230034, 4905.681130726492, 4906.803727850846, 4936.284238785356, 4957.107720610325, 4995.250712393097, 4949.925751113737, 4973.254011898244, 4985.127602669519, 4988.401391833003, 5028.120078986163, 4790.041991601694, 4944.456109827916, 4959.0, 4962.15643340633, 5008.398992120896, 4127.4015267786, 4135.91728165435, 4168.333066709312, 4191.077962848169, 4221.2190744712325, 3639.3267245559655, 3643.8360273787744, 3661.3043521730788, 3672.412414013745, 3694.5012423323046, 4054.432379466877, 4278.957210427856, 4295.8281668733525, 4333.328334108218, 4334.783260837009, 5010.148274793294, 5029.446760856303, 5063.3417655704525, 5065.848024559269, 5067.923981140286, 4255.148970205972, 4331.7184383015, 4337.674674399433, 4361.9127617447475, 4378.540253273424, 4505.279155335131, 4513.977430112828, 4525.547445255514, 4532.206863798822, 4558.202314594932, 4510.526394728638, 4618.168729628699, 4618.399608050931, 4817.084753896748, 4835.226363781778, 5003.699778013331, 5058.6206034548295, 5071.2139618359215, 5076.82231121909, 5118.00198961199, 4762.904741905212, 4819.566239038503, 4820.035992801524, 4837.298591704112, 4865.0756356292195, 4791.377120974391, 4902.681325713817, 4902.828401005948, 5031.924521132113, 5087.08432482142, 4918.090153321504, 4977.925331120108, 4989.351384320015, 5009.148444764472, 5027.597792176544, 4837.7097374157665, 4863.659543831898, 4864.756762161807, 4873.610111191168, 4911.656184067081, 4620.561046700558, 4850.46644869057, 4869.342638743724, 4874.53691899269, 4921.975390123026, 4702.623790096853, 4716.198246298069, 4782.258749893772, 4792.640551958547, 4806.831760888352, 4953.950460495349, 4962.404511458503, 4964.379452568429, 5007.799688012438, 5034.244863270539, 4864.294677271847, 4866.0, 4866.416030076413, 4867.342908707279, 4910.607151427948], "unit": "ms", "name": "dojo.html", "value": 4609.882843223938}, {"lowerIsBetter": false, "replicates": [513.3865031287611, 515.2374485761073, 520.1988937036963, 523.2073408785693, 542.1488263426418, 26703.4659306814, 32720.181995450126, 33263.16842078943, 33268.16829579262, 33335.99992000241, 40247.59752402475, 40900.59099409005, 40927.59072409275, 40971.79514102425, 41002.58997410025, 6936.479764017694, 7014.368706816385, 7942.126366099725, 8111.148329425414, 8116.0, 10111.54498047586, 10414.375137491737, 10420.062194402502, 10429.947850260738, 10434.0, 10044.296899217057, 10084.394936303808, 10153.492325383739, 10168.694939151837, 10172.6948191554, 7153.499255052148, 7303.926960730378, 7347.742829000959, 7349.889751653729, 10073.345232559861, 10139.847902281472, 10319.43243121628, 10368.222383321281, 10380.584776608926, 10388.065074143364, 37933.620663793285, 38457.0, 38470.80764596159, 38473.42289865654, 38480.80759596212, 2873.798834081615, 2900.4054168895327, 2909.156344660046, 2928.1947464447235, 2929.407548972768, 28330.858345708344, 28512.572311415344, 28868.422631547463, 29115.272118197, 29514.0, 3414.470757032664, 3442.7590068695204, 3454.2055327274866, 3495.5106285120105, 3563.94654080189, 220542.0, 220587.0, 220803.0, 221605.0, 221737.0, 46014.309785353245, 53986.46013539893, 54209.0, 54219.45780542223, 54252.0, 41317.793411032755, 63195.0, 64730.67634661797, 64781.35218647848, 64785.25399071159, 14676.706465870837, 15029.624259393384, 15035.0, 15044.398224071134, 15052.849471505364, 9273.211776998896, 9646.758831029281, 9832.459214743258, 11235.213535052631, 11429.0, 18551.44345669632, 18709.25162993465, 18722.906385467984, 18745.437636870916, 18766.249350025846, 7342.669579868919, 7436.66535005926, 7473.103227612722, 7512.812179695551, 7541.924580754122, 815.5432957543794, 861.1259571534897, 893.4996402014763, 967.2697113679127, 1017.4454922067491, 27343.179704608894, 27392.17823465299, 27458.725412746015, 27591.586126208123, 27779.305517361823, 944.6268723854176, 1068.7595291059604, 1077.9730506737394, 1104.4643347976225, 1115.1079136690614, 14161.221132837587, 14223.928880355532, 14303.713925721428, 14494.927525362305, 14528.854711452961, 280721.0, 284546.0, 285474.0, 286087.0, 286536.0, 47406.76296618564, 47526.52473475221, 47689.5231047692, 47766.761166193945, 47768.5223147771, 1183.1717797541755, 1205.8010428279235, 1207.927524348542, 1214.7874122028786, 1234.3211233821362, 25825.225243242734, 26621.334466637712, 26760.19719408421, 26935.461290774467, 27162.0, 41184.0, 41264.58735412607, 41446.513209207544, 41453.75638730843, 41565.79217103895, 263379.0, 264942.0, 264990.0, 265308.0, 265496.0, 24729.381765455288, 28109.297267568476, 28555.857765689972, 28598.14205573836, 28866.134015979555, 33593.16519118125, 37356.81321593375, 37408.0, 37669.81165094157, 37892.810535947145, 31607.525887111253, 31749.682503174674, 32033.199170020005, 32113.0, 32576.34847303088, 28340.43319133647, 31237.8438107808, 32448.513272301407, 32569.511457327684, 33734.49398258979, 30459.086227413212, 33706.0, 33860.661393386734, 34053.148671283416, 34196.14509637279, 24734.134305299227, 26948.595771063057, 27089.72910270872, 27118.0, 29398.853005734836, 22987.310380688607, 23003.24270391619, 23168.18911338095, 23318.53362932766, 23337.533249335258], "unit": "ms", "name": "ext.html", "value": 17183.793356900605}, {"lowerIsBetter": false, "replicates": [267.4196992526218, 269.53101603210416, 271.3744818194062, 274.8145002123566, 275.24582643556647, 11487.425628718573, 14254.3585538651, 14990.100593964356, 15441.0, 15446.382144714213, 16374.83625163748, 16550.586235344123, 16673.082980436073, 16714.66570668586, 16938.491845244633, 5564.693941833188, 5711.343195532525, 5725.570582206351, 5725.885482290372, 5732.828015159531, 4088.632023117919, 4219.683523735716, 4221.894452638678, 4233.661307095425, 5584.246126772895, 4201.138766552865, 6321.146645202908, 6538.967305163491, 6552.0, 6552.770653027145, 6310.9902415613515, 6556.737730490775, 6574.079628851964, 6589.04458853466, 6593.307702691221, 6175.722092505803, 6283.968580157116, 6302.212223472066, 6316.936830631681, 6345.048242763576, 19723.802761972485, 19780.208791648318, 19864.20543178271, 20606.072726727183, 20739.170433182655, 1963.4207908666835, 2000.949976250591, 2021.585574957145, 2054.1269960266977, 2082.0422605601443, 13203.471861125543, 13246.73506529864, 13350.666233344147, 13566.389512471962, 13688.041837071409, 1883.8210370014826, 1903.8857668539792, 1909.8663093583455, 1912.177763561668, 1931.2468137426274, 60965.695171524305, 61096.38903610996, 62114.0, 66151.66924165396, 66419.33580664228, 14593.635159120895, 14709.338079786436, 14812.481563145453, 14823.555293341216, 14869.479568215276, 21680.241191558536, 21810.0, 21827.563448730936, 21877.453063673216, 21886.343409697736, 8073.071596766447, 8145.959270203611, 8164.346852251806, 8223.753287401387, 8250.834983300421, 6720.462363010947, 6729.0, 6737.562058466184, 6794.3545363190415, 6801.149856267966, 7404.148522919825, 7467.178610352966, 7468.290512401313, 7476.925230747732, 7576.24237576238, 2243.3830696558575, 2914.7522460590662, 2924.2104631749307, 2927.312081660808, 2931.311141881656, 325.2778830995187, 329.2394568546665, 350.2784264415313, 783.6786917363968, 926.1942110364026, 8782.692605758768, 8970.461772293684, 9456.338056336128, 9741.123298903132, 10007.599696012223, 350.98596056157976, 356.0724313164222, 362.6645353048472, 367.3882984830281, 374.3000588898777, 5031.949680503221, 5094.159463688524, 5096.21008743638, 5162.9415969726115, 5199.350081239845, 286263.0, 290505.0, 473511.0, 495662.0, 498588.0, 73513.0, 76420.23579764132, 76672.61663691646, 76920.84618730724, 77538.0, 1024.3188279793853, 1027.0807627173638, 1030.1912998296302, 1034.0745033195399, 1050.9579616815395, 13705.246211458465, 13970.30148492551, 14344.641383965485, 14436.927815361276, 14570.781438278646, 31161.37677246488, 31200.843995779876, 31319.53020704737, 32076.83961580177, 34776.82611586926, 41556.0, 42585.0, 42686.78656606697, 42736.78631606822, 45800.0, 8393.160683931557, 8511.574421279036, 8589.055203927688, 8597.398182127441, 8645.697400590949, 11960.222585531912, 12141.0, 12304.569340073054, 15208.32708402097, 16910.57723556921, 13482.258475783927, 13520.12119212248, 13613.31933403306, 13755.931220343835, 13922.930385348009, 12884.871151288367, 13370.799438008244, 13436.865631343562, 13499.460021599027, 13707.0, 13718.245496497788, 13873.167609943435, 13907.096038757449, 13929.791053134008, 13995.51015714445, 8625.956870215608, 8670.82658346842, 8720.869186962074, 8866.335024873031, 8898.59956301955, 13778.448862045407, 13891.235982021086, 14051.36768845425, 14108.36512356926, 14343.354549045109], "unit": "ms", "name": "jquery.html", "value": 8437.173850632687}, {"lowerIsBetter": false, "replicates": [1430.9427622895084, 1592.3710134496873, 1665.2256700634202, 1688.4343744845476, 1720.4580557124498, 5734.340550836655, 5937.821865344035, 6928.930710692898, 7099.503034787567, 7160.677769500372, 6982.511224214307, 7044.366007059363, 7075.964620176892, 7102.538335008221, 7109.289071092888, 2030.9492262693402, 2049.200811683437, 2059.06312627754, 2061.175529788082, 2065.2461851424196, 2056.8663036902626, 2059.06312627754, 2059.6704527275638, 2108.3464126120875, 2110.62008838409, 2019.1519561784087, 2036.287299445197, 2059.835213182942, 2060.0832629479814, 2062.7215325931033, 2050.1491880869494, 2070.492729281321, 2073.35725924963, 2075.8650687705326, 2076.6262072826885, 1985.4242269741758, 2006.7792542820278, 2031.4413536277493, 2033.1257559249516, 2034.2168265217997, 7097.964510177416, 7194.244604316524, 7194.820129496752, 7201.063861697946, 7208.315210055036, 4162.41726158338, 4191.057012172268, 4194.517630472505, 4197.748135111872, 4219.050713589449, 2759.1584566707147, 2781.666200055986, 2798.2164993801766, 2824.124521398373, 2829.7453229209264, 839.8194388206504, 852.7271273192581, 860.2172023458685, 875.2166810704384, 889.0, 9576.186024187882, 9593.616255349778, 9594.9520252399, 9602.615895364177, 9612.615495380176, 3762.6425489578446, 3785.6971442284553, 3855.286771947143, 3858.305505009125, 3871.496705428276, 8296.294814940798, 8297.792555186048, 8320.292775114061, 8320.500769953702, 8322.66709331632, 4284.400183974246, 4298.4197133387215, 4301.462317210348, 4306.827726890952, 4307.5261721210645, 3207.711305982426, 3247.6752324767335, 3750.662440380379, 3904.2386734587053, 3914.3149948759424, 3373.241020770356, 3393.8812141574926, 3410.48842673596, 3421.726261899042, 3425.417678994577, 1039.6828967164936, 1048.575326992554, 1049.9947500262604, 1052.3528030261334, 1052.7052425320921, 948.0898337595847, 966.8549717542285, 967.2648786921849, 1028.7068185567077, 1205.9698507537207, 6713.4964877634375, 6718.798436046926, 6734.8989765153565, 6742.089817874622, 6754.797356079325, 394.37688452245385, 395.74474463971154, 404.7874865695533, 404.9007993041724, 406.43302592882765, 5328.893422131613, 5394.757235924393, 5400.054990376669, 5406.83779486616, 5409.377921538995, 8110.878336824952, 8480.618372173267, 8493.660253589911, 8542.18849209324, 8572.957135214285, 8442.07137214906, 8450.915490845136, 8455.408121431563, 8468.068512463624, 8471.924378527301, 6285.151504546828, 6317.084022816758, 6329.620222786648, 6651.833704157435, 6691.59850408977, 6531.477481801349, 6653.268140504444, 6659.167604049494, 6670.299618540177, 6688.531802773759, 7551.811204719926, 7573.659090682741, 7594.772156835304, 7612.467127301035, 7751.92248077512, 7785.493942893694, 7872.881906771518, 7954.244346787046, 8078.87881681787, 8088.0, 5601.271834661468, 5705.828825135252, 6043.516518678583, 6839.965800170968, 6958.965205173941, 6572.868542629216, 6799.878020126624, 6817.522773405814, 6850.177978642595, 6850.349216824394, 6206.379362063757, 6367.968160159169, 6457.354264573693, 6482.54622176462, 6615.37153970372, 6224.844378890564, 6294.8426289341305, 6386.712597933011, 6424.839379015375, 6457.289698133108, 6460.45086167681, 6497.5126865484335, 6504.642244676588, 6511.413972742476, 6520.869582608416, 5729.398413166724, 5757.0788673811985, 5766.884662306814, 5771.422857714363, 6078.331383547895, 6144.139820425234, 6162.969185154046, 6174.197354343906, 6187.443130118311, 6194.38056194377], "unit": "ms", "name": "mootools.html", "value": 3974.9501756667773}, {"lowerIsBetter": false, "replicates": [252.79397291207664, 252.95573274676937, 260.11560693641604, 260.14282937720213, 260.60128004153637, 5255.448177941318, 5330.786768529264, 5344.438833922436, 5348.411674715778, 5354.170103633938, 5039.622028347871, 5138.948610513903, 5201.661891977028, 5213.608979326556, 5213.8957220855655, 3999.040230344711, 4007.0, 4007.639312461878, 4032.0121570215338, 4033.455483509733, 4026.0740029793164, 4029.194161167778, 4029.6776257899296, 4032.717709760318, 4034.3948407738926, 3991.241664083829, 3993.0616305168264, 3996.9000774980714, 3998.620131087542, 4000.0399904023116, 3823.541175058983, 3989.242044011643, 3998.3602623580086, 3999.320115580358, 4001.419794129835, 3374.3420033093557, 3374.8143852088124, 3380.678835510623, 3381.7970921744527, 3386.983065084659, 5117.769700363493, 5118.6416950813455, 5123.923141152885, 5124.692518448905, 5132.178851383761, 4529.275315949432, 4532.818687252506, 4534.614557762594, 4537.115262523809, 4539.7049191802425, 5556.611037227396, 5561.054620714488, 5569.303837020372, 5580.051391263495, 5580.63725857822, 3598.2623562169692, 3701.222743223926, 3706.981465092684, 3706.981465092684, 3711.888643340704, 5635.690037047961, 5776.046952252873, 5822.767089316422, 5912.822615321505, 5919.704014799286, 3684.3736564783517, 3747.512823333004, 3773.52830896138, 3774.094217387807, 3775.811209439517, 3814.065553939303, 3815.809209539512, 3818.59904710007, 3820.9235815283537, 3821.293060783764, 4459.777011149429, 4477.037436951006, 4477.238869392211, 4478.48497422794, 4480.484744254452, 5403.540699040547, 5504.834854954358, 5511.173324001352, 5529.115341545334, 5530.751116199781, 1332.7601031814368, 1337.832770903637, 1340.6447291467769, 1341.872522110398, 1343.650650830791, 872.5898827551041, 884.4781578868499, 885.2608072259607, 895.2122132523338, 897.0939351255149, 4697.201475749131, 4743.66794324394, 4807.759612019455, 4860.927086093711, 4876.634252431082, 5820.417958204231, 5877.706114694248, 5878.382769809194, 5890.646561206341, 5894.351621321651, 4886.169351210303, 4891.290762839369, 4891.779869905863, 4901.534354236342, 4906.0433215522635, 3101.9224519387194, 3151.416987857254, 3153.0225630054756, 3155.5266709993225, 3159.3365393267213, 5384.0, 5532.446755324516, 5533.253010843485, 5559.24950131727, 5559.916601250984, 6042.516598672096, 6048.6975651218145, 6052.061930400795, 6053.3946605339115, 6054.878902421927, 5553.305836770403, 5555.777768889361, 5557.888842223133, 5561.0, 5563.248961390323, 5706.828795136153, 5835.533157347487, 5882.7058647066615, 5895.410458954242, 5899.4985426239255, 5744.770209191585, 5757.453041961007, 5758.049921762862, 5759.596828221985, 5759.827205183851, 5546.72266386671, 5548.140038294071, 5551.278333816578, 5553.611247212656, 5557.110862262019, 3777.9433308500943, 3783.9432408513344, 3787.0153760023145, 3787.16682329887, 3790.962090379061, 5696.629719068247, 5892.646441213541, 5897.203877476486, 5919.644821310735, 5939.851503712442, 5697.287839020122, 5703.230063941315, 5706.258186435737, 5707.058335374617, 5707.600467967202, 5652.519535839499, 5658.151277308272, 5674.460926212003, 5676.744546495335, 5679.977604031314, 5377.919331210113, 5565.38780734127, 5569.526590239713, 5570.749316280696, 5582.720863956867, 5724.0, 5729.885402292014, 5730.5129064030025, 5730.856728581819, 5737.827865164052, 5361.169018802092, 5400.648957817729, 5495.53287970527, 5517.062099443185, 5575.581831362583], "unit": "ms", "name": "prototype.html", "value": 4117.12931482833}, {"lowerIsBetter": false, "replicates": [672.6771149848073, 718.8382613911867, 745.1468069060924, 781.4998401023345, 816.5794615772875, 13713.451461941522, 14066.64833379166, 14106.929465352685, 14124.78812817806, 14128.646783830396, 13402.93298533506, 13504.12223205491, 13507.729845403086, 13520.526781562623, 13522.932385338085, 635.2630948100204, 644.9580777249464, 803.7508372404559, 810.5379933437943, 810.9837803243931, 799.5282783157936, 809.3039985612369, 814.9959250203771, 815.9510429374257, 815.9959200204021, 848.9363297752662, 857.1300130367682, 857.5969294431638, 858.5535521528801, 859.6776208921655, 659.9670016499156, 671.3320246354859, 830.1532436914374, 843.9957800210959, 853.2065179383171, 623.9282482514524, 623.9812805615838, 623.9875202495924, 624.1231070346171, 624.2540164503421, 11897.881021189763, 12013.038956883429, 12036.518539258419, 12036.699082522919, 12043.759124817454, 10845.51195196218, 11319.773604527945, 11352.14858885587, 11456.633378748656, 11538.653840384803, 9343.859842102374, 9376.812463750686, 9415.0, 9575.329726919119, 9749.658761943298, 3125.9374812503625, 3162.509810979279, 3194.2493514024186, 3199.936001279961, 3209.9197520062185, 41844.953876153035, 41888.37167442491, 42290.0, 42329.365059524134, 42344.788276058425, 8868.822623547492, 8961.775955601162, 9005.399843149777, 9029.548522573845, 9094.636214551476, 16181.271842767104, 16213.0, 16213.67572648564, 16236.188190590423, 16246.268917898722, 6350.7459701611415, 6527.54307198501, 6530.314316996742, 6619.0, 6639.668016599151, 3412.84642191102, 3421.3328400961573, 3477.8434970426392, 3506.0358401439807, 3532.0816587686872, 2674.946501069968, 2706.2693072870215, 2706.837589744582, 2714.443539074485, 2724.1827451764393, 480.10460491183693, 486.54264990908433, 488.1213815132818, 498.62353922788066, 503.3883831145103, 459.36148753233033, 556.5269520907196, 580.3673995345094, 584.8011082525283, 597.5876645114856, 7399.6670149843385, 7409.851802963911, 7659.234076592296, 7823.765287041398, 8020.518768873886, 580.6312991250586, 580.9244798176295, 585.4555263604803, 607.7690477618477, 614.9784757533554, 3634.5093412388987, 4052.615001574846, 4103.466549348565, 4109.445224894661, 4172.207280616673, 50894.745526272134, 52135.0, 52462.0, 52566.474335256156, 52641.21038184431, 44938.77530612391, 45030.09939801186, 45424.09151816945, 45499.0, 45722.542774571826, 41102.58897411048, 42334.78832605879, 42646.14707705828, 42878.57121428808, 43119.56880431156, 8064.233897779702, 8308.0, 8381.706640267561, 8438.451500652438, 8526.573671316286, 31798.682013179572, 32012.359752805278, 32104.0, 32218.35563288768, 32575.837120814245, 36682.63317366792, 37768.0, 40096.0, 40756.59243407528, 40814.0, 10630.149588032784, 10717.142628589538, 10722.195835312226, 10840.783184336111, 10854.837177442187, 11264.66206013821, 11267.661970140909, 11277.830832537355, 11375.0, 11921.344326061802, 10525.421101839473, 10563.63027294041, 10609.946950265508, 10626.36241825493, 10661.786764264516, 10468.790624187626, 10671.46642667848, 10718.303310284806, 10792.514336854703, 11189.328640281283, 10312.742181445525, 10522.842157367799, 10561.313514621525, 10626.84059739089, 10847.837282440612, 9341.626334946797, 9471.127633209418, 9686.56410461545, 9692.70921872345, 9750.21998240125, 8795.868061978947, 9098.681546145854, 9272.95363523205, 9275.30435217348, 9280.0], "unit": "ms", "name": "yui.html", "value": 5833.086571941203}], "name": "dromaeo_css", "value": 6321.397184615929}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 108.0, 114.0, 115.0, 113.0, 104.0, 115.0, 113.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [150.0, 130.0, 149.0, 166.0, 132.0, 152.0, 152.0, 130.0, 170.0, 138.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.9}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 161.0, 162.0, 160.0, 160.0, 161.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 80.0, 87.0, 74.0, 73.0, 72.0, 94.0, 87.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 78.4}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 129.0, 94.0, 96.0, 94.0, 136.0, 95.0, 96.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 148.0, 146.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 73.0, 73.0, 75.0, 72.0, 82.0, 69.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 73.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [236.0, 88.0, 89.0, 86.0, 85.0, 86.0, 84.0, 91.0, 89.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 102.0}, {"lowerIsBetter": true, "replicates": [130.0, 126.0, 120.0, 127.0, 127.0, 132.0, 126.0, 126.0, 119.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.1}, {"lowerIsBetter": true, "replicates": [137.0, 150.0, 149.0, 147.0, 150.0, 151.0, 144.0, 146.0, 147.0, 141.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.2}, {"lowerIsBetter": true, "replicates": [72.0, 69.0, 70.0, 70.0, 69.0, 72.0, 69.0, 70.0, 70.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1541.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.25103906899417], "unit": "score", "name": "Richards", "value": 212.3415300000001}, {"lowerIsBetter": false, "replicates": [185.42555164101614], "unit": "score", "name": "DeltaBlue", "value": 356.5743740000001}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1970.4724409448818], "unit": "score", "name": "RayTrace", "value": 375.5388731268733}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [27216.216216216217], "unit": "score", "name": "RegExp", "value": 33.472140019860944}, {"lowerIsBetter": false, "replicates": [603.1363088057901], "unit": "score", "name": "Splay", "value": 135.11207800000005}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19795.718686461667}]} 10:58:53 INFO - RETURN: dromaeo_css: 6321.40 10:58:53 INFO - RETURN: kraken: 1541.40 10:58:53 INFO - RETURN: v8_7: 19795.72 10:58:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19795.72"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1541.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6321.40"}}} 10:58:53 INFO - Return code: 0 10:58:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:58:53 ERROR - # TBPL SUCCESS # 10:58:53 INFO - Running post-action listener: _resource_record_post_action 10:58:53 INFO - Running post-run listener: _resource_record_post_run 10:58:54 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 10518528; Write bytes: 405872640; Read time: 3876; Write time: 515764 10:58:54 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 4997120; Read time: 0; Write time: 312 10:58:54 INFO - run-tests - Wall time: 1223s; CPU: 13.0%; Read bytes: 8781824; Write bytes: 400875520; Read time: 3812; Write time: 515452 10:58:54 INFO - Running post-run listener: _upload_blobber_files 10:58:54 INFO - Blob upload gear active. 10:58:54 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:58:54 INFO - Copying logs to upload dir... 10:58:54 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1276.217497 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-12-09 10:58:54.298472) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 10:58:54.301903) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009971 build_url: 'https://queue.taskcluster.net/v1/task/av6V2N4uTQK0a2GTgGjhVQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 10:58:54.353481) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 10:58:54.353799) ========= 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=b47e8c1238be48f5acbf8f2f000001bb-1449684186.32358-1955943703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 10:58:54.404507) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 10:58:54.404832) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 10:58:54.405135) ========= ========= Total master_lag: 0.29 =========