builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1448651793.38 results: success (0) buildid: 20151127103731 builduid: 3f081eb818b04624a3a075611ac903f2 revision: f48352b311eb120a09347efce60ae9045401858c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-27 11:16:33.377538) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-27 11:16:33.377951) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-27 11:16:33.378264) ========= 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=6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.009257 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-27 11:16:33.419249) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-27 11:16:33.419575) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-27 11:16:33.719794) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 11:16:33.720269) ========= 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=6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004124 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 11:16:33.777383) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-27 11:16:33.777750) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-27 11:16:33.778133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 11:16:33.778511) ========= 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=6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-27 11:16:33-- 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% 43.0M=0s 2015-11-27 11:16:34 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149909 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 11:16:33.953289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 11:16:33.953632) ========= 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=6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015193 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 11:16:34.004299) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 11:16:34.004689) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f48352b311eb120a09347efce60ae9045401858c --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 f48352b311eb120a09347efce60ae9045401858c --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=6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-27 11:16:34,218 truncating revision to first 12 chars 2015-11-27 11:16:34,218 Setting DEBUG logging. 2015-11-27 11:16:34,218 attempt 1/10 2015-11-27 11:16:34,218 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f48352b311eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-27 11:16:34,535 unpacking tar archive at: fx-team-f48352b311eb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649372 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 11:16:34.667538) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-27 11:16:34.667891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-27 11:16:34.678017) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-27 11:16:34.678401) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-27 11:16:34.678863) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-27 11:16:34.679180) ========= /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=6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:16:34 INFO - MultiFileLogger online at 20151127 11:16:34 in /builds/slave/test 11:16:34 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 11:16:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:16:34 INFO - {'append_to_log': False, 11:16:34 INFO - 'base_work_dir': '/builds/slave/test', 11:16:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:16:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:16:34 INFO - 'branch': 'Fx-Team-Non-PGO', 11:16:34 INFO - 'buildbot_json_path': 'buildprops.json', 11:16:34 INFO - 'config_files': ('talos/linux_config.py',), 11:16:34 INFO - 'default_actions': ('clobber', 11:16:34 INFO - 'read-buildbot-config', 11:16:34 INFO - 'download-and-extract', 11:16:34 INFO - 'populate-webroot', 11:16:34 INFO - 'create-virtualenv', 11:16:34 INFO - 'install', 11:16:34 INFO - 'run-tests'), 11:16:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:16:34 INFO - 'download_minidump_stackwalk': True, 11:16:34 INFO - 'download_symbols': 'ondemand', 11:16:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:16:34 INFO - 'tooltool.py': '/tools/tooltool.py', 11:16:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:16:34 INFO - '/tools/misc-python/virtualenv.py')}, 11:16:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:16:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:16:34 INFO - 'installer_path': 'installer.exe', 11:16:34 INFO - 'log_level': 'info', 11:16:34 INFO - 'log_name': 'talos', 11:16:34 INFO - 'log_to_console': True, 11:16:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:16:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:16:34 INFO - 'opt_config_files': (), 11:16:34 INFO - 'pip_index': False, 11:16:34 INFO - 'sps_profile': False, 11:16:34 INFO - 'sps_profile_interval': 0, 11:16:34 INFO - 'suite': 'dromaeojs', 11:16:34 INFO - 'system_bits': '64', 11:16:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:16:34 INFO - 'title': 'talos-linux64-ix-018', 11:16:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:16:34 INFO - 'use_talos_json': True, 11:16:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:16:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:16:34 INFO - 'work_dir': 'build'} 11:16:34 INFO - ##### 11:16:34 INFO - ##### Running clobber step. 11:16:34 INFO - ##### 11:16:34 INFO - Running pre-action listener: _resource_record_pre_action 11:16:34 INFO - Running main action method: clobber 11:16:34 INFO - rmtree: /builds/slave/test/build 11:16:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:16:35 INFO - Running post-action listener: _resource_record_post_action 11:16:35 INFO - ##### 11:16:35 INFO - ##### Running read-buildbot-config step. 11:16:35 INFO - ##### 11:16:35 INFO - Running pre-action listener: _resource_record_pre_action 11:16:35 INFO - Running main action method: read_buildbot_config 11:16:35 INFO - Using buildbot properties: 11:16:35 INFO - { 11:16:35 INFO - "properties": { 11:16:35 INFO - "buildnumber": 939, 11:16:35 INFO - "product": "firefox", 11:16:35 INFO - "script_repo_revision": "production", 11:16:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:16:35 INFO - "repository": "", 11:16:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:16:35 INFO - "buildid": "20151127103731", 11:16:35 INFO - "slavename": "talos-linux64-ix-018", 11:16:35 INFO - "pgo_build": "False", 11:16:35 INFO - "basedir": "/builds/slave/test", 11:16:35 INFO - "project": "", 11:16:35 INFO - "platform": "ubuntu64_hw", 11:16:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:16:35 INFO - "slavebuilddir": "test", 11:16:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:16:35 INFO - "branch": "fx-team", 11:16:35 INFO - "repo_path": "integration/fx-team", 11:16:35 INFO - "stage_platform": "linux64", 11:16:35 INFO - "builduid": "3f081eb818b04624a3a075611ac903f2", 11:16:35 INFO - "revision": "f48352b311eb120a09347efce60ae9045401858c" 11:16:35 INFO - }, 11:16:35 INFO - "sourcestamp": { 11:16:35 INFO - "repository": "", 11:16:35 INFO - "hasPatch": false, 11:16:35 INFO - "project": "", 11:16:35 INFO - "branch": "fx-team-linux64-talos", 11:16:35 INFO - "changes": [ 11:16:35 INFO - { 11:16:35 INFO - "category": null, 11:16:35 INFO - "files": [ 11:16:35 INFO - { 11:16:35 INFO - "url": null, 11:16:35 INFO - "name": "https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 11:16:35 INFO - } 11:16:35 INFO - ], 11:16:35 INFO - "repository": "", 11:16:35 INFO - "rev": "f48352b311eb120a09347efce60ae9045401858c", 11:16:35 INFO - "who": "mbanner@mozilla.com", 11:16:35 INFO - "when": 1448651775, 11:16:35 INFO - "number": 6715644, 11:16:35 INFO - "comments": "Backout changeset 958669938c10 / bug 1225832 due to frequent mochitest failures on Mac", 11:16:35 INFO - "project": "", 11:16:35 INFO - "at": "Fri 27 Nov 2015 11:16:15", 11:16:35 INFO - "branch": "fx-team-linux64-talos", 11:16:35 INFO - "revlink": "", 11:16:35 INFO - "properties": [ 11:16:35 INFO - [ 11:16:35 INFO - "buildid", 11:16:35 INFO - "20151127103731", 11:16:35 INFO - "Change" 11:16:35 INFO - ], 11:16:35 INFO - [ 11:16:35 INFO - "builduid", 11:16:35 INFO - "3f081eb818b04624a3a075611ac903f2", 11:16:35 INFO - "Change" 11:16:35 INFO - ], 11:16:35 INFO - [ 11:16:35 INFO - "pgo_build", 11:16:35 INFO - "False", 11:16:35 INFO - "Change" 11:16:35 INFO - ] 11:16:35 INFO - ], 11:16:35 INFO - "revision": "f48352b311eb120a09347efce60ae9045401858c" 11:16:35 INFO - } 11:16:35 INFO - ], 11:16:35 INFO - "revision": "f48352b311eb120a09347efce60ae9045401858c" 11:16:35 INFO - } 11:16:35 INFO - } 11:16:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 11:16:35 INFO - Running post-action listener: _resource_record_post_action 11:16:35 INFO - ##### 11:16:35 INFO - ##### Running download-and-extract step. 11:16:35 INFO - ##### 11:16:35 INFO - Running pre-action listener: _resource_record_pre_action 11:16:35 INFO - Running main action method: download_and_extract 11:16:35 INFO - mkdir: /builds/slave/test/build/tests 11:16:35 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')]} 11:16:35 INFO - https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:16:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/test_packages.json 11:16:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/test_packages.json 11:16:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:16:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:16:37 INFO - Downloaded 1302 bytes. 11:16:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:16:37 INFO - Using the following test package requirements: 11:16:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:16:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:16:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:37 INFO - u'jsshell-linux-x86_64.zip'], 11:16:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:16:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:16:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:16:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:16:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:16:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:16:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:16:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:16:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:37 INFO - https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:16:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:16:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:16:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:16:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:16:38 INFO - Downloaded 21517181 bytes. 11:16:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:16:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:16:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:16:39 INFO - Return code: 0 11:16:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:39 INFO - https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:16:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:16:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:16:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:16:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:16:40 INFO - Downloaded 21517181 bytes. 11:16:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:16:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:16:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:16:41 INFO - Return code: 0 11:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:41 INFO - https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:16:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:16:43 INFO - Downloaded 11131728 bytes. 11:16:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 11:16:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:16:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:16:43 INFO - Return code: 0 11:16:43 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')]} 11:16:43 INFO - https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:16:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:16:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:16:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:16:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:16:44 INFO - Downloaded 56872327 bytes. 11:16:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:16:44 INFO - mkdir: /builds/slave/test/properties 11:16:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:16:44 INFO - Writing to file /builds/slave/test/properties/build_url 11:16:44 INFO - Contents: 11:16:44 INFO - build_url:https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:16:44 INFO - Running post-action listener: _resource_record_post_action 11:16:44 INFO - Running post-action listener: set_extra_try_arguments 11:16:44 INFO - ##### 11:16:44 INFO - ##### Running populate-webroot step. 11:16:44 INFO - ##### 11:16:44 INFO - Running pre-action listener: _resource_record_pre_action 11:16:44 INFO - Running main action method: populate_webroot 11:16:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:16:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:16:44 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 11:16:44 INFO - '../fennec_ids.txt'], 11:16:44 INFO - 'tests': ['tcheck2']}, 11:16:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:16:44 INFO - '--tppagecycles', 11:16:44 INFO - '7'], 11:16:44 INFO - 'tests': ['tsvgm']}}, 11:16:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:16:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:16:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:16:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:16:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:16:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:16:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'talos_options': ['--e10s'], 11:16:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:16:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'tests': ['damp', 'tps']}, 11:16:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'talos_options': ['--e10s'], 11:16:44 INFO - 'tests': ['damp', 'tps']}, 11:16:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:16:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:16:44 INFO - 'other': {'tests': ['a11yr', 11:16:44 INFO - 'ts_paint', 11:16:44 INFO - 'tpaint', 11:16:44 INFO - 'sessionrestore', 11:16:44 INFO - 'sessionrestore_no_auto_restore']}, 11:16:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:16:44 INFO - 'tests': ['a11yr', 11:16:44 INFO - 'ts_paint', 11:16:44 INFO - 'tpaint', 11:16:44 INFO - 'sessionrestore', 11:16:44 INFO - 'sessionrestore_no_auto_restore']}, 11:16:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:16:44 INFO - 'tests': ['a11yr', 11:16:44 INFO - 'ts_paint', 11:16:44 INFO - 'tpaint', 11:16:44 INFO - 'sessionrestore', 11:16:44 INFO - 'sessionrestore_no_auto_restore']}, 11:16:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:16:44 INFO - 'tests': ['a11yr', 11:16:44 INFO - 'ts_paint', 11:16:44 INFO - 'tpaint', 11:16:44 INFO - 'sessionrestore', 11:16:44 INFO - 'sessionrestore_no_auto_restore']}, 11:16:44 INFO - 'other_l64': {'tests': ['a11yr', 11:16:44 INFO - 'ts_paint', 11:16:44 INFO - 'tpaint', 11:16:44 INFO - 'sessionrestore', 11:16:44 INFO - 'sessionrestore_no_auto_restore']}, 11:16:44 INFO - 'other_nol64': {'tests': ['a11yr', 11:16:44 INFO - 'ts_paint', 11:16:44 INFO - 'tpaint', 11:16:44 INFO - 'sessionrestore', 11:16:44 INFO - 'sessionrestore_no_auto_restore']}, 11:16:44 INFO - 'svgr': {'tests': ['tsvgx', 11:16:44 INFO - 'tsvgr_opacity', 11:16:44 INFO - 'tart', 11:16:44 INFO - 'tscrollx', 11:16:44 INFO - 'cart']}, 11:16:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:16:44 INFO - 'tests': ['tsvgx', 11:16:44 INFO - 'tsvgr_opacity', 11:16:44 INFO - 'tart', 11:16:44 INFO - 'tscrollx', 11:16:44 INFO - 'cart']}, 11:16:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'tests': ['tp5o']}, 11:16:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'talos_options': ['--e10s'], 11:16:44 INFO - 'tests': ['tp5o']}, 11:16:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'talos_options': ['--xperf_path', 11:16:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:44 INFO - 'tests': ['tp5n']}, 11:16:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:16:44 INFO - 'talos_options': ['--e10s', 11:16:44 INFO - '--xperf_path', 11:16:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:16:44 INFO - 'tests': ['tp5n']}}, 11:16:44 INFO - 'talos.zip': {'path': '', 11:16:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:16:44 INFO - Running post-action listener: _resource_record_post_action 11:16:44 INFO - ##### 11:16:44 INFO - ##### Running create-virtualenv step. 11:16:44 INFO - ##### 11:16:44 INFO - Running pre-action listener: _resource_record_pre_action 11:16:44 INFO - Running main action method: create_virtualenv 11:16:44 INFO - Creating virtualenv /builds/slave/test/build/venv 11:16:44 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 11:16:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:16:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:16:44 INFO - Using real prefix '/usr' 11:16:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:16:45 INFO - Installing distribute.............................................................................................................................................................................................done. 11:16:47 INFO - Installing pip.................done. 11:16:47 INFO - Return code: 0 11:16:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:16:47 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')]} 11:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:47 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')]} 11:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:47 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 0x7f3e3ac11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28650b0>, '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 0x2865fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866440>, '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': '6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842', '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 11:16:47 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 11:16:47 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 11:16:47 INFO - Using env: {'DISPLAY': ':0', 11:16:47 INFO - 'HOME': '/home/cltbld', 11:16:47 INFO - 'LANG': 'en_US.UTF-8', 11:16:47 INFO - 'LANGUAGE': 'en_US:en', 11:16:47 INFO - 'LOGNAME': 'cltbld', 11:16:47 INFO - 'MAIL': '/var/mail/cltbld', 11:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:47 INFO - 'MOZ_NO_REMOTE': '1', 11:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:47 INFO - 'NO_EM_RESTART': '1', 11:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:47 INFO - 'PWD': '/builds/slave/test', 11:16:47 INFO - 'SHELL': '/bin/bash', 11:16:47 INFO - 'SHLVL': '1', 11:16:47 INFO - 'TERM': 'linux', 11:16:47 INFO - 'TMOUT': '86400', 11:16:47 INFO - 'USER': 'cltbld', 11:16:47 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842', 11:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:47 INFO - '_': '/tools/buildbot/bin/python'} 11:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:47 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 11:16:47 INFO - Cleaning up... 11:16:47 INFO - Return code: 0 11:16:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:16:47 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')]} 11:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:47 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')]} 11:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:47 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 0x7f3e3ac11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28650b0>, '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 0x2865fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866440>, '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': '6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842', '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 11:16:47 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 11:16:47 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 11:16:47 INFO - Using env: {'DISPLAY': ':0', 11:16:47 INFO - 'HOME': '/home/cltbld', 11:16:47 INFO - 'LANG': 'en_US.UTF-8', 11:16:47 INFO - 'LANGUAGE': 'en_US:en', 11:16:47 INFO - 'LOGNAME': 'cltbld', 11:16:47 INFO - 'MAIL': '/var/mail/cltbld', 11:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:47 INFO - 'MOZ_NO_REMOTE': '1', 11:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:47 INFO - 'NO_EM_RESTART': '1', 11:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:47 INFO - 'PWD': '/builds/slave/test', 11:16:47 INFO - 'SHELL': '/bin/bash', 11:16:47 INFO - 'SHLVL': '1', 11:16:47 INFO - 'TERM': 'linux', 11:16:47 INFO - 'TMOUT': '86400', 11:16:47 INFO - 'USER': 'cltbld', 11:16:47 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842', 11:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:47 INFO - '_': '/tools/buildbot/bin/python'} 11:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:47 INFO - Downloading/unpacking psutil>=0.7.1 11:16:47 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 11:16:47 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 11:16:47 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 11:16:47 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 11:16:47 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 11:16:47 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 11:16:49 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:16:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:16:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:16:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:49 INFO - Installing collected packages: psutil 11:16:49 INFO - Running setup.py install for psutil 11:16:49 INFO - building 'psutil._psutil_linux' extension 11:16:49 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 11:16:49 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 11:16:49 INFO - building 'psutil._psutil_posix' extension 11:16:49 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 11:16:49 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 11:16:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:50 INFO - Successfully installed psutil 11:16:50 INFO - Cleaning up... 11:16:50 INFO - Return code: 0 11:16:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:16:50 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')]} 11:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:50 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')]} 11:16:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:50 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 0x7f3e3ac11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28650b0>, '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 0x2865fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866440>, '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': '6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842', '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 11:16:50 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 11:16:50 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 11:16:50 INFO - Using env: {'DISPLAY': ':0', 11:16:50 INFO - 'HOME': '/home/cltbld', 11:16:50 INFO - 'LANG': 'en_US.UTF-8', 11:16:50 INFO - 'LANGUAGE': 'en_US:en', 11:16:50 INFO - 'LOGNAME': 'cltbld', 11:16:50 INFO - 'MAIL': '/var/mail/cltbld', 11:16:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:50 INFO - 'MOZ_NO_REMOTE': '1', 11:16:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:50 INFO - 'NO_EM_RESTART': '1', 11:16:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:50 INFO - 'PWD': '/builds/slave/test', 11:16:50 INFO - 'SHELL': '/bin/bash', 11:16:50 INFO - 'SHLVL': '1', 11:16:50 INFO - 'TERM': 'linux', 11:16:50 INFO - 'TMOUT': '86400', 11:16:50 INFO - 'USER': 'cltbld', 11:16:50 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842', 11:16:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:50 INFO - '_': '/tools/buildbot/bin/python'} 11:16:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:16:50 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 11:16:50 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 11:16:50 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 11:16:50 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 11:16:50 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 11:16:50 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 11:16:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:16:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:16:52 INFO - Installing collected packages: mozsystemmonitor 11:16:52 INFO - Running setup.py install for mozsystemmonitor 11:16:52 INFO - Successfully installed mozsystemmonitor 11:16:52 INFO - Cleaning up... 11:16:52 INFO - Return code: 0 11:16:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:16: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')]} 11:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16: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')]} 11:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:52 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 0x7f3e3ac11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28650b0>, '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 0x2865fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866440>, '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': '6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842', '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 11:16:52 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 11:16:52 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 11:16:52 INFO - Using env: {'DISPLAY': ':0', 11:16:52 INFO - 'HOME': '/home/cltbld', 11:16:52 INFO - 'LANG': 'en_US.UTF-8', 11:16:52 INFO - 'LANGUAGE': 'en_US:en', 11:16:52 INFO - 'LOGNAME': 'cltbld', 11:16:52 INFO - 'MAIL': '/var/mail/cltbld', 11:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:52 INFO - 'MOZ_NO_REMOTE': '1', 11:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:52 INFO - 'NO_EM_RESTART': '1', 11:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:52 INFO - 'PWD': '/builds/slave/test', 11:16:52 INFO - 'SHELL': '/bin/bash', 11:16:52 INFO - 'SHLVL': '1', 11:16:52 INFO - 'TERM': 'linux', 11:16:52 INFO - 'TMOUT': '86400', 11:16:52 INFO - 'USER': 'cltbld', 11:16:52 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842', 11:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:52 INFO - '_': '/tools/buildbot/bin/python'} 11:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:52 INFO - Downloading/unpacking blobuploader==1.2.4 11:16:52 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 11:16:52 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 11:16:52 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 11:16:52 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 11:16:52 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 11:16:52 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 11:16:54 INFO - Downloading blobuploader-1.2.4.tar.gz 11:16:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:16:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:16:54 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 11:16:54 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 11:16:54 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 11:16:54 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 11:16:54 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 11:16:54 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 11:16:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:16:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:16:54 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 11:16:54 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 11:16:54 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 11:16:54 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 11:16:54 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 11:16:54 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 11:16:54 INFO - Downloading docopt-0.6.1.tar.gz 11:16:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:16:54 INFO - Installing collected packages: blobuploader, requests, docopt 11:16:54 INFO - Running setup.py install for blobuploader 11:16:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:16:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:16:54 INFO - Running setup.py install for requests 11:16:55 INFO - Running setup.py install for docopt 11:16:55 INFO - Successfully installed blobuploader requests docopt 11:16:55 INFO - Cleaning up... 11:16:55 INFO - Return code: 0 11:16:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:55 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')]} 11:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:55 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')]} 11:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:55 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 0x7f3e3ac11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28650b0>, '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 0x2865fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866440>, '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': '6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842', '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 11:16:55 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 11:16:55 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 11:16:55 INFO - Using env: {'DISPLAY': ':0', 11:16:55 INFO - 'HOME': '/home/cltbld', 11:16:55 INFO - 'LANG': 'en_US.UTF-8', 11:16:55 INFO - 'LANGUAGE': 'en_US:en', 11:16:55 INFO - 'LOGNAME': 'cltbld', 11:16:55 INFO - 'MAIL': '/var/mail/cltbld', 11:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:55 INFO - 'MOZ_NO_REMOTE': '1', 11:16:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:55 INFO - 'NO_EM_RESTART': '1', 11:16:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:55 INFO - 'PWD': '/builds/slave/test', 11:16:55 INFO - 'SHELL': '/bin/bash', 11:16:55 INFO - 'SHLVL': '1', 11:16:55 INFO - 'TERM': 'linux', 11:16:55 INFO - 'TMOUT': '86400', 11:16:55 INFO - 'USER': 'cltbld', 11:16:55 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842', 11:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:55 INFO - '_': '/tools/buildbot/bin/python'} 11:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:16:55 INFO - Running setup.py (path:/tmp/pip-MbBi3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:16:55 INFO - Running setup.py (path:/tmp/pip-u641dW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:16:55 INFO - Running setup.py (path:/tmp/pip-nXSalq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:16:55 INFO - Running setup.py (path:/tmp/pip-CBl98r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:16:55 INFO - Running setup.py (path:/tmp/pip-4XFPWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:16:55 INFO - Running setup.py (path:/tmp/pip-vM4OzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:16:55 INFO - Running setup.py (path:/tmp/pip-6fQuvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:16:56 INFO - Running setup.py (path:/tmp/pip-OOwjyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:16:56 INFO - Running setup.py (path:/tmp/pip-2pp8AK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:16:56 INFO - Running setup.py (path:/tmp/pip-Do9jy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:16:56 INFO - Running setup.py (path:/tmp/pip-jS1fvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:16:56 INFO - Running setup.py (path:/tmp/pip-UmQF5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:16:56 INFO - Running setup.py (path:/tmp/pip-gg_n__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:16:56 INFO - Running setup.py (path:/tmp/pip-GWvnzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:56 INFO - Running setup.py (path:/tmp/pip-6tRn5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:16:56 INFO - Running setup.py (path:/tmp/pip-3Y9qfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:16:56 INFO - Running setup.py (path:/tmp/pip-UTHJVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:16:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:16:56 INFO - Running setup.py install for manifestparser 11:16:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:16:56 INFO - Running setup.py install for mozcrash 11:16:56 INFO - Running setup.py install for mozdebug 11:16:57 INFO - Running setup.py install for mozdevice 11:16:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:16:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:16:57 INFO - Running setup.py install for mozfile 11:16:57 INFO - Running setup.py install for mozhttpd 11:16:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:16:57 INFO - Running setup.py install for mozinfo 11:16:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:16:57 INFO - Running setup.py install for mozInstall 11:16:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:16:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:16:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:16:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:16:57 INFO - Running setup.py install for mozleak 11:16:57 INFO - Running setup.py install for mozlog 11:16:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:16:57 INFO - Running setup.py install for moznetwork 11:16:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:16:57 INFO - Running setup.py install for mozprocess 11:16:57 INFO - Running setup.py install for mozprofile 11:16:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:16:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:16:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:16:58 INFO - Running setup.py install for mozrunner 11:16:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:16:58 INFO - Running setup.py install for mozscreenshot 11:16:58 INFO - Running setup.py install for moztest 11:16:58 INFO - Running setup.py install for mozversion 11:16:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:16:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:16:58 INFO - Cleaning up... 11:16:58 INFO - Return code: 0 11:16:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:16:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f3e3ac11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28650b0>, '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 0x2865fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866440>, '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': '6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842', '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 11:16:58 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 11:16:58 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 11:16:58 INFO - Using env: {'DISPLAY': ':0', 11:16:58 INFO - 'HOME': '/home/cltbld', 11:16:58 INFO - 'LANG': 'en_US.UTF-8', 11:16:58 INFO - 'LANGUAGE': 'en_US:en', 11:16:58 INFO - 'LOGNAME': 'cltbld', 11:16:58 INFO - 'MAIL': '/var/mail/cltbld', 11:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:58 INFO - 'MOZ_NO_REMOTE': '1', 11:16:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:58 INFO - 'NO_EM_RESTART': '1', 11:16:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:58 INFO - 'PWD': '/builds/slave/test', 11:16:58 INFO - 'SHELL': '/bin/bash', 11:16:58 INFO - 'SHLVL': '1', 11:16:58 INFO - 'TERM': 'linux', 11:16:58 INFO - 'TMOUT': '86400', 11:16:58 INFO - 'USER': 'cltbld', 11:16:58 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842', 11:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:58 INFO - '_': '/tools/buildbot/bin/python'} 11:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:16:58 INFO - Running setup.py (path:/tmp/pip-JnVqXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:16:58 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)) 11:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:16:58 INFO - Running setup.py (path:/tmp/pip-QaEfoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:16:58 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)) 11:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:16:58 INFO - Running setup.py (path:/tmp/pip-1NVRPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:16:58 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)) 11:16:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:16:58 INFO - Running setup.py (path:/tmp/pip-NgE_Ve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:16:59 INFO - Running setup.py (path:/tmp/pip-phRGz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:16:59 INFO - Running setup.py (path:/tmp/pip-XDBXZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:16:59 INFO - Running setup.py (path:/tmp/pip-BipSnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:16:59 INFO - Running setup.py (path:/tmp/pip-eghR1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:16:59 INFO - Running setup.py (path:/tmp/pip-IMY_Cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:16:59 INFO - Running setup.py (path:/tmp/pip-rdFu1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:16:59 INFO - Running setup.py (path:/tmp/pip-0nupk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:16:59 INFO - Running setup.py (path:/tmp/pip-G0FlyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:16:59 INFO - Running setup.py (path:/tmp/pip-mLnK49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:16:59 INFO - Running setup.py (path:/tmp/pip-4dFlqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:59 INFO - Running setup.py (path:/tmp/pip-SgRhR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:16:59 INFO - Running setup.py (path:/tmp/pip-ixvqIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:16:59 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)) 11:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:16:59 INFO - Running setup.py (path:/tmp/pip-879PBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:16:59 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)) 11:16:59 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)) 11:16:59 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)) 11:16:59 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)) 11:16:59 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)) 11:16:59 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)) 11:16:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:01 INFO - Downloading blessings-1.5.1.tar.gz 11:17:01 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 11:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:17:01 INFO - Installing collected packages: blessings 11:17:01 INFO - Running setup.py install for blessings 11:17:01 INFO - Successfully installed blessings 11:17:01 INFO - Cleaning up... 11:17:01 INFO - Return code: 0 11:17:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:17:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:02 INFO - Reading from file tmpfile_stdout 11:17:02 INFO - Current package versions: 11:17:02 INFO - argparse == 1.2.1 11:17:02 INFO - blessings == 1.5.1 11:17:02 INFO - blobuploader == 1.2.4 11:17:02 INFO - docopt == 0.6.1 11:17:02 INFO - manifestparser == 1.1 11:17:02 INFO - mozInstall == 1.12 11:17:02 INFO - mozcrash == 0.16 11:17:02 INFO - mozdebug == 0.1 11:17:02 INFO - mozdevice == 0.47 11:17:02 INFO - mozfile == 1.2 11:17:02 INFO - mozhttpd == 0.7 11:17:02 INFO - mozinfo == 0.9 11:17:02 INFO - mozleak == 0.1 11:17:02 INFO - mozlog == 3.1 11:17:02 INFO - moznetwork == 0.27 11:17:02 INFO - mozprocess == 0.22 11:17:02 INFO - mozprofile == 0.27 11:17:02 INFO - mozrunner == 6.11 11:17:02 INFO - mozscreenshot == 0.1 11:17:02 INFO - mozsystemmonitor == 0.0 11:17:02 INFO - moztest == 0.7 11:17:02 INFO - mozversion == 1.4 11:17:02 INFO - psutil == 3.1.1 11:17:02 INFO - requests == 1.2.3 11:17:02 INFO - wsgiref == 0.1.2 11:17:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:02 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')]} 11:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:02 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')]} 11:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:02 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 0x7f3e3ac11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28650b0>, '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 0x2865fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866440>, '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': '6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842', '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 11:17:02 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 11:17:02 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 11:17:02 INFO - Using env: {'DISPLAY': ':0', 11:17:02 INFO - 'HOME': '/home/cltbld', 11:17:02 INFO - 'LANG': 'en_US.UTF-8', 11:17:02 INFO - 'LANGUAGE': 'en_US:en', 11:17:02 INFO - 'LOGNAME': 'cltbld', 11:17:02 INFO - 'MAIL': '/var/mail/cltbld', 11:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:02 INFO - 'MOZ_NO_REMOTE': '1', 11:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:02 INFO - 'NO_EM_RESTART': '1', 11:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:02 INFO - 'PWD': '/builds/slave/test', 11:17:02 INFO - 'SHELL': '/bin/bash', 11:17:02 INFO - 'SHLVL': '1', 11:17:02 INFO - 'TERM': 'linux', 11:17:02 INFO - 'TMOUT': '86400', 11:17:02 INFO - 'USER': 'cltbld', 11:17:02 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842', 11:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:02 INFO - '_': '/tools/buildbot/bin/python'} 11:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 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)) 11:17:02 INFO - Cleaning up... 11:17:02 INFO - Return code: 0 11:17:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:17:02 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')]} 11:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:02 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')]} 11:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17:02 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 0x7f3e3ac11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28650b0>, '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 0x2865fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866440>, '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': '6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842', '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 11:17:02 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 11:17:02 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 11:17:02 INFO - Using env: {'DISPLAY': ':0', 11:17:02 INFO - 'HOME': '/home/cltbld', 11:17:02 INFO - 'LANG': 'en_US.UTF-8', 11:17:02 INFO - 'LANGUAGE': 'en_US:en', 11:17:02 INFO - 'LOGNAME': 'cltbld', 11:17:02 INFO - 'MAIL': '/var/mail/cltbld', 11:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:02 INFO - 'MOZ_NO_REMOTE': '1', 11:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:02 INFO - 'NO_EM_RESTART': '1', 11:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:02 INFO - 'PWD': '/builds/slave/test', 11:17:02 INFO - 'SHELL': '/bin/bash', 11:17:02 INFO - 'SHLVL': '1', 11:17:02 INFO - 'TERM': 'linux', 11:17:02 INFO - 'TMOUT': '86400', 11:17:02 INFO - 'USER': 'cltbld', 11:17:02 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842', 11:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:02 INFO - '_': '/tools/buildbot/bin/python'} 11:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:02 INFO - Downloading/unpacking jsonschema 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:17:04 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 11:17:04 INFO - Downloading/unpacking functools32 (from jsonschema) 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17:04 INFO - Downloading functools32-3.2.3-2.tar.gz 11:17:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:17:04 INFO - warning: no files found matching '*.txt' 11:17:04 INFO - no previously-included directories found matching 'build' 11:17:04 INFO - no previously-included directories found matching 'dist' 11:17:04 INFO - no previously-included directories found matching '.git*' 11:17:04 INFO - Installing collected packages: jsonschema, functools32 11:17:04 INFO - Running setup.py install for functools32 11:17:04 INFO - warning: no files found matching '*.txt' 11:17:04 INFO - no previously-included directories found matching 'build' 11:17:04 INFO - no previously-included directories found matching 'dist' 11:17:04 INFO - no previously-included directories found matching '.git*' 11:17:04 INFO - Successfully installed jsonschema functools32 11:17:04 INFO - Cleaning up... 11:17:04 INFO - Return code: 0 11:17:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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')]} 11:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:17: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e3ac11f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27088a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28650b0>, '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 0x2865fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866440>, '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': '6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842', '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 11:17: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', 'flake8'] in /builds/slave/test/build 11:17: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 flake8 11:17:04 INFO - Using env: {'DISPLAY': ':0', 11:17:04 INFO - 'HOME': '/home/cltbld', 11:17:04 INFO - 'LANG': 'en_US.UTF-8', 11:17:04 INFO - 'LANGUAGE': 'en_US:en', 11:17:04 INFO - 'LOGNAME': 'cltbld', 11:17:04 INFO - 'MAIL': '/var/mail/cltbld', 11:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:04 INFO - 'MOZ_NO_REMOTE': '1', 11:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:04 INFO - 'NO_EM_RESTART': '1', 11:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:04 INFO - 'PWD': '/builds/slave/test', 11:17:04 INFO - 'SHELL': '/bin/bash', 11:17:04 INFO - 'SHLVL': '1', 11:17:04 INFO - 'TERM': 'linux', 11:17:04 INFO - 'TMOUT': '86400', 11:17:04 INFO - 'USER': 'cltbld', 11:17:04 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842', 11:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:04 INFO - '_': '/tools/buildbot/bin/python'} 11:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:04 INFO - Downloading/unpacking flake8 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:17:06 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 11:17:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:17:06 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 11:17:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17:06 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 11:17:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17: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 11:17:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:17:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:17:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:17:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:17:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:17:07 INFO - no previously-included directories found matching 'docs/_build' 11:17:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:17:07 INFO - Running setup.py install for pep8 11:17:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:17:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:17:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:17:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:17:07 INFO - no previously-included directories found matching 'docs/_build' 11:17:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:17:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:17:07 INFO - Cleaning up... 11:17:07 INFO - Return code: 0 11:17:07 INFO - Running post-action listener: _resource_record_post_action 11:17:07 INFO - Running post-action listener: _start_resource_monitoring 11:17:07 INFO - Starting resource monitoring. 11:17:07 INFO - ##### 11:17:07 INFO - ##### Running install step. 11:17:07 INFO - ##### 11:17:07 INFO - Running pre-action listener: _resource_record_pre_action 11:17:07 INFO - Running main action method: install 11:17:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:07 INFO - Reading from file tmpfile_stdout 11:17:07 INFO - Detecting whether we're running mozinstall >=1.0... 11:17:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:17:07 INFO - Reading from file tmpfile_stdout 11:17:07 INFO - Output received: 11:17:07 INFO - Usage: mozinstall [options] installer 11:17:07 INFO - Options: 11:17:07 INFO - -h, --help show this help message and exit 11:17:07 INFO - -d DEST, --destination=DEST 11:17:07 INFO - Directory to install application into. [default: 11:17:07 INFO - "/builds/slave/test"] 11:17:07 INFO - --app=APP Application being installed. [default: firefox] 11:17:07 INFO - mkdir: /builds/slave/test/build/application 11:17:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:17:22 INFO - Reading from file tmpfile_stdout 11:17:22 INFO - Output received: 11:17:22 INFO - /builds/slave/test/build/application/firefox/firefox 11:17:22 INFO - Running post-action listener: _resource_record_post_action 11:17:22 INFO - ##### 11:17:22 INFO - ##### Running run-tests step. 11:17:22 INFO - ##### 11:17:22 INFO - Running pre-action listener: _resource_record_pre_action 11:17:22 INFO - Running main action method: run_tests 11:17:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:17:22 INFO - Python 2.7.3 11:17:22 INFO - Return code: 0 11:17:22 INFO - grabbing minidump binary from tooltool 11:17:22 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')]} 11:17:22 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 0x28650b0>, '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 0x2865fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2866440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:17:22 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 11:17:22 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 11:17:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:17:22 INFO - Return code: 0 11:17:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:17:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:17:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:17:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:17:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:17:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:17:23 INFO - Return code: 0 11:17:23 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/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] in /builds/slave/test/build 11:17:23 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/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost 11:17:23 INFO - Using env: {'DISPLAY': ':0', 11:17:23 INFO - 'HOME': '/home/cltbld', 11:17:23 INFO - 'LANG': 'en_US.UTF-8', 11:17:23 INFO - 'LANGUAGE': 'en_US:en', 11:17:23 INFO - 'LOGNAME': 'cltbld', 11:17:23 INFO - 'MAIL': '/var/mail/cltbld', 11:17:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:17:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:23 INFO - 'MOZ_NO_REMOTE': '1', 11:17:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:17:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:23 INFO - 'NO_EM_RESTART': '1', 11:17:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:23 INFO - 'PWD': '/builds/slave/test', 11:17:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:17:23 INFO - 'SHELL': '/bin/bash', 11:17:23 INFO - 'SHLVL': '1', 11:17:23 INFO - 'TERM': 'linux', 11:17:23 INFO - 'TMOUT': '86400', 11:17:23 INFO - 'USER': 'cltbld', 11:17:23 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842', 11:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:23 INFO - '_': '/tools/buildbot/bin/python'} 11:17:23 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/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] with output_timeout 3600 11:17:23 INFO - mozversion INFO | application_buildid: 20151127103731 11:17:23 INFO - mozversion INFO | application_changeset: f48352b311eb120a09347efce60ae9045401858c 11:17:23 INFO - mozversion INFO | application_display_name: Nightly 11:17:23 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:17:23 INFO - mozversion INFO | application_name: Firefox 11:17:23 INFO - mozversion INFO | application_remotingname: firefox 11:17:23 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:17:23 INFO - mozversion INFO | application_vendor: Mozilla 11:17:23 INFO - mozversion INFO | application_version: 45.0a1 11:17:23 INFO - mozversion INFO | platform_buildid: 20151127103731 11:17:23 INFO - mozversion INFO | platform_changeset: f48352b311eb120a09347efce60ae9045401858c 11:17:23 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:17:23 INFO - mozversion INFO | platform_version: 45.0a1 11:17:23 INFO - 2015-11-27 11:17:23,793 DEBUG : using testdate: 1448651843 11:17:23 INFO - 2015-11-27 11:17:23,793 DEBUG : actual date: 1448651843 11:17:23 INFO - 2015-11-27 11:17:23,840 INFO : starting webserver on 'localhost:45087' 11:17:23 INFO - 2015-11-27 11:17:23,841 INFO : Starting test suite talos-linux64-ix-018 11:17:23 INFO - 2015-11-27 11:17:23,842 INFO : Starting test dromaeo_css 11:17:23 INFO - 2015-11-27 11:17:23,842 DEBUG : operating with platform_type : linux_ 11:17:23 INFO - 2015-11-27 11:17:23,842 INFO : Initialising browser for dromaeo_css test... 11:17:23 INFO - 2015-11-27 11:17:23,855 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXAz7HZ/profile http://localhost:45087/getInfo.html 11:17:27 INFO - 2015-11-27 11:17:27,619 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:17:27 INFO - 2015-11-27 11:17:27,619 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:17:27 INFO - 2015-11-27 11:17:27,619 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:17:27 INFO - 2015-11-27 11:17:27,619 DEBUG : BROWSER_OUTPUT: __metrics 11:17:27 INFO - 2015-11-27 11:17:27,707 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] 11:17:29 INFO - 2015-11-27 11:17:29,224 INFO : Browser initialized. 11:17:29 INFO - 2015-11-27 11:17:29,225 INFO : Running cycle 1/1 for dromaeo_css test... 11:17:29 INFO - 2015-11-27 11:17:29,225 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXAz7HZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:17:41 INFO - 2015-11-27 11:17:41,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 139124736 11:17:41 INFO - 2015-11-27 11:17:41,100 DEBUG : BROWSER_OUTPUT: 11:18:32 INFO - 2015-11-27 11:18:32,303 DEBUG : BROWSER_OUTPUT: 1448651912302 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] 11:20:44 INFO - 2015-11-27 11:20:44,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45087/tests/dromaeo/cssquery-ext.html) 11:20:45 INFO - 2015-11-27 11:20:45,231 DEBUG : BROWSER_OUTPUT: RSS: Main: 237117440 11:20:45 INFO - 2015-11-27 11:20:45,231 DEBUG : BROWSER_OUTPUT: 11:23:47 INFO - 2015-11-27 11:23:47,686 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/dromaeo/cssquery-ext.html (next: http://localhost:45087/tests/dromaeo/cssquery-jquery.html) 11:23:48 INFO - 2015-11-27 11:23:48,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 220000256 11:23:48 INFO - 2015-11-27 11:23:48,255 DEBUG : BROWSER_OUTPUT: 11:26:50 INFO - 2015-11-27 11:26:50,355 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45087/tests/dromaeo/cssquery-mootools.html) 11:26:50 INFO - 2015-11-27 11:26:50,936 DEBUG : BROWSER_OUTPUT: RSS: Main: 220950528 11:26:50 INFO - 2015-11-27 11:26:50,937 DEBUG : BROWSER_OUTPUT: 11:29:52 INFO - 2015-11-27 11:29:52,950 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45087/tests/dromaeo/cssquery-prototype.html) 11:29:53 INFO - 2015-11-27 11:29:53,537 DEBUG : BROWSER_OUTPUT: RSS: Main: 200908800 11:29:53 INFO - 2015-11-27 11:29:53,537 DEBUG : BROWSER_OUTPUT: 11:32:56 INFO - 2015-11-27 11:32:56,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45087/tests/dromaeo/cssquery-yui.html) 11:32:56 INFO - 2015-11-27 11:32:56,951 DEBUG : BROWSER_OUTPUT: RSS: Main: 206946304 11:32:56 INFO - 2015-11-27 11:32:56,951 DEBUG : BROWSER_OUTPUT: 11:35:59 INFO - 2015-11-27 11:35:59,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/dromaeo/cssquery-yui.html (next: http://localhost:45087/tests/dromaeo/cssquery-dojo.html) 11:35:59 INFO - 2015-11-27 11:35:59,636 DEBUG : BROWSER_OUTPUT: RSS: Main: 266780672 11:35:59 INFO - 2015-11-27 11:35:59,636 DEBUG : BROWSER_OUTPUT: 11:35:59 INFO - 2015-11-27 11:35:59,636 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:35:59 INFO - 2015-11-27 11:35:59,636 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:35:59 INFO - 2015-11-27 11:35:59,636 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:35:59 INFO - 2015-11-27 11:35:59,636 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:35:59 INFO - 2015-11-27 11:35:59,640 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2608.387029048173;2699.64904562407;2713.674359076911;2719.048333083421;2731.207949694588;4531.954680453195;4623.676342656016;4656.464506581744;4665.04366604846;4666.626669866411;4531.365608814768;4549.135664223803;4589.426321709786;4593.356930029799;4607.147677679632;4264.23243816113;4277.93583096253;4284.721493102954;4327.069680018795;4393.2531469650075;4143.9171216575805;4385.56144385562;4399.318105693606;4435.9556404436025;4439.711418757786;4211.768352740598;4292.570742925698;4292.935605965913;4326.351047342892;4333.631641310492;4336.7831608419765;4344.6089851913475;4347.913041739147;4393.802278897458;4394.824207031715;4152.647025002879;4323.373110898933;4348.021695118605;4356.520782713899;4404.361367601712;4510.0979804039325;4570.085982803419;4587.128445595326;4632.0967411354795;4663.510331415187;5014.674046186986;5047.0915235257635;5050.343455350818;5052.368453943257;5091.389033315989;4883.536064073907;5055.772490237948;5067.037262920034;5067.138586440314;5079.8222062228015;4540.750258735735;4630.72215667061;4630.83792067276;4631.258998560248;4634.907301853944;5135.563477104413;5141.562967147835;5147.97426012875;5152.175651895679;5197.142471492237;4943.431505376856;4950.232713929347;4955.90088198234;4959.578435832923;5000.299958005882;4769.618430525549;4865.927011094836;4887.731174785421;4893.290472881412;5022.648414610942;4982.975085124624;5000.1249781288125;5002.724850133278;5022.246663000579;5022.4977502249485;4962.702237865739;4963.652544321935;4967.081089998362;4967.875803104951;5014.724190169576;4109.671226301889;4211.136716973075;4254.978725106354;4257.10600773841;4307.483102027714;3612.819359032038;3679.1721862580707;3714.4242642390473;3724.944125838115;3757.3800322946954;4291.721038132511;4300.827966881352;4306.246406878784;4310.030243195319;4357.934630980538;4837.105135549935;4990.950090499121;4995;4998.550130488274;5004.84985450437;4204.915901681949;4270.957290427118;4278.679099067583;4283.443152390169;4298.871033868989;4476.35092911526;4503.932441013388;4513.255312873339;4513.796879140446;4554.339620754972;4791.6406269529925;4807.326974223682;4813.9037219256115;4814.350062741555;4857.587105096107;4832.178529649897;4935.235038569028;4940.036692844861;4943.629227808001;5032.899342013066;4715.504871988529;4767.475577686521;4770.666053376231;4772.260299653559;4813.95186048135;4941.456439791548;4948.208286674115;4954.430240522242;4960.528749768766;5001.749912504433;4835.903281934412;4941.65408421407;4948.430930443045;4969.403671559436;5087.796488140433;4923.753812309298;4930.087933732271;4937.851864444073;4938.2839488273285;4942.5304596063315;4885.389326334208;4924.679895806761;4931.728754918514;4933.629977751755;4958.454569997225;4611;4663.860084197479;4702.717836929795;4728.71627702339;4876.561109500162;4887.877803054952;4896.36347274852;4954.529319714621;4959.082569724613;4963.255511673278;4832.057748738962;4837.056773929191;4851.223804191312;4853.781579828846;4895.265710143507 11:35:59 INFO - 2015-11-27 11:35:59,644 DEBUG : BROWSER_OUTPUT: |1;ext.html;545.5880809988458;546.581864873372;548.9780408783649;552.3868505958385;566.3515275010116;27433.45133097337;28099;36343.09142271441;37038.62961370385;37079.4438083429;40916;41383.17233655325;41462.58537414625;41497.58502414975;41510.792446037725;6825;6936.410405115571;7717.807054823632;7844.137144914055;7871.685132594718;9956.6515171969;10226.130778883766;10230.488475576229;10230.795384092313;10236.2322825788;10094.444805535693;10239.488025598728;10239.539220735085;10245.948770256138;10246.641367552138;7144.785656430316;7306.196318404971;9862.161716254128;10127.442990635513;10414.166866650725;9953.502324883726;10098.798024039552;10103.848442273298;10112.443815590139;10117.241206909512;33118.50322245144;33376.16559586005;33425.49861752076;33438.164045899044;33487.497687534706;2859.127965970378;2906.534954407306;2969.242843075002;3198.328351046283;3198.424283628946;27698.861505692545;27854.442911141665;27970.580441293398;28311;28348.29129271764;2884.538473844175;2917.2560996945854;2955.6305461817274;2971.777116716233;3053.175642576492;211283.94358028265;212435;212462;213203.5378761736;213211;49423.50576494261;50745.74627126841;53555.73222133864;53650.46349536454;55045;50161.24758128631;50255.49744502508;50370.496295037316;50542;50641;11880.108991825648;12033.037357011419;12037.578684745991;12046.216995895238;12055.698607534881;8532.317414606816;8549.401541892008;8572.828543429221;8690.478571285743;8790.033096359395;18213.90893045526;18294.26822927068;18354.90822545879;18422.723659145122;18448.26206951734;6724.260331363546;6798.150231221098;6812.420944219797;6860.3139686031;6935.861282774316;828.2131974624131;876.4215617692292;879.1077056787366;891.028778631295;995.0596686131536;26291;26888.49501283429;27456.862715686693;27655;29249.415011699646;860.8278344331159;866.5753780647437;881.8853549038583;895.8387490251818;983.8376667849725;11934.761304773856;12364.258144511357;12406.56577019818;12626.621201363974;13261.535846245335;258930;260639;262661;263666;263797;43577.34633980493;43661.56338436638;43725.562744372786;43769;43773.562264377586;1107.9058280046124;1127.182792475465;1168.9240199387013;1178.5698220149754;1180.474688763492;23617.173398930954;25380;26370.4725905477;26455.33861653474;26644.866775665996;38231.808840955615;38709.419358710205;38739.41890871583;38753.2249355017;38771.806140969114;227583;231747;242169;247747;248031;26597.867010664824;26621.334466638487;26686.332841678337;26814.59778103291;26848;36380.27239455249;36437.45343819792;37258.813705931294;38153;40030;32510;32658.83670581632;33146.34268286624;33445.33109337751;33516.65933362638;32019.519707203945;33096.338073237916;33415.83292083524;33598.3280334387;34198.82900585481;30636;30783.076507704805;31003.689963100984;31091.533626996064;31110.222244443165;25945.87027064928;27610.861945690143;29717.83950246924;29748;29789.702102978692;23221.651675225225;23274.457601525544;23437.298557049184;23511.529769404173;23545.64681529744 11:35:59 INFO - 2015-11-27 11:35:59,645 DEBUG : BROWSER_OUTPUT: |2;jquery.html;312.66388632220367;315.9905202843914;323.84131775430035;324.39014652453386;327.08579520240914;11928.403579821017;12263.325517096557;13672.111312764675;14952.476663316786;15344.923275383622;11688.298702077882;14673.26633668315;14995.175265360429;15448;15448.613784655361;4960.528749768784;4978.676386034906;5035.672681275723;5038.521340472649;5124.410692770323;3525.400681884073;3619.49327094207;4974.950250497485;4976.2286845539;5612.550995920316;5744.942550574483;5779.248697669297;5800.651960882339;5806.767729290823;5809;5593.440655934414;5720.77116915327;5727.3699893011735;5728.16941543476;5752.884942301152;4898.2162853943555;4919.96680697054;4920.384951881015;4920.680155789898;4932.5807306379;18750;18911.05444727772;19383.80616193834;19442.805571944242;19442.90278548598;551.7241379310345;552.3620218647469;552.9004779139754;552.9640573362718;1838.960987042317;12304.630861074182;12700.237985720887;12731.108822382437;12968.80546791799;13190.538331158363;1724.6205834716343;1735.878488505805;1748.9475315740422;1765.470358892327;1817.6637322095455;52132;53410.19884701694;53792.19311710328;53892.46107538914;54554.72722636361;8977.865332020025;9068.50123243228;9182.357234993486;9193.218576420946;9240.21458176049;11706.531738730355;11719.824202636968;11746.353950532632;11753.647390578297;11755.588554400554;6505.024246363083;6509.641969691713;6623.834404139839;6629.270780214172;6691.665416729144;6294.496440284766;6303.527235457359;6347.206599175103;6369.331220221903;6369.394907483782;5473.835784926379;5534.446555344433;5539.667619942736;5560.749766260528;5570.61005729595;1515.7423238049557;1560.2432820082252;1575.8811244016647;1593.3947995028213;1624.61821471954;808.3492788305471;808.9878651820227;875.5884734174928;897.7396554999108;926.754410081329;15724.13517256539;15841;16211.432599859185;16403.179841007903;16487.670246595;699.576756062585;819.3076850061689;826.4958375391006;827.5655280977535;836.2390224895316;8418.284445822173;8804.911950880538;8913.598888050054;9003.864942025875;9306.441613503212;545097;550415;553359;558650;561832;68662;73733;74695;75582.62208689032;77132.22867771363;1049.7900419915895;1050.0234781653137;1062.670572122629;1082.242430298794;1101.262154356583;14172.574822755334;14195.929020355245;14198.29008549589;14217.004809663224;14313.141211527342;30571.388572228876;32243.838780805945;32392;32660.183495411853;33825.323493530486;39129.21741565096;39617;39888.8005559982;40534.797326013184;43415.13169736651;7879.0939042010905;8132.430729848854;12333.62999110028;12638.3680815957;12714.237145771283;16707.665846682754;16882.66234675324;16902.661946761244;17327.480175594752;17550.210240538952;14076.929615351857;14378.568642940729;14902.552923412315;14911.105333680014;14925.55223343258;14164.787528187291;14605.488807891672;14679.48621798232;14760.409583616534;15039.323230454436;12320;12755.93622031884;14312.284385780878;15481.690366192388;15913.443029493912;13929.164250145024;13950.860491394957;13962.37169327403;14222.502212422516;14279.21464319431;14854.925725371304;14916.403343866124;15182.240887955779;15195.620109497351;15321.846781532488 11:35:59 INFO - 2015-11-27 11:35:59,649 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1244.831947687062;1440.7334643091021;1464.0264224290847;1590.68981548598;1664.6670665866825;5641.548676105912;6495.123158373624;6639.701213445394;6673.232578253496;6691.832704182398;6575.112359831422;6711.228208755982;6715.832104197398;6736;6736.562123461984;1889.9811001889977;1923.6152769446096;1925.4512463947779;1925.682262426705;1927.3639698899399;1934.3423236099723;1957.4225603447017;1964.0572525187847;1968.5865968146707;1990;1954.4039068084228;1961.3723608445302;1972.566035472201;1976.1502553901817;1977.8516611254142;1871.504051426373;1917.9041047947546;1920.0975541495475;1922.1542521290587;1922.5193701574606;1922.0293751655465;1931.4109196695003;1936.5255512399413;1947.6494231038407;1968.8031196880197;5683.175939488792;5840.97079514604;6584.604923704593;6660.433863121641;6664.533482656216;3598.208394153282;3719.386301260316;3725.5715592706642;3726.1802403471193;3726.4596633488263;2568.0754928225824;2569.8586577738215;2599.2072417912527;2627.0805218173487;2629.1455277034847;767.3017554025865;814.861473549498;832.5254604875223;920.3281604428738;922.7231830450838;8613.655453781841;8652.956735216347;8655.74032779024;8667.4366166199;8667.436616619963;3411.9829400852836;3483.6690514401093;3521.7710848794745;3550.8757193498104;3554.413521768931;7609.923900760921;7610.695572177051;7683.615819209017;7686.500377475446;7687.2697093776005;3825.215830754689;3825.3305671507374;3825.8087095645105;3826.426036094608;3828.157805282833;3486.4944583035826;3488.6162522122545;3497.283056973314;3501.824908754552;3501.824908754552;3137.8117312961294;3142.5757522734593;3159.131238909318;3159.1944054266473;3191.9680803192136;968.733598260484;970.6505657963128;970.9708708738749;977.1059480575194;978.5694294510392;1142.948567314473;1146.3523109443138;1149.6953307373553;1152.2337645465839;1192.266755945105;6241.656708880964;6285.088662143963;6309.9588567885785;6322.399372059647;6342.39747224013;364.7574363048543;366.6608387241791;370.04528316942225;370.5238768182872;371.87542173371685;4681.063787242565;5038.622103342264;5067.315912351859;5112.539871411591;5113.1052065888325;6943.548669336477;7564.281393267631;7803.648835802289;7820.804479888048;7821.7262395817015;7634.312911837961;7664.4634875559295;7682.193369696213;7713.807154821175;7719.498232614862;6068.605540639845;6200.441960223511;6227.346128656516;6231.158793562901;6260.843478913063;6062.878742425039;6075.908861366995;6076.817695469143;6083.69581520931;6087.66517841523;6775.186977562724;7078.68145933424;7116.822079448055;7204.3155900189395;7204.9279507204255;7145.356917877416;7324.047873776375;7369.8157546061775;7419.29516695913;7420.740274090381;5774.682392468455;5820.679862607597;5824.3593204748295;5829.795957141479;5830.125481177857;6257.0614407837365;6267.46726528232;6268.2478102626155;6273.811785646438;6275.6862156892885;6007.279126504673;6009.399060093956;6067.271927368744;6074.3318234994995;6177.135201071944;5957.821265362046;5984.790532331347;6103.145559621567;6158.907616385847;6198.969005155126;5929.050853204865;5939.3466718661775;5998.580099393001;6166.691665416622;6229.4393504582995;5791.102379131242;5833.970830145822;5844.736986835517;5849.239598852122;5854.795082172274;5719.113537401709;5728.885422291448;5748.741306641127;5752.137179422953;5764.423557644202 11:35:59 INFO - 2015-11-27 11:35:59,650 DEBUG : BROWSER_OUTPUT: |4;prototype.html;278.1419321393501;280.9943801123978;284.3999161768667;285.072090345924;288.53977905241135;5115.079285728568;5124.820631277906;5274.5780337573;5343.30537030186;5344.198370244465;5242.606804489669;5244.527992480676;5270.9736451317685;5278.709670968105;5280.603954703393;4055.310597198476;4093.5087789465306;4097.323941549641;4099.877003689894;4101.241270364977;3846.1730727893496;3878.3988481785227;4031.5565287818317;4078.1843631273714;4086.5300490443683;4050.8379664813374;4065.8373665053364;4078.4086307485395;4084.14233011068;4089.0799570096788;4054.5337286212166;4065.6747460203114;4076.694247931417;4080.510338759338;4085.611866872642;3558.5373901392913;3568.6431356864364;3568.839402226906;3570.553680789901;3575.302815950891;5075.593952483792;5081.8729531762;5087.414947281073;5087.745612719349;5093.567046801027;4660.487346391894;4669.089527542131;4669.112868554964;4669.439667239919;4674;5527.55779537636;5529.778808847682;5534.557235421197;5536.861578460531;5539.667619942817;3876.457295978565;3880.0687834919418;3880.844766209348;3882.456456096149;3884.8057597120032;5443.455654434525;5808.3030036395485;5817.156512305734;5822.7088645567555;5824.53403727705;3452.2922800825772;3729.869454569077;3791.810409479515;3804.4483549885667;3805.752626079296;3854.3062248794927;3863.632954869283;3914.64768170866;3977.801109944549;3997.080671445584;4483.125790470892;4557.794899229542;4568.862934111982;4635.513271106485;4644.373009643722;5527.2538207342295;5537.335519737658;5542.251796007487;5547.694876781816;5548.528375088163;1417.8156839610785;1435.397133204036;1436.9425222990963;1437.5687293811814;1439.1437094928501;955.3312681123242;970.2432102959702;978.5351957819978;994.4282037828277;996.7657600463886;4865.172920603435;4875.634327425457;4882.340883980688;4882.51174882516;4884.3161957326;5758.049921762946;5760.769569217268;5765.682887441231;5766.88466230673;5770.538356931435;4866.902661946741;4868.878278043077;4871.95128048715;4872.6832755870755;4874.8537543873745;3032.969670303313;3072.8002679826186;3106.6116735408073;3109.626844778641;3137.388209299165;5506.752196151183;5524.281843360337;5524.944750552523;5537.418571049981;5538.390777014525;5999.790007349722;6002.129691194839;6012.188354572164;6013.278406591237;6014.338422773491;5504.752286147133;5519.061759500894;5525.806596769094;5529.142982837667;5531.3915469298345;5680.204771331934;5834.824955251349;5836;5848.707564621837;5848.970755146197;5426.375966763872;5567.498925096761;5615.410381909841;5615.747291371979;5616.803411880564;5401.783928642967;5425.050616142238;5510.338759348743;5527.115661494142;5529.502344788988;3858.5562660294427;3880.320943834874;3907.765534067965;3908.8827335178853;3908.9609103908597;5706.4864162225595;5826.475617194304;5832.1543376209365;5835.854103647443;5838.153467747068;5619.157126431068;5623.128415095667;5623.775048997994;5629.0712032514175;5632.352279487911;5615.185798059177;5616.1014237721765;5620.578456615688;5622.746976385991;5626.38109807929;5398.946010539844;5519.365272993497;5520.834374968757;5527.226188333556;5532.529734972572;5647.604667673388;5662.490375866192;5664.773409063756;5667.263255776723;5672.858178545569;5518.448155184449;5529.198266251451;5530.834074977757;5531.0873705838085;5534.391216966211 11:35:59 INFO - 2015-11-27 11:35:59,651 DEBUG : BROWSER_OUTPUT: |5;yui.html;654.0293767368003;659.518551457436;752.8945947567341;755.1052003376;756.2362014365489;9779.804403911918;10158.2889197756;10165.288429809916;10169.38983660981;10174;10406.947965260182;10527.105196058325;10535.63125290613;10538.631147909824;10540.947295263531;600.2167171840746;606.5632744424007;735.2757533829188;755.4862693368507;768.1358471719316;761.2235519769831;762.7101701353478;768.4428789127893;768.561919705768;768.7386288661854;520.2352541763602;796.8565658181525;802.8474589827914;803.0604193094094;803.1245941923303;471.5002097776368;782.9804254893617;789.8578255913933;791.8337149198618;793.4009822583942;592.6503363015798;592.6710675575055;592.8784599157162;593.1192179613271;593.2495393327445;10464.42445665488;10564.683059508227;10581;10584.206184536191;10591.894081059168;11130.944345278303;11397.601083962105;11399.835694192056;11696.532138714441;11917.463714132798;9325.487098209596;9471.10024547667;9502.524873756354;9513.857292140623;9551.856722149174;3169.160172554275;3228.8708451661905;3271.787333823294;3278.557394751702;3301.603807543086;39623.8018809907;39644.40533392001;39651.801740991395;39714.404283935764;39725;8743.38796284254;8894.28845692343;8948.418352807046;9214;9224.492652904155;16158.676826463405;16392.672146557;16393.59016024585;16436.589085272964;16482.25829837636;6114.38856114385;6150.723217455135;6287.339829317947;6304.495640348761;6452.1289625900845;3619.348517266917;3682.0978860178893;3708.4808126862263;3720;3741.551013878352;2554.1698947842024;2571.061562529663;2573.9356516087246;2576.30439781258;2579.4781079163386;487.8536439068336;489.36138339466623;489.9906193241862;500.26211338275755;502.32939026399436;449.56755174244876;559.1835919557492;572.4189947203508;580.1906340654847;584.4944123333371;7362.411007119525;7462.253774622494;7470.0662417197855;7613.238676132453;7694;458.0175523502069;477.8661974647104;522.2453554613547;542.1542393865583;565.5221337969409;3272.2473831018997;3423.606285277175;3455.568053993251;3456.7753096048677;3458.3083383323437;50669.49330506648;51029.48970510322;51049.744751276005;51063.74468127636;51196.488035119175;45114.32328515075;45689.43105689471;46990.29514557285;47068.76465617718;47101;41786.791066044476;42271;42641.57358426438;42668.57331426708;43043.56956430396;6842.93157068423;6950.409215216763;7114.964425177841;7115.181754098345;7173.641317933978;32132.83933580317;32189;32599.947008213763;32907;32984.83507582447;38008.23983520369;38078.619213807506;38148;40553;40703.59296407116;8668.956655216683;8707.608157632794;8916.15296546827;9003.81992360136;9090.272778177598;9863.460362747119;10062.647807326708;10141.309257319934;10232;10281.331713438603;9108.089191080839;9475.857862131936;9479.905200947902;9580.28147888925;9717.951410242904;9459.337846350689;9717.757056073655;9763.658271960447;9799.069088436587;9835.704928852147;9425.293103017439;9486;9496.335256531976;9632.22942164611;9694.709158725249;7093.361597456254;7247.637618119178;8626.223639872442;8724.520151391735;9008.054154313964;8530.232279094911;8635.481871087755;8674.392792504717;8756.343274254328;8904.910950890408 11:35:59 INFO - 2015-11-27 11:35:59,652 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:35:59 INFO - 2015-11-27 11:35:59,652 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:35:59 INFO - 2015-11-27 11:35:59,652 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,860 11:35:59 INFO - 2015-11-27 11:35:59,652 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:35:59 INFO - 2015-11-27 11:35:59,652 DEBUG : BROWSER_OUTPUT: __startTimestamp1448652959635__endTimestamp 11:35:59 INFO - 2015-11-27 11:35:59,652 DEBUG : BROWSER_OUTPUT: 11:35:59 INFO - 2015-11-27 11:35:59,652 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:35:59 INFO - 2015-11-27 11:35:59,652 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:35:59 INFO - 2015-11-27 11:35:59,652 DEBUG : BROWSER_OUTPUT: 11:35:59 INFO - 2015-11-27 11:35:59,652 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4624.29 Median:4770.67 stddev:475.83 (10.0%) stddev-sans-first:450.24 11:35:59 INFO - 2015-11-27 11:35:59,652 DEBUG : BROWSER_OUTPUT: Values: 2608.4 2699.6 2713.7 2719.0 2731.2 4532.0 4623.7 4656.5 4665.0 4666.6 4531.4 4549.1 4589.4 4593.4 4607.1 4264.2 4277.9 4284.7 4327.1 4393.3 4143.9 4385.6 4399.3 4436.0 4439.7 4211.8 4292.6 4292.9 4326.4 4333.6 4336.8 4344.6 4347.9 4393.8 4394.8 4152.6 4323.4 4348.0 4356.5 4404.4 4510.1 4570.1 4587.1 4632.1 4663.5 5014.7 5047.1 5050.3 5052.4 5091.4 4883.5 5055.8 5067.0 5067.1 5079.8 4540.8 4630.7 4630.8 4631.3 4634.9 5135.6 5141.6 5148.0 5152.2 5197.1 4943.4 4950.2 4955.9 4959.6 5000.3 4769.6 4865.9 4887.7 4893.3 5022.6 4983.0 5000.1 5002.7 5022.2 5022.5 4962.7 4963.7 4967.1 4967.9 5014.7 4109.7 4211.1 4255.0 4257.1 4307.5 3612.8 3679.2 3714.4 3724.9 3757.4 4291.7 4300.8 4306.2 4310.0 4357.9 4837.1 4991.0 4995.0 4998.6 5004.8 4204.9 4271.0 4278.7 4283.4 4298.9 4476.4 4503.9 4513.3 4513.8 4554.3 4791.6 4807.3 4813.9 4814.4 4857.6 4832.2 4935.2 4940.0 4943.6 5032.9 4715.5 4767.5 4770.7 4772.3 4814.0 4941.5 4948.2 4954.4 4960.5 5001.7 4835.9 4941.7 4948.4 4969.4 5087.8 4923.8 4930.1 4937.9 4938.3 4942.5 4885.4 4924.7 4931.7 4933.6 4958.5 4611.0 4663.9 4702.7 4728.7 4876.6 4887.9 4896.4 4954.5 4959.1 4963.3 4832.1 4837.1 4851.2 4853.8 4895.3 11:35:59 INFO - 2015-11-27 11:35:59,652 DEBUG : BROWSER_OUTPUT: 11:35:59 INFO - 2015-11-27 11:35:59,653 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39348.64 Median:30709.54 stddev:62128.18 (202.3%) stddev-sans-first:62234.15 11:35:59 INFO - 2015-11-27 11:35:59,654 DEBUG : BROWSER_OUTPUT: Values: 545.6 546.6 549.0 552.4 566.4 27433.5 28099.0 36343.1 37038.6 37079.4 40916.0 41383.2 41462.6 41497.6 41510.8 6825.0 6936.4 7717.8 7844.1 7871.7 9956.7 10226.1 10230.5 10230.8 10236.2 10094.4 10239.5 10239.5 10245.9 10246.6 7144.8 7306.2 9862.2 10127.4 10414.2 9953.5 10098.8 10103.8 10112.4 10117.2 33118.5 33376.2 33425.5 33438.2 33487.5 2859.1 2906.5 2969.2 3198.3 3198.4 27698.9 27854.4 27970.6 28311.0 28348.3 2884.5 2917.3 2955.6 2971.8 3053.2 211283.9 212435.0 212462.0 213203.5 213211.0 49423.5 50745.7 53555.7 53650.5 55045.0 50161.2 50255.5 50370.5 50542.0 50641.0 11880.1 12033.0 12037.6 12046.2 12055.7 8532.3 8549.4 8572.8 8690.5 8790.0 18213.9 18294.3 18354.9 18422.7 18448.3 6724.3 6798.2 6812.4 6860.3 6935.9 828.2 876.4 879.1 891.0 995.1 26291.0 26888.5 27456.9 27655.0 29249.4 860.8 866.6 881.9 895.8 983.8 11934.8 12364.3 12406.6 12626.6 13261.5 258930.0 260639.0 262661.0 263666.0 263797.0 43577.3 43661.6 43725.6 43769.0 43773.6 1107.9 1127.2 1168.9 1178.6 1180.5 23617.2 25380.0 26370.5 26455.3 26644.9 38231.8 38709.4 38739.4 38753.2 38771.8 227583.0 231747.0 242169.0 247747.0 248031.0 26597.9 26621.3 26686.3 26814.6 26848.0 36380.3 36437.5 37258.8 38153.0 40030.0 32510.0 32658.8 33146.3 33445.3 33516.7 32019.5 33096.3 33415.8 33598.3 34198.8 30636.0 30783.1 31003.7 31091.5 31110.2 25945.9 27610.9 29717.8 29748.0 29789.7 23221.7 23274.5 23437.3 23511.5 23545.6 11:35:59 INFO - 2015-11-27 11:35:59,654 DEBUG : BROWSER_OUTPUT: 11:35:59 INFO - 2015-11-27 11:35:59,654 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28512.98 Median:16492.29 stddev:90313.06 (547.6%) stddev-sans-first:90541.58 11:35:59 INFO - 2015-11-27 11:35:59,654 DEBUG : BROWSER_OUTPUT: Values: 312.7 316.0 323.8 324.4 327.1 11928.4 12263.3 13672.1 14952.5 15344.9 11688.3 14673.3 14995.2 15448.0 15448.6 4960.5 4978.7 5035.7 5038.5 5124.4 3525.4 3619.5 4975.0 4976.2 5612.6 5744.9 5779.2 5800.7 5806.8 5809.0 5593.4 5720.8 5727.4 5728.2 5752.9 4898.2 4920.0 4920.4 4920.7 4932.6 18750.0 18911.1 19383.8 19442.8 19442.9 551.7 552.4 552.9 553.0 1839.0 12304.6 12700.2 12731.1 12968.8 13190.5 1724.6 1735.9 1748.9 1765.5 1817.7 52132.0 53410.2 53792.2 53892.5 54554.7 8977.9 9068.5 9182.4 9193.2 9240.2 11706.5 11719.8 11746.4 11753.6 11755.6 6505.0 6509.6 6623.8 6629.3 6691.7 6294.5 6303.5 6347.2 6369.3 6369.4 5473.8 5534.4 5539.7 5560.7 5570.6 1515.7 1560.2 1575.9 1593.4 1624.6 808.3 809.0 875.6 897.7 926.8 15724.1 15841.0 16211.4 16403.2 16487.7 699.6 819.3 826.5 827.6 836.2 8418.3 8804.9 8913.6 9003.9 9306.4 545097.0 550415.0 553359.0 558650.0 561832.0 68662.0 73733.0 74695.0 75582.6 77132.2 1049.8 1050.0 1062.7 1082.2 1101.3 14172.6 14195.9 14198.3 14217.0 14313.1 30571.4 32243.8 32392.0 32660.2 33825.3 39129.2 39617.0 39888.8 40534.8 43415.1 7879.1 8132.4 12333.6 12638.4 12714.2 16707.7 16882.7 16902.7 17327.5 17550.2 14076.9 14378.6 14902.6 14911.1 14925.6 14164.8 14605.5 14679.5 14760.4 15039.3 12320.0 12755.9 14312.3 15481.7 15913.4 13929.2 13950.9 13962.4 14222.5 14279.2 14854.9 14916.4 15182.2 15195.6 15321.8 11:35:59 INFO - 2015-11-27 11:35:59,654 DEBUG : BROWSER_OUTPUT: 11:35:59 INFO - 2015-11-27 11:35:59,654 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4601.60 Median:5846.99 stddev:2377.16 (40.7%) stddev-sans-first:2370.44 11:35:59 INFO - 2015-11-27 11:35:59,655 DEBUG : BROWSER_OUTPUT: Values: 1244.8 1440.7 1464.0 1590.7 1664.7 5641.5 6495.1 6639.7 6673.2 6691.8 6575.1 6711.2 6715.8 6736.0 6736.6 1890.0 1923.6 1925.5 1925.7 1927.4 1934.3 1957.4 1964.1 1968.6 1990.0 1954.4 1961.4 1972.6 1976.2 1977.9 1871.5 1917.9 1920.1 1922.2 1922.5 1922.0 1931.4 1936.5 1947.6 1968.8 5683.2 5841.0 6584.6 6660.4 6664.5 3598.2 3719.4 3725.6 3726.2 3726.5 2568.1 2569.9 2599.2 2627.1 2629.1 767.3 814.9 832.5 920.3 922.7 8613.7 8653.0 8655.7 8667.4 8667.4 3412.0 3483.7 3521.8 3550.9 3554.4 7609.9 7610.7 7683.6 7686.5 7687.3 3825.2 3825.3 3825.8 3826.4 3828.2 3486.5 3488.6 3497.3 3501.8 3501.8 3137.8 3142.6 3159.1 3159.2 3192.0 968.7 970.7 971.0 977.1 978.6 1142.9 1146.4 1149.7 1152.2 1192.3 6241.7 6285.1 6310.0 6322.4 6342.4 364.8 366.7 370.0 370.5 371.9 4681.1 5038.6 5067.3 5112.5 5113.1 6943.5 7564.3 7803.6 7820.8 7821.7 7634.3 7664.5 7682.2 7713.8 7719.5 6068.6 6200.4 6227.3 6231.2 6260.8 6062.9 6075.9 6076.8 6083.7 6087.7 6775.2 7078.7 7116.8 7204.3 7204.9 7145.4 7324.0 7369.8 7419.3 7420.7 5774.7 5820.7 5824.4 5829.8 5830.1 6257.1 6267.5 6268.2 6273.8 6275.7 6007.3 6009.4 6067.3 6074.3 6177.1 5957.8 5984.8 6103.1 6158.9 6199.0 5929.1 5939.3 5998.6 6166.7 6229.4 5791.1 5834.0 5844.7 5849.2 5854.8 5719.1 5728.9 5748.7 5752.1 5764.4 11:35:59 INFO - 2015-11-27 11:35:59,656 DEBUG : BROWSER_OUTPUT: 11:35:59 INFO - 2015-11-27 11:35:59,656 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4605.92 Median:5276.64 stddev:1373.44 (26.0%) stddev-sans-first:1338.33 11:35:59 INFO - 2015-11-27 11:35:59,656 DEBUG : BROWSER_OUTPUT: Values: 278.1 281.0 284.4 285.1 288.5 5115.1 5124.8 5274.6 5343.3 5344.2 5242.6 5244.5 5271.0 5278.7 5280.6 4055.3 4093.5 4097.3 4099.9 4101.2 3846.2 3878.4 4031.6 4078.2 4086.5 4050.8 4065.8 4078.4 4084.1 4089.1 4054.5 4065.7 4076.7 4080.5 4085.6 3558.5 3568.6 3568.8 3570.6 3575.3 5075.6 5081.9 5087.4 5087.7 5093.6 4660.5 4669.1 4669.1 4669.4 4674.0 5527.6 5529.8 5534.6 5536.9 5539.7 3876.5 3880.1 3880.8 3882.5 3884.8 5443.5 5808.3 5817.2 5822.7 5824.5 3452.3 3729.9 3791.8 3804.4 3805.8 3854.3 3863.6 3914.6 3977.8 3997.1 4483.1 4557.8 4568.9 4635.5 4644.4 5527.3 5537.3 5542.3 5547.7 5548.5 1417.8 1435.4 1436.9 1437.6 1439.1 955.3 970.2 978.5 994.4 996.8 4865.2 4875.6 4882.3 4882.5 4884.3 5758.0 5760.8 5765.7 5766.9 5770.5 4866.9 4868.9 4872.0 4872.7 4874.9 3033.0 3072.8 3106.6 3109.6 3137.4 5506.8 5524.3 5524.9 5537.4 5538.4 5999.8 6002.1 6012.2 6013.3 6014.3 5504.8 5519.1 5525.8 5529.1 5531.4 5680.2 5834.8 5836.0 5848.7 5849.0 5426.4 5567.5 5615.4 5615.7 5616.8 5401.8 5425.1 5510.3 5527.1 5529.5 3858.6 3880.3 3907.8 3908.9 3909.0 5706.5 5826.5 5832.2 5835.9 5838.2 5619.2 5623.1 5623.8 5629.1 5632.4 5615.2 5616.1 5620.6 5622.7 5626.4 5398.9 5519.4 5520.8 5527.2 5532.5 5647.6 5662.5 5664.8 5667.3 5672.9 5518.4 5529.2 5530.8 5531.1 5534.4 11:35:59 INFO - 2015-11-27 11:35:59,656 DEBUG : BROWSER_OUTPUT: 11:35:59 INFO - 2015-11-27 11:35:59,656 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12023.30 Median:562.35 stddev:14187.06 (2522.8%) stddev-sans-first:14201.17 11:35:59 INFO - 2015-11-27 11:35:59,657 DEBUG : BROWSER_OUTPUT: Values: 654.0 659.5 752.9 755.1 756.2 9779.8 10158.3 10165.3 10169.4 10174.0 10406.9 10527.1 10535.6 10538.6 10540.9 600.2 606.6 735.3 755.5 768.1 761.2 762.7 768.4 768.6 768.7 520.2 796.9 802.8 803.1 803.1 471.5 783.0 789.9 791.8 793.4 592.7 592.7 592.9 593.1 593.2 10464.4 10564.7 10581.0 10584.2 10591.9 11130.9 11397.6 11399.8 11696.5 11917.5 9325.5 9471.1 9502.5 9513.9 9551.9 3169.2 3228.9 3271.8 3278.6 3301.6 39623.8 39644.4 39651.8 39714.4 39725.0 8743.4 8894.3 8948.4 9214.0 9224.5 16158.7 16392.7 16393.6 16436.6 16482.3 6114.4 6150.7 6287.3 6304.5 6452.1 3619.3 3682.1 3708.5 3720.0 3741.6 2554.2 2571.1 2573.9 2576.3 2579.5 487.9 489.4 490.0 500.3 502.3 449.6 559.2 572.4 580.2 584.5 7362.4 7462.3 7470.1 7613.2 7694.0 458.0 477.9 522.2 542.2 565.5 3272.2 3423.6 3455.6 3456.8 3458.3 50669.5 51029.5 51049.7 51063.7 51196.5 45114.3 45689.4 46990.3 47068.8 47101.0 41786.8 42271.0 42641.6 42668.6 43043.6 6842.9 6950.4 7115.0 7115.2 7173.6 32132.8 32189.0 32599.9 32907.0 32984.8 38008.2 38078.6 38148.0 40553.0 40703.6 8669.0 8707.6 8916.2 9003.8 9090.3 9863.5 10062.6 10141.3 10232.0 10281.3 9108.1 9475.9 9479.9 9580.3 9718.0 9459.3 9717.8 9763.7 9799.1 9835.7 9425.3 9486.0 9496.3 9632.2 9694.7 7093.4 7247.6 8626.2 8724.5 9008.1 8530.2 8635.5 8674.4 8756.3 8904.9 11:35:59 INFO - 2015-11-27 11:35:59,657 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:35:59 INFO - 2015-11-27 11:35:59,657 DEBUG : BROWSER_OUTPUT: 11:36:00 INFO - 2015-11-27 11:36:00,377 INFO : Browser exited with error code: 0 11:36:00 INFO - 2015-11-27 11:36:00,401 INFO : Completed test dromaeo_css (00:18:36) 11:36:00 INFO - 2015-11-27 11:36:00,401 INFO : Starting test kraken 11:36:00 INFO - 2015-11-27 11:36:00,401 DEBUG : operating with platform_type : linux_ 11:36:00 INFO - 2015-11-27 11:36:00,401 INFO : Initialising browser for kraken test... 11:36:00 INFO - 2015-11-27 11:36:00,407 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmJbAed/profile http://localhost:45087/getInfo.html 11:36:04 INFO - 2015-11-27 11:36:04,191 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:36:04 INFO - 2015-11-27 11:36:04,191 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:36:04 INFO - 2015-11-27 11:36:04,191 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:36:04 INFO - 2015-11-27 11:36:04,191 DEBUG : BROWSER_OUTPUT: __metrics 11:36:04 INFO - 2015-11-27 11:36:04,320 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] 11:36:05 INFO - 2015-11-27 11:36:05,576 INFO : Browser initialized. 11:36:05 INFO - 2015-11-27 11:36:05,576 INFO : Running cycle 1/1 for kraken test... 11:36:05 INFO - 2015-11-27 11:36:05,576 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmJbAed/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:36:17 INFO - 2015-11-27 11:36:17,381 DEBUG : BROWSER_OUTPUT: RSS: Main: 139460608 11:36:17 INFO - 2015-11-27 11:36:17,381 DEBUG : BROWSER_OUTPUT: 11:36:19 INFO - 2015-11-27 11:36:19,996 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45087/tests/kraken/driver.html?testName=audio-beat-detection) 11:36:20 INFO - 2015-11-27 11:36:20,578 DEBUG : BROWSER_OUTPUT: RSS: Main: 174497792 11:36:20 INFO - 2015-11-27 11:36:20,578 DEBUG : BROWSER_OUTPUT: 11:36:23 INFO - 2015-11-27 11:36:23,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45087/tests/kraken/driver.html?testName=audio-dft) 11:36:23 INFO - 2015-11-27 11:36:23,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 165310464 11:36:23 INFO - 2015-11-27 11:36:23,843 DEBUG : BROWSER_OUTPUT: 11:36:26 INFO - 2015-11-27 11:36:26,881 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45087/tests/kraken/driver.html?testName=audio-fft) 11:36:27 INFO - 2015-11-27 11:36:27,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 151187456 11:36:27 INFO - 2015-11-27 11:36:27,442 DEBUG : BROWSER_OUTPUT: 11:36:29 INFO - 2015-11-27 11:36:29,506 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45087/tests/kraken/driver.html?testName=audio-oscillator) 11:36:30 INFO - 2015-11-27 11:36:30,079 DEBUG : BROWSER_OUTPUT: RSS: Main: 153120768 11:36:30 INFO - 2015-11-27 11:36:30,079 DEBUG : BROWSER_OUTPUT: 11:36:32 INFO - 2015-11-27 11:36:32,338 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45087/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:36:32 INFO - 2015-11-27 11:36:32,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 154398720 11:36:32 INFO - 2015-11-27 11:36:32,904 DEBUG : BROWSER_OUTPUT: 11:36:35 INFO - 2015-11-27 11:36:35,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45087/tests/kraken/driver.html?testName=imaging-darkroom) 11:36:36 INFO - 2015-11-27 11:36:36,471 DEBUG : BROWSER_OUTPUT: RSS: Main: 154714112 11:36:36 INFO - 2015-11-27 11:36:36,472 DEBUG : BROWSER_OUTPUT: 11:36:39 INFO - 2015-11-27 11:36:39,864 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45087/tests/kraken/driver.html?testName=imaging-desaturate) 11:36:40 INFO - 2015-11-27 11:36:40,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 154476544 11:36:40 INFO - 2015-11-27 11:36:40,446 DEBUG : BROWSER_OUTPUT: 11:36:43 INFO - 2015-11-27 11:36:43,325 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45087/tests/kraken/driver.html?testName=json-parse-financial) 11:36:43 INFO - 2015-11-27 11:36:43,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 154738688 11:36:43 INFO - 2015-11-27 11:36:43,911 DEBUG : BROWSER_OUTPUT: 11:36:45 INFO - 2015-11-27 11:36:45,684 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45087/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:36:46 INFO - 2015-11-27 11:36:46,249 DEBUG : BROWSER_OUTPUT: RSS: Main: 165068800 11:36:46 INFO - 2015-11-27 11:36:46,249 DEBUG : BROWSER_OUTPUT: 11:36:48 INFO - 2015-11-27 11:36:48,140 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45087/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:36:48 INFO - 2015-11-27 11:36:48,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 165765120 11:36:48 INFO - 2015-11-27 11:36:48,733 DEBUG : BROWSER_OUTPUT: 11:36:50 INFO - 2015-11-27 11:36:50,849 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45087/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:36:51 INFO - 2015-11-27 11:36:51,430 DEBUG : BROWSER_OUTPUT: RSS: Main: 175972352 11:36:51 INFO - 2015-11-27 11:36:51,430 DEBUG : BROWSER_OUTPUT: 11:36:53 INFO - 2015-11-27 11:36:53,924 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45087/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:36:54 INFO - 2015-11-27 11:36:54,504 DEBUG : BROWSER_OUTPUT: RSS: Main: 183410688 11:36:54 INFO - 2015-11-27 11:36:54,505 DEBUG : BROWSER_OUTPUT: 11:36:57 INFO - 2015-11-27 11:36:57,133 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45087/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:36:57 INFO - 2015-11-27 11:36:57,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 181788672 11:36:57 INFO - 2015-11-27 11:36:57,715 DEBUG : BROWSER_OUTPUT: 11:36:59 INFO - 2015-11-27 11:36:59,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45087/tests/kraken/driver.html?testName=ai-astar) 11:36:59 INFO - 2015-11-27 11:36:59,729 DEBUG : BROWSER_OUTPUT: RSS: Main: 239239168 11:36:59 INFO - 2015-11-27 11:36:59,729 DEBUG : BROWSER_OUTPUT: 11:36:59 INFO - 2015-11-27 11:36:59,732 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:36:59 INFO - 2015-11-27 11:36:59,733 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:36:59 INFO - 2015-11-27 11:36:59,733 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:36:59 INFO - 2015-11-27 11:36:59,733 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:36:59 INFO - 2015-11-27 11:36:59,733 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;114;106;112;112;113;103;112;112;107 11:36:59 INFO - 2015-11-27 11:36:59,733 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;132;151;171;129;152;149;129;175;131 11:36:59 INFO - 2015-11-27 11:36:59,733 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;161;160;160;161;160;160;161;161;170 11:36:59 INFO - 2015-11-27 11:36:59,733 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;82;90;72;72;72;93;100;72 11:36:59 INFO - 2015-11-27 11:36:59,733 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;127;100;94;94;136;95;95;130 11:36:59 INFO - 2015-11-27 11:36:59,733 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;110;109;109;109;110;109 11:36:59 INFO - 2015-11-27 11:36:59,734 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;146 11:36:59 INFO - 2015-11-27 11:36:59,734 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;95 11:36:59 INFO - 2015-11-27 11:36:59,734 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;70;71;71;71;71;75;80;70;70 11:36:59 INFO - 2015-11-27 11:36:59,734 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;69;69;77;70;70;70;69;69 11:36:59 INFO - 2015-11-27 11:36:59,734 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;83;83;83;92;83;84;84;84 11:36:59 INFO - 2015-11-27 11:36:59,734 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;119;124;121;117;127;128;128;122;118 11:36:59 INFO - 2015-11-27 11:36:59,734 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;154;153;149;158;145;145;146;146;145;136 11:36:59 INFO - 2015-11-27 11:36:59,734 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;67;69;71;69;68;68;67;71 11:36:59 INFO - 2015-11-27 11:36:59,734 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:36:59 INFO - 2015-11-27 11:36:59,734 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:36:59 INFO - 2015-11-27 11:36:59,734 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1006 11:36:59 INFO - 2015-11-27 11:36:59,735 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:36:59 INFO - 2015-11-27 11:36:59,735 DEBUG : BROWSER_OUTPUT: __startTimestamp1448653019731__endTimestamp 11:36:59 INFO - 2015-11-27 11:36:59,735 DEBUG : BROWSER_OUTPUT: 11:36:59 INFO - 2015-11-27 11:36:59,736 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:36:59 INFO - 2015-11-27 11:36:59,736 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:36:59 INFO - 2015-11-27 11:36:59,736 DEBUG : BROWSER_OUTPUT: 11:36:59 INFO - 2015-11-27 11:36:59,736 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:3.58 (3.2%) stddev-sans-first:3.79 11:36:59 INFO - 2015-11-27 11:36:59,736 DEBUG : BROWSER_OUTPUT: Values: 111.0 114.0 106.0 112.0 112.0 113.0 103.0 112.0 112.0 107.0 11:36:59 INFO - 2015-11-27 11:36:59,737 DEBUG : BROWSER_OUTPUT: 11:36:59 INFO - 2015-11-27 11:36:59,737 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.30 Median:151.50 stddev:16.94 (11.2%) stddev-sans-first:17.79 11:36:59 INFO - 2015-11-27 11:36:59,737 DEBUG : BROWSER_OUTPUT: Values: 154.0 132.0 151.0 171.0 129.0 152.0 149.0 129.0 175.0 131.0 11:36:59 INFO - 2015-11-27 11:36:59,737 DEBUG : BROWSER_OUTPUT: 11:36:59 INFO - 2015-11-27 11:36:59,738 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:3.13 (1.9%) stddev-sans-first:3.21 11:36:59 INFO - 2015-11-27 11:36:59,738 DEBUG : BROWSER_OUTPUT: Values: 159.0 161.0 160.0 160.0 161.0 160.0 160.0 161.0 161.0 170.0 11:36:59 INFO - 2015-11-27 11:36:59,738 DEBUG : BROWSER_OUTPUT: 11:36:59 INFO - 2015-11-27 11:36:59,738 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.80 Median:72.50 stddev:10.76 (14.8%) stddev-sans-first:11.13 11:36:59 INFO - 2015-11-27 11:36:59,738 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 82.0 90.0 72.0 72.0 72.0 93.0 100.0 72.0 11:36:59 INFO - 2015-11-27 11:36:59,739 DEBUG : BROWSER_OUTPUT: 11:36:59 INFO - 2015-11-27 11:36:59,739 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:94.00 stddev:17.47 (18.6%) stddev-sans-first:17.99 11:36:59 INFO - 2015-11-27 11:36:59,739 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 127.0 100.0 94.0 94.0 136.0 95.0 95.0 130.0 11:36:59 INFO - 2015-11-27 11:36:59,739 DEBUG : BROWSER_OUTPUT: 11:36:59 INFO - 2015-11-27 11:36:59,739 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:36:59 INFO - 2015-11-27 11:36:59,739 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 110.0 109.0 109.0 109.0 110.0 109.0 11:36:59 INFO - 2015-11-27 11:36:59,739 DEBUG : BROWSER_OUTPUT: 11:36:59 INFO - 2015-11-27 11:36:59,739 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:36:59 INFO - 2015-11-27 11:36:59,739 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 11:36:59 INFO - 2015-11-27 11:36:59,739 DEBUG : BROWSER_OUTPUT: 11:36:59 INFO - 2015-11-27 11:36:59,740 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:36:59 INFO - 2015-11-27 11:36:59,740 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 11:36:59 INFO - 2015-11-27 11:36:59,740 DEBUG : BROWSER_OUTPUT: 11:36:59 INFO - 2015-11-27 11:36:59,740 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.00 Median:71.00 stddev:3.16 (4.5%) stddev-sans-first:3.33 11:36:59 INFO - 2015-11-27 11:36:59,740 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 71.0 71.0 71.0 71.0 75.0 80.0 70.0 70.0 11:36:59 INFO - 2015-11-27 11:36:59,740 DEBUG : BROWSER_OUTPUT: 11:36:59 INFO - 2015-11-27 11:36:59,741 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.00 stddev:2.44 (3.5%) stddev-sans-first:2.55 11:36:59 INFO - 2015-11-27 11:36:59,741 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 69.0 77.0 70.0 70.0 70.0 69.0 69.0 11:36:59 INFO - 2015-11-27 11:36:59,741 DEBUG : BROWSER_OUTPUT: 11:36:59 INFO - 2015-11-27 11:36:59,741 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.50 stddev:2.85 (3.4%) stddev-sans-first:2.92 11:36:59 INFO - 2015-11-27 11:36:59,741 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 83.0 83.0 83.0 92.0 83.0 84.0 84.0 84.0 11:36:59 INFO - 2015-11-27 11:36:59,741 DEBUG : BROWSER_OUTPUT: 11:36:59 INFO - 2015-11-27 11:36:59,741 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.20 Median:123.00 stddev:4.32 (3.5%) stddev-sans-first:4.30 11:36:59 INFO - 2015-11-27 11:36:59,741 DEBUG : BROWSER_OUTPUT: Values: 118.0 119.0 124.0 121.0 117.0 127.0 128.0 128.0 122.0 118.0 11:36:59 INFO - 2015-11-27 11:36:59,741 DEBUG : BROWSER_OUTPUT: 11:36:59 INFO - 2015-11-27 11:36:59,741 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:147.50 stddev:6.15 (4.2%) stddev-sans-first:6.08 11:36:59 INFO - 2015-11-27 11:36:59,742 DEBUG : BROWSER_OUTPUT: Values: 154.0 153.0 149.0 158.0 145.0 145.0 146.0 146.0 145.0 136.0 11:36:59 INFO - 2015-11-27 11:36:59,742 DEBUG : BROWSER_OUTPUT: 11:36:59 INFO - 2015-11-27 11:36:59,742 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.45 (2.1%) stddev-sans-first:1.48 11:36:59 INFO - 2015-11-27 11:36:59,742 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 67.0 69.0 71.0 69.0 68.0 68.0 67.0 71.0 11:36:59 INFO - 2015-11-27 11:36:59,742 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:36:59 INFO - 2015-11-27 11:36:59,742 DEBUG : BROWSER_OUTPUT: 11:37:00 INFO - 2015-11-27 11:37:00,629 INFO : Browser exited with error code: 0 11:37:00 INFO - 2015-11-27 11:37:00,682 INFO : Completed test kraken (00:01:00) 11:37:00 INFO - 2015-11-27 11:37:00,682 INFO : Starting test v8_7 11:37:00 INFO - 2015-11-27 11:37:00,682 DEBUG : operating with platform_type : linux_ 11:37:00 INFO - 2015-11-27 11:37:00,682 INFO : Initialising browser for v8_7 test... 11:37:00 INFO - 2015-11-27 11:37:00,688 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGKq6GA/profile http://localhost:45087/getInfo.html 11:37:04 INFO - 2015-11-27 11:37:04,409 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:37:04 INFO - 2015-11-27 11:37:04,409 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:37:04 INFO - 2015-11-27 11:37:04,409 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:37:04 INFO - 2015-11-27 11:37:04,409 DEBUG : BROWSER_OUTPUT: __metrics 11:37:04 INFO - 2015-11-27 11:37:04,531 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] 11:37:05 INFO - 2015-11-27 11:37:05,151 DEBUG : BROWSER_OUTPUT: console.error: 11:37:05 INFO - 2015-11-27 11:37:05,152 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 11:37:05 INFO - 2015-11-27 11:37:05,152 DEBUG : BROWSER_OUTPUT: Stack: 11:37:05 INFO - 2015-11-27 11:37:05,152 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 11:37:05 INFO - 2015-11-27 11:37:05,152 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 11:37:05 INFO - 2015-11-27 11:37:05,153 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 11:37:05 INFO - 2015-11-27 11:37:05,153 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 11:37:05 INFO - 2015-11-27 11:37:05,153 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 11:37:05 INFO - 2015-11-27 11:37:05,153 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 11:37:05 INFO - 2015-11-27 11:37:05,153 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:529:9 11:37:05 INFO - 2015-11-27 11:37:05,154 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 11:37:05 INFO - 2015-11-27 11:37:05,154 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:529:9 11:37:05 INFO - 2015-11-27 11:37:05,154 DEBUG : BROWSER_OUTPUT: 11:37:05 INFO - 2015-11-27 11:37:05,700 INFO : Browser initialized. 11:37:05 INFO - 2015-11-27 11:37:05,701 INFO : Running cycle 1/1 for v8_7 test... 11:37:05 INFO - 2015-11-27 11:37:05,701 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGKq6GA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:37:17 INFO - 2015-11-27 11:37:17,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 141197312 11:37:17 INFO - 2015-11-27 11:37:17,629 DEBUG : BROWSER_OUTPUT: 11:37:39 INFO - 2015-11-27 11:37:39,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45087/tests/v8_7/run.html (next: http://localhost:45087/tests/v8_7/run.html) 11:37:39 INFO - 2015-11-27 11:37:39,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 442175488 11:37:39 INFO - 2015-11-27 11:37:39,310 DEBUG : BROWSER_OUTPUT: 11:37:39 INFO - 2015-11-27 11:37:39,310 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:37:39 INFO - 2015-11-27 11:37:39,310 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:37:39 INFO - 2015-11-27 11:37:39,310 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:37:39 INFO - 2015-11-27 11:37:39,310 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:37:39 INFO - 2015-11-27 11:37:39,310 DEBUG : BROWSER_OUTPUT: |0;Richards;165.18004625041294 11:37:39 INFO - 2015-11-27 11:37:39,311 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.42419601837673 11:37:39 INFO - 2015-11-27 11:37:39,311 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.4694783573807 11:37:39 INFO - 2015-11-27 11:37:39,311 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5175.257731958763 11:37:39 INFO - 2015-11-27 11:37:39,311 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2004.0080160320642 11:37:39 INFO - 2015-11-27 11:37:39,311 DEBUG : BROWSER_OUTPUT: |5;Earley;788.1889763779527 11:37:39 INFO - 2015-11-27 11:37:39,311 DEBUG : BROWSER_OUTPUT: |6;Boyer;12048.192771084337 11:37:39 INFO - 2015-11-27 11:37:39,311 DEBUG : BROWSER_OUTPUT: |7;RegExp;26578.947368421053 11:37:39 INFO - 2015-11-27 11:37:39,311 DEBUG : BROWSER_OUTPUT: |8;Splay;619.9628022318661 11:37:39 INFO - 2015-11-27 11:37:39,312 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 11:37:39 INFO - 2015-11-27 11:37:39,312 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:37:39 INFO - 2015-11-27 11:37:39,312 DEBUG : BROWSER_OUTPUT: __startTimestamp1448653059303__endTimestamp 11:37:39 INFO - 2015-11-27 11:37:39,312 DEBUG : BROWSER_OUTPUT: 11:37:39 INFO - 2015-11-27 11:37:39,312 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:37:39 INFO - 2015-11-27 11:37:39,312 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:37:39 INFO - 2015-11-27 11:37:39,312 DEBUG : BROWSER_OUTPUT: 11:37:39 INFO - 2015-11-27 11:37:39,313 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.18 Median:165.18 stddev:0.00 (0.0%) 11:37:39 INFO - 2015-11-27 11:37:39,313 DEBUG : BROWSER_OUTPUT: Values: 165.2 11:37:39 INFO - 2015-11-27 11:37:39,313 DEBUG : BROWSER_OUTPUT: 11:37:39 INFO - 2015-11-27 11:37:39,313 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.42 Median:191.42 stddev:0.00 (0.0%) 11:37:39 INFO - 2015-11-27 11:37:39,313 DEBUG : BROWSER_OUTPUT: Values: 191.4 11:37:39 INFO - 2015-11-27 11:37:39,313 DEBUG : BROWSER_OUTPUT: 11:37:39 INFO - 2015-11-27 11:37:39,313 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.47 Median:277.47 stddev:0.00 (0.0%) 11:37:39 INFO - 2015-11-27 11:37:39,314 DEBUG : BROWSER_OUTPUT: Values: 277.5 11:37:39 INFO - 2015-11-27 11:37:39,314 DEBUG : BROWSER_OUTPUT: 11:37:39 INFO - 2015-11-27 11:37:39,314 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 11:37:39 INFO - 2015-11-27 11:37:39,314 DEBUG : BROWSER_OUTPUT: Values: 5175.3 11:37:39 INFO - 2015-11-27 11:37:39,314 DEBUG : BROWSER_OUTPUT: 11:37:39 INFO - 2015-11-27 11:37:39,314 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2004.01 Median:2004.01 stddev:0.00 (0.0%) 11:37:39 INFO - 2015-11-27 11:37:39,314 DEBUG : BROWSER_OUTPUT: Values: 2004.0 11:37:39 INFO - 2015-11-27 11:37:39,315 DEBUG : BROWSER_OUTPUT: 11:37:39 INFO - 2015-11-27 11:37:39,315 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.19 Median:788.19 stddev:0.00 (0.0%) 11:37:39 INFO - 2015-11-27 11:37:39,315 DEBUG : BROWSER_OUTPUT: Values: 788.2 11:37:39 INFO - 2015-11-27 11:37:39,315 DEBUG : BROWSER_OUTPUT: 11:37:39 INFO - 2015-11-27 11:37:39,315 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12048.19 Median:12048.19 stddev:0.00 (0.0%) 11:37:39 INFO - 2015-11-27 11:37:39,315 DEBUG : BROWSER_OUTPUT: Values: 12048.2 11:37:39 INFO - 2015-11-27 11:37:39,315 DEBUG : BROWSER_OUTPUT: 11:37:39 INFO - 2015-11-27 11:37:39,315 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26578.95 Median:26578.95 stddev:0.00 (0.0%) 11:37:39 INFO - 2015-11-27 11:37:39,316 DEBUG : BROWSER_OUTPUT: Values: 26578.9 11:37:39 INFO - 2015-11-27 11:37:39,316 DEBUG : BROWSER_OUTPUT: 11:37:39 INFO - 2015-11-27 11:37:39,316 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:619.96 Median:619.96 stddev:0.00 (0.0%) 11:37:39 INFO - 2015-11-27 11:37:39,316 DEBUG : BROWSER_OUTPUT: Values: 620.0 11:37:39 INFO - 2015-11-27 11:37:39,316 DEBUG : BROWSER_OUTPUT: 11:37:39 INFO - 2015-11-27 11:37:39,316 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 11:37:39 INFO - 2015-11-27 11:37:39,316 DEBUG : BROWSER_OUTPUT: Values: 4835.7 11:37:39 INFO - 2015-11-27 11:37:39,317 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:37:39 INFO - 2015-11-27 11:37:39,317 DEBUG : BROWSER_OUTPUT: 11:37:40 INFO - 2015-11-27 11:37:40,205 INFO : Browser exited with error code: 0 11:37:40 INFO - 2015-11-27 11:37:40,222 INFO : Completed test v8_7 (00:00:39) 11:37:40 INFO - 2015-11-27 11:37:40,310 INFO : Completed test suite (00:20:16) 11:37:40 INFO - 2015-11-27 11:37:40,311 DEBUG : Working with test: dromaeo_css 11:37:40 INFO - 2015-11-27 11:37:40,311 DEBUG : Generating results file: dromaeo_css 11:37:40 INFO - 2015-11-27 11:37:40,312 DEBUG : Working with test: kraken 11:37:40 INFO - 2015-11-27 11:37:40,312 DEBUG : Generating results file: kraken 11:37:40 INFO - 2015-11-27 11:37:40,312 INFO : javascript benchmark 11:37:40 INFO - 2015-11-27 11:37:40,312 DEBUG : Working with test: v8_7 11:37:40 INFO - 2015-11-27 11:37:40,313 DEBUG : Generating results file: v8_7 11:37:40 INFO - 2015-11-27 11:37:40,313 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:37:40 INFO - 2015-11-27 11:37:40,369 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 11:37:40 INFO - 2015-11-27 11:37:40,370 DEBUG : process_Request line: dromaeo_css 6137.31 graph.html#tests=[[72,132,35]] 11:37:40 INFO - 2015-11-27 11:37:40,370 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:37:40 INFO - 2015-11-27 11:37:40,413 DEBUG : process_Request line: kraken 1520.30 graph.html#tests=[[232,132,35]] 11:37:40 INFO - 2015-11-27 11:37:40,414 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:37:40 INFO - 2015-11-27 11:37:40,567 DEBUG : process_Request line: v8_7 19752.47 graph.html#tests=[[230,132,35]] 11:37:40 INFO - 2015-11-27 11:37:40,569 INFO : javascript benchmark 11:37:40 INFO - 2015-11-27 11:37:40,572 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2608.387029048173, 2699.64904562407, 2713.674359076911, 2719.048333083421, 2731.207949694588, 4531.954680453195, 4623.676342656016, 4656.464506581744, 4665.04366604846, 4666.626669866411, 4531.365608814768, 4549.135664223803, 4589.426321709786, 4593.356930029799, 4607.147677679632, 4264.23243816113, 4277.93583096253, 4284.721493102954, 4327.069680018795, 4393.2531469650075, 4143.9171216575805, 4385.56144385562, 4399.318105693606, 4435.9556404436025, 4439.711418757786, 4211.768352740598, 4292.570742925698, 4292.935605965913, 4326.351047342892, 4333.631641310492, 4336.7831608419765, 4344.6089851913475, 4347.913041739147, 4393.802278897458, 4394.824207031715, 4152.647025002879, 4323.373110898933, 4348.021695118605, 4356.520782713899, 4404.361367601712, 4510.0979804039325, 4570.085982803419, 4587.128445595326, 4632.0967411354795, 4663.510331415187, 5014.674046186986, 5047.0915235257635, 5050.343455350818, 5052.368453943257, 5091.389033315989, 4883.536064073907, 5055.772490237948, 5067.037262920034, 5067.138586440314, 5079.8222062228015, 4540.750258735735, 4630.72215667061, 4630.83792067276, 4631.258998560248, 4634.907301853944, 5135.563477104413, 5141.562967147835, 5147.97426012875, 5152.175651895679, 5197.142471492237, 4943.431505376856, 4950.232713929347, 4955.90088198234, 4959.578435832923, 5000.299958005882, 4769.618430525549, 4865.927011094836, 4887.731174785421, 4893.290472881412, 5022.648414610942, 4982.975085124624, 5000.1249781288125, 5002.724850133278, 5022.246663000579, 5022.4977502249485, 4962.702237865739, 4963.652544321935, 4967.081089998362, 4967.875803104951, 5014.724190169576, 4109.671226301889, 4211.136716973075, 4254.978725106354, 4257.10600773841, 4307.483102027714, 3612.819359032038, 3679.1721862580707, 3714.4242642390473, 3724.944125838115, 3757.3800322946954, 4291.721038132511, 4300.827966881352, 4306.246406878784, 4310.030243195319, 4357.934630980538, 4837.105135549935, 4990.950090499121, 4995.0, 4998.550130488274, 5004.84985450437, 4204.915901681949, 4270.957290427118, 4278.679099067583, 4283.443152390169, 4298.871033868989, 4476.35092911526, 4503.932441013388, 4513.255312873339, 4513.796879140446, 4554.339620754972, 4791.6406269529925, 4807.326974223682, 4813.9037219256115, 4814.350062741555, 4857.587105096107, 4832.178529649897, 4935.235038569028, 4940.036692844861, 4943.629227808001, 5032.899342013066, 4715.504871988529, 4767.475577686521, 4770.666053376231, 4772.260299653559, 4813.95186048135, 4941.456439791548, 4948.208286674115, 4954.430240522242, 4960.528749768766, 5001.749912504433, 4835.903281934412, 4941.65408421407, 4948.430930443045, 4969.403671559436, 5087.796488140433, 4923.753812309298, 4930.087933732271, 4937.851864444073, 4938.2839488273285, 4942.5304596063315, 4885.389326334208, 4924.679895806761, 4931.728754918514, 4933.629977751755, 4958.454569997225, 4611.0, 4663.860084197479, 4702.717836929795, 4728.71627702339, 4876.561109500162, 4887.877803054952, 4896.36347274852, 4954.529319714621, 4959.082569724613, 4963.255511673278, 4832.057748738962, 4837.056773929191, 4851.223804191312, 4853.781579828846, 4895.265710143507], "unit": "ms", "name": "dojo.html", "value": 4595.055594886922}, {"lowerIsBetter": false, "replicates": [545.5880809988458, 546.581864873372, 548.9780408783649, 552.3868505958385, 566.3515275010116, 27433.45133097337, 28099.0, 36343.09142271441, 37038.62961370385, 37079.4438083429, 40916.0, 41383.17233655325, 41462.58537414625, 41497.58502414975, 41510.792446037725, 6825.0, 6936.410405115571, 7717.807054823632, 7844.137144914055, 7871.685132594718, 9956.6515171969, 10226.130778883766, 10230.488475576229, 10230.795384092313, 10236.2322825788, 10094.444805535693, 10239.488025598728, 10239.539220735085, 10245.948770256138, 10246.641367552138, 7144.785656430316, 7306.196318404971, 9862.161716254128, 10127.442990635513, 10414.166866650725, 9953.502324883726, 10098.798024039552, 10103.848442273298, 10112.443815590139, 10117.241206909512, 33118.50322245144, 33376.16559586005, 33425.49861752076, 33438.164045899044, 33487.497687534706, 2859.127965970378, 2906.534954407306, 2969.242843075002, 3198.328351046283, 3198.424283628946, 27698.861505692545, 27854.442911141665, 27970.580441293398, 28311.0, 28348.29129271764, 2884.538473844175, 2917.2560996945854, 2955.6305461817274, 2971.777116716233, 3053.175642576492, 211283.94358028265, 212435.0, 212462.0, 213203.5378761736, 213211.0, 49423.50576494261, 50745.74627126841, 53555.73222133864, 53650.46349536454, 55045.0, 50161.24758128631, 50255.49744502508, 50370.496295037316, 50542.0, 50641.0, 11880.108991825648, 12033.037357011419, 12037.578684745991, 12046.216995895238, 12055.698607534881, 8532.317414606816, 8549.401541892008, 8572.828543429221, 8690.478571285743, 8790.033096359395, 18213.90893045526, 18294.26822927068, 18354.90822545879, 18422.723659145122, 18448.26206951734, 6724.260331363546, 6798.150231221098, 6812.420944219797, 6860.3139686031, 6935.861282774316, 828.2131974624131, 876.4215617692292, 879.1077056787366, 891.028778631295, 995.0596686131536, 26291.0, 26888.49501283429, 27456.862715686693, 27655.0, 29249.415011699646, 860.8278344331159, 866.5753780647437, 881.8853549038583, 895.8387490251818, 983.8376667849725, 11934.761304773856, 12364.258144511357, 12406.56577019818, 12626.621201363974, 13261.535846245335, 258930.0, 260639.0, 262661.0, 263666.0, 263797.0, 43577.34633980493, 43661.56338436638, 43725.562744372786, 43769.0, 43773.562264377586, 1107.9058280046124, 1127.182792475465, 1168.9240199387013, 1178.5698220149754, 1180.474688763492, 23617.173398930954, 25380.0, 26370.4725905477, 26455.33861653474, 26644.866775665996, 38231.808840955615, 38709.419358710205, 38739.41890871583, 38753.2249355017, 38771.806140969114, 227583.0, 231747.0, 242169.0, 247747.0, 248031.0, 26597.867010664824, 26621.334466638487, 26686.332841678337, 26814.59778103291, 26848.0, 36380.27239455249, 36437.45343819792, 37258.813705931294, 38153.0, 40030.0, 32510.0, 32658.83670581632, 33146.34268286624, 33445.33109337751, 33516.65933362638, 32019.519707203945, 33096.338073237916, 33415.83292083524, 33598.3280334387, 34198.82900585481, 30636.0, 30783.076507704805, 31003.689963100984, 31091.533626996064, 31110.222244443165, 25945.87027064928, 27610.861945690143, 29717.83950246924, 29748.0, 29789.702102978692, 23221.651675225225, 23274.457601525544, 23437.298557049184, 23511.529769404173, 23545.64681529744], "unit": "ms", "name": "ext.html", "value": 16478.36904833785}, {"lowerIsBetter": false, "replicates": [312.66388632220367, 315.9905202843914, 323.84131775430035, 324.39014652453386, 327.08579520240914, 11928.403579821017, 12263.325517096557, 13672.111312764675, 14952.476663316786, 15344.923275383622, 11688.298702077882, 14673.26633668315, 14995.175265360429, 15448.0, 15448.613784655361, 4960.528749768784, 4978.676386034906, 5035.672681275723, 5038.521340472649, 5124.410692770323, 3525.400681884073, 3619.49327094207, 4974.950250497485, 4976.2286845539, 5612.550995920316, 5744.942550574483, 5779.248697669297, 5800.651960882339, 5806.767729290823, 5809.0, 5593.440655934414, 5720.77116915327, 5727.3699893011735, 5728.16941543476, 5752.884942301152, 4898.2162853943555, 4919.96680697054, 4920.384951881015, 4920.680155789898, 4932.5807306379, 18750.0, 18911.05444727772, 19383.80616193834, 19442.805571944242, 19442.90278548598, 551.7241379310345, 552.3620218647469, 552.9004779139754, 552.9640573362718, 1838.960987042317, 12304.630861074182, 12700.237985720887, 12731.108822382437, 12968.80546791799, 13190.538331158363, 1724.6205834716343, 1735.878488505805, 1748.9475315740422, 1765.470358892327, 1817.6637322095455, 52132.0, 53410.19884701694, 53792.19311710328, 53892.46107538914, 54554.72722636361, 8977.865332020025, 9068.50123243228, 9182.357234993486, 9193.218576420946, 9240.21458176049, 11706.531738730355, 11719.824202636968, 11746.353950532632, 11753.647390578297, 11755.588554400554, 6505.024246363083, 6509.641969691713, 6623.834404139839, 6629.270780214172, 6691.665416729144, 6294.496440284766, 6303.527235457359, 6347.206599175103, 6369.331220221903, 6369.394907483782, 5473.835784926379, 5534.446555344433, 5539.667619942736, 5560.749766260528, 5570.61005729595, 1515.7423238049557, 1560.2432820082252, 1575.8811244016647, 1593.3947995028213, 1624.61821471954, 808.3492788305471, 808.9878651820227, 875.5884734174928, 897.7396554999108, 926.754410081329, 15724.13517256539, 15841.0, 16211.432599859185, 16403.179841007903, 16487.670246595, 699.576756062585, 819.3076850061689, 826.4958375391006, 827.5655280977535, 836.2390224895316, 8418.284445822173, 8804.911950880538, 8913.598888050054, 9003.864942025875, 9306.441613503212, 545097.0, 550415.0, 553359.0, 558650.0, 561832.0, 68662.0, 73733.0, 74695.0, 75582.62208689032, 77132.22867771363, 1049.7900419915895, 1050.0234781653137, 1062.670572122629, 1082.242430298794, 1101.262154356583, 14172.574822755334, 14195.929020355245, 14198.29008549589, 14217.004809663224, 14313.141211527342, 30571.388572228876, 32243.838780805945, 32392.0, 32660.183495411853, 33825.323493530486, 39129.21741565096, 39617.0, 39888.8005559982, 40534.797326013184, 43415.13169736651, 7879.0939042010905, 8132.430729848854, 12333.62999110028, 12638.3680815957, 12714.237145771283, 16707.665846682754, 16882.66234675324, 16902.661946761244, 17327.480175594752, 17550.210240538952, 14076.929615351857, 14378.568642940729, 14902.552923412315, 14911.105333680014, 14925.55223343258, 14164.787528187291, 14605.488807891672, 14679.48621798232, 14760.409583616534, 15039.323230454436, 12320.0, 12755.93622031884, 14312.284385780878, 15481.690366192388, 15913.443029493912, 13929.164250145024, 13950.860491394957, 13962.37169327403, 14222.502212422516, 14279.21464319431, 14854.925725371304, 14916.403343866124, 15182.240887955779, 15195.620109497351, 15321.846781532488], "unit": "ms", "name": "jquery.html", "value": 8369.601377935407}, {"lowerIsBetter": false, "replicates": [1244.831947687062, 1440.7334643091021, 1464.0264224290847, 1590.68981548598, 1664.6670665866825, 5641.548676105912, 6495.123158373624, 6639.701213445394, 6673.232578253496, 6691.832704182398, 6575.112359831422, 6711.228208755982, 6715.832104197398, 6736.0, 6736.562123461984, 1889.9811001889977, 1923.6152769446096, 1925.4512463947779, 1925.682262426705, 1927.3639698899399, 1934.3423236099723, 1957.4225603447017, 1964.0572525187847, 1968.5865968146707, 1990.0, 1954.4039068084228, 1961.3723608445302, 1972.566035472201, 1976.1502553901817, 1977.8516611254142, 1871.504051426373, 1917.9041047947546, 1920.0975541495475, 1922.1542521290587, 1922.5193701574606, 1922.0293751655465, 1931.4109196695003, 1936.5255512399413, 1947.6494231038407, 1968.8031196880197, 5683.175939488792, 5840.97079514604, 6584.604923704593, 6660.433863121641, 6664.533482656216, 3598.208394153282, 3719.386301260316, 3725.5715592706642, 3726.1802403471193, 3726.4596633488263, 2568.0754928225824, 2569.8586577738215, 2599.2072417912527, 2627.0805218173487, 2629.1455277034847, 767.3017554025865, 814.861473549498, 832.5254604875223, 920.3281604428738, 922.7231830450838, 8613.655453781841, 8652.956735216347, 8655.74032779024, 8667.4366166199, 8667.436616619963, 3411.9829400852836, 3483.6690514401093, 3521.7710848794745, 3550.8757193498104, 3554.413521768931, 7609.923900760921, 7610.695572177051, 7683.615819209017, 7686.500377475446, 7687.2697093776005, 3825.215830754689, 3825.3305671507374, 3825.8087095645105, 3826.426036094608, 3828.157805282833, 3486.4944583035826, 3488.6162522122545, 3497.283056973314, 3501.824908754552, 3501.824908754552, 3137.8117312961294, 3142.5757522734593, 3159.131238909318, 3159.1944054266473, 3191.9680803192136, 968.733598260484, 970.6505657963128, 970.9708708738749, 977.1059480575194, 978.5694294510392, 1142.948567314473, 1146.3523109443138, 1149.6953307373553, 1152.2337645465839, 1192.266755945105, 6241.656708880964, 6285.088662143963, 6309.9588567885785, 6322.399372059647, 6342.39747224013, 364.7574363048543, 366.6608387241791, 370.04528316942225, 370.5238768182872, 371.87542173371685, 4681.063787242565, 5038.622103342264, 5067.315912351859, 5112.539871411591, 5113.1052065888325, 6943.548669336477, 7564.281393267631, 7803.648835802289, 7820.804479888048, 7821.7262395817015, 7634.312911837961, 7664.4634875559295, 7682.193369696213, 7713.807154821175, 7719.498232614862, 6068.605540639845, 6200.441960223511, 6227.346128656516, 6231.158793562901, 6260.843478913063, 6062.878742425039, 6075.908861366995, 6076.817695469143, 6083.69581520931, 6087.66517841523, 6775.186977562724, 7078.68145933424, 7116.822079448055, 7204.3155900189395, 7204.9279507204255, 7145.356917877416, 7324.047873776375, 7369.8157546061775, 7419.29516695913, 7420.740274090381, 5774.682392468455, 5820.679862607597, 5824.3593204748295, 5829.795957141479, 5830.125481177857, 6257.0614407837365, 6267.46726528232, 6268.2478102626155, 6273.811785646438, 6275.6862156892885, 6007.279126504673, 6009.399060093956, 6067.271927368744, 6074.3318234994995, 6177.135201071944, 5957.821265362046, 5984.790532331347, 6103.145559621567, 6158.907616385847, 6198.969005155126, 5929.050853204865, 5939.3466718661775, 5998.580099393001, 6166.691665416622, 6229.4393504582995, 5791.102379131242, 5833.970830145822, 5844.736986835517, 5849.239598852122, 5854.795082172274, 5719.113537401709, 5728.885422291448, 5748.741306641127, 5752.137179422953, 5764.423557644202], "unit": "ms", "name": "mootools.html", "value": 3724.3722563840834}, {"lowerIsBetter": false, "replicates": [278.1419321393501, 280.9943801123978, 284.3999161768667, 285.072090345924, 288.53977905241135, 5115.079285728568, 5124.820631277906, 5274.5780337573, 5343.30537030186, 5344.198370244465, 5242.606804489669, 5244.527992480676, 5270.9736451317685, 5278.709670968105, 5280.603954703393, 4055.310597198476, 4093.5087789465306, 4097.323941549641, 4099.877003689894, 4101.241270364977, 3846.1730727893496, 3878.3988481785227, 4031.5565287818317, 4078.1843631273714, 4086.5300490443683, 4050.8379664813374, 4065.8373665053364, 4078.4086307485395, 4084.14233011068, 4089.0799570096788, 4054.5337286212166, 4065.6747460203114, 4076.694247931417, 4080.510338759338, 4085.611866872642, 3558.5373901392913, 3568.6431356864364, 3568.839402226906, 3570.553680789901, 3575.302815950891, 5075.593952483792, 5081.8729531762, 5087.414947281073, 5087.745612719349, 5093.567046801027, 4660.487346391894, 4669.089527542131, 4669.112868554964, 4669.439667239919, 4674.0, 5527.55779537636, 5529.778808847682, 5534.557235421197, 5536.861578460531, 5539.667619942817, 3876.457295978565, 3880.0687834919418, 3880.844766209348, 3882.456456096149, 3884.8057597120032, 5443.455654434525, 5808.3030036395485, 5817.156512305734, 5822.7088645567555, 5824.53403727705, 3452.2922800825772, 3729.869454569077, 3791.810409479515, 3804.4483549885667, 3805.752626079296, 3854.3062248794927, 3863.632954869283, 3914.64768170866, 3977.801109944549, 3997.080671445584, 4483.125790470892, 4557.794899229542, 4568.862934111982, 4635.513271106485, 4644.373009643722, 5527.2538207342295, 5537.335519737658, 5542.251796007487, 5547.694876781816, 5548.528375088163, 1417.8156839610785, 1435.397133204036, 1436.9425222990963, 1437.5687293811814, 1439.1437094928501, 955.3312681123242, 970.2432102959702, 978.5351957819978, 994.4282037828277, 996.7657600463886, 4865.172920603435, 4875.634327425457, 4882.340883980688, 4882.51174882516, 4884.3161957326, 5758.049921762946, 5760.769569217268, 5765.682887441231, 5766.88466230673, 5770.538356931435, 4866.902661946741, 4868.878278043077, 4871.95128048715, 4872.6832755870755, 4874.8537543873745, 3032.969670303313, 3072.8002679826186, 3106.6116735408073, 3109.626844778641, 3137.388209299165, 5506.752196151183, 5524.281843360337, 5524.944750552523, 5537.418571049981, 5538.390777014525, 5999.790007349722, 6002.129691194839, 6012.188354572164, 6013.278406591237, 6014.338422773491, 5504.752286147133, 5519.061759500894, 5525.806596769094, 5529.142982837667, 5531.3915469298345, 5680.204771331934, 5834.824955251349, 5836.0, 5848.707564621837, 5848.970755146197, 5426.375966763872, 5567.498925096761, 5615.410381909841, 5615.747291371979, 5616.803411880564, 5401.783928642967, 5425.050616142238, 5510.338759348743, 5527.115661494142, 5529.502344788988, 3858.5562660294427, 3880.320943834874, 3907.765534067965, 3908.8827335178853, 3908.9609103908597, 5706.4864162225595, 5826.475617194304, 5832.1543376209365, 5835.854103647443, 5838.153467747068, 5619.157126431068, 5623.128415095667, 5623.775048997994, 5629.0712032514175, 5632.352279487911, 5615.185798059177, 5616.1014237721765, 5620.578456615688, 5622.746976385991, 5626.38109807929, 5398.946010539844, 5519.365272993497, 5520.834374968757, 5527.226188333556, 5532.529734972572, 5647.604667673388, 5662.490375866192, 5664.773409063756, 5667.263255776723, 5672.858178545569, 5518.448155184449, 5529.198266251451, 5530.834074977757, 5531.0873705838085, 5534.391216966211], "unit": "ms", "name": "prototype.html", "value": 4160.556755632797}, {"lowerIsBetter": false, "replicates": [654.0293767368003, 659.518551457436, 752.8945947567341, 755.1052003376, 756.2362014365489, 9779.804403911918, 10158.2889197756, 10165.288429809916, 10169.38983660981, 10174.0, 10406.947965260182, 10527.105196058325, 10535.63125290613, 10538.631147909824, 10540.947295263531, 600.2167171840746, 606.5632744424007, 735.2757533829188, 755.4862693368507, 768.1358471719316, 761.2235519769831, 762.7101701353478, 768.4428789127893, 768.561919705768, 768.7386288661854, 520.2352541763602, 796.8565658181525, 802.8474589827914, 803.0604193094094, 803.1245941923303, 471.5002097776368, 782.9804254893617, 789.8578255913933, 791.8337149198618, 793.4009822583942, 592.6503363015798, 592.6710675575055, 592.8784599157162, 593.1192179613271, 593.2495393327445, 10464.42445665488, 10564.683059508227, 10581.0, 10584.206184536191, 10591.894081059168, 11130.944345278303, 11397.601083962105, 11399.835694192056, 11696.532138714441, 11917.463714132798, 9325.487098209596, 9471.10024547667, 9502.524873756354, 9513.857292140623, 9551.856722149174, 3169.160172554275, 3228.8708451661905, 3271.787333823294, 3278.557394751702, 3301.603807543086, 39623.8018809907, 39644.40533392001, 39651.801740991395, 39714.404283935764, 39725.0, 8743.38796284254, 8894.28845692343, 8948.418352807046, 9214.0, 9224.492652904155, 16158.676826463405, 16392.672146557, 16393.59016024585, 16436.589085272964, 16482.25829837636, 6114.38856114385, 6150.723217455135, 6287.339829317947, 6304.495640348761, 6452.1289625900845, 3619.348517266917, 3682.0978860178893, 3708.4808126862263, 3720.0, 3741.551013878352, 2554.1698947842024, 2571.061562529663, 2573.9356516087246, 2576.30439781258, 2579.4781079163386, 487.8536439068336, 489.36138339466623, 489.9906193241862, 500.26211338275755, 502.32939026399436, 449.56755174244876, 559.1835919557492, 572.4189947203508, 580.1906340654847, 584.4944123333371, 7362.411007119525, 7462.253774622494, 7470.0662417197855, 7613.238676132453, 7694.0, 458.0175523502069, 477.8661974647104, 522.2453554613547, 542.1542393865583, 565.5221337969409, 3272.2473831018997, 3423.606285277175, 3455.568053993251, 3456.7753096048677, 3458.3083383323437, 50669.49330506648, 51029.48970510322, 51049.744751276005, 51063.74468127636, 51196.488035119175, 45114.32328515075, 45689.43105689471, 46990.29514557285, 47068.76465617718, 47101.0, 41786.791066044476, 42271.0, 42641.57358426438, 42668.57331426708, 43043.56956430396, 6842.93157068423, 6950.409215216763, 7114.964425177841, 7115.181754098345, 7173.641317933978, 32132.83933580317, 32189.0, 32599.947008213763, 32907.0, 32984.83507582447, 38008.23983520369, 38078.619213807506, 38148.0, 40553.0, 40703.59296407116, 8668.956655216683, 8707.608157632794, 8916.15296546827, 9003.81992360136, 9090.272778177598, 9863.460362747119, 10062.647807326708, 10141.309257319934, 10232.0, 10281.331713438603, 9108.089191080839, 9475.857862131936, 9479.905200947902, 9580.28147888925, 9717.951410242904, 9459.337846350689, 9717.757056073655, 9763.658271960447, 9799.069088436587, 9835.704928852147, 9425.293103017439, 9486.0, 9496.335256531976, 9632.22942164611, 9694.709158725249, 7093.361597456254, 7247.637618119178, 8626.223639872442, 8724.520151391735, 9008.054154313964, 8530.232279094911, 8635.481871087755, 8674.392792504717, 8756.343274254328, 8904.910950890408], "unit": "ms", "name": "yui.html", "value": 5441.319456629283}], "name": "dromaeo_css", "value": 6137.307966109511}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 106.0, 112.0, 112.0, 113.0, 103.0, 112.0, 112.0, 107.0], "unit": "ms", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [154.0, 132.0, 151.0, 171.0, 129.0, 152.0, 149.0, 129.0, 175.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.3}, {"lowerIsBetter": true, "replicates": [159.0, 161.0, 160.0, 160.0, 161.0, 160.0, 160.0, 161.0, 161.0, 170.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 82.0, 90.0, 72.0, 72.0, 72.0, 93.0, 100.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 127.0, 100.0, 94.0, 94.0, 136.0, 95.0, 95.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 71.0, 71.0, 71.0, 71.0, 75.0, 80.0, 70.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 72.0}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 69.0, 77.0, 70.0, 70.0, 70.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.2}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 83.0, 83.0, 83.0, 92.0, 83.0, 84.0, 84.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.1}, {"lowerIsBetter": true, "replicates": [118.0, 119.0, 124.0, 121.0, 117.0, 127.0, 128.0, 128.0, 122.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.2}, {"lowerIsBetter": true, "replicates": [154.0, 153.0, 149.0, 158.0, 145.0, 145.0, 146.0, 146.0, 145.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.7}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 67.0, 69.0, 71.0, 69.0, 68.0, 68.0, 67.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1520.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.18004625041294], "unit": "score", "name": "Richards", "value": 213.71830799999998}, {"lowerIsBetter": false, "replicates": [191.42419601837673], "unit": "score", "name": "DeltaBlue", "value": 345.40043199999997}, {"lowerIsBetter": false, "replicates": [277.4694783573807], "unit": "score", "name": "Encrypt", "value": 959.316324}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [2004.0080160320642], "unit": "score", "name": "RayTrace", "value": 369.254511}, {"lowerIsBetter": false, "replicates": [788.1889763779527], "unit": "score", "name": "Earley", "value": 845.5624475524476}, {"lowerIsBetter": false, "replicates": [12048.192771084337], "unit": "score", "name": "Boyer", "value": 55.31642899999996}, {"lowerIsBetter": false, "replicates": [26578.947368421053], "unit": "score", "name": "RegExp", "value": 34.27468316831682}, {"lowerIsBetter": false, "replicates": [619.9628022318661], "unit": "score", "name": "Splay", "value": 131.44498299999998}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19752.471569759804}]} 11:37:40 INFO - RETURN: dromaeo_css: 6137.31 11:37:40 INFO - RETURN: kraken: 1520.30 11:37:40 INFO - RETURN: v8_7: 19752.47 11:37:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19752.47"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1520.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6137.31"}}} 11:37:40 INFO - Return code: 0 11:37:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:37:40 INFO - # TBPL SUCCESS # 11:37:40 INFO - Running post-action listener: _resource_record_post_action 11:37:40 INFO - Running post-run listener: _resource_record_post_run 11:37:41 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 8192; Write bytes: 514281472; Read time: 312; Write time: 803700 11:37:41 INFO - install - Wall time: 15s; CPU: 17.0%; Read bytes: 4096; Write bytes: 240390144; Read time: 300; Write time: 543884 11:37:41 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273027072; Read time: 12; Write time: 259772 11:37:41 INFO - Running post-run listener: _upload_blobber_files 11:37:41 INFO - Blob upload gear active. 11:37:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:37:41 INFO - Copying logs to upload dir... 11:37:41 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1266.963781 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-27 11:37:41.671165) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-27 11:37:41.674729) ========= 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=6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009938 build_url: 'https://queue.taskcluster.net/v1/task/WtuEzvTuSOWb0BLfP0evkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-27 11:37:41.725347) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 11:37:41.725683) ========= 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=6d5287d839824eebc594b0c9000001d1-1448647361.615766-669434842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-27 11:37:41.776206) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-27 11:37:41.776897) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-27 11:37:41.777540) ========= ========= Total master_lag: 0.27 =========