builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-029 starttime: 1450271989.27 results: success (0) buildid: 20151216045007 builduid: 2cde2e0c6f5948a788a3a975977b2a4a revision: 48a56019f52049bbf9ccede95d15a2cb3b5295bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 05:19:49.273526) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 05:19:49.273942) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 05:19:49.274237) ========= 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=1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006189 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 05:19:49.297063) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 05:19:49.297332) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 05:19:49.310530) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:19:49.310791) ========= 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=1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:19:49.360479) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 05:19:49.360776) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 05:19:49.361153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:19:49.361460) ========= 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=1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 05:19:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2015-12-16 05:19:50 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.243913 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:19:49.617822) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:19:49.618143) ========= 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=1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018612 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:19:49.669393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:19:49.669726) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 48a56019f52049bbf9ccede95d15a2cb3b5295bc --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 48a56019f52049bbf9ccede95d15a2cb3b5295bc --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=1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 05:19:50,295 truncating revision to first 12 chars 2015-12-16 05:19:50,295 Setting DEBUG logging. 2015-12-16 05:19:50,295 attempt 1/10 2015-12-16 05:19:50,295 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/48a56019f520?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 05:19:50,737 unpacking tar archive at: fx-team-48a56019f520/testing/mozharness/ program finished with exit code 0 elapsedTime=0.722090 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:19:50.405191) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 05:19:50.405536) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 05:19:50.413665) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 05:19:50.413950) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 05:19:50.414373) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-16 05:19:50.414649) ========= /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=1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:19:51 INFO - MultiFileLogger online at 20151216 05:19:51 in /builds/slave/test 05:19:51 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 05:19:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:19:51 INFO - {'append_to_log': False, 05:19:51 INFO - 'base_work_dir': '/builds/slave/test', 05:19:51 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:19:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:19:51 INFO - 'branch': 'Fx-Team-Non-PGO', 05:19:51 INFO - 'buildbot_json_path': 'buildprops.json', 05:19:51 INFO - 'config_files': ('talos/linux_config.py',), 05:19:51 INFO - 'default_actions': ('clobber', 05:19:51 INFO - 'read-buildbot-config', 05:19:51 INFO - 'download-and-extract', 05:19:51 INFO - 'populate-webroot', 05:19:51 INFO - 'create-virtualenv', 05:19:51 INFO - 'install', 05:19:51 INFO - 'run-tests'), 05:19:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:19:51 INFO - 'download_minidump_stackwalk': True, 05:19:51 INFO - 'download_symbols': 'ondemand', 05:19:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:19:51 INFO - 'tooltool.py': '/tools/tooltool.py', 05:19:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:19:51 INFO - '/tools/misc-python/virtualenv.py')}, 05:19:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:19:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:19:51 INFO - 'installer_path': 'installer.exe', 05:19:51 INFO - 'log_level': 'info', 05:19:51 INFO - 'log_name': 'talos', 05:19:51 INFO - 'log_to_console': True, 05:19:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:19:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:19:51 INFO - 'opt_config_files': (), 05:19:51 INFO - 'pip_index': False, 05:19:51 INFO - 'sps_profile': False, 05:19:51 INFO - 'sps_profile_interval': 0, 05:19:51 INFO - 'suite': 'dromaeojs', 05:19:51 INFO - 'system_bits': '64', 05:19:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:19:51 INFO - 'title': 'talos-linux64-ix-029', 05:19:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:19:51 INFO - 'use_talos_json': True, 05:19:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:19:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:19:51 INFO - 'work_dir': 'build'} 05:19:51 INFO - ##### 05:19:51 INFO - ##### Running clobber step. 05:19:51 INFO - ##### 05:19:51 INFO - Running pre-action listener: _resource_record_pre_action 05:19:51 INFO - Running main action method: clobber 05:19:51 INFO - rmtree: /builds/slave/test/build 05:19:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:19:51 INFO - Running post-action listener: _resource_record_post_action 05:19:51 INFO - ##### 05:19:51 INFO - ##### Running read-buildbot-config step. 05:19:51 INFO - ##### 05:19:51 INFO - Running pre-action listener: _resource_record_pre_action 05:19:51 INFO - Running main action method: read_buildbot_config 05:19:51 INFO - Using buildbot properties: 05:19:51 INFO - { 05:19:51 INFO - "properties": { 05:19:51 INFO - "buildnumber": 2219, 05:19:51 INFO - "product": "firefox", 05:19:51 INFO - "script_repo_revision": "production", 05:19:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:19:51 INFO - "repository": "", 05:19:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:19:51 INFO - "buildid": "20151216045007", 05:19:51 INFO - "slavename": "talos-linux64-ix-029", 05:19:51 INFO - "pgo_build": "False", 05:19:51 INFO - "basedir": "/builds/slave/test", 05:19:51 INFO - "project": "", 05:19:51 INFO - "platform": "ubuntu64_hw", 05:19:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:19:51 INFO - "slavebuilddir": "test", 05:19:51 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:19:51 INFO - "branch": "fx-team", 05:19:51 INFO - "repo_path": "integration/fx-team", 05:19:51 INFO - "stage_platform": "linux64", 05:19:51 INFO - "builduid": "2cde2e0c6f5948a788a3a975977b2a4a", 05:19:51 INFO - "revision": "48a56019f52049bbf9ccede95d15a2cb3b5295bc" 05:19:51 INFO - }, 05:19:51 INFO - "sourcestamp": { 05:19:51 INFO - "repository": "", 05:19:51 INFO - "hasPatch": false, 05:19:51 INFO - "project": "", 05:19:51 INFO - "branch": "fx-team-linux64-talos", 05:19:51 INFO - "changes": [ 05:19:51 INFO - { 05:19:51 INFO - "category": null, 05:19:51 INFO - "files": [ 05:19:51 INFO - { 05:19:51 INFO - "url": null, 05:19:51 INFO - "name": "https://queue.taskcluster.net/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 05:19:51 INFO - } 05:19:51 INFO - ], 05:19:51 INFO - "repository": "", 05:19:51 INFO - "rev": "48a56019f52049bbf9ccede95d15a2cb3b5295bc", 05:19:51 INFO - "who": "s.kaspari@gmail.com", 05:19:51 INFO - "when": 1450271213, 05:19:51 INFO - "number": 7366024, 05:19:51 INFO - "comments": "Bug 1222377 - Add option to enable blocking content in restricted profiles. r=margaret\n\n(Feature only enabled in Nightly until we deployed an actual block list)", 05:19:51 INFO - "project": "", 05:19:51 INFO - "at": "Wed 16 Dec 2015 05:06:53", 05:19:51 INFO - "branch": "fx-team-linux64-talos", 05:19:51 INFO - "revlink": "", 05:19:51 INFO - "properties": [ 05:19:51 INFO - [ 05:19:51 INFO - "buildid", 05:19:51 INFO - "20151216045007", 05:19:51 INFO - "Change" 05:19:51 INFO - ], 05:19:51 INFO - [ 05:19:51 INFO - "builduid", 05:19:51 INFO - "2cde2e0c6f5948a788a3a975977b2a4a", 05:19:51 INFO - "Change" 05:19:51 INFO - ], 05:19:51 INFO - [ 05:19:51 INFO - "pgo_build", 05:19:51 INFO - "False", 05:19:51 INFO - "Change" 05:19:51 INFO - ] 05:19:51 INFO - ], 05:19:51 INFO - "revision": "48a56019f52049bbf9ccede95d15a2cb3b5295bc" 05:19:51 INFO - } 05:19:51 INFO - ], 05:19:51 INFO - "revision": "48a56019f52049bbf9ccede95d15a2cb3b5295bc" 05:19:51 INFO - } 05:19:51 INFO - } 05:19:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:19:51 INFO - Running post-action listener: _resource_record_post_action 05:19:51 INFO - ##### 05:19:51 INFO - ##### Running download-and-extract step. 05:19:51 INFO - ##### 05:19:51 INFO - Running pre-action listener: _resource_record_pre_action 05:19:51 INFO - Running main action method: download_and_extract 05:19:51 INFO - mkdir: /builds/slave/test/build/tests 05:19: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')]} 05:19:51 INFO - https://queue.taskcluster.net/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:19:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/test_packages.json 05:19:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/test_packages.json 05:19:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:19:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:19:52 INFO - Downloaded 1302 bytes. 05:19:52 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:19:52 INFO - Using the following test package requirements: 05:19:52 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:19:52 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:19:52 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:52 INFO - u'jsshell-linux-x86_64.zip'], 05:19:52 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:19:52 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:19:52 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:19:52 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:19:52 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:19:52 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:19:52 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:19:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:19:52 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:52 INFO - https://queue.taskcluster.net/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:19:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:19:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:19:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:19:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:19:53 INFO - Downloaded 21869445 bytes. 05:19:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 05:19:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:19:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:19:54 INFO - Return code: 0 05:19:54 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:19:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:54 INFO - https://queue.taskcluster.net/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:19:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:19:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:19:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:19:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:19:55 INFO - Downloaded 21869445 bytes. 05:19:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 05:19:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:19:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:19:56 INFO - Return code: 0 05:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:56 INFO - https://queue.taskcluster.net/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:19:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:19:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:19:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:19:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:19:57 INFO - Downloaded 11132052 bytes. 05:19:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 05:19:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:19:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:19:57 INFO - Return code: 0 05:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:57 INFO - https://queue.taskcluster.net/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:19:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:19:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:19:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:19:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:19:59 INFO - Downloaded 57745992 bytes. 05:19:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:19:59 INFO - mkdir: /builds/slave/test/properties 05:19:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:19:59 INFO - Writing to file /builds/slave/test/properties/build_url 05:19:59 INFO - Contents: 05:19:59 INFO - build_url:https://queue.taskcluster.net/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:19:59 INFO - Running post-action listener: _resource_record_post_action 05:19:59 INFO - Running post-action listener: set_extra_try_arguments 05:19:59 INFO - ##### 05:19:59 INFO - ##### Running populate-webroot step. 05:19:59 INFO - ##### 05:19:59 INFO - Running pre-action listener: _resource_record_pre_action 05:19:59 INFO - Running main action method: populate_webroot 05:19:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:19:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:19:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:19:59 INFO - '--tppagecycles', 05:19:59 INFO - '7'], 05:19:59 INFO - 'tests': ['tsvgm']}}, 05:19:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:19:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:19:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:19:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:19:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:19:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:19:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:19:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:59 INFO - 'talos_options': ['--e10s'], 05:19:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:19:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:59 INFO - 'tests': ['damp', 'tps']}, 05:19:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:59 INFO - 'talos_options': ['--e10s'], 05:19:59 INFO - 'tests': ['damp', 'tps']}, 05:19:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:19:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:19:59 INFO - 'other': {'tests': ['a11yr', 05:19:59 INFO - 'ts_paint', 05:19:59 INFO - 'tpaint', 05:19:59 INFO - 'sessionrestore', 05:19:59 INFO - 'sessionrestore_no_auto_restore']}, 05:19:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:19:59 INFO - 'tests': ['a11yr', 05:19:59 INFO - 'ts_paint', 05:19:59 INFO - 'tpaint', 05:19:59 INFO - 'sessionrestore', 05:19:59 INFO - 'sessionrestore_no_auto_restore']}, 05:19:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:19:59 INFO - 'tests': ['a11yr', 05:19:59 INFO - 'ts_paint', 05:19:59 INFO - 'tpaint', 05:19:59 INFO - 'sessionrestore', 05:19:59 INFO - 'sessionrestore_no_auto_restore']}, 05:19:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:19:59 INFO - 'tests': ['a11yr', 05:19:59 INFO - 'ts_paint', 05:19:59 INFO - 'tpaint', 05:19:59 INFO - 'sessionrestore', 05:19:59 INFO - 'sessionrestore_no_auto_restore']}, 05:19:59 INFO - 'other_l64': {'tests': ['a11yr', 05:19:59 INFO - 'ts_paint', 05:19:59 INFO - 'tpaint', 05:19:59 INFO - 'sessionrestore', 05:19:59 INFO - 'sessionrestore_no_auto_restore']}, 05:19:59 INFO - 'other_nol64': {'tests': ['a11yr', 05:19:59 INFO - 'ts_paint', 05:19:59 INFO - 'tpaint', 05:19:59 INFO - 'sessionrestore', 05:19:59 INFO - 'sessionrestore_no_auto_restore']}, 05:19:59 INFO - 'svgr': {'tests': ['tsvgx', 05:19:59 INFO - 'tsvgr_opacity', 05:19:59 INFO - 'tart', 05:19:59 INFO - 'tscrollx', 05:19:59 INFO - 'cart']}, 05:19:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:19:59 INFO - 'tests': ['tsvgx', 05:19:59 INFO - 'tsvgr_opacity', 05:19:59 INFO - 'tart', 05:19:59 INFO - 'tscrollx', 05:19:59 INFO - 'cart']}, 05:19:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:59 INFO - 'tests': ['tp5o']}, 05:19:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:59 INFO - 'talos_options': ['--e10s'], 05:19:59 INFO - 'tests': ['tp5o']}, 05:19:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:59 INFO - 'talos_options': ['--xperf_path', 05:19:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:19:59 INFO - 'tests': ['tp5n']}, 05:19:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:19:59 INFO - 'talos_options': ['--e10s', 05:19:59 INFO - '--xperf_path', 05:19:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:19:59 INFO - 'tests': ['tp5n']}}, 05:19:59 INFO - 'talos.zip': {'path': '', 05:19:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:19:59 INFO - Running post-action listener: _resource_record_post_action 05:19:59 INFO - ##### 05:19:59 INFO - ##### Running create-virtualenv step. 05:19:59 INFO - ##### 05:19:59 INFO - Running pre-action listener: _resource_record_pre_action 05:19:59 INFO - Running main action method: create_virtualenv 05:19:59 INFO - Creating virtualenv /builds/slave/test/build/venv 05:19:59 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 05:19:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:19:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:19:59 INFO - Using real prefix '/usr' 05:19:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:19:59 INFO - Installing distribute.............................................................................................................................................................................................done. 05:20:01 INFO - Installing pip.................done. 05:20:01 INFO - Return code: 0 05:20:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1c761cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e0b0>, '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 0x1c0efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f440>, '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': '1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451', '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 05:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:20:01 INFO - Using env: {'DISPLAY': ':0', 05:20:01 INFO - 'HOME': '/home/cltbld', 05:20:01 INFO - 'LANG': 'en_US.UTF-8', 05:20:01 INFO - 'LANGUAGE': 'en_US:en', 05:20:01 INFO - 'LOGNAME': 'cltbld', 05:20:01 INFO - 'MAIL': '/var/mail/cltbld', 05:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:01 INFO - 'MOZ_NO_REMOTE': '1', 05:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:01 INFO - 'NO_EM_RESTART': '1', 05:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:01 INFO - 'PWD': '/builds/slave/test', 05:20:01 INFO - 'SHELL': '/bin/bash', 05:20:01 INFO - 'SHLVL': '1', 05:20:01 INFO - 'TERM': 'linux', 05:20:01 INFO - 'TMOUT': '86400', 05:20:01 INFO - 'USER': 'cltbld', 05:20:01 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451', 05:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:01 INFO - '_': '/tools/buildbot/bin/python'} 05:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:01 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 05:20:01 INFO - Cleaning up... 05:20:01 INFO - Return code: 0 05:20:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1c761cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e0b0>, '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 0x1c0efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f440>, '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': '1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451', '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 05:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:20:01 INFO - Using env: {'DISPLAY': ':0', 05:20:01 INFO - 'HOME': '/home/cltbld', 05:20:01 INFO - 'LANG': 'en_US.UTF-8', 05:20:01 INFO - 'LANGUAGE': 'en_US:en', 05:20:01 INFO - 'LOGNAME': 'cltbld', 05:20:01 INFO - 'MAIL': '/var/mail/cltbld', 05:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:01 INFO - 'MOZ_NO_REMOTE': '1', 05:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:01 INFO - 'NO_EM_RESTART': '1', 05:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:01 INFO - 'PWD': '/builds/slave/test', 05:20:01 INFO - 'SHELL': '/bin/bash', 05:20:01 INFO - 'SHLVL': '1', 05:20:01 INFO - 'TERM': 'linux', 05:20:01 INFO - 'TMOUT': '86400', 05:20:01 INFO - 'USER': 'cltbld', 05:20:01 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451', 05:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:01 INFO - '_': '/tools/buildbot/bin/python'} 05:20:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:02 INFO - Downloading/unpacking psutil>=0.7.1 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20:03 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:20:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:20:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:20:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:20:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:20:03 INFO - Installing collected packages: psutil 05:20:03 INFO - Running setup.py install for psutil 05:20:03 INFO - building 'psutil._psutil_linux' extension 05:20:04 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 05:20:04 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 05:20:04 INFO - building 'psutil._psutil_posix' extension 05:20:04 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 05:20:04 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 05:20:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:20:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:20:04 INFO - Successfully installed psutil 05:20:04 INFO - Cleaning up... 05:20:04 INFO - Return code: 0 05:20:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:04 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 0x7f1c761cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e0b0>, '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 0x1c0efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f440>, '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': '1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451', '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 05:20:04 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 05:20:04 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 05:20:04 INFO - Using env: {'DISPLAY': ':0', 05:20:04 INFO - 'HOME': '/home/cltbld', 05:20:04 INFO - 'LANG': 'en_US.UTF-8', 05:20:04 INFO - 'LANGUAGE': 'en_US:en', 05:20:04 INFO - 'LOGNAME': 'cltbld', 05:20:04 INFO - 'MAIL': '/var/mail/cltbld', 05:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:04 INFO - 'MOZ_NO_REMOTE': '1', 05:20:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:04 INFO - 'NO_EM_RESTART': '1', 05:20:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:04 INFO - 'PWD': '/builds/slave/test', 05:20:04 INFO - 'SHELL': '/bin/bash', 05:20:04 INFO - 'SHLVL': '1', 05:20:04 INFO - 'TERM': 'linux', 05:20:04 INFO - 'TMOUT': '86400', 05:20:04 INFO - 'USER': 'cltbld', 05:20:04 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451', 05:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:04 INFO - '_': '/tools/buildbot/bin/python'} 05:20:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:20:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:20:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:20:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:20:06 INFO - Installing collected packages: mozsystemmonitor 05:20:06 INFO - Running setup.py install for mozsystemmonitor 05:20:06 INFO - Successfully installed mozsystemmonitor 05:20:06 INFO - Cleaning up... 05:20:06 INFO - Return code: 0 05:20:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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', '--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 0x7f1c761cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e0b0>, '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 0x1c0efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f440>, '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': '1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451', '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 05:20:06 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 05:20:06 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 05:20:06 INFO - Using env: {'DISPLAY': ':0', 05:20:06 INFO - 'HOME': '/home/cltbld', 05:20:06 INFO - 'LANG': 'en_US.UTF-8', 05:20:06 INFO - 'LANGUAGE': 'en_US:en', 05:20:06 INFO - 'LOGNAME': 'cltbld', 05:20:06 INFO - 'MAIL': '/var/mail/cltbld', 05:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:06 INFO - 'MOZ_NO_REMOTE': '1', 05:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:06 INFO - 'NO_EM_RESTART': '1', 05:20:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:06 INFO - 'PWD': '/builds/slave/test', 05:20:06 INFO - 'SHELL': '/bin/bash', 05:20:06 INFO - 'SHLVL': '1', 05:20:06 INFO - 'TERM': 'linux', 05:20:06 INFO - 'TMOUT': '86400', 05:20:06 INFO - 'USER': 'cltbld', 05:20:06 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451', 05:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:06 INFO - '_': '/tools/buildbot/bin/python'} 05:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:06 INFO - Downloading/unpacking blobuploader==1.2.4 05:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:08 INFO - Downloading blobuploader-1.2.4.tar.gz 05:20:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:20:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:20:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:20:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:20:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:09 INFO - Downloading docopt-0.6.1.tar.gz 05:20:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:20:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:20:09 INFO - Installing collected packages: blobuploader, requests, docopt 05:20:09 INFO - Running setup.py install for blobuploader 05:20:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:20:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:20:09 INFO - Running setup.py install for requests 05:20:09 INFO - Running setup.py install for docopt 05:20:09 INFO - Successfully installed blobuploader requests docopt 05:20:09 INFO - Cleaning up... 05:20:09 INFO - Return code: 0 05:20:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:09 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')]} 05:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:09 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')]} 05:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:09 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 0x7f1c761cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e0b0>, '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 0x1c0efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f440>, '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': '1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451', '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 05:20:09 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 05:20:09 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 05:20:09 INFO - Using env: {'DISPLAY': ':0', 05:20:09 INFO - 'HOME': '/home/cltbld', 05:20:09 INFO - 'LANG': 'en_US.UTF-8', 05:20:09 INFO - 'LANGUAGE': 'en_US:en', 05:20:09 INFO - 'LOGNAME': 'cltbld', 05:20:09 INFO - 'MAIL': '/var/mail/cltbld', 05:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:09 INFO - 'MOZ_NO_REMOTE': '1', 05:20:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:09 INFO - 'NO_EM_RESTART': '1', 05:20:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:09 INFO - 'PWD': '/builds/slave/test', 05:20:09 INFO - 'SHELL': '/bin/bash', 05:20:09 INFO - 'SHLVL': '1', 05:20:09 INFO - 'TERM': 'linux', 05:20:09 INFO - 'TMOUT': '86400', 05:20:09 INFO - 'USER': 'cltbld', 05:20:09 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451', 05:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:09 INFO - '_': '/tools/buildbot/bin/python'} 05:20:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:10 INFO - Running setup.py (path:/tmp/pip-2ppyeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:10 INFO - Running setup.py (path:/tmp/pip-koN_E4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:10 INFO - Running setup.py (path:/tmp/pip-4aXbR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:10 INFO - Running setup.py (path:/tmp/pip-s5pKEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:10 INFO - Running setup.py (path:/tmp/pip-_ntSyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:10 INFO - Running setup.py (path:/tmp/pip-_CIFOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:10 INFO - Running setup.py (path:/tmp/pip-pSvdyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:10 INFO - Running setup.py (path:/tmp/pip-HqwO4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:10 INFO - Running setup.py (path:/tmp/pip-pjpmdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:10 INFO - Running setup.py (path:/tmp/pip-4ZRk9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:10 INFO - Running setup.py (path:/tmp/pip-c3bp6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:10 INFO - Running setup.py (path:/tmp/pip-zIhr0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:10 INFO - Running setup.py (path:/tmp/pip-g_CNEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:10 INFO - Running setup.py (path:/tmp/pip-zOj7SX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:11 INFO - Running setup.py (path:/tmp/pip-UVzClR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:11 INFO - Running setup.py (path:/tmp/pip-Q3dPh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:11 INFO - Running setup.py (path:/tmp/pip-ikp6ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:20:11 INFO - Running setup.py install for manifestparser 05:20:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:20:11 INFO - Running setup.py install for mozcrash 05:20:11 INFO - Running setup.py install for mozdebug 05:20:11 INFO - Running setup.py install for mozdevice 05:20:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:20:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:20:11 INFO - Running setup.py install for mozfile 05:20:11 INFO - Running setup.py install for mozhttpd 05:20:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:20:11 INFO - Running setup.py install for mozinfo 05:20:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:20:11 INFO - Running setup.py install for mozInstall 05:20:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:20:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:20:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:20:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:20:12 INFO - Running setup.py install for mozleak 05:20:12 INFO - Running setup.py install for mozlog 05:20:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:20:12 INFO - Running setup.py install for moznetwork 05:20:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:20:12 INFO - Running setup.py install for mozprocess 05:20:12 INFO - Running setup.py install for mozprofile 05:20:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:20:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:20:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:20:12 INFO - Running setup.py install for mozrunner 05:20:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:20:12 INFO - Running setup.py install for mozscreenshot 05:20:12 INFO - Running setup.py install for moztest 05:20:12 INFO - Running setup.py install for mozversion 05:20:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:20:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:20:12 INFO - Cleaning up... 05:20:12 INFO - Return code: 0 05:20:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:13 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 0x7f1c761cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e0b0>, '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 0x1c0efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f440>, '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': '1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451', '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 05:20:13 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 05:20:13 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 05:20:13 INFO - Using env: {'DISPLAY': ':0', 05:20:13 INFO - 'HOME': '/home/cltbld', 05:20:13 INFO - 'LANG': 'en_US.UTF-8', 05:20:13 INFO - 'LANGUAGE': 'en_US:en', 05:20:13 INFO - 'LOGNAME': 'cltbld', 05:20:13 INFO - 'MAIL': '/var/mail/cltbld', 05:20:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:13 INFO - 'MOZ_NO_REMOTE': '1', 05:20:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:13 INFO - 'NO_EM_RESTART': '1', 05:20:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:13 INFO - 'PWD': '/builds/slave/test', 05:20:13 INFO - 'SHELL': '/bin/bash', 05:20:13 INFO - 'SHLVL': '1', 05:20:13 INFO - 'TERM': 'linux', 05:20:13 INFO - 'TMOUT': '86400', 05:20:13 INFO - 'USER': 'cltbld', 05:20:13 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451', 05:20:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:13 INFO - '_': '/tools/buildbot/bin/python'} 05:20:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:13 INFO - Running setup.py (path:/tmp/pip-LoRqE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:13 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)) 05:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:13 INFO - Running setup.py (path:/tmp/pip-CtMwTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:13 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)) 05:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:13 INFO - Running setup.py (path:/tmp/pip-1Gk6zU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:13 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)) 05:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:13 INFO - Running setup.py (path:/tmp/pip-c3v_6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:13 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)) 05:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:13 INFO - Running setup.py (path:/tmp/pip-Va91v7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:13 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)) 05:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:13 INFO - Running setup.py (path:/tmp/pip-urceYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:13 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)) 05:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:13 INFO - Running setup.py (path:/tmp/pip-bNOQuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:13 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)) 05:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:13 INFO - Running setup.py (path:/tmp/pip-9gdqJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:13 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)) 05:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:13 INFO - Running setup.py (path:/tmp/pip-uq59Sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:13 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)) 05:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:13 INFO - Running setup.py (path:/tmp/pip-M_lu35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:13 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)) 05:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:13 INFO - Running setup.py (path:/tmp/pip-g5Kl5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:14 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)) 05:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:14 INFO - Running setup.py (path:/tmp/pip-K3JcwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:14 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)) 05:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:14 INFO - Running setup.py (path:/tmp/pip-zx2syN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:14 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)) 05:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:14 INFO - Running setup.py (path:/tmp/pip-kGu4j_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:14 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)) 05:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:14 INFO - Running setup.py (path:/tmp/pip-wiR49r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:14 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)) 05:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:14 INFO - Running setup.py (path:/tmp/pip-qa7Fni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:14 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)) 05:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:14 INFO - Running setup.py (path:/tmp/pip-BcVwTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:14 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)) 05:20:14 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)) 05:20:14 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)) 05:20:14 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)) 05:20:14 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)) 05:20:14 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)) 05:20:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20: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 05:20:16 INFO - Downloading blessings-1.5.1.tar.gz 05:20:16 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 05:20:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:20:16 INFO - Installing collected packages: blessings 05:20:16 INFO - Running setup.py install for blessings 05:20:16 INFO - Successfully installed blessings 05:20:16 INFO - Cleaning up... 05:20:16 INFO - Return code: 0 05:20:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:20:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:16 INFO - Reading from file tmpfile_stdout 05:20:16 INFO - Current package versions: 05:20:16 INFO - argparse == 1.2.1 05:20:16 INFO - blessings == 1.5.1 05:20:16 INFO - blobuploader == 1.2.4 05:20:16 INFO - docopt == 0.6.1 05:20:16 INFO - manifestparser == 1.1 05:20:16 INFO - mozInstall == 1.12 05:20:16 INFO - mozcrash == 0.16 05:20:16 INFO - mozdebug == 0.1 05:20:16 INFO - mozdevice == 0.47 05:20:16 INFO - mozfile == 1.2 05:20:16 INFO - mozhttpd == 0.7 05:20:16 INFO - mozinfo == 0.9 05:20:16 INFO - mozleak == 0.1 05:20:16 INFO - mozlog == 3.1 05:20:16 INFO - moznetwork == 0.27 05:20:16 INFO - mozprocess == 0.22 05:20:16 INFO - mozprofile == 0.27 05:20:16 INFO - mozrunner == 6.11 05:20:16 INFO - mozscreenshot == 0.1 05:20:16 INFO - mozsystemmonitor == 0.0 05:20:16 INFO - moztest == 0.7 05:20:16 INFO - mozversion == 1.4 05:20:16 INFO - psutil == 3.1.1 05:20:16 INFO - requests == 1.2.3 05:20:16 INFO - wsgiref == 0.1.2 05:20:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:16 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')]} 05:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:16 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')]} 05:20:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:16 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 0x7f1c761cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e0b0>, '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 0x1c0efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f440>, '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': '1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451', '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 05:20:16 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 05:20:16 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 05:20:16 INFO - Using env: {'DISPLAY': ':0', 05:20:16 INFO - 'HOME': '/home/cltbld', 05:20:16 INFO - 'LANG': 'en_US.UTF-8', 05:20:16 INFO - 'LANGUAGE': 'en_US:en', 05:20:16 INFO - 'LOGNAME': 'cltbld', 05:20:16 INFO - 'MAIL': '/var/mail/cltbld', 05:20:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:16 INFO - 'MOZ_NO_REMOTE': '1', 05:20:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:16 INFO - 'NO_EM_RESTART': '1', 05:20:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:16 INFO - 'PWD': '/builds/slave/test', 05:20:16 INFO - 'SHELL': '/bin/bash', 05:20:16 INFO - 'SHLVL': '1', 05:20:16 INFO - 'TERM': 'linux', 05:20:16 INFO - 'TMOUT': '86400', 05:20:16 INFO - 'USER': 'cltbld', 05:20:16 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451', 05:20:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:16 INFO - '_': '/tools/buildbot/bin/python'} 05:20:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:16 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)) 05:20:16 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)) 05:20:16 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)) 05:20:16 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)) 05:20:16 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)) 05:20:16 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)) 05:20:16 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)) 05:20:16 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)) 05:20:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:20:16 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)) 05:20:16 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)) 05:20:16 INFO - Cleaning up... 05:20:16 INFO - Return code: 0 05:20:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:20:16 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')]} 05:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:16 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')]} 05:20:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:16 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 0x7f1c761cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e0b0>, '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 0x1c0efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f440>, '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': '1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451', '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 05:20:16 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 05:20:16 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 05:20:16 INFO - Using env: {'DISPLAY': ':0', 05:20:16 INFO - 'HOME': '/home/cltbld', 05:20:16 INFO - 'LANG': 'en_US.UTF-8', 05:20:16 INFO - 'LANGUAGE': 'en_US:en', 05:20:16 INFO - 'LOGNAME': 'cltbld', 05:20:16 INFO - 'MAIL': '/var/mail/cltbld', 05:20:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:16 INFO - 'MOZ_NO_REMOTE': '1', 05:20:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:16 INFO - 'NO_EM_RESTART': '1', 05:20:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:16 INFO - 'PWD': '/builds/slave/test', 05:20:16 INFO - 'SHELL': '/bin/bash', 05:20:16 INFO - 'SHLVL': '1', 05:20:16 INFO - 'TERM': 'linux', 05:20:16 INFO - 'TMOUT': '86400', 05:20:16 INFO - 'USER': 'cltbld', 05:20:16 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451', 05:20:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:16 INFO - '_': '/tools/buildbot/bin/python'} 05:20:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:16 INFO - Downloading/unpacking jsonschema 05:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:20:18 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 05:20:18 INFO - Downloading/unpacking functools32 (from jsonschema) 05:20:18 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 05:20:18 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 05:20:18 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 05:20:18 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 05:20:18 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 05:20:18 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 05:20:18 INFO - Downloading functools32-3.2.3-2.tar.gz 05:20:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:20:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:20:18 INFO - warning: no files found matching '*.txt' 05:20:18 INFO - no previously-included directories found matching 'build' 05:20:18 INFO - no previously-included directories found matching 'dist' 05:20:18 INFO - no previously-included directories found matching '.git*' 05:20:18 INFO - Installing collected packages: jsonschema, functools32 05:20:18 INFO - Running setup.py install for functools32 05:20:19 INFO - warning: no files found matching '*.txt' 05:20:19 INFO - no previously-included directories found matching 'build' 05:20:19 INFO - no previously-included directories found matching 'dist' 05:20:19 INFO - no previously-included directories found matching '.git*' 05:20:19 INFO - Successfully installed jsonschema functools32 05:20:19 INFO - Cleaning up... 05:20:19 INFO - Return code: 0 05:20:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:20:19 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')]} 05:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:19 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')]} 05:20:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:19 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 0x7f1c761cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ab18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0e0b0>, '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 0x1c0efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f440>, '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': '1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451', '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 05:20:19 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 05:20:19 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 05:20:19 INFO - Using env: {'DISPLAY': ':0', 05:20:19 INFO - 'HOME': '/home/cltbld', 05:20:19 INFO - 'LANG': 'en_US.UTF-8', 05:20:19 INFO - 'LANGUAGE': 'en_US:en', 05:20:19 INFO - 'LOGNAME': 'cltbld', 05:20:19 INFO - 'MAIL': '/var/mail/cltbld', 05:20:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:19 INFO - 'MOZ_NO_REMOTE': '1', 05:20:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:19 INFO - 'NO_EM_RESTART': '1', 05:20:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:19 INFO - 'PWD': '/builds/slave/test', 05:20:19 INFO - 'SHELL': '/bin/bash', 05:20:19 INFO - 'SHLVL': '1', 05:20:19 INFO - 'TERM': 'linux', 05:20:19 INFO - 'TMOUT': '86400', 05:20:19 INFO - 'USER': 'cltbld', 05:20:19 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451', 05:20:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:19 INFO - '_': '/tools/buildbot/bin/python'} 05:20:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:19 INFO - Downloading/unpacking flake8 05:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:20:21 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 05:20:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:20:21 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 05:20:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:21 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 05:20:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:20:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:20:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:20:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:20:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:20:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:20:21 INFO - no previously-included directories found matching 'docs/_build' 05:20:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:20:21 INFO - Running setup.py install for pep8 05:20:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:20:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:20:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:20:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:20:21 INFO - no previously-included directories found matching 'docs/_build' 05:20:21 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:20:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:20:21 INFO - Cleaning up... 05:20:21 INFO - Return code: 0 05:20:21 INFO - Running post-action listener: _resource_record_post_action 05:20:21 INFO - Running post-action listener: _start_resource_monitoring 05:20:21 INFO - Starting resource monitoring. 05:20:21 INFO - ##### 05:20:21 INFO - ##### Running install step. 05:20:21 INFO - ##### 05:20:21 INFO - Running pre-action listener: _resource_record_pre_action 05:20:21 INFO - Running main action method: install 05:20:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:22 INFO - Reading from file tmpfile_stdout 05:20:22 INFO - Detecting whether we're running mozinstall >=1.0... 05:20:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:20:22 INFO - Reading from file tmpfile_stdout 05:20:22 INFO - Output received: 05:20:22 INFO - Usage: mozinstall [options] installer 05:20:22 INFO - Options: 05:20:22 INFO - -h, --help show this help message and exit 05:20:22 INFO - -d DEST, --destination=DEST 05:20:22 INFO - Directory to install application into. [default: 05:20:22 INFO - "/builds/slave/test"] 05:20:22 INFO - --app=APP Application being installed. [default: firefox] 05:20:22 INFO - mkdir: /builds/slave/test/build/application 05:20:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:20:36 INFO - Reading from file tmpfile_stdout 05:20:36 INFO - Output received: 05:20:36 INFO - /builds/slave/test/build/application/firefox/firefox 05:20:36 INFO - Running post-action listener: _resource_record_post_action 05:20:36 INFO - ##### 05:20:36 INFO - ##### Running run-tests step. 05:20:36 INFO - ##### 05:20:36 INFO - Running pre-action listener: _resource_record_pre_action 05:20:36 INFO - Running main action method: run_tests 05:20:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:20:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:20:36 INFO - Python 2.7.3 05:20:36 INFO - Return code: 0 05:20:36 INFO - grabbing minidump binary from tooltool 05:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:36 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 0x1c0e0b0>, '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 0x1c0efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c0f440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:20:36 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 05:20:36 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 05:20:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:20:36 INFO - Return code: 0 05:20:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:20:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:20:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:20:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:20:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:20:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:20:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:20:37 INFO - Return code: 0 05:20:37 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/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost'] in /builds/slave/test/build 05:20:37 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/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost 05:20:37 INFO - Using env: {'DISPLAY': ':0', 05:20:37 INFO - 'HOME': '/home/cltbld', 05:20:37 INFO - 'LANG': 'en_US.UTF-8', 05:20:37 INFO - 'LANGUAGE': 'en_US:en', 05:20:37 INFO - 'LOGNAME': 'cltbld', 05:20:37 INFO - 'MAIL': '/var/mail/cltbld', 05:20:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:20:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:37 INFO - 'MOZ_NO_REMOTE': '1', 05:20:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:37 INFO - 'NO_EM_RESTART': '1', 05:20:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:37 INFO - 'PWD': '/builds/slave/test', 05:20:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:20:37 INFO - 'SHELL': '/bin/bash', 05:20:37 INFO - 'SHLVL': '1', 05:20:37 INFO - 'TERM': 'linux', 05:20:37 INFO - 'TMOUT': '86400', 05:20:37 INFO - 'USER': 'cltbld', 05:20:37 INFO - 'XDG_SESSION_COOKIE': '1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451', 05:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:37 INFO - '_': '/tools/buildbot/bin/python'} 05:20:37 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/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost'] with output_timeout 3600 05:20:37 INFO - mozversion INFO | application_buildid: 20151216045007 05:20:37 INFO - mozversion INFO | application_changeset: 48a56019f52049bbf9ccede95d15a2cb3b5295bc 05:20:37 INFO - mozversion INFO | application_display_name: Nightly 05:20:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:20:37 INFO - mozversion INFO | application_name: Firefox 05:20:37 INFO - mozversion INFO | application_remotingname: firefox 05:20:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 05:20:37 INFO - mozversion INFO | application_vendor: Mozilla 05:20:37 INFO - mozversion INFO | application_version: 46.0a1 05:20:37 INFO - mozversion INFO | platform_buildid: 20151216045007 05:20:37 INFO - mozversion INFO | platform_changeset: 48a56019f52049bbf9ccede95d15a2cb3b5295bc 05:20:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 05:20:37 INFO - mozversion INFO | platform_version: 46.0a1 05:20:37 INFO - 2015-12-16 05:20:37,963 DEBUG : using testdate: 1450272037 05:20:37 INFO - 2015-12-16 05:20:37,963 DEBUG : actual date: 1450272037 05:20:37 INFO - 2015-12-16 05:20:37,973 INFO : starting webserver on 'localhost:41288' 05:20:37 INFO - 2015-12-16 05:20:37,973 INFO : Starting test suite talos-linux64-ix-029 05:20:37 INFO - 2015-12-16 05:20:37,974 INFO : Starting test dromaeo_css 05:20:37 INFO - 2015-12-16 05:20:37,974 DEBUG : operating with platform_type : linux_ 05:20:37 INFO - 2015-12-16 05:20:37,974 INFO : Initialising browser for dromaeo_css test... 05:20:37 INFO - 2015-12-16 05:20:37,991 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Oz8hm/profile http://localhost:41288/getInfo.html 05:20:42 INFO - 2015-12-16 05:20:42,730 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:20:42 INFO - 2015-12-16 05:20:42,730 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:20:42 INFO - 2015-12-16 05:20:42,730 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:20:42 INFO - 2015-12-16 05:20:42,730 DEBUG : BROWSER_OUTPUT: __metrics 05:20:42 INFO - 2015-12-16 05:20:42,839 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] 05:20:42 INFO - 2015-12-16 05:20:42,919 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] 05:20:42 ERROR - 2015-12-16 05:20:42,935 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 05:20:43 INFO - 2015-12-16 05:20:43,996 INFO : Browser initialized. 05:20:43 INFO - 2015-12-16 05:20:43,996 INFO : Running cycle 1/1 for dromaeo_css test... 05:20:43 INFO - 2015-12-16 05:20:43,996 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Oz8hm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:20:56 INFO - 2015-12-16 05:20:56,121 DEBUG : BROWSER_OUTPUT: RSS: Main: 142540800 05:20:56 INFO - 2015-12-16 05:20:56,121 DEBUG : BROWSER_OUTPUT: 05:21:47 INFO - 2015-12-16 05:21:47,319 DEBUG : BROWSER_OUTPUT: 1450272107312 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] 05:23:59 INFO - 2015-12-16 05:23:59,431 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41288/tests/dromaeo/cssquery-ext.html) 05:24:00 INFO - 2015-12-16 05:24:00,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 259665920 05:24:00 INFO - 2015-12-16 05:24:00,575 DEBUG : BROWSER_OUTPUT: 05:27:03 INFO - 2015-12-16 05:27:03,159 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/dromaeo/cssquery-ext.html (next: http://localhost:41288/tests/dromaeo/cssquery-jquery.html) 05:27:03 INFO - 2015-12-16 05:27:03,745 DEBUG : BROWSER_OUTPUT: RSS: Main: 220946432 05:27:03 INFO - 2015-12-16 05:27:03,745 DEBUG : BROWSER_OUTPUT: 05:30:05 INFO - 2015-12-16 05:30:05,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41288/tests/dromaeo/cssquery-mootools.html) 05:30:06 INFO - 2015-12-16 05:30:06,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 216412160 05:30:06 INFO - 2015-12-16 05:30:06,442 DEBUG : BROWSER_OUTPUT: 05:33:08 INFO - 2015-12-16 05:33:08,410 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41288/tests/dromaeo/cssquery-prototype.html) 05:33:09 INFO - 2015-12-16 05:33:09,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 207859712 05:33:09 INFO - 2015-12-16 05:33:09,004 DEBUG : BROWSER_OUTPUT: 05:36:11 INFO - 2015-12-16 05:36:11,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41288/tests/dromaeo/cssquery-yui.html) 05:36:12 INFO - 2015-12-16 05:36:12,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 209248256 05:36:12 INFO - 2015-12-16 05:36:12,307 DEBUG : BROWSER_OUTPUT: 05:39:14 INFO - 2015-12-16 05:39:14,840 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/dromaeo/cssquery-yui.html (next: http://localhost:41288/tests/dromaeo/cssquery-dojo.html) 05:39:15 INFO - 2015-12-16 05:39:15,099 DEBUG : BROWSER_OUTPUT: RSS: Main: 295190528 05:39:15 INFO - 2015-12-16 05:39:15,099 DEBUG : BROWSER_OUTPUT: 05:39:15 INFO - 2015-12-16 05:39:15,100 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:39:15 INFO - 2015-12-16 05:39:15,100 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:39:15 INFO - 2015-12-16 05:39:15,100 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:39:15 INFO - 2015-12-16 05:39:15,100 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:39:15 INFO - 2015-12-16 05:39:15,101 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2636.9077082302124;2720.034387792335;2727.563589825627;2736.7536921677033;2755.2285360099168;4537.387452693885;4674.485806561275;4704.247320428732;4757.119932812428;4787.281907713845;4633.976830115853;4669.743164125972;4736.834210802623;4751.477337492873;4814.951850481494;4351.303791393378;4357.629601483878;4383.517813040563;4409.11817636474;4431.26884064129;4167.74993500391;4427.977860110695;4444.466664000324;4482.394876691654;4497.14554234696;4260.7656578888145;4325.8485952991805;4339.696221264513;4355.412019377391;4369.322754972953;4335.934960975588;4372.5627437256335;4393.209222339978;4398.890027749332;4444.933326000112;4210.221109094828;4301.978490107561;4338.848140315105;4373.737575745466;4430.778461076966;4560.726356418625;4643.582077613031;4765.285207218945;4780.880477988043;4793.544613261734;5083.135866902636;5154.613403994716;5161.870953226162;5162.148245539482;5208.973955130238;4866.391701037371;5150.201718733602;5160.483951604847;5166.560842328407;5169.379674439091;4602.907941841145;4623.2371658676275;4664.766761661904;4746.7389293589185;4790.616750659939;5167.9224811627855;5192.117340052125;5214.374275087014;5226.294450249244;5248.947510524922;4812.494688057774;4986.127427700138;5024.145895197825;5034.773435195425;5076.441591425014;4971.1549036663855;4998.825041123543;5000.74996250186;5072.873178170576;5094.439611642716;5015.799368025238;5046.697198168122;5049.293098966147;5050.116229659869;5089.414717307557;4818.277258411196;4994.40067191932;4995.850124496271;5000.249962505581;5002.2496625506465;4151.356539736345;4180.017695841475;4194.727342722713;4235.512916014636;4248.490181178278;3673.8714145004797;3679.6504332088407;3697.8520859165333;3713.3316003119157;3713.7586056906216;4345.261305578059;4376.015396535818;4386.0569977455;4388.319810429389;4414.646828253732;4905.337779399807;5013.523715247045;5018.121828679967;5019.874503137451;5119.180931051088;4375.453068366454;4391.055922976575;4430.313301438282;4462.486814016364;4469.932951005738;4524.773761311922;4529.343245229489;4531.478879928851;4543.795529201194;4577.427821522309;4632.096741135513;4746.7863946121815;4752.025834703877;4794.928076078932;4917.164082105979;5017.096922553976;5031.245313203049;5033.194688849767;5035.496450354935;5079.136546786981;4786.042791441656;4793.185158523129;4796.184648609675;4805.519448055166;4830.1305764961235;4800.183968725255;4877.268409738567;4919;4925.458199598113;4993.226049962262;5089.7709603067215;5115.514026167508;5116.948830511647;5122.436531981404;5161.277421161116;4931.235658472942;4932.778024988956;4934.679245849008;4934.827281045146;4938.1358262304675;4794.95205047959;4797.088553174885;4870.634702397405;4924.581410580141;4928.852134435972;4902.877428064185;4904.068227036852;4905.3623029006;4914.8771280718265;4914.8771280718265;5031.270745256903;5033.622478314068;5036.521530454601;5067.619928505451;5082.644214904921;4599.172149013076;4758.381410416624;4784.0192760484715;4785.353977213032;4911.115999120193 05:39:15 INFO - 2015-12-16 05:39:15,101 DEBUG : BROWSER_OUTPUT: |1;ext.html;564.6668465605295;569.3424095170077;571.0435021339256;574.4571380045859;575.4935656622172;25897.22308330751;36781.44827827581;37600.24799504008;37622.62377376226;37659.43510847336;41030.58969410305;41429.58570414295;41559.16881662365;41565;41612.375814362735;7070.469714771387;7184.245654206312;7835;8008.399370047241;8037.919620803805;10192.541335639915;10461.163106951426;10466.319689220176;10467.319624224401;10473.528691208914;9917.355371900803;9924.851127233062;9971.302008859382;9984.950075249613;9985.600575976952;7296.927030729677;7498.1002279726235;7500.174980752113;7501.887471687929;10102.545385457672;7208.315210055036;10212.591496340137;10477.947610261976;10487.318324308972;10498.580056797718;37887.24225515502;38449.42325865114;38479.61520384788;38528.80735596304;38623.61376386228;2883.480973424783;2894.1462268630803;2910.970890291091;3582.5163602913535;3639.331047763125;29034.709652903413;29231.707682923112;29902.102936911928;29969.40061198764;30350.696493035008;3222.548843161959;3222.6293976192806;3240.287136829894;3267.803931764102;3300.6369299377047;220728;221014;221369;221371;221942;53187;54402.72798636061;57359.71320143456;57900.71049644809;57915.71042144762;67614;69161.65419172872;69203;69219.65390173117;69332;14688.192149431883;14754.48359307419;14866.628334291512;14909.925450372679;14988.625284367978;10630.787384252271;10640.148788096934;10645.467726613639;10646.095081918123;10651.201159913038;19336;19496.90861353432;19527.609447810963;19621.705674414894;19647.365237430837;7339.376153026946;7475.813104672427;7487.812804679927;7582.848343033108;7603.65783539742;856.8671855862351;867.9392442529089;923.89375221849;973.6884197057016;1008.3848852200152;27238.455230895666;27348.179554613394;27417.588736168975;27612.171634850583;27623.585646215324;952.3667654784459;962.7929995051097;981.2542467724438;1093.1254996003165;1109.4785450838094;14046.789298160536;14271.357788899524;14285.285735713172;14328.283585820667;14560.63598410027;269612;273339;274085;274299;274308;47020.059598807835;47440;47502.52497474981;47518.52481475141;47560;1227.6808029912288;1231.132051903406;1236.6290112966074;1238.4984081447028;1253.9310337931502;25931.740682592932;26447.471050579265;26802.463950721267;27183.320416989733;27191.72808271892;41769.79115104405;42236.78881605572;42240.36639450472;42243;42247;224088;230175;237160;244765;245497;25466.618000730374;25509.489810204064;25521.361965951;25529.617055743805;25618.74381256238;33813;34077.48883766696;34652.48021279733;34888.12779680528;34936.825315873255;31170.532442013842;31754.523682144325;31835.319782644132;32901.67098328986;33178.834105829315;32166.83916580402;32728.509072363457;33020.66979330176;33034.504482433265;34107.31785364328;31788.205294867814;32448.675513244565;32618;32729;32886.50670239996;28880.133595992153;29370.70629293765;29665.406691866472;29824.8915476496;29919.55120673148;21666.766329805785;23264.651030234898;23354.766452335258;23523.647145293176;25317 05:39:15 INFO - 2015-12-16 05:39:15,101 DEBUG : BROWSER_OUTPUT: |2;jquery.html;323.3855674218984;327.9294951585409;332.9417351963406;335.6827797731142;338.5733975191258;12720.55478058268;13078.476860925552;14860.702785944288;15357.155356455405;16030.557249847512;9295.628174872996;9375.6718514852;9894.802103957916;9953.601855925754;12559.309237991907;4436.245838207513;4543.204939135655;4549.090181963604;4553.408056952608;4555.74943378114;3448.931021379571;3463.878764243252;4431.1802316571375;4530.909381812362;5145.948540514603;5129.615278854082;5129.948700513003;5142.228665700138;5155.896882062357;5169.6898186108765;5150.124478838607;5163.922541161885;5713.371529131792;5736.254286942692;5736.7992120276;5057.873553161164;5071.847844564669;5087.338645976037;5088.872778180538;5091.159958606825;11170.385628790413;11178.888211117948;11203.775924481464;11204.66386008421;15332.540023799193;1711.5806627376248;1790.7851057873008;1801.7477553142571;1810.8913465192131;1956.2566224834472;9058.954705226432;9133.45199288045;9363.48500832454;10685.572577096907;12897.67755806103;429.4610264118542;430.54147333090157;1484.4136566056347;1700.743077007529;1772.7252275897256;51720.22419663708;54189.729051354494;56037.1594426088;56092.43907560913;56938.430615693724;9871.901280987242;9915.504224788732;9949.950250248847;9951.502424878727;10018.599256029824;12511.249325040526;12514.436850341757;12533.93733031329;12553;12561.811572826415;6902.516823822385;6920.550164239308;6928.688209030605;6958.02587637721;7000.299970002959;6410.358964103646;6487;6499.09012738217;6538.673066346663;6540.9345906541275;4173.269677806372;4209.431726716915;4210.0948296116485;4233.153369326147;4242.745435273893;1549.3802479008486;1588.3725928258273;1623.8213796482378;1627.3490603758592;1648.5960939569643;841.2260720137489;861.6725644255268;911.3802614222392;930.5998420679173;946.0823001688351;15704.842951570567;15792.763108553381;16191.514254572381;16290.755638665429;16341;763.2215140556601;844.4806444036873;858.5063588436674;882.8719835623928;883.1301168349171;8211.753647390588;8646.43798153118;8921.553922303989;9331.673391431268;9362.110599493037;464094;475298;477964.2544681915;478309;481338.5933070312;72535.2746472539;72633.91049134267;73782.63108684422;74284.25715742882;74313;1089.2810744908322;1100.1583788401879;1102.9393383363831;1114.8439218509416;1117.3798541809374;14548.709025819213;14712.852871471148;14735;14974.401023958919;15307.540773776804;33189.368440909784;33504.16239593932;33982.83008584941;34123.31753364869;34222.14444638904;43575;43627.781861090494;43855;44169;44809.775951120035;8032.4778889372;8435.45169564001;8448.408611397143;8469.491830490191;8874.556272186235;10060.49697515136;10122.746931326776;10143.34068285559;13755.518556850462;15971.361145554049;13612.319384030561;14195.432182712575;14382.712345753236;14390.85609143895;14492.637684057983;13508.797368039684;13740.587782366545;13929.58211253664;13945.930270348583;13992;11109.333439993627;11258.099352051653;11657.53369865196;13998.300084995913;14712.411503539739;8173.754787356389;8457.36569757283;8591.957040214758;8638.395312328077;8855.557222138996;13279.070465067352;13280.468781249028;13299.80050299227;13384.93307533456;13547.932260338635 05:39:15 INFO - 2015-12-16 05:39:15,104 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1249.5626530714258;1629.4622774484417;1706.1469265367316;1708.495993681864;1737.930482780688;5952.107183922414;6951.617661028641;7141.535800172998;7144.857102857953;7149.42804575634;6847.212570554375;7010.158780946281;7019.7543085992;7022.052022976896;7029;1744.3284335530848;1778.8043315235313;1778.8932664040135;2029.1984666056935;2059.70134330522;1750.746141809437;2060.5157787919825;2117.5764847030578;2117.87292762434;2117.904694288753;1962.7742809576866;2033.8779673219653;2039.1945181653239;2039.3576023552607;2039.4595432210401;2021.7169596256535;2048.9282875099448;2049.231538173185;2050.507878109258;2051.8768873867543;2064.6283668939586;2082.6980087887323;2120.9787902120934;2122.1617461102933;2122.352682431858;7038.401735852459;7096.432285417154;7109.8933515997305;7113.64431778409;7118.715251389938;4206.789660516993;4273.914521709548;4280.229558679436;4284.2930916398755;4292.484901811803;2694.8248363856287;2720.9047683331187;2753.917382478509;2757.5587905934954;2761.295869553251;845.3195177881803;847;860.2558786649565;862.2239984014375;884.5046773806624;9460.479673617949;9474.052594740471;9485.715428537154;9496.525173741285;9497.477638729937;3849.8652547160714;3901.2392583445953;3947.8618248361167;3954.8022598870516;3959.920801583952;8197.180281971756;8202.917970820215;8208.958955205306;8211.548364839991;8215.383846211558;4279.144171165717;4283.571642835754;4287.871363859089;4288.849890253889;4295.269804133305;3868.9226215475533;3874.554426240962;3875.7286989910435;3877.224555088937;3880.9223815523533;2954.5568164775455;3355.614104377979;3387.458006718913;3405.523226748257;3406.7104296135108;968.2931460034215;1115.9330440173615;1132.2187690493697;1138.7039369763756;1151.1539018821327;869.5434896679294;881.405051590174;882.298572634757;896.3814967672286;928.5032507608397;6680.699368528428;6760.628165450948;6770.796876093725;6771.762988295386;6776.08522849409;1024.3085917005992;1040.5213601743133;1050.1703654113317;1059.7085801404676;1074.8011617850723;5325.254464374991;5339.786408543615;5347.3583170019065;5364.168553874156;5393.110136827379;8061.072976607648;8164.67341306353;8348.165183481724;8404.705835295736;8479.364047696448;8314.41799074059;8426.283765879969;8442.57787110642;8444.240018398374;8450.408471407065;6379.649119298483;6483;6550.410463058348;6642.136522252076;6663.666816659244;6679;6724.49566282521;6739.629320387426;6742.93257067423;6743.865122697421;7492.138404083382;7592.544447333178;7607.809804754926;7615.200403957505;7618.200088990798;7237.095363079615;7302.050733404623;7395.334419902235;7709.6530656119485;7798.454108212371;6229.657368844757;6348.174737284124;6350.396712312323;6354.714037868214;6360.204974378203;5627.493525582717;5963.194968679173;6592.24189218246;6625;6703.162104736908;5827.155062515827;6042.818715438544;6336.58812177207;6425.646589437626;6462.450691691259;6297.055441683784;6309.3690630936535;6316.399942005502;6398.680065996588;6404.807855764335;6385.68071596409;6429.067785171031;6433.967830160819;6475.579087359307;6476.773312934025;5975.910361344497;5992.221011268507;6003.7898673546215;6006.939930600638;6019.638821670714;5864.354920958605;5911.497522710446;5923.763049477972;5925.644461332334;5930.318013428511 05:39:15 INFO - 2015-12-16 05:39:15,105 DEBUG : BROWSER_OUTPUT: |4;prototype.html;300.7894473868292;305.4745837160084;306.789848953467;307.23192019950125;308.31553950230494;5338.652987555811;5398.298221231239;5437.836864894055;5456.154296084103;5461.044317244487;5287;5351.919721204175;5373.059714549958;5379.6503227290195;5383;3967.7420967637154;4175.895602609944;4181.435506206669;4191.308434108369;4204.159168166371;4013.3979903014633;4015.1166743316426;4021.4168945502884;4070.9185816283657;4092.283850326196;4060.3706425504092;4159.916801663965;4163.20899029185;4166.3125584278705;4170.374443833434;4133.958660413403;4140.15126898985;4149.398337241083;4149.419081328601;4169.91660166795;3464.861405543775;3535.611082780892;3599.208174201671;3666.9633303666888;3674.8346324415465;5175.353080864892;5185.974070129663;5188.844334669966;5188.92216616751;5215.608829337815;4803.975980120077;4804.087223427572;4809.78355973982;4810.663253572251;4815.975920120412;5626.549876009909;5631.465010824006;5632.295963004624;5634.802781902614;5635.323761148688;3933.1347103637154;4005.499312585927;4023.3361495353233;4027.7986100694848;4049.2711311963835;5938.792142275043;5939.524838012949;5942.732577034044;5942.910856337158;5948.970255148696;4152.896177595584;4157.688173387008;4161.10536234711;4163.521195062546;4164.167166566699;4176.1230141669985;4222.915541689211;4224.366345048267;4225.68307376948;4230.280852255124;4526.275795872644;4665.626749860071;4668.3697700810635;4772.5227477252;4779.593734532604;5638.069718496484;5639.661620302795;5640.32316122068;5644.774209031592;5651.152327150878;1424.978625320621;1433.168762117969;1437.1089924247033;1439.7408466475924;1440.5246268731294;946.8532377481501;973.8393165127675;978.3689520259393;979.0698836105728;999.205631522941;4991.276264941635;4995.575376093;4999.375078115236;5006.249062640633;5009.273655319958;5891.116332550066;5892.234009578728;5894.263217097863;5894.852628684317;5899.292084949833;4982.875428114254;4995.750212489361;4999.125153098194;5004.974975125101;5006.148954677714;3108.265773177379;3147.2603938074535;3159;3178.7774855760335;3180.4911214205617;5395.487428694268;5463.672179669233;5535.640183388067;5568.470995255444;5577.6653400796085;6043.153958445821;6055.061465472859;6062.333143354227;6095.817125486243;6098.32918378978;5623.100303951348;5623.634463759842;5624.971875140598;5635.408282130481;5639.43605639441;5825.70871456434;5929.703514824328;5938.376470470711;5944.851378715393;5945.464908158287;5779.450952159538;5781.335146458043;5785.710714464344;5790.594658373873;5795.304563452412;5617.606767526234;5618.634788738719;5621.4659607337235;5627.18405831144;5628.577856660849;4034.556198818186;4041.777702226406;4042;4043.1711499142016;4045.6358927696647;5767.8558036049435;5929.52563794904;5936.37668044849;5944.464998150187;5948.672822994777;5686.459786320293;5689.862027594415;5694.715264236855;5695.373508914099;5696.430356964271;5627.606067575394;5678.233438485917;5678.630888992202;5680.886382272414;5709.400512946081;5398.1902714593125;5574.303212098488;5580.9441905580425;5582.469665381782;5586.245856809279;5729.627574207663;5750.539956803529;5752.68360240174;5755.223044889054;5756.7409466574945;5601.355844077821;5601.943980560305;5605.607607467438;5605.943940560705;5609.990201763721 05:39:15 INFO - 2015-12-16 05:39:15,105 DEBUG : BROWSER_OUTPUT: |5;yui.html;654.3848782144784;681.7239018197631;685.143570536829;759.0701390796273;767.1101522234206;11859.881401185996;12164.452599633016;12168.878311216886;12197.512099516009;12207.328596927166;11594.826077608843;11670;11678.941605291982;11679.649610511698;11684.941575292112;635.1552435261092;643.2249139786546;803.9477433966803;817.1991448380561;822.0669540072001;814.3241109878816;814.9062857771344;821.1747194069951;821.2813787935556;822.56404105824;865.7489328094845;873.2097451806126;873.5195642396689;874.5321253129576;874.5539774714878;667.4793660944471;674.9628770417625;849.235687880906;859.4757198109148;860.6299291304737;639.9520035997319;640.1486023588616;640.7437025189961;640.7693230437039;641.0032399618638;11774.352410617412;11918.702032449259;11924.761504769942;11926.88073119275;11937.164398492023;10914.836277455845;11258.59125769536;11417;11690;11843.289402635783;9090.13643703847;9264.861027084598;9280.164785169367;9289.628414863397;9344.439333639935;3248.902532924016;3266.2324353776844;3290.5393244945726;3308.106811160973;3323.3851737428413;39484.407733884014;39590.60409395898;39609.00977475557;39672.80163599193;39824.60175398267;8909;9122.133397327243;9666.565004574812;9693.791738807817;9755.512224388753;16549.089800060872;16752.748708769377;16760.832391676173;16790.244439000275;16794.41219557334;6239.78160764371;6273.52948528853;6363.5863668861375;6402.743890244431;6428.260750013715;3453.3438646657055;3472.8958131256104;3493.074335301147;3496.8426420811124;3536.858525658945;2452.6934133233344;2492.1152990688047;2496.6754321938033;2497.2383423056144;2498.4503409249937;440.90300133970476;457.94733605635776;463.46469827349466;465.0861058021005;466.3052052441905;479.6546486529693;559.3315987395024;566.8922904648103;612.4304396910827;620.8882401167833;7525.887111693329;7651.579163145969;7682.385409167365;7725.227477252342;7741.225877412214;469.6876577076274;503.13963123059244;547.9917801232905;595.1935127901718;616.808789275326;3497.2655742294405;3756.7370284079852;3792.6207379262405;3857.363535016747;3869.709771767072;47427.525724742314;47622.76188619104;48064.75967620209;48504.75747621239;48734.51265487371;44883.32675009877;45078.32382514265;45168.548314517095;45258.54741452609;45283.320750188774;39434.80282598569;40355.394669079986;40591;48974.75512622414;49225.50774492281;8335.166483351617;8358.791030224293;8469.61886715087;8729.825403492021;8885.644574216958;30479.847600761856;30826.845865770527;31974.840125799223;32191.839040804647;33501.497477538345;36760.26479470342;38421.4236786454;38994.6100538991;39622.40566391564;39933.80033099816;10901.727456813644;10949.671509854717;10951.123910087015;10985.231033827555;11127.554897803997;11369.602063927723;11651.41742912868;11659.591914282959;11705.414729263332;11738.823917641414;10817.56729730802;10984.450777461256;11165.16261280391;11432.256903301259;11472.827907581226;10536.683899483029;10888.401137937173;11123.555057797921;11257.549698012315;11472.139589530985;10616.256862019893;10970.341779493256;10990.285631434252;11024.338539687324;11207.159463040467;9497.905020949702;9510.046244618215;9589.822155454114;9734.9026509734;10033.1973442123;8769.254613357936;8929.866052009094;9339.08188708856;9422;9558.522073896416 05:39:15 INFO - 2015-12-16 05:39:15,105 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:39:15 INFO - 2015-12-16 05:39:15,105 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:39:15 INFO - 2015-12-16 05:39:15,105 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,987 05:39:15 INFO - 2015-12-16 05:39:15,105 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:39:15 INFO - 2015-12-16 05:39:15,105 DEBUG : BROWSER_OUTPUT: __startTimestamp1450273155092__endTimestamp 05:39:15 INFO - 2015-12-16 05:39:15,105 DEBUG : BROWSER_OUTPUT: 05:39:15 INFO - 2015-12-16 05:39:15,106 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:39:15 INFO - 2015-12-16 05:39:15,106 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:39:15 INFO - 2015-12-16 05:39:15,106 DEBUG : BROWSER_OUTPUT: 05:39:15 INFO - 2015-12-16 05:39:15,106 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4675.09 Median:4793.54 stddev:486.46 (10.1%) stddev-sans-first:460.92 05:39:15 INFO - 2015-12-16 05:39:15,106 DEBUG : BROWSER_OUTPUT: Values: 2636.9 2720.0 2727.6 2736.8 2755.2 4537.4 4674.5 4704.2 4757.1 4787.3 4634.0 4669.7 4736.8 4751.5 4815.0 4351.3 4357.6 4383.5 4409.1 4431.3 4167.7 4428.0 4444.5 4482.4 4497.1 4260.8 4325.8 4339.7 4355.4 4369.3 4335.9 4372.6 4393.2 4398.9 4444.9 4210.2 4302.0 4338.8 4373.7 4430.8 4560.7 4643.6 4765.3 4780.9 4793.5 5083.1 5154.6 5161.9 5162.1 5209.0 4866.4 5150.2 5160.5 5166.6 5169.4 4602.9 4623.2 4664.8 4746.7 4790.6 5167.9 5192.1 5214.4 5226.3 5248.9 4812.5 4986.1 5024.1 5034.8 5076.4 4971.2 4998.8 5000.7 5072.9 5094.4 5015.8 5046.7 5049.3 5050.1 5089.4 4818.3 4994.4 4995.9 5000.2 5002.2 4151.4 4180.0 4194.7 4235.5 4248.5 3673.9 3679.7 3697.9 3713.3 3713.8 4345.3 4376.0 4386.1 4388.3 4414.6 4905.3 5013.5 5018.1 5019.9 5119.2 4375.5 4391.1 4430.3 4462.5 4469.9 4524.8 4529.3 4531.5 4543.8 4577.4 4632.1 4746.8 4752.0 4794.9 4917.2 5017.1 5031.2 5033.2 5035.5 5079.1 4786.0 4793.2 4796.2 4805.5 4830.1 4800.2 4877.3 4919.0 4925.5 4993.2 5089.8 5115.5 5116.9 5122.4 5161.3 4931.2 4932.8 4934.7 4934.8 4938.1 4795.0 4797.1 4870.6 4924.6 4928.9 4902.9 4904.1 4905.4 4914.9 4914.9 5031.3 5033.6 5036.5 5067.6 5082.6 4599.2 4758.4 4784.0 4785.4 4911.1 05:39:15 INFO - 2015-12-16 05:39:15,106 DEBUG : BROWSER_OUTPUT: 05:39:15 INFO - 2015-12-16 05:39:15,106 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41043.02 Median:32001.08 stddev:63739.89 (199.2%) stddev-sans-first:63846.23 05:39:15 INFO - 2015-12-16 05:39:15,107 DEBUG : BROWSER_OUTPUT: Values: 564.7 569.3 571.0 574.5 575.5 25897.2 36781.4 37600.2 37622.6 37659.4 41030.6 41429.6 41559.2 41565.0 41612.4 7070.5 7184.2 7835.0 8008.4 8037.9 10192.5 10461.2 10466.3 10467.3 10473.5 9917.4 9924.9 9971.3 9985.0 9985.6 7296.9 7498.1 7500.2 7501.9 10102.5 7208.3 10212.6 10477.9 10487.3 10498.6 37887.2 38449.4 38479.6 38528.8 38623.6 2883.5 2894.1 2911.0 3582.5 3639.3 29034.7 29231.7 29902.1 29969.4 30350.7 3222.5 3222.6 3240.3 3267.8 3300.6 220728.0 221014.0 221369.0 221371.0 221942.0 53187.0 54402.7 57359.7 57900.7 57915.7 67614.0 69161.7 69203.0 69219.7 69332.0 14688.2 14754.5 14866.6 14909.9 14988.6 10630.8 10640.1 10645.5 10646.1 10651.2 19336.0 19496.9 19527.6 19621.7 19647.4 7339.4 7475.8 7487.8 7582.8 7603.7 856.9 867.9 923.9 973.7 1008.4 27238.5 27348.2 27417.6 27612.2 27623.6 952.4 962.8 981.3 1093.1 1109.5 14046.8 14271.4 14285.3 14328.3 14560.6 269612.0 273339.0 274085.0 274299.0 274308.0 47020.1 47440.0 47502.5 47518.5 47560.0 1227.7 1231.1 1236.6 1238.5 1253.9 25931.7 26447.5 26802.5 27183.3 27191.7 41769.8 42236.8 42240.4 42243.0 42247.0 224088.0 230175.0 237160.0 244765.0 245497.0 25466.6 25509.5 25521.4 25529.6 25618.7 33813.0 34077.5 34652.5 34888.1 34936.8 31170.5 31754.5 31835.3 32901.7 33178.8 32166.8 32728.5 33020.7 33034.5 34107.3 31788.2 32448.7 32618.0 32729.0 32886.5 28880.1 29370.7 29665.4 29824.9 29919.6 21666.8 23264.7 23354.8 23523.6 25317.0 05:39:15 INFO - 2015-12-16 05:39:15,108 DEBUG : BROWSER_OUTPUT: 05:39:15 INFO - 2015-12-16 05:39:15,108 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25658.45 Median:22002.77 stddev:77765.92 (353.4%) stddev-sans-first:77960.81 05:39:15 INFO - 2015-12-16 05:39:15,108 DEBUG : BROWSER_OUTPUT: Values: 323.4 327.9 332.9 335.7 338.6 12720.6 13078.5 14860.7 15357.2 16030.6 9295.6 9375.7 9894.8 9953.6 12559.3 4436.2 4543.2 4549.1 4553.4 4555.7 3448.9 3463.9 4431.2 4530.9 5145.9 5129.6 5129.9 5142.2 5155.9 5169.7 5150.1 5163.9 5713.4 5736.3 5736.8 5057.9 5071.8 5087.3 5088.9 5091.2 11170.4 11178.9 11203.8 11204.7 15332.5 1711.6 1790.8 1801.7 1810.9 1956.3 9059.0 9133.5 9363.5 10685.6 12897.7 429.5 430.5 1484.4 1700.7 1772.7 51720.2 54189.7 56037.2 56092.4 56938.4 9871.9 9915.5 9950.0 9951.5 10018.6 12511.2 12514.4 12533.9 12553.0 12561.8 6902.5 6920.6 6928.7 6958.0 7000.3 6410.4 6487.0 6499.1 6538.7 6540.9 4173.3 4209.4 4210.1 4233.2 4242.7 1549.4 1588.4 1623.8 1627.3 1648.6 841.2 861.7 911.4 930.6 946.1 15704.8 15792.8 16191.5 16290.8 16341.0 763.2 844.5 858.5 882.9 883.1 8211.8 8646.4 8921.6 9331.7 9362.1 464094.0 475298.0 477964.3 478309.0 481338.6 72535.3 72633.9 73782.6 74284.3 74313.0 1089.3 1100.2 1102.9 1114.8 1117.4 14548.7 14712.9 14735.0 14974.4 15307.5 33189.4 33504.2 33982.8 34123.3 34222.1 43575.0 43627.8 43855.0 44169.0 44809.8 8032.5 8435.5 8448.4 8469.5 8874.6 10060.5 10122.7 10143.3 13755.5 15971.4 13612.3 14195.4 14382.7 14390.9 14492.6 13508.8 13740.6 13929.6 13945.9 13992.0 11109.3 11258.1 11657.5 13998.3 14712.4 8173.8 8457.4 8592.0 8638.4 8855.6 13279.1 13280.5 13299.8 13384.9 13547.9 05:39:15 INFO - 2015-12-16 05:39:15,108 DEBUG : BROWSER_OUTPUT: 05:39:15 INFO - 2015-12-16 05:39:15,108 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4925.67 Median:6303.21 stddev:2532.64 (40.2%) stddev-sans-first:2524.67 05:39:15 INFO - 2015-12-16 05:39:15,109 DEBUG : BROWSER_OUTPUT: Values: 1249.6 1629.5 1706.1 1708.5 1737.9 5952.1 6951.6 7141.5 7144.9 7149.4 6847.2 7010.2 7019.8 7022.1 7029.0 1744.3 1778.8 1778.9 2029.2 2059.7 1750.7 2060.5 2117.6 2117.9 2117.9 1962.8 2033.9 2039.2 2039.4 2039.5 2021.7 2048.9 2049.2 2050.5 2051.9 2064.6 2082.7 2121.0 2122.2 2122.4 7038.4 7096.4 7109.9 7113.6 7118.7 4206.8 4273.9 4280.2 4284.3 4292.5 2694.8 2720.9 2753.9 2757.6 2761.3 845.3 847.0 860.3 862.2 884.5 9460.5 9474.1 9485.7 9496.5 9497.5 3849.9 3901.2 3947.9 3954.8 3959.9 8197.2 8202.9 8209.0 8211.5 8215.4 4279.1 4283.6 4287.9 4288.8 4295.3 3868.9 3874.6 3875.7 3877.2 3880.9 2954.6 3355.6 3387.5 3405.5 3406.7 968.3 1115.9 1132.2 1138.7 1151.2 869.5 881.4 882.3 896.4 928.5 6680.7 6760.6 6770.8 6771.8 6776.1 1024.3 1040.5 1050.2 1059.7 1074.8 5325.3 5339.8 5347.4 5364.2 5393.1 8061.1 8164.7 8348.2 8404.7 8479.4 8314.4 8426.3 8442.6 8444.2 8450.4 6379.6 6483.0 6550.4 6642.1 6663.7 6679.0 6724.5 6739.6 6742.9 6743.9 7492.1 7592.5 7607.8 7615.2 7618.2 7237.1 7302.1 7395.3 7709.7 7798.5 6229.7 6348.2 6350.4 6354.7 6360.2 5627.5 5963.2 6592.2 6625.0 6703.2 5827.2 6042.8 6336.6 6425.6 6462.5 6297.1 6309.4 6316.4 6398.7 6404.8 6385.7 6429.1 6434.0 6475.6 6476.8 5975.9 5992.2 6003.8 6006.9 6019.6 5864.4 5911.5 5923.8 5925.6 5930.3 05:39:15 INFO - 2015-12-16 05:39:15,109 DEBUG : BROWSER_OUTPUT: 05:39:15 INFO - 2015-12-16 05:39:15,109 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4712.08 Median:5389.24 stddev:1391.70 (25.8%) stddev-sans-first:1355.65 05:39:15 INFO - 2015-12-16 05:39:15,110 DEBUG : BROWSER_OUTPUT: Values: 300.8 305.5 306.8 307.2 308.3 5338.7 5398.3 5437.8 5456.2 5461.0 5287.0 5351.9 5373.1 5379.7 5383.0 3967.7 4175.9 4181.4 4191.3 4204.2 4013.4 4015.1 4021.4 4070.9 4092.3 4060.4 4159.9 4163.2 4166.3 4170.4 4134.0 4140.2 4149.4 4149.4 4169.9 3464.9 3535.6 3599.2 3667.0 3674.8 5175.4 5186.0 5188.8 5188.9 5215.6 4804.0 4804.1 4809.8 4810.7 4816.0 5626.5 5631.5 5632.3 5634.8 5635.3 3933.1 4005.5 4023.3 4027.8 4049.3 5938.8 5939.5 5942.7 5942.9 5949.0 4152.9 4157.7 4161.1 4163.5 4164.2 4176.1 4222.9 4224.4 4225.7 4230.3 4526.3 4665.6 4668.4 4772.5 4779.6 5638.1 5639.7 5640.3 5644.8 5651.2 1425.0 1433.2 1437.1 1439.7 1440.5 946.9 973.8 978.4 979.1 999.2 4991.3 4995.6 4999.4 5006.2 5009.3 5891.1 5892.2 5894.3 5894.9 5899.3 4982.9 4995.8 4999.1 5005.0 5006.1 3108.3 3147.3 3159.0 3178.8 3180.5 5395.5 5463.7 5535.6 5568.5 5577.7 6043.2 6055.1 6062.3 6095.8 6098.3 5623.1 5623.6 5625.0 5635.4 5639.4 5825.7 5929.7 5938.4 5944.9 5945.5 5779.5 5781.3 5785.7 5790.6 5795.3 5617.6 5618.6 5621.5 5627.2 5628.6 4034.6 4041.8 4042.0 4043.2 4045.6 5767.9 5929.5 5936.4 5944.5 5948.7 5686.5 5689.9 5694.7 5695.4 5696.4 5627.6 5678.2 5678.6 5680.9 5709.4 5398.2 5574.3 5580.9 5582.5 5586.2 5729.6 5750.5 5752.7 5755.2 5756.7 5601.4 5601.9 5605.6 5605.9 5610.0 05:39:15 INFO - 2015-12-16 05:39:15,110 DEBUG : BROWSER_OUTPUT: 05:39:15 INFO - 2015-12-16 05:39:15,110 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12389.31 Median:44980.83 stddev:13852.58 (30.8%) stddev-sans-first:13863.41 05:39:15 INFO - 2015-12-16 05:39:15,110 DEBUG : BROWSER_OUTPUT: Values: 654.4 681.7 685.1 759.1 767.1 11859.9 12164.5 12168.9 12197.5 12207.3 11594.8 11670.0 11678.9 11679.6 11684.9 635.2 643.2 803.9 817.2 822.1 814.3 814.9 821.2 821.3 822.6 865.7 873.2 873.5 874.5 874.6 667.5 675.0 849.2 859.5 860.6 640.0 640.1 640.7 640.8 641.0 11774.4 11918.7 11924.8 11926.9 11937.2 10914.8 11258.6 11417.0 11690.0 11843.3 9090.1 9264.9 9280.2 9289.6 9344.4 3248.9 3266.2 3290.5 3308.1 3323.4 39484.4 39590.6 39609.0 39672.8 39824.6 8909.0 9122.1 9666.6 9693.8 9755.5 16549.1 16752.7 16760.8 16790.2 16794.4 6239.8 6273.5 6363.6 6402.7 6428.3 3453.3 3472.9 3493.1 3496.8 3536.9 2452.7 2492.1 2496.7 2497.2 2498.5 440.9 457.9 463.5 465.1 466.3 479.7 559.3 566.9 612.4 620.9 7525.9 7651.6 7682.4 7725.2 7741.2 469.7 503.1 548.0 595.2 616.8 3497.3 3756.7 3792.6 3857.4 3869.7 47427.5 47622.8 48064.8 48504.8 48734.5 44883.3 45078.3 45168.5 45258.5 45283.3 39434.8 40355.4 40591.0 48974.8 49225.5 8335.2 8358.8 8469.6 8729.8 8885.6 30479.8 30826.8 31974.8 32191.8 33501.5 36760.3 38421.4 38994.6 39622.4 39933.8 10901.7 10949.7 10951.1 10985.2 11127.6 11369.6 11651.4 11659.6 11705.4 11738.8 10817.6 10984.5 11165.2 11432.3 11472.8 10536.7 10888.4 11123.6 11257.5 11472.1 10616.3 10970.3 10990.3 11024.3 11207.2 9497.9 9510.0 9589.8 9734.9 10033.2 8769.3 8929.9 9339.1 9422.0 9558.5 05:39:15 INFO - 2015-12-16 05:39:15,110 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:39:15 INFO - 2015-12-16 05:39:15,110 DEBUG : BROWSER_OUTPUT: 05:39:15 INFO - 2015-12-16 05:39:15,939 INFO : Browser exited with error code: 0 05:39:15 INFO - 2015-12-16 05:39:15,963 INFO : Completed test dromaeo_css (00:18:37) 05:39:15 INFO - 2015-12-16 05:39:15,963 INFO : Starting test kraken 05:39:15 INFO - 2015-12-16 05:39:15,963 DEBUG : operating with platform_type : linux_ 05:39:15 INFO - 2015-12-16 05:39:15,963 INFO : Initialising browser for kraken test... 05:39:15 INFO - 2015-12-16 05:39:15,969 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOvYThB/profile http://localhost:41288/getInfo.html 05:39:20 INFO - 2015-12-16 05:39:20,314 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:39:20 INFO - 2015-12-16 05:39:20,314 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:39:20 INFO - 2015-12-16 05:39:20,314 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:39:20 INFO - 2015-12-16 05:39:20,314 DEBUG : BROWSER_OUTPUT: __metrics 05:39:20 INFO - 2015-12-16 05:39:20,431 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] 05:39:20 INFO - 2015-12-16 05:39:20,486 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] 05:39:21 INFO - 2015-12-16 05:39:21,790 INFO : Browser initialized. 05:39:21 INFO - 2015-12-16 05:39:21,790 INFO : Running cycle 1/1 for kraken test... 05:39:21 INFO - 2015-12-16 05:39:21,791 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOvYThB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:39:33 INFO - 2015-12-16 05:39:33,793 DEBUG : BROWSER_OUTPUT: RSS: Main: 142258176 05:39:33 INFO - 2015-12-16 05:39:33,794 DEBUG : BROWSER_OUTPUT: 05:39:36 INFO - 2015-12-16 05:39:36,398 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41288/tests/kraken/driver.html?testName=audio-beat-detection) 05:39:36 INFO - 2015-12-16 05:39:36,981 DEBUG : BROWSER_OUTPUT: RSS: Main: 176406528 05:39:36 INFO - 2015-12-16 05:39:36,981 DEBUG : BROWSER_OUTPUT: 05:39:39 INFO - 2015-12-16 05:39:39,723 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41288/tests/kraken/driver.html?testName=audio-dft) 05:39:40 INFO - 2015-12-16 05:39:40,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 165732352 05:39:40 INFO - 2015-12-16 05:39:40,296 DEBUG : BROWSER_OUTPUT: 05:39:43 INFO - 2015-12-16 05:39:43,295 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41288/tests/kraken/driver.html?testName=audio-fft) 05:39:43 INFO - 2015-12-16 05:39:43,860 DEBUG : BROWSER_OUTPUT: RSS: Main: 152981504 05:39:43 INFO - 2015-12-16 05:39:43,860 DEBUG : BROWSER_OUTPUT: 05:39:45 INFO - 2015-12-16 05:39:45,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41288/tests/kraken/driver.html?testName=audio-oscillator) 05:39:46 INFO - 2015-12-16 05:39:46,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 155484160 05:39:46 INFO - 2015-12-16 05:39:46,506 DEBUG : BROWSER_OUTPUT: 05:39:48 INFO - 2015-12-16 05:39:48,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41288/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:39:49 INFO - 2015-12-16 05:39:49,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 157745152 05:39:49 INFO - 2015-12-16 05:39:49,342 DEBUG : BROWSER_OUTPUT: 05:39:52 INFO - 2015-12-16 05:39:52,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41288/tests/kraken/driver.html?testName=imaging-darkroom) 05:39:52 INFO - 2015-12-16 05:39:52,957 DEBUG : BROWSER_OUTPUT: RSS: Main: 157634560 05:39:52 INFO - 2015-12-16 05:39:52,957 DEBUG : BROWSER_OUTPUT: 05:39:56 INFO - 2015-12-16 05:39:56,339 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41288/tests/kraken/driver.html?testName=imaging-desaturate) 05:39:56 INFO - 2015-12-16 05:39:56,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 158756864 05:39:56 INFO - 2015-12-16 05:39:56,908 DEBUG : BROWSER_OUTPUT: 05:39:59 INFO - 2015-12-16 05:39:59,767 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41288/tests/kraken/driver.html?testName=json-parse-financial) 05:40:00 INFO - 2015-12-16 05:40:00,348 DEBUG : BROWSER_OUTPUT: RSS: Main: 158724096 05:40:00 INFO - 2015-12-16 05:40:00,349 DEBUG : BROWSER_OUTPUT: 05:40:02 INFO - 2015-12-16 05:40:02,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41288/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:40:02 INFO - 2015-12-16 05:40:02,668 DEBUG : BROWSER_OUTPUT: RSS: Main: 167079936 05:40:02 INFO - 2015-12-16 05:40:02,668 DEBUG : BROWSER_OUTPUT: 05:40:04 INFO - 2015-12-16 05:40:04,525 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41288/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:40:05 INFO - 2015-12-16 05:40:05,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 164716544 05:40:05 INFO - 2015-12-16 05:40:05,119 DEBUG : BROWSER_OUTPUT: 05:40:07 INFO - 2015-12-16 05:40:07,257 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41288/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:40:07 INFO - 2015-12-16 05:40:07,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 178397184 05:40:07 INFO - 2015-12-16 05:40:07,842 DEBUG : BROWSER_OUTPUT: 05:40:10 INFO - 2015-12-16 05:40:10,356 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:40:10 INFO - 2015-12-16 05:40:10,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 182247424 05:40:10 INFO - 2015-12-16 05:40:10,943 DEBUG : BROWSER_OUTPUT: 05:40:13 INFO - 2015-12-16 05:40:13,562 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:40:14 INFO - 2015-12-16 05:40:14,145 DEBUG : BROWSER_OUTPUT: RSS: Main: 179613696 05:40:14 INFO - 2015-12-16 05:40:14,145 DEBUG : BROWSER_OUTPUT: 05:40:15 INFO - 2015-12-16 05:40:15,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41288/tests/kraken/driver.html?testName=ai-astar) 05:40:16 INFO - 2015-12-16 05:40:16,185 DEBUG : BROWSER_OUTPUT: RSS: Main: 238067712 05:40:16 INFO - 2015-12-16 05:40:16,185 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-12-16 05:40:16,186 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:40:16 INFO - 2015-12-16 05:40:16,186 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:40:16 INFO - 2015-12-16 05:40:16,187 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:40:16 INFO - 2015-12-16 05:40:16,187 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:40:16 INFO - 2015-12-16 05:40:16,187 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;114;107;111;115;114;103;115;113;105 05:40:16 INFO - 2015-12-16 05:40:16,187 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;139;153;162;133;155;156;130;177;129 05:40:16 INFO - 2015-12-16 05:40:16,187 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;159;162;163;162;161;162;163;162 05:40:16 INFO - 2015-12-16 05:40:16,187 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;86;98;71;75;72;113;91;74 05:40:16 INFO - 2015-12-16 05:40:16,187 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;128;96;96;95;135;95;95;131 05:40:16 INFO - 2015-12-16 05:40:16,187 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;110;109;110;109 05:40:16 INFO - 2015-12-16 05:40:16,188 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;147;146;146;147;147;146;146 05:40:16 INFO - 2015-12-16 05:40:16,188 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;95;96;96;95;96;95 05:40:16 INFO - 2015-12-16 05:40:16,188 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;73;73;71;73;72;73;81;70;70 05:40:16 INFO - 2015-12-16 05:40:16,188 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;67;68;68;69;68;68;68;68 05:40:16 INFO - 2015-12-16 05:40:16,188 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;85;85;86;87;86;85;85;85;86 05:40:16 INFO - 2015-12-16 05:40:16,188 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;122;124;123;124;127;121;135;127;119 05:40:16 INFO - 2015-12-16 05:40:16,188 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;148;147;147;147;134;152;146;160;138 05:40:16 INFO - 2015-12-16 05:40:16,189 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;74;70;71;71;69;70;71;68;70 05:40:16 INFO - 2015-12-16 05:40:16,189 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:40:16 INFO - 2015-12-16 05:40:16,189 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:40:16 INFO - 2015-12-16 05:40:16,189 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,967 05:40:16 INFO - 2015-12-16 05:40:16,189 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:40:16 INFO - 2015-12-16 05:40:16,189 DEBUG : BROWSER_OUTPUT: __startTimestamp1450273216185__endTimestamp 05:40:16 INFO - 2015-12-16 05:40:16,189 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-12-16 05:40:16,197 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:40:16 INFO - 2015-12-16 05:40:16,197 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:40:16 INFO - 2015-12-16 05:40:16,197 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-12-16 05:40:16,197 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.90 Median:113.50 stddev:4.36 (3.8%) stddev-sans-first:4.60 05:40:16 INFO - 2015-12-16 05:40:16,197 DEBUG : BROWSER_OUTPUT: Values: 112.0 114.0 107.0 111.0 115.0 114.0 103.0 115.0 113.0 105.0 05:40:16 INFO - 2015-12-16 05:40:16,197 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-12-16 05:40:16,197 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.00 Median:155.50 stddev:15.71 (10.1%) stddev-sans-first:16.45 05:40:16 INFO - 2015-12-16 05:40:16,198 DEBUG : BROWSER_OUTPUT: Values: 156.0 139.0 153.0 162.0 133.0 155.0 156.0 130.0 177.0 129.0 05:40:16 INFO - 2015-12-16 05:40:16,198 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-12-16 05:40:16,198 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.27 (0.8%) stddev-sans-first:1.22 05:40:16 INFO - 2015-12-16 05:40:16,198 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 159.0 162.0 163.0 162.0 161.0 162.0 163.0 162.0 05:40:16 INFO - 2015-12-16 05:40:16,198 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-12-16 05:40:16,198 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.50 Median:74.50 stddev:14.25 (19.1%) stddev-sans-first:14.59 05:40:16 INFO - 2015-12-16 05:40:16,198 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 86.0 98.0 71.0 75.0 72.0 113.0 91.0 74.0 05:40:16 INFO - 2015-12-16 05:40:16,198 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-12-16 05:40:16,198 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.10 Median:95.00 stddev:17.50 (18.4%) stddev-sans-first:18.09 05:40:16 INFO - 2015-12-16 05:40:16,198 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 128.0 96.0 96.0 95.0 135.0 95.0 95.0 131.0 05:40:16 INFO - 2015-12-16 05:40:16,198 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-12-16 05:40:16,199 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:40:16 INFO - 2015-12-16 05:40:16,199 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 109.0 05:40:16 INFO - 2015-12-16 05:40:16,199 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-12-16 05:40:16,199 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 05:40:16 INFO - 2015-12-16 05:40:16,199 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 147.0 146.0 146.0 147.0 147.0 146.0 146.0 05:40:16 INFO - 2015-12-16 05:40:16,199 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-12-16 05:40:16,199 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:40:16 INFO - 2015-12-16 05:40:16,199 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 05:40:16 INFO - 2015-12-16 05:40:16,199 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-12-16 05:40:16,199 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.10 Median:73.00 stddev:3.18 (4.4%) stddev-sans-first:3.30 05:40:16 INFO - 2015-12-16 05:40:16,199 DEBUG : BROWSER_OUTPUT: Values: 75.0 73.0 73.0 71.0 73.0 72.0 73.0 81.0 70.0 70.0 05:40:16 INFO - 2015-12-16 05:40:16,199 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-12-16 05:40:16,199 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 05:40:16 INFO - 2015-12-16 05:40:16,199 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 67.0 68.0 68.0 69.0 68.0 68.0 68.0 68.0 05:40:16 INFO - 2015-12-16 05:40:16,199 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-12-16 05:40:16,200 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 05:40:16 INFO - 2015-12-16 05:40:16,200 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 85.0 86.0 87.0 86.0 85.0 85.0 85.0 86.0 05:40:16 INFO - 2015-12-16 05:40:16,200 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-12-16 05:40:16,200 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:125.50 stddev:4.46 (3.6%) stddev-sans-first:4.66 05:40:16 INFO - 2015-12-16 05:40:16,200 DEBUG : BROWSER_OUTPUT: Values: 127.0 122.0 124.0 123.0 124.0 127.0 121.0 135.0 127.0 119.0 05:40:16 INFO - 2015-12-16 05:40:16,200 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-12-16 05:40:16,200 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.70 Median:147.00 stddev:7.53 (5.1%) stddev-sans-first:7.45 05:40:16 INFO - 2015-12-16 05:40:16,200 DEBUG : BROWSER_OUTPUT: Values: 138.0 148.0 147.0 147.0 147.0 134.0 152.0 146.0 160.0 138.0 05:40:16 INFO - 2015-12-16 05:40:16,200 DEBUG : BROWSER_OUTPUT: 05:40:16 INFO - 2015-12-16 05:40:16,200 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:1.58 (2.2%) stddev-sans-first:1.67 05:40:16 INFO - 2015-12-16 05:40:16,200 DEBUG : BROWSER_OUTPUT: Values: 70.0 74.0 70.0 71.0 71.0 69.0 70.0 71.0 68.0 70.0 05:40:16 INFO - 2015-12-16 05:40:16,200 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:40:16 INFO - 2015-12-16 05:40:16,200 DEBUG : BROWSER_OUTPUT: 05:40:17 INFO - 2015-12-16 05:40:17,091 INFO : Browser exited with error code: 0 05:40:17 INFO - 2015-12-16 05:40:17,145 INFO : Completed test kraken (00:01:01) 05:40:17 INFO - 2015-12-16 05:40:17,145 INFO : Starting test v8_7 05:40:17 INFO - 2015-12-16 05:40:17,145 DEBUG : operating with platform_type : linux_ 05:40:17 INFO - 2015-12-16 05:40:17,145 INFO : Initialising browser for v8_7 test... 05:40:17 INFO - 2015-12-16 05:40:17,151 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgVYs4a/profile http://localhost:41288/getInfo.html 05:40:21 INFO - 2015-12-16 05:40:21,860 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:40:21 INFO - 2015-12-16 05:40:21,860 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:40:21 INFO - 2015-12-16 05:40:21,860 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:40:21 INFO - 2015-12-16 05:40:21,861 DEBUG : BROWSER_OUTPUT: __metrics 05:40:21 INFO - 2015-12-16 05:40:21,998 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] 05:40:22 INFO - 2015-12-16 05:40:22,054 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] 05:40:22 ERROR - 2015-12-16 05:40:22,070 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 05:40:23 INFO - 2015-12-16 05:40:23,022 INFO : Browser initialized. 05:40:23 INFO - 2015-12-16 05:40:23,022 INFO : Running cycle 1/1 for v8_7 test... 05:40:23 INFO - 2015-12-16 05:40:23,023 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgVYs4a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:40:35 INFO - 2015-12-16 05:40:35,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 142143488 05:40:35 INFO - 2015-12-16 05:40:35,078 DEBUG : BROWSER_OUTPUT: 05:40:56 INFO - 2015-12-16 05:40:56,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41288/tests/v8_7/run.html (next: http://localhost:41288/tests/v8_7/run.html) 05:40:56 INFO - 2015-12-16 05:40:56,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 447172608 05:40:56 INFO - 2015-12-16 05:40:56,697 DEBUG : BROWSER_OUTPUT: 05:40:56 INFO - 2015-12-16 05:40:56,698 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:40:56 INFO - 2015-12-16 05:40:56,698 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:40:56 INFO - 2015-12-16 05:40:56,698 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:40:56 INFO - 2015-12-16 05:40:56,699 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:40:56 INFO - 2015-12-16 05:40:56,699 DEBUG : BROWSER_OUTPUT: |0;Richards;165.89250165892503 05:40:56 INFO - 2015-12-16 05:40:56,699 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.28912071535024 05:40:56 INFO - 2015-12-16 05:40:56,699 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.31895352073474 05:40:56 INFO - 2015-12-16 05:40:56,699 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5122.448979591837 05:40:56 INFO - 2015-12-16 05:40:56,699 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2028.3975659229209 05:40:56 INFO - 2015-12-16 05:40:56,699 DEBUG : BROWSER_OUTPUT: |5;Earley;789.8894154818325 05:40:56 INFO - 2015-12-16 05:40:56,700 DEBUG : BROWSER_OUTPUT: |6;Boyer;12530.864197530864 05:40:56 INFO - 2015-12-16 05:40:56,700 DEBUG : BROWSER_OUTPUT: |7;RegExp;27378.37837837838 05:40:56 INFO - 2015-12-16 05:40:56,700 DEBUG : BROWSER_OUTPUT: |8;Splay;608.6427267194157 05:40:56 INFO - 2015-12-16 05:40:56,701 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 05:40:56 INFO - 2015-12-16 05:40:56,701 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:40:56 INFO - 2015-12-16 05:40:56,701 DEBUG : BROWSER_OUTPUT: __startTimestamp1450273256697__endTimestamp 05:40:56 INFO - 2015-12-16 05:40:56,701 DEBUG : BROWSER_OUTPUT: 05:40:56 INFO - 2015-12-16 05:40:56,701 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:40:56 INFO - 2015-12-16 05:40:56,701 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:40:56 INFO - 2015-12-16 05:40:56,701 DEBUG : BROWSER_OUTPUT: 05:40:56 INFO - 2015-12-16 05:40:56,702 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.89 Median:165.89 stddev:0.00 (0.0%) 05:40:56 INFO - 2015-12-16 05:40:56,702 DEBUG : BROWSER_OUTPUT: Values: 165.9 05:40:56 INFO - 2015-12-16 05:40:56,702 DEBUG : BROWSER_OUTPUT: 05:40:56 INFO - 2015-12-16 05:40:56,702 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.29 Median:186.29 stddev:0.00 (0.0%) 05:40:56 INFO - 2015-12-16 05:40:56,702 DEBUG : BROWSER_OUTPUT: Values: 186.3 05:40:56 INFO - 2015-12-16 05:40:56,703 DEBUG : BROWSER_OUTPUT: 05:40:56 INFO - 2015-12-16 05:40:56,703 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 05:40:56 INFO - 2015-12-16 05:40:56,703 DEBUG : BROWSER_OUTPUT: Values: 278.3 05:40:56 INFO - 2015-12-16 05:40:56,703 DEBUG : BROWSER_OUTPUT: 05:40:56 INFO - 2015-12-16 05:40:56,703 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5122.45 Median:5122.45 stddev:0.00 (0.0%) 05:40:56 INFO - 2015-12-16 05:40:56,704 DEBUG : BROWSER_OUTPUT: Values: 5122.4 05:40:56 INFO - 2015-12-16 05:40:56,704 DEBUG : BROWSER_OUTPUT: 05:40:56 INFO - 2015-12-16 05:40:56,705 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2028.40 Median:2028.40 stddev:0.00 (0.0%) 05:40:56 INFO - 2015-12-16 05:40:56,705 DEBUG : BROWSER_OUTPUT: Values: 2028.4 05:40:56 INFO - 2015-12-16 05:40:56,705 DEBUG : BROWSER_OUTPUT: 05:40:56 INFO - 2015-12-16 05:40:56,705 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:789.89 Median:789.89 stddev:0.00 (0.0%) 05:40:56 INFO - 2015-12-16 05:40:56,705 DEBUG : BROWSER_OUTPUT: Values: 789.9 05:40:56 INFO - 2015-12-16 05:40:56,706 DEBUG : BROWSER_OUTPUT: 05:40:56 INFO - 2015-12-16 05:40:56,706 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12530.86 Median:12530.86 stddev:0.00 (0.0%) 05:40:56 INFO - 2015-12-16 05:40:56,706 DEBUG : BROWSER_OUTPUT: Values: 12530.9 05:40:56 INFO - 2015-12-16 05:40:56,706 DEBUG : BROWSER_OUTPUT: 05:40:56 INFO - 2015-12-16 05:40:56,706 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27378.38 Median:27378.38 stddev:0.00 (0.0%) 05:40:56 INFO - 2015-12-16 05:40:56,706 DEBUG : BROWSER_OUTPUT: Values: 27378.4 05:40:56 INFO - 2015-12-16 05:40:56,706 DEBUG : BROWSER_OUTPUT: 05:40:56 INFO - 2015-12-16 05:40:56,707 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:608.64 Median:608.64 stddev:0.00 (0.0%) 05:40:56 INFO - 2015-12-16 05:40:56,707 DEBUG : BROWSER_OUTPUT: Values: 608.6 05:40:56 INFO - 2015-12-16 05:40:56,707 DEBUG : BROWSER_OUTPUT: 05:40:56 INFO - 2015-12-16 05:40:56,707 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 05:40:56 INFO - 2015-12-16 05:40:56,707 DEBUG : BROWSER_OUTPUT: Values: 4835.7 05:40:56 INFO - 2015-12-16 05:40:56,707 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:40:56 INFO - 2015-12-16 05:40:56,708 DEBUG : BROWSER_OUTPUT: 05:40:57 INFO - 2015-12-16 05:40:57,643 INFO : Browser exited with error code: 0 05:40:57 INFO - 2015-12-16 05:40:57,657 INFO : Completed test v8_7 (00:00:40) 05:40:57 INFO - 2015-12-16 05:40:57,742 INFO : Completed test suite (00:20:19) 05:40:57 INFO - 2015-12-16 05:40:57,742 DEBUG : Working with test: dromaeo_css 05:40:57 INFO - 2015-12-16 05:40:57,742 DEBUG : Generating results file: dromaeo_css 05:40:57 INFO - 2015-12-16 05:40:57,743 DEBUG : Working with test: kraken 05:40:57 INFO - 2015-12-16 05:40:57,743 DEBUG : Generating results file: kraken 05:40:57 INFO - 2015-12-16 05:40:57,744 INFO : javascript benchmark 05:40:57 INFO - 2015-12-16 05:40:57,744 DEBUG : Working with test: v8_7 05:40:57 INFO - 2015-12-16 05:40:57,744 DEBUG : Generating results file: v8_7 05:40:57 INFO - 2015-12-16 05:40:57,744 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:40:57 INFO - 2015-12-16 05:40:57,815 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 05:40:57 INFO - 2015-12-16 05:40:57,816 DEBUG : process_Request line: dromaeo_css 6309.99 graph.html#tests=[[72,132,35]] 05:40:57 INFO - 2015-12-16 05:40:57,816 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:40:57 INFO - 2015-12-16 05:40:57,850 DEBUG : process_Request line: kraken 1528.90 graph.html#tests=[[232,132,35]] 05:40:57 INFO - 2015-12-16 05:40:57,850 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:40:57 INFO - 2015-12-16 05:40:57,883 DEBUG : process_Request line: v8_7 19686.20 graph.html#tests=[[230,132,35]] 05:40:57 INFO - 2015-12-16 05:40:57,885 INFO : javascript benchmark 05:40:57 INFO - 2015-12-16 05:40:57,889 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2636.9077082302124, 2720.034387792335, 2727.563589825627, 2736.7536921677033, 2755.2285360099168, 4537.387452693885, 4674.485806561275, 4704.247320428732, 4757.119932812428, 4787.281907713845, 4633.976830115853, 4669.743164125972, 4736.834210802623, 4751.477337492873, 4814.951850481494, 4351.303791393378, 4357.629601483878, 4383.517813040563, 4409.11817636474, 4431.26884064129, 4167.74993500391, 4427.977860110695, 4444.466664000324, 4482.394876691654, 4497.14554234696, 4260.7656578888145, 4325.8485952991805, 4339.696221264513, 4355.412019377391, 4369.322754972953, 4335.934960975588, 4372.5627437256335, 4393.209222339978, 4398.890027749332, 4444.933326000112, 4210.221109094828, 4301.978490107561, 4338.848140315105, 4373.737575745466, 4430.778461076966, 4560.726356418625, 4643.582077613031, 4765.285207218945, 4780.880477988043, 4793.544613261734, 5083.135866902636, 5154.613403994716, 5161.870953226162, 5162.148245539482, 5208.973955130238, 4866.391701037371, 5150.201718733602, 5160.483951604847, 5166.560842328407, 5169.379674439091, 4602.907941841145, 4623.2371658676275, 4664.766761661904, 4746.7389293589185, 4790.616750659939, 5167.9224811627855, 5192.117340052125, 5214.374275087014, 5226.294450249244, 5248.947510524922, 4812.494688057774, 4986.127427700138, 5024.145895197825, 5034.773435195425, 5076.441591425014, 4971.1549036663855, 4998.825041123543, 5000.74996250186, 5072.873178170576, 5094.439611642716, 5015.799368025238, 5046.697198168122, 5049.293098966147, 5050.116229659869, 5089.414717307557, 4818.277258411196, 4994.40067191932, 4995.850124496271, 5000.249962505581, 5002.2496625506465, 4151.356539736345, 4180.017695841475, 4194.727342722713, 4235.512916014636, 4248.490181178278, 3673.8714145004797, 3679.6504332088407, 3697.8520859165333, 3713.3316003119157, 3713.7586056906216, 4345.261305578059, 4376.015396535818, 4386.0569977455, 4388.319810429389, 4414.646828253732, 4905.337779399807, 5013.523715247045, 5018.121828679967, 5019.874503137451, 5119.180931051088, 4375.453068366454, 4391.055922976575, 4430.313301438282, 4462.486814016364, 4469.932951005738, 4524.773761311922, 4529.343245229489, 4531.478879928851, 4543.795529201194, 4577.427821522309, 4632.096741135513, 4746.7863946121815, 4752.025834703877, 4794.928076078932, 4917.164082105979, 5017.096922553976, 5031.245313203049, 5033.194688849767, 5035.496450354935, 5079.136546786981, 4786.042791441656, 4793.185158523129, 4796.184648609675, 4805.519448055166, 4830.1305764961235, 4800.183968725255, 4877.268409738567, 4919.0, 4925.458199598113, 4993.226049962262, 5089.7709603067215, 5115.514026167508, 5116.948830511647, 5122.436531981404, 5161.277421161116, 4931.235658472942, 4932.778024988956, 4934.679245849008, 4934.827281045146, 4938.1358262304675, 4794.95205047959, 4797.088553174885, 4870.634702397405, 4924.581410580141, 4928.852134435972, 4902.877428064185, 4904.068227036852, 4905.3623029006, 4914.8771280718265, 4914.8771280718265, 5031.270745256903, 5033.622478314068, 5036.521530454601, 5067.619928505451, 5082.644214904921, 4599.172149013076, 4758.381410416624, 4784.0192760484715, 4785.353977213032, 4911.115999120193], "unit": "score", "name": "dojo.html", "value": 4644.963440185209}, {"lowerIsBetter": false, "replicates": [564.6668465605295, 569.3424095170077, 571.0435021339256, 574.4571380045859, 575.4935656622172, 25897.22308330751, 36781.44827827581, 37600.24799504008, 37622.62377376226, 37659.43510847336, 41030.58969410305, 41429.58570414295, 41559.16881662365, 41565.0, 41612.375814362735, 7070.469714771387, 7184.245654206312, 7835.0, 8008.399370047241, 8037.919620803805, 10192.541335639915, 10461.163106951426, 10466.319689220176, 10467.319624224401, 10473.528691208914, 9917.355371900803, 9924.851127233062, 9971.302008859382, 9984.950075249613, 9985.600575976952, 7296.927030729677, 7498.1002279726235, 7500.174980752113, 7501.887471687929, 10102.545385457672, 7208.315210055036, 10212.591496340137, 10477.947610261976, 10487.318324308972, 10498.580056797718, 37887.24225515502, 38449.42325865114, 38479.61520384788, 38528.80735596304, 38623.61376386228, 2883.480973424783, 2894.1462268630803, 2910.970890291091, 3582.5163602913535, 3639.331047763125, 29034.709652903413, 29231.707682923112, 29902.102936911928, 29969.40061198764, 30350.696493035008, 3222.548843161959, 3222.6293976192806, 3240.287136829894, 3267.803931764102, 3300.6369299377047, 220728.0, 221014.0, 221369.0, 221371.0, 221942.0, 53187.0, 54402.72798636061, 57359.71320143456, 57900.71049644809, 57915.71042144762, 67614.0, 69161.65419172872, 69203.0, 69219.65390173117, 69332.0, 14688.192149431883, 14754.48359307419, 14866.628334291512, 14909.925450372679, 14988.625284367978, 10630.787384252271, 10640.148788096934, 10645.467726613639, 10646.095081918123, 10651.201159913038, 19336.0, 19496.90861353432, 19527.609447810963, 19621.705674414894, 19647.365237430837, 7339.376153026946, 7475.813104672427, 7487.812804679927, 7582.848343033108, 7603.65783539742, 856.8671855862351, 867.9392442529089, 923.89375221849, 973.6884197057016, 1008.3848852200152, 27238.455230895666, 27348.179554613394, 27417.588736168975, 27612.171634850583, 27623.585646215324, 952.3667654784459, 962.7929995051097, 981.2542467724438, 1093.1254996003165, 1109.4785450838094, 14046.789298160536, 14271.357788899524, 14285.285735713172, 14328.283585820667, 14560.63598410027, 269612.0, 273339.0, 274085.0, 274299.0, 274308.0, 47020.059598807835, 47440.0, 47502.52497474981, 47518.52481475141, 47560.0, 1227.6808029912288, 1231.132051903406, 1236.6290112966074, 1238.4984081447028, 1253.9310337931502, 25931.740682592932, 26447.471050579265, 26802.463950721267, 27183.320416989733, 27191.72808271892, 41769.79115104405, 42236.78881605572, 42240.36639450472, 42243.0, 42247.0, 224088.0, 230175.0, 237160.0, 244765.0, 245497.0, 25466.618000730374, 25509.489810204064, 25521.361965951, 25529.617055743805, 25618.74381256238, 33813.0, 34077.48883766696, 34652.48021279733, 34888.12779680528, 34936.825315873255, 31170.532442013842, 31754.523682144325, 31835.319782644132, 32901.67098328986, 33178.834105829315, 32166.83916580402, 32728.509072363457, 33020.66979330176, 33034.504482433265, 34107.31785364328, 31788.205294867814, 32448.675513244565, 32618.0, 32729.0, 32886.50670239996, 28880.133595992153, 29370.70629293765, 29665.406691866472, 29824.8915476496, 29919.55120673148, 21666.766329805785, 23264.651030234898, 23354.766452335258, 23523.647145293176, 25317.0], "unit": "score", "name": "ext.html", "value": 17335.043645470425}, {"lowerIsBetter": false, "replicates": [323.3855674218984, 327.9294951585409, 332.9417351963406, 335.6827797731142, 338.5733975191258, 12720.55478058268, 13078.476860925552, 14860.702785944288, 15357.155356455405, 16030.557249847512, 9295.628174872996, 9375.6718514852, 9894.802103957916, 9953.601855925754, 12559.309237991907, 4436.245838207513, 4543.204939135655, 4549.090181963604, 4553.408056952608, 4555.74943378114, 3448.931021379571, 3463.878764243252, 4431.1802316571375, 4530.909381812362, 5145.948540514603, 5129.615278854082, 5129.948700513003, 5142.228665700138, 5155.896882062357, 5169.6898186108765, 5150.124478838607, 5163.922541161885, 5713.371529131792, 5736.254286942692, 5736.7992120276, 5057.873553161164, 5071.847844564669, 5087.338645976037, 5088.872778180538, 5091.159958606825, 11170.385628790413, 11178.888211117948, 11203.775924481464, 11204.66386008421, 15332.540023799193, 1711.5806627376248, 1790.7851057873008, 1801.7477553142571, 1810.8913465192131, 1956.2566224834472, 9058.954705226432, 9133.45199288045, 9363.48500832454, 10685.572577096907, 12897.67755806103, 429.4610264118542, 430.54147333090157, 1484.4136566056347, 1700.743077007529, 1772.7252275897256, 51720.22419663708, 54189.729051354494, 56037.1594426088, 56092.43907560913, 56938.430615693724, 9871.901280987242, 9915.504224788732, 9949.950250248847, 9951.502424878727, 10018.599256029824, 12511.249325040526, 12514.436850341757, 12533.93733031329, 12553.0, 12561.811572826415, 6902.516823822385, 6920.550164239308, 6928.688209030605, 6958.02587637721, 7000.299970002959, 6410.358964103646, 6487.0, 6499.09012738217, 6538.673066346663, 6540.9345906541275, 4173.269677806372, 4209.431726716915, 4210.0948296116485, 4233.153369326147, 4242.745435273893, 1549.3802479008486, 1588.3725928258273, 1623.8213796482378, 1627.3490603758592, 1648.5960939569643, 841.2260720137489, 861.6725644255268, 911.3802614222392, 930.5998420679173, 946.0823001688351, 15704.842951570567, 15792.763108553381, 16191.514254572381, 16290.755638665429, 16341.0, 763.2215140556601, 844.4806444036873, 858.5063588436674, 882.8719835623928, 883.1301168349171, 8211.753647390588, 8646.43798153118, 8921.553922303989, 9331.673391431268, 9362.110599493037, 464094.0, 475298.0, 477964.2544681915, 478309.0, 481338.5933070312, 72535.2746472539, 72633.91049134267, 73782.63108684422, 74284.25715742882, 74313.0, 1089.2810744908322, 1100.1583788401879, 1102.9393383363831, 1114.8439218509416, 1117.3798541809374, 14548.709025819213, 14712.852871471148, 14735.0, 14974.401023958919, 15307.540773776804, 33189.368440909784, 33504.16239593932, 33982.83008584941, 34123.31753364869, 34222.14444638904, 43575.0, 43627.781861090494, 43855.0, 44169.0, 44809.775951120035, 8032.4778889372, 8435.45169564001, 8448.408611397143, 8469.491830490191, 8874.556272186235, 10060.49697515136, 10122.746931326776, 10143.34068285559, 13755.518556850462, 15971.361145554049, 13612.319384030561, 14195.432182712575, 14382.712345753236, 14390.85609143895, 14492.637684057983, 13508.797368039684, 13740.587782366545, 13929.58211253664, 13945.930270348583, 13992.0, 11109.333439993627, 11258.099352051653, 11657.53369865196, 13998.300084995913, 14712.411503539739, 8173.754787356389, 8457.36569757283, 8591.957040214758, 8638.395312328077, 8855.557222138996, 13279.070465067352, 13280.468781249028, 13299.80050299227, 13384.93307533456, 13547.932260338635], "unit": "score", "name": "jquery.html", "value": 7885.850969302801}, {"lowerIsBetter": false, "replicates": [1249.5626530714258, 1629.4622774484417, 1706.1469265367316, 1708.495993681864, 1737.930482780688, 5952.107183922414, 6951.617661028641, 7141.535800172998, 7144.857102857953, 7149.42804575634, 6847.212570554375, 7010.158780946281, 7019.7543085992, 7022.052022976896, 7029.0, 1744.3284335530848, 1778.8043315235313, 1778.8932664040135, 2029.1984666056935, 2059.70134330522, 1750.746141809437, 2060.5157787919825, 2117.5764847030578, 2117.87292762434, 2117.904694288753, 1962.7742809576866, 2033.8779673219653, 2039.1945181653239, 2039.3576023552607, 2039.4595432210401, 2021.7169596256535, 2048.9282875099448, 2049.231538173185, 2050.507878109258, 2051.8768873867543, 2064.6283668939586, 2082.6980087887323, 2120.9787902120934, 2122.1617461102933, 2122.352682431858, 7038.401735852459, 7096.432285417154, 7109.8933515997305, 7113.64431778409, 7118.715251389938, 4206.789660516993, 4273.914521709548, 4280.229558679436, 4284.2930916398755, 4292.484901811803, 2694.8248363856287, 2720.9047683331187, 2753.917382478509, 2757.5587905934954, 2761.295869553251, 845.3195177881803, 847.0, 860.2558786649565, 862.2239984014375, 884.5046773806624, 9460.479673617949, 9474.052594740471, 9485.715428537154, 9496.525173741285, 9497.477638729937, 3849.8652547160714, 3901.2392583445953, 3947.8618248361167, 3954.8022598870516, 3959.920801583952, 8197.180281971756, 8202.917970820215, 8208.958955205306, 8211.548364839991, 8215.383846211558, 4279.144171165717, 4283.571642835754, 4287.871363859089, 4288.849890253889, 4295.269804133305, 3868.9226215475533, 3874.554426240962, 3875.7286989910435, 3877.224555088937, 3880.9223815523533, 2954.5568164775455, 3355.614104377979, 3387.458006718913, 3405.523226748257, 3406.7104296135108, 968.2931460034215, 1115.9330440173615, 1132.2187690493697, 1138.7039369763756, 1151.1539018821327, 869.5434896679294, 881.405051590174, 882.298572634757, 896.3814967672286, 928.5032507608397, 6680.699368528428, 6760.628165450948, 6770.796876093725, 6771.762988295386, 6776.08522849409, 1024.3085917005992, 1040.5213601743133, 1050.1703654113317, 1059.7085801404676, 1074.8011617850723, 5325.254464374991, 5339.786408543615, 5347.3583170019065, 5364.168553874156, 5393.110136827379, 8061.072976607648, 8164.67341306353, 8348.165183481724, 8404.705835295736, 8479.364047696448, 8314.41799074059, 8426.283765879969, 8442.57787110642, 8444.240018398374, 8450.408471407065, 6379.649119298483, 6483.0, 6550.410463058348, 6642.136522252076, 6663.666816659244, 6679.0, 6724.49566282521, 6739.629320387426, 6742.93257067423, 6743.865122697421, 7492.138404083382, 7592.544447333178, 7607.809804754926, 7615.200403957505, 7618.200088990798, 7237.095363079615, 7302.050733404623, 7395.334419902235, 7709.6530656119485, 7798.454108212371, 6229.657368844757, 6348.174737284124, 6350.396712312323, 6354.714037868214, 6360.204974378203, 5627.493525582717, 5963.194968679173, 6592.24189218246, 6625.0, 6703.162104736908, 5827.155062515827, 6042.818715438544, 6336.58812177207, 6425.646589437626, 6462.450691691259, 6297.055441683784, 6309.3690630936535, 6316.399942005502, 6398.680065996588, 6404.807855764335, 6385.68071596409, 6429.067785171031, 6433.967830160819, 6475.579087359307, 6476.773312934025, 5975.910361344497, 5992.221011268507, 6003.7898673546215, 6006.939930600638, 6019.638821670714, 5864.354920958605, 5911.497522710446, 5923.763049477972, 5925.644461332334, 5930.318013428511], "unit": "score", "name": "mootools.html", "value": 4046.5097291377724}, {"lowerIsBetter": false, "replicates": [300.7894473868292, 305.4745837160084, 306.789848953467, 307.23192019950125, 308.31553950230494, 5338.652987555811, 5398.298221231239, 5437.836864894055, 5456.154296084103, 5461.044317244487, 5287.0, 5351.919721204175, 5373.059714549958, 5379.6503227290195, 5383.0, 3967.7420967637154, 4175.895602609944, 4181.435506206669, 4191.308434108369, 4204.159168166371, 4013.3979903014633, 4015.1166743316426, 4021.4168945502884, 4070.9185816283657, 4092.283850326196, 4060.3706425504092, 4159.916801663965, 4163.20899029185, 4166.3125584278705, 4170.374443833434, 4133.958660413403, 4140.15126898985, 4149.398337241083, 4149.419081328601, 4169.91660166795, 3464.861405543775, 3535.611082780892, 3599.208174201671, 3666.9633303666888, 3674.8346324415465, 5175.353080864892, 5185.974070129663, 5188.844334669966, 5188.92216616751, 5215.608829337815, 4803.975980120077, 4804.087223427572, 4809.78355973982, 4810.663253572251, 4815.975920120412, 5626.549876009909, 5631.465010824006, 5632.295963004624, 5634.802781902614, 5635.323761148688, 3933.1347103637154, 4005.499312585927, 4023.3361495353233, 4027.7986100694848, 4049.2711311963835, 5938.792142275043, 5939.524838012949, 5942.732577034044, 5942.910856337158, 5948.970255148696, 4152.896177595584, 4157.688173387008, 4161.10536234711, 4163.521195062546, 4164.167166566699, 4176.1230141669985, 4222.915541689211, 4224.366345048267, 4225.68307376948, 4230.280852255124, 4526.275795872644, 4665.626749860071, 4668.3697700810635, 4772.5227477252, 4779.593734532604, 5638.069718496484, 5639.661620302795, 5640.32316122068, 5644.774209031592, 5651.152327150878, 1424.978625320621, 1433.168762117969, 1437.1089924247033, 1439.7408466475924, 1440.5246268731294, 946.8532377481501, 973.8393165127675, 978.3689520259393, 979.0698836105728, 999.205631522941, 4991.276264941635, 4995.575376093, 4999.375078115236, 5006.249062640633, 5009.273655319958, 5891.116332550066, 5892.234009578728, 5894.263217097863, 5894.852628684317, 5899.292084949833, 4982.875428114254, 4995.750212489361, 4999.125153098194, 5004.974975125101, 5006.148954677714, 3108.265773177379, 3147.2603938074535, 3159.0, 3178.7774855760335, 3180.4911214205617, 5395.487428694268, 5463.672179669233, 5535.640183388067, 5568.470995255444, 5577.6653400796085, 6043.153958445821, 6055.061465472859, 6062.333143354227, 6095.817125486243, 6098.32918378978, 5623.100303951348, 5623.634463759842, 5624.971875140598, 5635.408282130481, 5639.43605639441, 5825.70871456434, 5929.703514824328, 5938.376470470711, 5944.851378715393, 5945.464908158287, 5779.450952159538, 5781.335146458043, 5785.710714464344, 5790.594658373873, 5795.304563452412, 5617.606767526234, 5618.634788738719, 5621.4659607337235, 5627.18405831144, 5628.577856660849, 4034.556198818186, 4041.777702226406, 4042.0, 4043.1711499142016, 4045.6358927696647, 5767.8558036049435, 5929.52563794904, 5936.37668044849, 5944.464998150187, 5948.672822994777, 5686.459786320293, 5689.862027594415, 5694.715264236855, 5695.373508914099, 5696.430356964271, 5627.606067575394, 5678.233438485917, 5678.630888992202, 5680.886382272414, 5709.400512946081, 5398.1902714593125, 5574.303212098488, 5580.9441905580425, 5582.469665381782, 5586.245856809279, 5729.627574207663, 5750.539956803529, 5752.68360240174, 5755.223044889054, 5756.7409466574945, 5601.355844077821, 5601.943980560305, 5605.607607467438, 5605.943940560705, 5609.990201763721], "unit": "score", "name": "prototype.html", "value": 4261.967450898962}, {"lowerIsBetter": false, "replicates": [654.3848782144784, 681.7239018197631, 685.143570536829, 759.0701390796273, 767.1101522234206, 11859.881401185996, 12164.452599633016, 12168.878311216886, 12197.512099516009, 12207.328596927166, 11594.826077608843, 11670.0, 11678.941605291982, 11679.649610511698, 11684.941575292112, 635.1552435261092, 643.2249139786546, 803.9477433966803, 817.1991448380561, 822.0669540072001, 814.3241109878816, 814.9062857771344, 821.1747194069951, 821.2813787935556, 822.56404105824, 865.7489328094845, 873.2097451806126, 873.5195642396689, 874.5321253129576, 874.5539774714878, 667.4793660944471, 674.9628770417625, 849.235687880906, 859.4757198109148, 860.6299291304737, 639.9520035997319, 640.1486023588616, 640.7437025189961, 640.7693230437039, 641.0032399618638, 11774.352410617412, 11918.702032449259, 11924.761504769942, 11926.88073119275, 11937.164398492023, 10914.836277455845, 11258.59125769536, 11417.0, 11690.0, 11843.289402635783, 9090.13643703847, 9264.861027084598, 9280.164785169367, 9289.628414863397, 9344.439333639935, 3248.902532924016, 3266.2324353776844, 3290.5393244945726, 3308.106811160973, 3323.3851737428413, 39484.407733884014, 39590.60409395898, 39609.00977475557, 39672.80163599193, 39824.60175398267, 8909.0, 9122.133397327243, 9666.565004574812, 9693.791738807817, 9755.512224388753, 16549.089800060872, 16752.748708769377, 16760.832391676173, 16790.244439000275, 16794.41219557334, 6239.78160764371, 6273.52948528853, 6363.5863668861375, 6402.743890244431, 6428.260750013715, 3453.3438646657055, 3472.8958131256104, 3493.074335301147, 3496.8426420811124, 3536.858525658945, 2452.6934133233344, 2492.1152990688047, 2496.6754321938033, 2497.2383423056144, 2498.4503409249937, 440.90300133970476, 457.94733605635776, 463.46469827349466, 465.0861058021005, 466.3052052441905, 479.6546486529693, 559.3315987395024, 566.8922904648103, 612.4304396910827, 620.8882401167833, 7525.887111693329, 7651.579163145969, 7682.385409167365, 7725.227477252342, 7741.225877412214, 469.6876577076274, 503.13963123059244, 547.9917801232905, 595.1935127901718, 616.808789275326, 3497.2655742294405, 3756.7370284079852, 3792.6207379262405, 3857.363535016747, 3869.709771767072, 47427.525724742314, 47622.76188619104, 48064.75967620209, 48504.75747621239, 48734.51265487371, 44883.32675009877, 45078.32382514265, 45168.548314517095, 45258.54741452609, 45283.320750188774, 39434.80282598569, 40355.394669079986, 40591.0, 48974.75512622414, 49225.50774492281, 8335.166483351617, 8358.791030224293, 8469.61886715087, 8729.825403492021, 8885.644574216958, 30479.847600761856, 30826.845865770527, 31974.840125799223, 32191.839040804647, 33501.497477538345, 36760.26479470342, 38421.4236786454, 38994.6100538991, 39622.40566391564, 39933.80033099816, 10901.727456813644, 10949.671509854717, 10951.123910087015, 10985.231033827555, 11127.554897803997, 11369.602063927723, 11651.41742912868, 11659.591914282959, 11705.414729263332, 11738.823917641414, 10817.56729730802, 10984.450777461256, 11165.16261280391, 11432.256903301259, 11472.827907581226, 10536.683899483029, 10888.401137937173, 11123.555057797921, 11257.549698012315, 11472.139589530985, 10616.256862019893, 10970.341779493256, 10990.285631434252, 11024.338539687324, 11207.159463040467, 9497.905020949702, 9510.046244618215, 9589.822155454114, 9734.9026509734, 10033.1973442123, 8769.254613357936, 8929.866052009094, 9339.08188708856, 9422.0, 9558.522073896416], "unit": "score", "name": "yui.html", "value": 5763.4118759809935}], "name": "dromaeo_css", "value": 6309.988508700932}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 107.0, 111.0, 115.0, 114.0, 103.0, 115.0, 113.0, 105.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [156.0, 139.0, 153.0, 162.0, 133.0, 155.0, 156.0, 130.0, 177.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 159.0, 162.0, 163.0, 162.0, 161.0, 162.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 86.0, 98.0, 71.0, 75.0, 72.0, 113.0, 91.0, 74.0], "unit": "score", "name": "audio-fft", "value": 82.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 128.0, 96.0, 96.0, 95.0, 135.0, 95.0, 95.0, 131.0], "unit": "score", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 73.0, 71.0, 73.0, 72.0, 73.0, 81.0, 70.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 73.1}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 67.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 86.0, 87.0, 86.0, 85.0, 85.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [127.0, 122.0, 124.0, 123.0, 124.0, 127.0, 121.0, 135.0, 127.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.9}, {"lowerIsBetter": true, "replicates": [138.0, 148.0, 147.0, 147.0, 147.0, 134.0, 152.0, 146.0, 160.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.7}, {"lowerIsBetter": true, "replicates": [70.0, 74.0, 70.0, 71.0, 71.0, 69.0, 70.0, 71.0, 68.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1528.9000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.89250165892503], "unit": "score", "name": "Richards", "value": 212.80045599999988}, {"lowerIsBetter": false, "replicates": [186.28912071535024], "unit": "score", "name": "DeltaBlue", "value": 354.92142400000006}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5122.448979591837], "unit": "score", "name": "Decrypt", "value": 51.96362151394425}, {"lowerIsBetter": false, "replicates": [2028.3975659229209], "unit": "score", "name": "RayTrace", "value": 364.8145770000001}, {"lowerIsBetter": false, "replicates": [789.8894154818325], "unit": "score", "name": "Earley", "value": 843.7421580000001}, {"lowerIsBetter": false, "replicates": [12530.864197530864], "unit": "score", "name": "Boyer", "value": 53.185717241379315}, {"lowerIsBetter": false, "replicates": [27378.37837837838], "unit": "score", "name": "RegExp", "value": 33.27388450148074}, {"lowerIsBetter": false, "replicates": [608.6427267194157], "unit": "score", "name": "Splay", "value": 133.88971299999997}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19686.199240669284}]} 05:40:57 INFO - RETURN: dromaeo_css: 6309.99 05:40:57 INFO - RETURN: kraken: 1528.90 05:40:57 INFO - RETURN: v8_7: 19686.20 05:40:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19686.20"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1528.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6309.99"}}} 05:40:57 INFO - Return code: 0 05:40:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:40:58 ERROR - # TBPL SUCCESS # 05:40:58 INFO - Running post-action listener: _resource_record_post_action 05:40:58 INFO - Running post-run listener: _resource_record_post_run 05:40:59 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 520220672; Read time: 8; Write time: 644452 05:40:59 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 246587392; Read time: 0; Write time: 451472 05:40:59 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273633280; Read time: 8; Write time: 192980 05:40:59 INFO - Running post-run listener: _upload_blobber_files 05:40:59 INFO - Blob upload gear active. 05:40:59 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:40:59 INFO - Copying logs to upload dir... 05:40:59 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.125626 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-16 05:40:58.556695) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 05:40:58.560609) ========= 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=1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010005 build_url: 'https://queue.taskcluster.net/v1/task/ANpTl2gpRymqbyq130qVZg/artifacts/public/build/firefox-46.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-16 05:40:58.612241) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:40:58.612618) ========= 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=1d09c2d9237d126f9c84bbb400000198-1450271989.173721-3794451 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 05:40:58.662046) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 05:40:58.662369) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 05:40:58.662715) ========= ========= Total master_lag: 0.22 =========